Oct 15 22:17:00 rivoplus volumio[3257]: info: Loading plugin "randomizer"... Oct 15 22:17:00 rivoplus volumio[3257]: info: Applying required configuration parameters for plugin randomizer Oct 15 22:17:00 rivoplus volumio[3257]: info: Loading i18n strings for locale en Oct 15 22:17:00 rivoplus volumio[3257]: Updating browse sources language Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::initPlayerControls Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 22:17:00 rivoplus volumio[3257]: Express server listening on port 3000 Oct 15 22:17:00 rivoplus volumio[3257]: [Metrics] WebUI: 24s 132.01ms Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreStateMachine::resetVolumioState Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreStateMachine::getcurrentVolume Oct 15 22:17:00 rivoplus volumio[3257]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:01 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:01 rivoplus sudo[3662]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 22:17:01 rivoplus sudo[3662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus volumio[3257]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 15 22:17:01 rivoplus volumio[3257]: info: Completed loading Core Plugins Oct 15 22:17:01 rivoplus sudo[3664]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 22:17:01 rivoplus sudo[3664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus volumio[3257]: info: Preparing to generate the ALSA configuration file Oct 15 22:17:01 rivoplus sudo[3662]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus sudo[3664]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus volumio[3257]: info: Volumio Network Manager: Network status updated: 1 Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: Removed streaming files Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: volumioStreaming STOPPED Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: SNAPSERVER STOPPED Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: SNAPCLIENT STOPPED Oct 15 22:17:01 rivoplus volumio[3257]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 15 22:17:01 rivoplus volumio[3257]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 15 22:17:01 rivoplus volumio[3257]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 22:17:01 rivoplus volumio[3257]: info: Reading ALSA contributions from plugins. Oct 15 22:17:01 rivoplus systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Oct 15 22:17:01 rivoplus systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 15 22:17:01 rivoplus systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 15 22:17:01 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 15 22:17:01 rivoplus upmpdcli[3669]: :3:../libupnpp/upnpplib.cxx:273::LibUPnP: Using IPV4 192.168.1.240 port 49152 IPV6 port 49152 Oct 15 22:17:01 rivoplus upmpdcli[3669]: :3:../src/mediaserver/cdplugins/plgwithslave.cxx:274::PlgWithSlave: starting streaming proxy on port 49149 Oct 15 22:17:01 rivoplus upmpdcli[3669]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Cannot assign requested address Oct 15 22:17:01 rivoplus upmpdcli[3669]: :2:../src/main.cxx:732::MPD connection failed Oct 15 22:17:01 rivoplus volumio[3257]: info: Reloading queue from file Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreStateMachine::setRepeat false single undefined Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:01 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreStateMachine::setRandom null Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:01 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:01 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 15 22:17:01 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 15 22:17:01 rivoplus volumio[3257]: info: Discovery: adding e4113e5b-1014-4fd0-aae1-aa63bdd08fd0 Oct 15 22:17:01 rivoplus volumio[3257]: info: Discovery: Found device Rivoplus Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:01 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:01 rivoplus sudo[3696]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 15 22:17:01 rivoplus sudo[3696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output for this device Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding audio output: Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding audio output: Oct 15 22:17:01 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 15 22:17:01 rivoplus volumio[3257]: info: Discovery: this is already registered, e4113e5b-1014-4fd0-aae1-aa63bdd08fd0 Oct 15 22:17:01 rivoplus volumio[3257]: info: Discovery: Found device Rivoplus Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:01 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:01 rivoplus volumio[3257]: info: Asound.conf file unchanged, so no further update is needed Oct 15 22:17:01 rivoplus volumio[3257]: info: Output device has changed, restarting MPD Oct 15 22:17:01 rivoplus sudo[3696]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus volumio[3257]: info: Output device has changed, restarting Shairport Sync Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:01 rivoplus sudo[3699]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 22:17:01 rivoplus sudo[3699]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus sudo[3699]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus sudo[3701]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 22:17:01 rivoplus sudo[3701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus volumio[3257]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:17:01 rivoplus volumio[3257]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:01 rivoplus volumio[3257]: info: ___________ START PLUGINS ___________ Oct 15 22:17:01 rivoplus volumio[3257]: info: ControllerMpd::onStart: Initializing MPD Oct 15 22:17:01 rivoplus volumio[3257]: info: Creating MPD Configuration file Oct 15 22:17:01 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 15 22:17:01 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 22:17:01 rivoplus sudo[3723]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 15 22:17:01 rivoplus sudo[3723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:17:01 rivoplus volumio[3257]: info: [1792099021731] CoreMusicLibrary::Adding element Media Servers Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:17:01 rivoplus volumio[3257]: info: UPNP Browser: Client initialized successfully Oct 15 22:17:01 rivoplus sudo[3732]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 22:17:01 rivoplus sudo[3732]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus sudo[3734]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 22:17:01 rivoplus sudo[3734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus sudo[3732]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding METAVOLUMIO REST API Endpoints Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 15 22:17:01 rivoplus volumio[3257]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:01 rivoplus volumio[3257]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:01 rivoplus systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 15 22:17:01 rivoplus sudo[3723]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus volumio[3257]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:17:01 rivoplus volumio[3257]: info: [1792099021848] CoreMusicLibrary::Adding element Last_100 Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:17:01 rivoplus volumio[3257]: info: Streaming services startup Oct 15 22:17:01 rivoplus volumio[3257]: info: Starting Streaming Daemon Oct 15 22:17:01 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 15 22:17:01 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 15 22:17:01 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 15 22:17:01 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 15 22:17:01 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:17:01 rivoplus sudo[3746]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 15 22:17:01 rivoplus sudo[3746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:01 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 15 22:17:01 rivoplus volumio[3257]: info: [1792099021896] CoreMusicLibrary::Adding element Webradio Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:17:01 rivoplus volumio[3257]: info: Initializing BBC Radios Oct 15 22:17:01 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 15 22:17:01 rivoplus sudo[3746]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:17:01 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Oct 15 22:17:02 rivoplus volumio[3257]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 15 22:17:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:02 rivoplus volumio[3257]: error: Hi Res Audio Failed Login: Missing Login Data Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 15 22:17:02 rivoplus volumio[3257]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 15 22:17:02 rivoplus volumio[3257]: info: Touch Event Listener Process Starting Oct 15 22:17:02 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Oct 15 22:17:02 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Oct 15 22:17:02 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding inputs REST Endpoints Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 15 22:17:02 rivoplus volumio[3257]: info: Scanning Audio Inputs Oct 15 22:17:02 rivoplus sudo[3774]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 15 22:17:02 rivoplus sudo[3774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus volumio[3257]: info: Checking against Known Cards name Oct 15 22:17:02 rivoplus volumio[3257]: info: Checking against Known Cards name Oct 15 22:17:02 rivoplus volumio[3257]: info: Checking against Known Cards name Oct 15 22:17:02 rivoplus volumio[3257]: info: Checking against Known Cards name Oct 15 22:17:02 rivoplus volumio[3257]: info: Checking against Known Cards name Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding Server instance for streaming Oct 15 22:17:02 rivoplus sudo[3784]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 15 22:17:02 rivoplus sudo[3784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus sudo[3784]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus sudo[3787]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 15 22:17:02 rivoplus sudo[3787]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus sudo[3787]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus sudo[3790]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 15 22:17:02 rivoplus sudo[3790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus sudo[3790]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:17:02.319+01:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 15 22:17:02 rivoplus sudo[3793]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 15 22:17:02 rivoplus sudo[3793]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus sudo[3793]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus volumio[3257]: info: Apply VIM3L Onboard LEDs Settings Oct 15 22:17:02 rivoplus volumio[3257]: info: Turning On Onboard LEDs Oct 15 22:17:02 rivoplus volumio[3257]: info: Starting CEC Event listener Oct 15 22:17:02 rivoplus sudo[3798]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 15 22:17:02 rivoplus sudo[3798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus sudo[3798]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus sudo[3759]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 22:17:02 rivoplus sudo[3759]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 15 22:17:02 rivoplus sudo[3803]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 15 22:17:02 rivoplus sudo[3759]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus volumio[3257]: info: FusionDsp - CamillaDSP binary found. Oct 15 22:17:02 rivoplus sudo[3802]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 15 22:17:02 rivoplus sudo[3802]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:02 rivoplus volumio[3257]: info: Loading i18n strings for locale en Oct 15 22:17:02 rivoplus sudo[3802]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 22:17:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:02 rivoplus volumio[3257]: info: FusionDsp - mixtype--------------------- None Oct 15 22:17:02 rivoplus volumio[3257]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 22:17:02 rivoplus volumio[3257]: info: [1792099022501] CoreMusicLibrary::Adding element Randomizer Oct 15 22:17:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:17:02 rivoplus volumio[3257]: Cannot find translation for source Randomizer Oct 15 22:17:02 rivoplus volumio[3257]: info: Volumio Calling Home Oct 15 22:17:02 rivoplus volumio[3257]: info: Stopping AccessToken refresher cron for QOBUZ Oct 15 22:17:02 rivoplus volumio[3257]: info: AccessToken refresher cron started for QOBUZ Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding TIDAL REST API Endpoints Oct 15 22:17:02 rivoplus volumio[3257]: info: Preparing to generate the ALSA configuration file Oct 15 22:17:02 rivoplus volumio[3257]: info: Adding QOBUZ REST API Endpoints Oct 15 22:17:03 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 15 22:17:03 rivoplus volumio[3257]: info: Discovery: adding 40aa7701-c698-41ae-b5dd-bb77ea10ad66 Oct 15 22:17:03 rivoplus volumio[3257]: info: Discovery: Found device Primo Oct 15 22:17:03 rivoplus volumio[3257]: info: Discovery: Connecting to remote: 192.168.1.234 Oct 15 22:17:03 rivoplus volumio[3257]: info: Serial port opened successfully Oct 15 22:17:03 rivoplus volumio[3257]: info: Sending serial start messages Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: Reporting MCU Network Status: 1 Oct 15 22:17:03 rivoplus volumio[3257]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 15 22:17:03 rivoplus volumio[3257]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 22:17:03 rivoplus volumio[3257]: info: Reading ALSA contributions from plugins. Oct 15 22:17:03 rivoplus volumio[3257]: error: Cannot start Volumio Streaming Daemon Oct 15 22:17:03 rivoplus volumio[3257]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 15 22:17:03 rivoplus volumio[3257]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 15 22:17:03 rivoplus volumio[3257]: info: MPD Permissions set Oct 15 22:17:03 rivoplus volumio[3257]: info: MPD Permissions set Oct 15 22:17:03 rivoplus volumio[3257]: info: Upmpdcli Daemon Started Oct 15 22:17:03 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 15 22:17:03 rivoplus volumio[3257]: info: Volumio called home Oct 15 22:17:03 rivoplus volumio-remote-updater[2935]: [2026-10-15 22:17:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1792099019 101 Oct 15 22:17:03 rivoplus volumio[3257]: 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: 7 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting Device Volume Override Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 15 22:17:03 rivoplus volumio[3257]: info: Updating Volume Controller Parameters: Device: 5 Name: No580x Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 15 22:17:03 rivoplus volumio[3257]: info: Disabling external Volume Control Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:03 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:03 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output update for this device Oct 15 22:17:03 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting Additional System Software info: Hardware Revision: 1.0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting HW Firmware info: undefined Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting HW Version info: 1.0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting HW Firmware info: 0.3.0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 15 22:17:03 rivoplus volumio[3257]: info: Setting HW Version info: 1.0 Oct 15 22:17:03 rivoplus volumio[3257]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 15 22:17:03 rivoplus volumio[3257]: info: MCU Signalled Headphone Mode Disabled Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 15 22:17:03 rivoplus volumio[3257]: info: MCU Signalled Sleep Mode Disabled Oct 15 22:17:03 rivoplus volumio[3257]: info: Enabling Advanced system settings configuration Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Oct 15 22:17:03 rivoplus volumio[3257]: info: Additional UI Settings Added for plugin music_service/inputs Oct 15 22:17:03 rivoplus volumio[3257]: info: MCU Signalled Auto Boot Mode On Power Disabled Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:03 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:03 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output update for this device Oct 15 22:17:03 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:03 rivoplus sudo[3829]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Oct 15 22:17:03 rivoplus sudo[3829]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:03 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) Oct 15 22:17:03 rivoplus sudo[3829]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:03 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 22:17:03 rivoplus volumio[3257]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Oct 15 22:17:03 rivoplus volumio[3257]: error: error Oct 15 22:17:03 rivoplus volumio[3257]: 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: 9 Oct 15 22:17:03 rivoplus volumio[3257]: info: MP1 GPIO: Signalled system ready via GPIO Oct 15 22:17:03 rivoplus sudo[3836]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Oct 15 22:17:03 rivoplus sudo[3836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:03 rivoplus sudo[3836]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:03 rivoplus volumio[3257]: 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: 9 Oct 15 22:17:03 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:17:03 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:03 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:17:03 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:17:03.868+01:00 level=INFO msg="system info for 16c6471147fae0d6293ec6660367c62d" deviceName=Rivoplus deviceVariant=rivoplus deviceModel="Volumio Rivo+" softwareVersion=4.208 Oct 15 22:17:03 rivoplus volumio[3257]: info: Starting Shairport Sync Oct 15 22:17:03 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:17:03.882+01:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 15 22:17:03 rivoplus volumio[3257]: info: Starting Shairport Sync Oct 15 22:17:03 rivoplus volumio[3257]: info: Starting Shairport Sync Oct 15 22:17:03 rivoplus sudo[3842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:17:03 rivoplus sudo[3842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:03 rivoplus sudo[3844]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:17:03 rivoplus sudo[3844]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:03 rivoplus sudo[3848]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:17:03 rivoplus sudo[3848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:03 rivoplus volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 15 22:17:03 rivoplus volumio[3257]: info: Adding Inputs via Serial API Oct 15 22:17:03 rivoplus volumio[3257]: info: Adding Advanced Audio Settings via Serial API Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 15 22:17:03 rivoplus volumio[3257]: info: Additional UI Settings Added for plugin music_service/inputs Oct 15 22:17:03 rivoplus volumio[3257]: info: MRS: Found cast device: SHIELD-Android-TV-4c08e6b9964b115ee14d9ee87995eedb Oct 15 22:17:03 rivoplus volumio[3257]: info: Adding audio output: Oct 15 22:17:03 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:17:03 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:03 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:03 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:17:04 rivoplus volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 15 22:17:04 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 15 22:17:04 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 15 22:17:04 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:04 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Pushing audio output on request Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:04 rivoplus sudo[3842]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:04 rivoplus sudo[3844]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:04 rivoplus sudo[3848]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:04 rivoplus volumio[3257]: info: Discovery: Connected to remote: 192.168.1.234 Oct 15 22:17:04 rivoplus volumio[3257]: info: Asound.conf file unchanged, so no further update is needed Oct 15 22:17:04 rivoplus volumio[3257]: info: Output device has changed, restarting MPD Oct 15 22:17:04 rivoplus volumio[3257]: info: Output device has changed, restarting Shairport Sync Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:04 rivoplus sudo[3855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 22:17:04 rivoplus sudo[3855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:04 rivoplus volumio[3257]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus sudo[3856]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 22:17:04 rivoplus sudo[3856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:04 rivoplus sudo[3855]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: Preparing to generate the ALSA configuration file Oct 15 22:17:04 rivoplus volumio-remote-updater[2935]: Test mode disabled Oct 15 22:17:04 rivoplus volumio-remote-updater[2935]: Alpha mode disabled Oct 15 22:17:04 rivoplus volumio-remote-updater[2935]: Alpha legacy test mode disabled Oct 15 22:17:04 rivoplus volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 15 22:17:04 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 15 22:17:04 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 15 22:17:04 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 15 22:17:04 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 15 22:17:04 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 15 22:17:04 rivoplus upmpdcli[3669]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Connection reset by peer Oct 15 22:17:04 rivoplus upmpdcli[3669]: :2:../src/main.cxx:732::MPD connection failed Oct 15 22:17:04 rivoplus volumio[3257]: info: Shairport-Sync Started Oct 15 22:17:04 rivoplus volumio[3257]: Error adding Membership: Error: addMembership EINVAL Oct 15 22:17:04 rivoplus volumio[3257]: info: Shairport-Sync Started Oct 15 22:17:04 rivoplus volumio[3257]: info: Shairport-Sync Started Oct 15 22:17:04 rivoplus volumio[3257]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 15 22:17:04 rivoplus volumio[3257]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 22:17:04 rivoplus volumio[3257]: info: Reading ALSA contributions from plugins. Oct 15 22:17:04 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 15 22:17:04 rivoplus volumio[3257]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 22:17:04 rivoplus volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Oct 15 22:17:04 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 15 22:17:04 rivoplus volumio[3257]: info: MPD Permissions set Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::servicePushState Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:04 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output update for this device Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:04 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:04 rivoplus volumio[3257]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received inputs Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:17:04 rivoplus volumio[3257]: Cannot find translation for source Randomizer Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreStateMachine::pushState Oct 15 22:17:04 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::volumioPushState Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output update for this device Oct 15 22:17:04 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:17:04 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:17:04 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:04 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 15 22:17:04 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 15 22:17:04 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:17:04.814+01:00 level=INFO msg="enabling local network discovery" Oct 15 22:17:04 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:17:04.815+01:00 level=INFO msg="enabling BLE discovery" Oct 15 22:17:04 rivoplus volumio[3257]: info: Starting Shairport Sync Oct 15 22:17:04 rivoplus sudo[3910]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:17:04 rivoplus sudo[3910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 15 22:17:05 rivoplus sudo[3881]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 22:17:05 rivoplus sudo[3881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 15 22:17:05 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 15 22:17:05 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:05 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:05 rivoplus sudo[3912]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 15 22:17:05 rivoplus sudo[3910]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus volumio[3257]: info: Asound.conf file written Oct 15 22:17:05 rivoplus sudo[3881]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus sudo[3915]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 15 22:17:05 rivoplus sudo[3915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus sudo[3915]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus kernel: Fine tdm clk setting range (0~2000000), 12287994 Oct 15 22:17:05 rivoplus kernel: Err: can not set rate to 4282967296! Oct 15 22:17:05 rivoplus kernel: Range[3920000 - 500000000] Oct 15 22:17:05 rivoplus kernel: out of value, fixed it Oct 15 22:17:05 rivoplus kernel: id=0 set inskew=0 Oct 15 22:17:05 rivoplus volumio[3257]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 15 22:17:05 rivoplus volumio[3257]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Oct 15 22:17:05 rivoplus volumio[3257]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Oct 15 22:17:05 rivoplus volumio[3257]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Oct 15 22:17:05 rivoplus volumio[3257]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Oct 15 22:17:05 rivoplus volumio[3257]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Clock Source 5 Validity:0' : Operation not permitted Oct 15 22:17:05 rivoplus volumio[3257]: info: Output device has changed, restarting MPD Oct 15 22:17:05 rivoplus volumio[3257]: info: Output device has changed, restarting Shairport Sync Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:05 rivoplus sudo[3935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 22:17:05 rivoplus sudo[3935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus sudo[3935]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus sudo[3937]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 22:17:05 rivoplus sudo[3937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus volumio[3257]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:17:05 rivoplus volumio[3257]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: Preparing to generate the ALSA configuration file Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:05 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:05 rivoplus volumio[3257]: info: Shairport-Sync Started Oct 15 22:17:05 rivoplus volumio[3257]: info: Turning Off Onboard LEDs Oct 15 22:17:05 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 15 22:17:05 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 15 22:17:05 rivoplus volumio[3257]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 15 22:17:05 rivoplus volumio[3257]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 22:17:05 rivoplus volumio[3257]: info: Reading ALSA contributions from plugins. Oct 15 22:17:05 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 15 22:17:05 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 15 22:17:05 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 15 22:17:05 rivoplus volumio[3257]: info: MPD Permissions set Oct 15 22:17:05 rivoplus volumio[3257]: info: MCU Signalled Playback Inactive Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:05 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:05 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 15 22:17:05 rivoplus sudo[3947]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 15 22:17:05 rivoplus sudo[3947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus sudo[3947]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 15 22:17:05 rivoplus sudo[3951]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 15 22:17:05 rivoplus sudo[3951]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 15 22:17:05 rivoplus sudo[3951]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Oct 15 22:17:05 rivoplus volumio[3257]: info: Onboard LEDs initialized Oct 15 22:17:05 rivoplus volumio[3257]: info: Starting Shairport Sync Oct 15 22:17:05 rivoplus volumio[3257]: info: Asound.conf file unchanged, so no further update is needed Oct 15 22:17:05 rivoplus volumio[3257]: info: Output device has changed, restarting MPD Oct 15 22:17:05 rivoplus volumio[3257]: info: Output device has changed, restarting Shairport Sync Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:05 rivoplus sudo[3961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:17:05 rivoplus sudo[3961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus sudo[3967]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 22:17:05 rivoplus sudo[3967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus sudo[3963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 22:17:05 rivoplus sudo[3963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus sudo[3963]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus volumio[3257]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 22:17:05 rivoplus volumio[3257]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 15 22:17:05 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 15 22:17:05 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: MPD Permissions set Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 15 22:17:05 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:05 rivoplus sudo[3961]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 15 22:17:05 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:05 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 15 22:17:05 rivoplus volumio[3257]: info: MRS: Adding multiroomSync output Oct 15 22:17:05 rivoplus volumio[3257]: info: Adding audio output: Oct 15 22:17:05 rivoplus volumio[3257]: info: MRS: Pushing multiroomSync output Oct 15 22:17:05 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 15 22:17:05 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 15 22:17:05 rivoplus volumio[3257]: info: Shairport-Sync Started Oct 15 22:17:05 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 15 22:17:05 rivoplus volumio[3257]: info: Starting Shairport Sync Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 15 22:17:05 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:17:05 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:17:05 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 15 22:17:05 rivoplus sudo[3997]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 22:17:05 rivoplus sudo[3997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:05 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:17:05.804+01:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 15 22:17:05 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 15 22:17:05 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 15 22:17:05 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:05 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 15 22:17:05 rivoplus sudo[3997]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:05 rivoplus volumio[3257]: info: Shairport-Sync Started Oct 15 22:17:06 rivoplus sudo[3995]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 22:17:06 rivoplus sudo[3995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 15 22:17:06 rivoplus sudo[4015]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 15 22:17:06 rivoplus sudo[3995]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:07 rivoplus volumio[3257]: info: MRS: Getting audio outputs on start Oct 15 22:17:07 rivoplus volumio[3257]: info: MRS: Requesting all other devices output Oct 15 22:17:09 rivoplus mpd[4016]: 2026-10-15T22:17:09 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 22:17:09 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240:3000 from 192.168.1.234 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 15 22:17:10 rivoplus upmpdcli[3669]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout Oct 15 22:17:10 rivoplus upmpdcli[3669]: :2:../src/main.cxx:732::MPD connection failed Oct 15 22:17:10 rivoplus systemd[1]: Started mpd.service - Music Player Daemon. Oct 15 22:17:10 rivoplus sudo[3701]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:10 rivoplus sudo[3856]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:10 rivoplus sudo[3734]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:10 rivoplus sudo[3937]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:10 rivoplus sudo[3967]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:10 rivoplus volumio[3257]: info: Completed starting Core Plugins Oct 15 22:17:10 rivoplus volumio[3257]: info: ------------------------------------------- Oct 15 22:17:10 rivoplus volumio[3257]: info: ----- MyVolumio plugins startup ---- Oct 15 22:17:10 rivoplus volumio[3257]: info: ------------------------------------------- Oct 15 22:17:10 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 15 22:17:10 rivoplus volumio[3257]: error: MPD error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: MPD error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: MPD error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: MPD error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: error: The expression evaluated to a falsy value: Oct 15 22:17:10 rivoplus volumio[3257]: assert.ok(self.idling) Oct 15 22:17:10 rivoplus volumio[3257]: info: MPD running with PID4016 Oct 15 22:17:10 rivoplus volumio[3257]: ,establishing connection Oct 15 22:17:10 rivoplus volumio[3257]: error: updateQueue error: null Oct 15 22:17:10 rivoplus volumio[3257]: error: updateQueue error: null Oct 15 22:17:11 rivoplus volumio[3257]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 15 22:17:11 rivoplus volumio[3257]: info: camilladsp service started and running in background, instance 1 Oct 15 22:17:11 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:11 rivoplus volumio[3257]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for No580x Oct 15 22:17:11 rivoplus volumio[3257]: cannot open device 'volumioHw': No such device Oct 15 22:17:11 rivoplus volumio[3257]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 22:17:11 rivoplus volumio[3257]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for No580x Oct 15 22:17:11 rivoplus volumio[3257]: cannot open device 'volumioHw': No such device Oct 15 22:17:11 rivoplus volumio[3257]: info: FusionDsp loaded Oct 15 22:17:11 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:17:11 rivoplus volumio[3257]: info: FusionDsp - --[object Object] Oct 15 22:17:11 rivoplus volumio[3257]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 22:17:11 rivoplus volumio[3257]: info: Adding Signal Path Element [object Object] Oct 15 22:17:11 rivoplus volumio[3257]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 22:17:11 rivoplus volumio[3257]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Oct 15 22:17:11 rivoplus volumio[3257]: error: FusionDsp - Reload WebSocket error: [object Object] Oct 15 22:17:11 rivoplus volumio[3257]: warn: FusionDsp - CamillaDSP reload failed; continuing without rejecting the Promise to avoid an unhandled rejection: connect ECONNREFUSED 127.0.0.1:9876 Oct 15 22:17:11 rivoplus sudo[4059]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 22:17:11 rivoplus sudo[4059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:11 rivoplus systemd[1]: Starting fusiondsp.service - FusionDsp Daemon... Oct 15 22:17:12 rivoplus volumio[3257]: info: Checking for updated MCU Firmware Oct 15 22:17:12 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:17:12 rivoplus volumio[3257]: info: Firware on device is on latest version, no need to update Oct 15 22:17:13 rivoplus systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 15 22:17:13 rivoplus systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 15 22:17:14 rivoplus kernel: fb: mem_free_work, free memory: addr:800000 Oct 15 22:17:16 rivoplus systemd[1]: Started fusiondsp.service - FusionDsp Daemon. Oct 15 22:17:16 rivoplus sudo[4059]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:18 rivoplus systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 15 22:17:18 rivoplus systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 15 22:17:19 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 15 22:17:20 rivoplus upmpdcli[3669]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout Oct 15 22:17:20 rivoplus upmpdcli[3669]: :2:../src/main.cxx:732::MPD connection failed Oct 15 22:17:23 rivoplus volumio[3257]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 15 22:17:23 rivoplus volumio[3257]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 15 22:17:23 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:23 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:23 rivoplus volumio[3257]: info: Starting MyVolumio Remote Streaming Endpoints Oct 15 22:17:23 rivoplus volumio[3257]: info: MyVolumio login type: Token Oct 15 22:17:23 rivoplus volumio[3257]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 15 22:17:23 rivoplus volumio[3257]: 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' Oct 15 22:17:26 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 16 Oct 15 22:17:28 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 17 Oct 15 22:17:30 rivoplus volumio[3257]: (node:3257) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit Oct 15 22:17:30 rivoplus volumio[3257]: (Use `node --trace-warnings ...` to show where the warning was created) Oct 15 22:17:31 rivoplus volumio[3257]: error: MyVolumio Plugin failed to start in a timely fashion Oct 15 22:17:31 rivoplus volumio[3257]: [Metrics] CommandRouter: 53s 550.75ms Oct 15 22:17:31 rivoplus volumio[3257]: info: CoreCommandRouter::volumiosetStartupVolume Oct 15 22:17:31 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:31 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:31 rivoplus volumio[3257]: info: CoreCommandRouter::Close All Modals sent Oct 15 22:17:31 rivoplus volumio[3257]: info: CoreCommandRouter::Close All Modals sent Oct 15 22:17:33 rivoplus volumio[3257]: info: camilladsp respawn in 100 ms (attempt 1/10) Oct 15 22:17:33 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 15 22:17:33 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 22:17:33 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 15 22:17:33 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:17:33 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:17:33 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 22:17:34 rivoplus volumio[3257]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 15 22:17:34 rivoplus volumio[3257]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 15 22:17:34 rivoplus volumio[3257]: info: camilladsp stopping service pid 4500... Oct 15 22:17:35 rivoplus volumio[3257]: info: camilladsp service terminated, instance 1 Oct 15 22:17:35 rivoplus volumio[3257]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 15 22:17:35 rivoplus volumio[3257]: info: camilladsp service started and running in background, instance 1 Oct 15 22:17:36 rivoplus volumio[3257]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 15 22:17:36 rivoplus volumio-remote-updater[2935]: Test mode disabled Oct 15 22:17:36 rivoplus volumio-remote-updater[2935]: Alpha mode disabled Oct 15 22:17:36 rivoplus volumio-remote-updater[2935]: Alpha legacy test mode disabled Oct 15 22:17:36 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 15 22:17:36 rivoplus volumio[3257]: info: camilladsp respawn in 100 ms (attempt 1/10) Oct 15 22:17:36 rivoplus upmpdcli[4512]: writing RSA key Oct 15 22:17:36 rivoplus upmpdcli[3669]: :2:../libupnpp/device/devdevice.cxx:639::UpnpDevice::notifyEvent: UpnpNotify :-100: UPNP_E_INVALID_HANDLE for urn:av-openhome-org:serviceId:Radio Oct 15 22:17:36 rivoplus upmpdcli[3669]: :2:../libupnpp/device/devdevice.cxx:639::UpnpDevice::notifyEvent: UpnpNotify :-100: UPNP_E_INVALID_HANDLE for urn:av-openhome-org:serviceId:Product Oct 15 22:17:37 rivoplus volumio[3257]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 22:17:37 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 22:17:39 rivoplus volumio[3257]: info: BOOT COMPLETED Oct 15 22:17:39 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 22:17:40 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 18 Oct 15 22:17:40 rivoplus volumio[3257]: info: camilladsp respawn in 200 ms (attempt 2/10) Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetBrowseSources Oct 15 22:17:43 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:17:45 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 19 Oct 15 22:17:45 rivoplus volumio[3257]: info: camilladsp respawn in 400 ms (attempt 3/10) Oct 15 22:17:47 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 20 Oct 15 22:17:49 rivoplus volumio[3257]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Oct 15 22:17:51 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 22 Oct 15 22:17:51 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 23 Oct 15 22:17:51 rivoplus volumio[3257]: info: camilladsp respawn in 800 ms (attempt 4/10) Oct 15 22:17:51 rivoplus volumio[3257]: info: MyVolumio token set successfully Oct 15 22:17:51 rivoplus volumio[3257]: info: MYVOLUMIO: Adding device Oct 15 22:17:51 rivoplus volumio[3257]: info: MYVOLUMIO: Evaluating Server Oct 15 22:17:56 rivoplus volumio[3257]: info: MyVolumio status changed Oct 15 22:17:56 rivoplus volumio[3257]: info: Streaming services startup Oct 15 22:17:56 rivoplus volumio[3257]: info: Starting Streaming Daemon Oct 15 22:17:56 rivoplus volumio[3257]: info: Removing browser output: myVolumio user plan is not superstar Oct 15 22:17:56 rivoplus volumio[3257]: info: Removing audio output: Oct 15 22:17:56 rivoplus volumio[3257]: info: Stoppping Tunnel 1 Oct 15 22:17:56 rivoplus sudo[4627]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 15 22:17:56 rivoplus sudo[4627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:56 rivoplus sudo[4629]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 15 22:17:56 rivoplus sudo[4629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:17:56 rivoplus systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 15 22:17:56 rivoplus systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 15 22:17:56 rivoplus sudo[4627]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:56 rivoplus systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 15 22:17:56 rivoplus systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 15 22:17:56 rivoplus systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 15 22:17:56 rivoplus systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 15 22:17:56 rivoplus sudo[4629]: pam_unix(sudo:session): session closed for user root Oct 15 22:17:58 rivoplus volumio[3257]: info: camilladsp respawn in 1600 ms (attempt 5/10) Oct 15 22:18:00 rivoplus volumio[3257]: info: Setting Geolocation for MyVolumio to eu3 Oct 15 22:18:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:00 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:00 rivoplus volumio[3257]: info: Remote SSH Stopped Oct 15 22:18:00 rivoplus volumio[3257]: error: Cannot start Volumio Streaming Daemon Oct 15 22:18:00 rivoplus volumio[3257]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 15 22:18:00 rivoplus volumio[3257]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 15 22:18:02 rivoplus volumio[3257]: info: Updating MyVolumio device info Oct 15 22:18:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:02 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:09 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 24 Oct 15 22:18:09 rivoplus volumio[3257]: info: camilladsp respawn in 3200 ms (attempt 6/10) Oct 15 22:18:09 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 25 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: error: error Oct 15 22:18:10 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 26 Oct 15 22:18:10 rivoplus volumio[3257]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 15 22:18:10 rivoplus volumio[3257]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 15 22:18:10 rivoplus volumio[3257]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 27 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 22:18:10 rivoplus volumio[3257]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 22:18:10 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:10 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: Listing playlists Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:18:10 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:10 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 15 22:18:10 rivoplus volumio[3257]: info: MyVolumio login type: Token Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 22:18:10 rivoplus volumio[3257]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 15 22:18:10 rivoplus volumio[3257]: info: Received Get System Version Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 22:18:10 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:10 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 22:18:10 rivoplus volumio[3257]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 22:18:10 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:10 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:10 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:10 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:10 rivoplus volumio[3257]: info: Listing playlists Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 22:18:11 rivoplus volumio[3257]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 22:18:12 rivoplus volumio5-onboarding[3742]: time=2026-10-15T22:18:12.487+01:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=0dlc0tTAuaT6TnM3RKeXFbHsWYt1 tokenExpiry=2026-10-15T23:18:12.487+01:00 Oct 15 22:18:12 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 15 22:18:13 rivoplus volumio[3257]: info: Executing endpoint metavolumio Oct 15 22:18:13 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 15 22:18:13 rivoplus volumio[3257]: info: Executing endpoint metavolumio Oct 15 22:18:13 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 15 22:18:13 rivoplus volumio[3257]: info: Executing endpoint metavolumio Oct 15 22:18:13 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 15 22:18:13 rivoplus volumio[3257]: info: camilladsp respawn in 6400 ms (attempt 7/10) Oct 15 22:18:14 rivoplus volumio[3257]: info: MYVOLUMIO: Adding device Oct 15 22:18:14 rivoplus volumio[3257]: info: MYVOLUMIO: Evaluating Server Oct 15 22:18:14 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:18:14 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:14 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:14 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:14 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:14 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:14 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:14 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:15 rivoplus volumio[3257]: info: Setting Geolocation for MyVolumio to eu3 Oct 15 22:18:15 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:15 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:15 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:15 rivoplus volumio[3257]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 15 22:18:16 rivoplus volumio[3257]: info: Updating MyVolumio device info Oct 15 22:18:16 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:16 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:16 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 22:18:16 rivoplus volumio[3257]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 15 22:18:17 rivoplus sudo[4731]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 22:18:17 rivoplus sudo[4731]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:18:17 rivoplus sudo[4733]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 22:18:17 rivoplus sudo[4733]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:18:17 rivoplus sudo[4731]: pam_unix(sudo:session): session closed for user root Oct 15 22:18:17 rivoplus sudo[4733]: pam_unix(sudo:session): session closed for user root Oct 15 22:18:17 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240 from 192.168.1.202 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/155.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Oct 15 22:18:17 rivoplus sudo[4739]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 22:18:17 rivoplus sudo[4739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:18:17 rivoplus sudo[4741]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 22:18:17 rivoplus sudo[4741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 22:18:17 rivoplus sudo[4739]: pam_unix(sudo:session): session closed for user root Oct 15 22:18:17 rivoplus sudo[4741]: pam_unix(sudo:session): session closed for user root Oct 15 22:18:17 rivoplus volumio[3257]: verbose: New Socket.io Connection to 192.168.1.240 from 192.168.1.202 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/155.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:18 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 22:18:18 rivoplus volumio[3257]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 22:18:18 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:18 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:18 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:18 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:18 rivoplus volumio[3257]: info: Listing playlists Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 15 22:18:18 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:18 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:19 rivoplus volumio[3257]: info: camilladsp respawn in 10000 ms (attempt 8/10) Oct 15 22:18:19 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 15 22:18:19 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:18:19 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:19 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:19 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:19 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:19 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:19 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:19 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:21 rivoplus volumio[3257]: info: Executing endpoint metavolumio Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 15 22:18:21 rivoplus volumio[3257]: info: Executing endpoint metavolumio Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 15 22:18:21 rivoplus volumio[3257]: info: Executing endpoint metavolumio Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 22:18:21 rivoplus volumio[3257]: info: Received Get System Info Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 22:18:21 rivoplus volumio[3257]: info: Discovery: Getting this device information Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetState Oct 15 22:18:21 rivoplus volumio[3257]: info: CorePlayQueue::getTrack 0 Oct 15 22:18:21 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 22:18:27 rivoplus volumio[3257]: info: CoreCommandRouter::volumioGetQueue Oct 15 22:18:27 rivoplus volumio[3257]: info: CoreStateMachine::getQueue Oct 15 22:18:27 rivoplus volumio[3257]: info: CorePlayQueue::getQueue Oct 15 22:18:27 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 15 22:18:29 rivoplus volumio[3257]: info: camilladsp respawn in 10000 ms (attempt 9/10) Oct 15 22:18:30 rivoplus volumio[3257]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 15 22:18:30 rivoplus volumio[3257]: info: CURURI: artists:// Oct 15 22:18:30 rivoplus volumio[3257]: info: Preload queue cleared Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/10%2C000%20Maniacs/cfa58c8e-96b6-49e1-b781-8a99561bd5e2.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/311/5dec409b-1767-4ff6-858c-a452edd10776.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/ABBA/7638a6c0-7bf1-4ecd-a104-e7cf7dc7d8a8.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/AC%2FDC/d6c54d5e-665f-45c4-9479-0888980f9224.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Accept/fc1c43cf-b5cd-4475-acbd-a9a79aeffa14.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/A%20Perfect%20Circle/5514c75c-9aca-4ee6-9135-3f822b49f3e6.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Albert%20King/68ccfbd4-97fa-4606-b778-4017eb800610.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alanis%20Morissette/d1a83e9b-42f2-4ea0-81ee-e48d0d7b87b3.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Al%20Di%20Meola/b1e30513-5cb0-4bab-9eec-1ea1984b058d.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/cf987df5-d77b-4c08-8003-f85328516e34.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aerosmith/7cd89fbd-1bc0-4373-b1f0-4446c9ec756d.jpg' Oct 15 22:18:31 rivoplus volumio[3257]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 22:18:31 rivoplus volumio[3257]: Error: unable to verify the first certificate Oct 15 22:18:31 rivoplus volumio[3257]: at TLSSocket.onConnectSecure (node:_tls_wrap:1627:34) Oct 15 22:18:31 rivoplus volumio[3257]: at TLSSocket.emit (node:events:514:28) Oct 15 22:18:31 rivoplus volumio[3257]: at TLSSocket._finishInit (node:_tls_wrap:1038:8) Oct 15 22:18:31 rivoplus volumio[3257]: at ssl.onhandshakedone (node:_tls_wrap:824:12) { Oct 15 22:18:31 rivoplus volumio[3257]: code: 'UNABLE_TO_VERIFY_LEAF_SIGNATURE' Oct 15 22:18:31 rivoplus volumio[3257]: } Oct 15 22:18:31 rivoplus volumio[3257]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 22:18:32 rivoplus sudo[4797]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 22:17' Oct 15 22:18:32 rivoplus sudo[4797]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:52:40 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="ba37532a86808e19439a6278b2d45f47"