Oct 16 16:36:00 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:00.688-04:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 16 16:36:01 rivoplus volumio[15929]: info: Loading plugin "smart_inputs"... Oct 16 16:36:01 rivoplus volumio[15929]: info: Loading plugin "tidal"... Oct 16 16:36:02 rivoplus volumio[15929]: info: Loading plugin "rivopluscontrol"... Oct 16 16:36:02 rivoplus volumio[15929]: info: Adding this device properties Oct 16 16:36:02 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 16 16:36:02 rivoplus volumio[15929]: info: Setting Additional Device Volumio Properties: [object Object] Oct 16 16:36:02 rivoplus volumio[15929]: info: Loading plugin "updater_comm"... Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.736-04:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=60.618123ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.758-04:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.770-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=11.742399ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.787-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=28.299133ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.789-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=29.980398ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.818-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://myvolumio.firebaseio.com duration=59.544044ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.819-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://securetoken.googleapis.com duration=60.621762ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.820-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://functions.volumio.cloud duration=61.773647ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.829-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://functions.volumio.cloud duration=69.644969ms Oct 16 16:36:02 rivoplus volumio[15929]: info: Loading plugin "cec_controller"... Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.835-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://database.volumio.cloud duration=75.454022ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.867-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=http://plugins.volumio.org duration=107.837401ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.872-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=http://pushupdates.volumio.org duration=112.816571ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.885-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://www.googleapis.com duration=126.183194ms Oct 16 16:36:02 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:02.928-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=https://google.com duration=169.300045ms Oct 16 16:36:03 rivoplus volumio[15929]: info: Applying required configuration parameters for plugin cec_controller Oct 16 16:36:03 rivoplus volumio[15929]: info: Plugin mpdemulation is not enabled Oct 16 16:36:03 rivoplus volumio[15929]: info: Loading plugin "rest_api"... Oct 16 16:36:03 rivoplus volumio[15929]: info: Loading plugin "websocket"... Oct 16 16:36:03 rivoplus volumio[15929]: info: Starting Socket.io Server version 1.7.4 Oct 16 16:36:03 rivoplus volumio[15929]: info: Loading plugin "fusiondsp"... Oct 16 16:36:03 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:03.232-04:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-531.433µs timeout=10s endpoint=http://cddb.volumio.org duration=473.121277ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 16 16:36:03 rivoplus volumio[15929]: info: Applying required configuration parameters for plugin fusiondsp Oct 16 16:36:03 rivoplus volumio[15929]: info: Loading plugin "dmd2_music"... Oct 16 16:36:05 rivoplus volumio[15929]: info: Loading plugin "myb"... Oct 16 16:36:05 rivoplus volumio[15929]: info: Applying required configuration parameters for plugin myb Oct 16 16:36:05 rivoplus volumio[15929]: info: Loading plugin "podcast"... Oct 16 16:36:05 rivoplus volumio[15929]: info: ControllerPodcast::constructor Oct 16 16:36:05 rivoplus volumio[15929]: info: Loading plugin "radio_paradise"... Oct 16 16:36:05 rivoplus volumio[15929]: info: Applying required configuration parameters for plugin radio_paradise Oct 16 16:36:05 rivoplus volumio[15929]: info: [1792182965907] [RadioParadise] API delay: 5 Oct 16 16:36:05 rivoplus volumio[15929]: info: Loading i18n strings for locale en Oct 16 16:36:05 rivoplus volumio[15929]: Updating browse sources language Oct 16 16:36:05 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::initPlayerControls Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: Express server listening on port 3000 Oct 16 16:36:06 rivoplus volumio[15929]: [Metrics] WebUI: 21s 71.18ms Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::resetVolumioState Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::getcurrentVolume Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:06 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 16:36:06 rivoplus volumio[15929]: info: Completed loading Core Plugins Oct 16 16:36:06 rivoplus volumio[15929]: info: Preparing to generate the ALSA configuration file Oct 16 16:36:06 rivoplus volumio[15929]: info: Volumio Network Manager: Network status updated: 1 Oct 16 16:36:06 rivoplus volumio[15929]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 16:36:06 rivoplus volumio[15929]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 16 16:36:06 rivoplus volumio[15929]: info: Reading ALSA contributions from plugins. Oct 16 16:36:06 rivoplus volumio[15929]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.179 UA: Mozilla/5.0 (iPad; CPU OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: websocket Total Clients: 1 Oct 16 16:36:06 rivoplus volumio[15929]: info: Reloading queue from file Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::setRepeat false single undefined Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:06 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::setRandom false Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:06 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:06 rivoplus volumio[15929]: info: Asound.conf file unchanged, so no further update is needed Oct 16 16:36:06 rivoplus volumio[15929]: info: Output device has changed, restarting MPD Oct 16 16:36:06 rivoplus volumio[15929]: info: ___________ START PLUGINS ___________ Oct 16 16:36:06 rivoplus sudo[16079]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 16:36:06 rivoplus sudo[16079]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:06 rivoplus sudo[16081]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 16:36:06 rivoplus sudo[16081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:06 rivoplus volumio[15929]: info: ControllerMpd::onStart: Initializing MPD Oct 16 16:36:06 rivoplus volumio[15929]: info: Creating MPD Configuration file Oct 16 16:36:06 rivoplus sudo[16079]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:06 rivoplus sudo[16085]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 16 16:36:06 rivoplus sudo[16085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:06 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: [FUNC] onStart Oct 16 16:36:06 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Oct 16 16:36:06 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Oct 16 16:36:06 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Oct 16 16:36:06 rivoplus sudo[16089]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 16:36:06 rivoplus sudo[16091]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 16:36:06 rivoplus sudo[16091]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:06 rivoplus sudo[16089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:06 rivoplus sudo[16089]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:06 rivoplus volumio[15929]: info: [1792182966794] CoreMusicLibrary::Adding element Last_100 Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:06 rivoplus volumio[15929]: info: Starting RAAT Plugin Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 16:36:06 rivoplus volumio[15929]: info: Additional UI Settings Added for plugin music_service/raat Oct 16 16:36:06 rivoplus volumio[15929]: info: Registering DSP Elements listener and retrieving current ones Oct 16 16:36:06 rivoplus systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 16 16:36:06 rivoplus volumio[15929]: info: Additional DSP elements updated Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:06 rivoplus volumio[15929]: info: Updating RAAT Signal Path Oct 16 16:36:06 rivoplus volumio[15929]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 16:36:06 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:06.815-04:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:46600->127.0.0.1:3000: i/o timeout" Oct 16 16:36:06 rivoplus volumio[15929]: info: Streaming services startup Oct 16 16:36:06 rivoplus volumio[15929]: info: Starting Streaming Daemon Oct 16 16:36:06 rivoplus sudo[16085]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:06 rivoplus sudo[16097]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 16:36:06 rivoplus sudo[16097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:06 rivoplus volumio[15929]: info: [1792182966867] CoreMusicLibrary::Adding element Webradio Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:06 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 16 16:36:06 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:06 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 16 16:36:06 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 16:36:06 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 16:36:06 rivoplus volumio[15929]: info: Initializing BBC Radios Oct 16 16:36:06 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 16:36:06 rivoplus bluetoothd[3431]: Path / reserved for Adv Monitor app :1.321 Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:06 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:06 rivoplus volumio[15929]: info: [1792182966972] CoreMusicLibrary::Adding element Bandcamp Discover Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:06 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:06 rivoplus volumio[15929]: info: Adding Calm Radio to Browse Sources Oct 16 16:36:06 rivoplus bluetoothd[3431]: Adv Monitor app :1.321 disconnected from D-Bus Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:06 rivoplus volumio[15929]: info: [1792182966986] CoreMusicLibrary::Adding element Calm Radio Oct 16 16:36:06 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:06 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:06 rivoplus volumio[15929]: Cannot find translation for source Calm Radio Oct 16 16:36:06 rivoplus sudo[16097]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:07 rivoplus volumio[15929]: info: [1792182967002] CoreMusicLibrary::Adding element Mixcloud Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Calm Radio Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Mixcloud Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:07 rivoplus volumio[15929]: info: [1792182967013] CoreMusicLibrary::Adding element SoundCloud Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Calm Radio Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Mixcloud Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source SoundCloud Oct 16 16:36:07 rivoplus volumio[15929]: error: Hi Res Audio Failed Login: Missing Login Data Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 16 16:36:07 rivoplus volumio[15929]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 16 16:36:07 rivoplus volumio[15929]: info: Touch Event Listener Process Starting Oct 16 16:36:07 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding inputs REST Endpoints Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 16 16:36:07 rivoplus volumio[15929]: info: Scanning Audio Inputs Oct 16 16:36:07 rivoplus sudo[16119]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 16 16:36:07 rivoplus sudo[16119]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus volumio[15929]: info: Checking against Known Cards name Oct 16 16:36:07 rivoplus volumio[15929]: info: Checking against Known Cards name Oct 16 16:36:07 rivoplus volumio[15929]: info: Checking against Known Cards name Oct 16 16:36:07 rivoplus volumio[15929]: info: Checking against Known Cards name Oct 16 16:36:07 rivoplus volumio[15929]: info: Checking against Known Cards name Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding Server instance for streaming Oct 16 16:36:07 rivoplus sudo[16126]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 16 16:36:07 rivoplus sudo[16126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus sudo[16126]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus sudo[16129]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 16 16:36:07 rivoplus sudo[16129]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus sudo[16129]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus sudo[16133]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 16 16:36:07 rivoplus sudo[16133]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus sudo[16133]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus sudo[16136]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 16 16:36:07 rivoplus sudo[16136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus sudo[16136]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus volumio[15929]: info: Apply VIM3L Onboard LEDs Settings Oct 16 16:36:07 rivoplus volumio[15929]: info: Turning On Onboard LEDs Oct 16 16:36:07 rivoplus volumio[15929]: info: Starting CEC Event listener Oct 16 16:36:07 rivoplus sudo[16140]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 16:36:07 rivoplus sudo[16140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus sudo[16140]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus volumio[15929]: info: FusionDsp - CamillaDSP binary found. Oct 16 16:36:07 rivoplus volumio[15929]: info: Loading i18n strings for locale en Oct 16 16:36:07 rivoplus sudo[16145]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 16:36:07 rivoplus sudo[16145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:07 rivoplus sudo[16145]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:07 rivoplus volumio[15929]: info: FusionDsp - mixtype--------------------- None Oct 16 16:36:07 rivoplus sudo[16116]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 16:36:07 rivoplus sudo[16116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 16:36:07 rivoplus volumio[15929]: info: Stopping AccessToken refresher cron for DMD2 Music Oct 16 16:36:07 rivoplus sudo[16116]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:07 rivoplus volumio[15929]: info: AccessToken refresher cron started for DMD2 Music Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:07 rivoplus volumio[15929]: info: [1792182967511] CoreMusicLibrary::Adding element Podcast Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Calm Radio Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Mixcloud Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source SoundCloud Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Podcast Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:36:07 rivoplus volumio[15929]: info: [1792182967521] CoreMusicLibrary::Adding element Radio Paradise Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Calm Radio Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Mixcloud Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source SoundCloud Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Podcast Oct 16 16:36:07 rivoplus volumio[15929]: Cannot find translation for source Radio Paradise Oct 16 16:36:07 rivoplus volumio[15929]: info: Volumio Calling Home Oct 16 16:36:07 rivoplus volumio[15929]: (node:15929) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Oct 16 16:36:07 rivoplus volumio[15929]: (Use `node --trace-deprecation ...` to show where the warning was created) Oct 16 16:36:07 rivoplus volumio[15929]: info: Stopping AccessToken refresher cron for QOBUZ Oct 16 16:36:07 rivoplus volumio[15929]: info: AccessToken refresher cron started for QOBUZ Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding TIDAL REST API Endpoints Oct 16 16:36:07 rivoplus volumio[15929]: info: Preparing to generate the ALSA configuration file Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: appearance , registerThirdPartyUI Oct 16 16:36:07 rivoplus volumio[15929]: info: Registering Third Party UI: {"uiName":"nova","uiPath":"/data/nova/current","uiPrettyName":"Nova"} Oct 16 16:36:07 rivoplus volumio[15929]: info: UI already registered: {"uiName":"nova","uiPath":"/data/nova/current","uiPrettyName":"Nova"} Oct 16 16:36:07 rivoplus volumio[15929]: info: Nova UI: serving version 0.261012.0 Oct 16 16:36:07 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentUpdaterChannel Oct 16 16:36:07 rivoplus volumio[15929]: info: Adding QOBUZ REST API Endpoints Oct 16 16:36:07 rivoplus volumio[15929]: info: Nova UI: checking for updates on the stable channel: https://static.vlmapi.io/volumio/assets/v4/themes/nova/manifest.json Oct 16 16:36:07 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:07] [connect] Successful connection Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: adding 34818ac3-59d5-4df6-9b99-92d8916d10d2 Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: Found device Rivoplus Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: this is already registered, 34818ac3-59d5-4df6-9b99-92d8916d10d2 Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: Found device Rivoplus Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: Serial port opened successfully Oct 16 16:36:08 rivoplus volumio[15929]: info: Sending serial start messages Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: Reporting MCU Network Status: 1 Oct 16 16:36:08 rivoplus volumio[15929]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 16 16:36:08 rivoplus volumio[15929]: info: Reading ALSA contributions from plugins. Oct 16 16:36:08 rivoplus volumio[15929]: error: Cannot start Volumio Streaming Daemon Oct 16 16:36:08 rivoplus volumio[15929]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 16 16:36:08 rivoplus volumio[15929]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 16 16:36:08 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Oct 16 16:36:08 rivoplus volumio[15929]: info: MPD Permissions set Oct 16 16:36:08 rivoplus volumio[15929]: info: MPD Permissions set Oct 16 16:36:08 rivoplus sudo[16159]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Oct 16 16:36:08 rivoplus sudo[16159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:08 rivoplus volumio[15929]: info: Nova UI: update check: up to date Oct 16 16:36:08 rivoplus volumio[15929]: info: Volumio called home Oct 16 16:36:08 rivoplus sudo[16159]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting Device Volume Override Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 16 16:36:08 rivoplus volumio[15929]: info: Updating Volume Controller Parameters: Device: 5 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 16 16:36:08 rivoplus volumio[15929]: info: Disabling external Volume Control Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting Additional System Software info: Hardware Revision: 1.0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting HW Firmware info: undefined Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting HW Version info: 1.0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting HW Firmware info: 0.3.0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 16:36:08 rivoplus volumio[15929]: info: Setting HW Version info: 1.0 Oct 16 16:36:08 rivoplus volumio[15929]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 16 16:36:08 rivoplus volumio[15929]: info: MCU Signalled Headphone Mode Disabled Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 16 16:36:08 rivoplus volumio[15929]: info: Reporting Headphone State: false Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus volumio[15929]: info: Updating RAAT Signal Path Oct 16 16:36:08 rivoplus volumio[15929]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 16:36:08 rivoplus volumio[15929]: info: MCU Signalled Sleep Mode Disabled Oct 16 16:36:08 rivoplus volumio[15929]: info: Enabling Advanced system settings configuration Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Oct 16 16:36:08 rivoplus volumio[15929]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 16:36:08 rivoplus volumio[15929]: info: MCU Signalled Auto Boot Mode On Power Active Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:08 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Oct 16 16:36:08 rivoplus volumio[15929]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Oct 16 16:36:08 rivoplus sudo[16195]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Oct 16 16:36:08 rivoplus sudo[16195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:08 rivoplus sudo[16195]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:08 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) Oct 16 16:36:08 rivoplus volumio[15929]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:08 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:08 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1792182967 101 Oct 16 16:36:08 rivoplus volumio[15929]: 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: 1 Oct 16 16:36:08 rivoplus volumio[15929]: info: MP1 GPIO: Signalled system ready via GPIO Oct 16 16:36:08 rivoplus sudo[16198]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Oct 16 16:36:08 rivoplus sudo[16198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:08 rivoplus volumio[15929]: 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: 2 Oct 16 16:36:08 rivoplus sudo[16198]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:08 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 16 16:36:08 rivoplus volumio[15929]: info: Adding Inputs via Serial API Oct 16 16:36:08 rivoplus volumio[15929]: info: Adding Advanced Audio Settings via Serial API Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 16:36:08 rivoplus volumio[15929]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 16:36:08 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 16 16:36:08 rivoplus volumio[15929]: info: Asound.conf file unchanged, so no further update is needed Oct 16 16:36:08 rivoplus volumio[15929]: info: Output device has changed, restarting MPD Oct 16 16:36:08 rivoplus volumio[15929]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:08 rivoplus sudo[16201]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 16:36:08 rivoplus sudo[16201]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:08 rivoplus sudo[16201]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:08 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 16 16:36:08 rivoplus sudo[16203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 16:36:08 rivoplus sudo[16203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::servicePushState Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:08 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:08 rivoplus volumio[15929]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received inputs Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 16 16:36:08 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:08 rivoplus volumio[15929]: Cannot find translation for source Bandcamp Discover Oct 16 16:36:08 rivoplus volumio[15929]: Cannot find translation for source Calm Radio Oct 16 16:36:08 rivoplus volumio[15929]: Cannot find translation for source Mixcloud Oct 16 16:36:08 rivoplus volumio[15929]: Cannot find translation for source SoundCloud Oct 16 16:36:08 rivoplus volumio[15929]: Cannot find translation for source Podcast Oct 16 16:36:08 rivoplus volumio[15929]: Cannot find translation for source Radio Paradise Oct 16 16:36:09 rivoplus volumio[15929]: verbose: New Socket.io Connection to 192.168.1.115:3000 from 192.168.1.179 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 16 16:36:09 rivoplus volumio[15929]: info: MPD Permissions set Oct 16 16:36:09 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 16 16:36:09 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 16:36:09 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 16 16:36:09 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 16:36:09 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 16:36:09 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 16:36:09 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreStateMachine::pushState Oct 16 16:36:09 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:09 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:09 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:09 rivoplus volumio[15929]: 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: 5 Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:36:09 rivoplus volumio[15929]: info: Not Reporting Auto name since its the default one Oct 16 16:36:09 rivoplus volumio[15929]: verbose: New Socket.io Connection to 192.168.1.115:3000 from 192.168.1.179 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 16 16:36:09 rivoplus volumio[15929]: info: MCU Signalled Playback Inactive Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:09 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 16 16:36:09 rivoplus sudo[16211]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 16:36:09 rivoplus sudo[16211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 16:36:09 rivoplus sudo[16211]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:09 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:36:09 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:36:09 rivoplus sudo[16224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 16 16:36:09 rivoplus sudo[16224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:09 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:09 rivoplus sudo[16224]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:09 rivoplus sudo[16227]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 16 16:36:09 rivoplus sudo[16227]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:09 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 16 16:36:09 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 16 16:36:09 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 16 16:36:09 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 16 16:36:09 rivoplus sudo[16227]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:09 rivoplus volumio[15929]: info: Raat Daemon started successfully Oct 16 16:36:09 rivoplus volumio[15929]: info: Executing endpoint restartRAATSocket Oct 16 16:36:09 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 16 16:36:09 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:09 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 16 16:36:10 rivoplus volumio[15929]: info: Turning Off Onboard LEDs Oct 16 16:36:10 rivoplus sudo[16245]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 16:36:10 rivoplus sudo[16245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:10 rivoplus sudo[16245]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:10 rivoplus sudo[16248]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 16:36:10 rivoplus sudo[16248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:10 rivoplus sudo[16248]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:10 rivoplus volumio[15929]: info: Onboard LEDs initialized Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::servicePushState Oct 16 16:36:10 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:10 rivoplus volumio[15929]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received raat Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::servicePushState Oct 16 16:36:10 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:10 rivoplus volumio[15929]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received raat Oct 16 16:36:10 rivoplus volumio[15929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: websocket Total Clients: 7 Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:10 rivoplus volumio[15929]: info: Received Get System Version Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:10 rivoplus volumio[15929]: info: Received Get System Info Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:10 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:10 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:10 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 16 16:36:11 rivoplus sudo[16251]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 16 16:36:11 rivoplus sudo[16251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:11 rivoplus sudo[16256]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:36:11 rivoplus sudo[16256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:11 rivoplus volumio[15929]: info: CALLMETHOD: miscellanea novaui getTheme [object Object] Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: novaui , getTheme Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 16 16:36:11 rivoplus sudo[16256]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 16:36:11 rivoplus sudo[16251]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:11 rivoplus sudo[16264]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:36:11 rivoplus sudo[16264]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:11 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:11 rivoplus sudo[16267]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:36:11 rivoplus sudo[16267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:11 rivoplus sudo[16276]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:36:11 rivoplus sudo[16276]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:11 rivoplus sudo[16274]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:36:11 rivoplus sudo[16274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreStateMachine::getQueue Oct 16 16:36:11 rivoplus volumio[15929]: info: CorePlayQueue::getQueue Oct 16 16:36:11 rivoplus sudo[16276]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:11 rivoplus sudo[16264]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:11 rivoplus sudo[16267]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:11 rivoplus sudo[16274]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:11 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 16 16:36:12 rivoplus systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 16 16:36:12 rivoplus volumio[15929]: info: RAAT: Requesting Headphone Status Oct 16 16:36:12 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 16 16:36:12 rivoplus volumio[15929]: info: MCU Signalled Headphone Mode Disabled Oct 16 16:36:12 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 16 16:36:12 rivoplus volumio[15929]: info: Reporting Headphone State: false Oct 16 16:36:12 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:12 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:12 rivoplus volumio[15929]: info: Updating RAAT Signal Path Oct 16 16:36:13 rivoplus mpd[16225]: 2026-10-16T16:36:13 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 16 16:36:13 rivoplus systemd[1]: Started mpd.service - Music Player Daemon. Oct 16 16:36:13 rivoplus sudo[16091]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:13 rivoplus sudo[16081]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:13 rivoplus sudo[16203]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:13 rivoplus systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 952. Oct 16 16:36:13 rivoplus systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:13 rivoplus volumio[15929]: info: Completed starting Core Plugins Oct 16 16:36:13 rivoplus systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:13 rivoplus volumio[15929]: info: ------------------------------------------- Oct 16 16:36:13 rivoplus volumio[15929]: info: ----- MyVolumio plugins startup ---- Oct 16 16:36:13 rivoplus volumio[15929]: info: ------------------------------------------- Oct 16 16:36:13 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 16 16:36:13 rivoplus upmpdcli[16304]: Could not open config: /tmp/upmpdcli.conf Oct 16 16:36:13 rivoplus systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:36:13 rivoplus systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 16 16:36:13 rivoplus volumio[15929]: error: MPD error: The expression evaluated to a falsy value: Oct 16 16:36:13 rivoplus volumio[15929]: assert.ok(self.idling) Oct 16 16:36:13 rivoplus volumio[15929]: error: The expression evaluated to a falsy value: Oct 16 16:36:13 rivoplus volumio[15929]: assert.ok(self.idling) Oct 16 16:36:13 rivoplus volumio[15929]: error: MPD error: The expression evaluated to a falsy value: Oct 16 16:36:13 rivoplus volumio[15929]: assert.ok(self.idling) Oct 16 16:36:13 rivoplus volumio[15929]: error: The expression evaluated to a falsy value: Oct 16 16:36:13 rivoplus volumio[15929]: assert.ok(self.idling) Oct 16 16:36:13 rivoplus volumio[15929]: info: MPD running with PID16225 Oct 16 16:36:13 rivoplus volumio[15929]: ,establishing connection Oct 16 16:36:13 rivoplus volumio[15929]: error: updateQueue error: null Oct 16 16:36:13 rivoplus volumio[15929]: error: updateQueue error: null Oct 16 16:36:15 rivoplus systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 16 16:36:15 rivoplus systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 16 16:36:16 rivoplus volumio[15929]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 16 16:36:16 rivoplus volumio[15929]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Oct 16 16:36:16 rivoplus volumio[15929]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 16 16:36:16 rivoplus volumio[15929]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 16 16:36:16 rivoplus volumio[15929]: info: camilladsp service started and running in background, instance 1 Oct 16 16:36:16 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:16 rivoplus volumio[15929]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Oct 16 16:36:16 rivoplus volumio[15929]: info: FusionDsp loaded Oct 16 16:36:16 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:16 rivoplus volumio[15929]: info: FusionDsp - --[object Object] Oct 16 16:36:16 rivoplus volumio[15929]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 16 16:36:16 rivoplus volumio[15929]: info: Adding Signal Path Element [object Object] Oct 16 16:36:16 rivoplus volumio[15929]: info: Adding fusiondspeq DSP Signal Path Element Oct 16 16:36:16 rivoplus volumio[15929]: info: Additional DSP elements updated Oct 16 16:36:16 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:16 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:16 rivoplus volumio[15929]: info: Updating RAAT Signal Path Oct 16 16:36:16 rivoplus volumio[15929]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Oct 16 16:36:16 rivoplus volumio[15929]: error: FusionDsp - Reload WebSocket error: [object Object] Oct 16 16:36:16 rivoplus volumio[15929]: warn: FusionDsp - CamillaDSP reload failed; continuing without rejecting the Promise to avoid an unhandled rejection: connect ECONNREFUSED 127.0.0.1:9876 Oct 16 16:36:16 rivoplus sudo[16328]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 16 16:36:16 rivoplus sudo[16328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:16 rivoplus sudo[16328]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:17 rivoplus volumio[15929]: info: Checking for updated MCU Firmware Oct 16 16:36:17 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:17 rivoplus volumio[15929]: info: Firware on device is on latest version, no need to update Oct 16 16:36:18 rivoplus volumio[15929]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 16 16:36:20 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:20 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.474-04:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-1.559512ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.491-04:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 16 16:36:21 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.506-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=14.990179ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.517-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=24.308472ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.522-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=28.82593ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.548-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://securetoken.googleapis.com duration=56.075554ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.558-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://myvolumio.firebaseio.com duration=65.486223ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.567-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://functions.volumio.cloud duration=74.011509ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.567-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://functions.volumio.cloud duration=72.943332ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.583-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://database.volumio.cloud duration=88.722059ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.598-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=http://plugins.volumio.org duration=103.494194ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.608-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=http://pushupdates.volumio.org duration=113.835998ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.612-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://www.googleapis.com duration=119.98197ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.667-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=https://google.com duration=174.981472ms Oct 16 16:36:21 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:21.891-04:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" latency=-774.748µs timeout=10s endpoint=http://cddb.volumio.org duration=398.027174ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 16 16:36:22 rivoplus volumio[15929]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 16 16:36:22 rivoplus volumio[15929]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 16 16:36:22 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:22 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:22 rivoplus volumio[15929]: info: Starting MyVolumio Remote Streaming Endpoints Oct 16 16:36:22 rivoplus volumio[15929]: info: MyVolumio login type: Token Oct 16 16:36:23 rivoplus volumio[15929]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 16 16:36:23 rivoplus volumio[15929]: 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 16 16:36:23 rivoplus volumio[15929]: error: MyVolumio Custom Token format not valid, refreshing it Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:23 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:23 rivoplus volumio[15929]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.179 UA: Mozilla/5.0 (iPad; CPU OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: websocket Total Clients: 8 Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreStateMachine::getQueue Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getQueue Oct 16 16:36:23 rivoplus volumio[15929]: info: Received Get System Version Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:23 rivoplus volumio[15929]: info: Received Get System Info Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:23 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 16:36:23 rivoplus volumio[15929]: info: CALLMETHOD: miscellanea novaui getTheme [object Object] Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: novaui , getTheme Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 16 16:36:23 rivoplus sudo[16348]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 16 16:36:23 rivoplus sudo[16348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:23 rivoplus sudo[16353]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:36:23 rivoplus sudo[16353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:23 rivoplus sudo[16359]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:36:23 rivoplus sudo[16359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 16:36:23 rivoplus sudo[16348]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 16:36:23 rivoplus volumio[15929]: info: Received Get System Version Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:23 rivoplus volumio[15929]: info: Received Get System Info Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:36:23 rivoplus volumio[15929]: info: Discovery: Getting this device information Oct 16 16:36:23 rivoplus sudo[16359]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetState Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:23 rivoplus sudo[16353]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreStateMachine::getQueue Oct 16 16:36:23 rivoplus volumio[15929]: info: CorePlayQueue::getQueue Oct 16 16:36:23 rivoplus sudo[16364]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:36:23 rivoplus sudo[16364]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:23 rivoplus sudo[16373]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:36:23 rivoplus sudo[16373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:23 rivoplus sudo[16374]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:36:23 rivoplus sudo[16374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 16 16:36:23 rivoplus sudo[16364]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:23 rivoplus sudo[16374]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:23 rivoplus sudo[16373]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 16:36:23 rivoplus volumio[15929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 16:36:23 rivoplus volumio[15929]: info: Preload queue cleared Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: https://stream.radioparadise.com/rock-flacm Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: bandcamp/track@startIndex=0@trackUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Ftrack%2Fsong-for-a-lonely-woman@albumUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Falbum%2Fvol-1-childs-dance@artistUrl=https%3A%2F%2Fartblakey.bandcamp.com@explode:o=%7B%22title%22%3A%22Song%20For%20A%20Lonely%20Woman%22%2C%22artist%22%3A%22Art%20Blakey%20%26%20The%20Jazz%20Messengers%22%2C%22album%22%3A%22Vol.%201%3A%20Child's%20Dance%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2Fa1649826565_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Ftrack%40trackUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Ftrack%252Fsong-for-a-lonely-woman%40albumUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Falbum%252Fvol-1-childs-dance%40artistUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%22%7D Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: https://stream.radioparadise.com/flacm Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm Oct 16 16:36:23 rivoplus volumio[15929]: info: Preload queue cleared Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: https://stream.radioparadise.com/rock-flacm Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: bandcamp/track@startIndex=0@trackUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Ftrack%2Fsong-for-a-lonely-woman@albumUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Falbum%2Fvol-1-childs-dance@artistUrl=https%3A%2F%2Fartblakey.bandcamp.com@explode:o=%7B%22title%22%3A%22Song%20For%20A%20Lonely%20Woman%22%2C%22artist%22%3A%22Art%20Blakey%20%26%20The%20Jazz%20Messengers%22%2C%22album%22%3A%22Vol.%201%3A%20Child's%20Dance%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2Fa1649826565_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Ftrack%40trackUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Ftrack%252Fsong-for-a-lonely-woman%40albumUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Falbum%252Fvol-1-childs-dance%40artistUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%22%7D Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: https://stream.radioparadise.com/flacm Oct 16 16:36:23 rivoplus volumio[15929]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm Oct 16 16:36:23 rivoplus volumio[15929]: info: Exploding uri https://stream.radioparadise.com/rock-flacm in service radio_paradise Oct 16 16:36:23 rivoplus volumio[15929]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/rock-flacm" Oct 16 16:36:23 rivoplus volumio[15929]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:36:23 rivoplus volumio[15929]: TypeError: Cannot read properties of undefined (reading 'then') Oct 16 16:36:23 rivoplus volumio[15929]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31) Oct 16 16:36:23 rivoplus volumio[15929]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 16 16:36:23 rivoplus volumio[15929]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Oct 16 16:36:23 rivoplus volumio[15929]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Oct 16 16:36:23 rivoplus volumio[15929]: at listOnTimeout (node:internal/timers:573:17) Oct 16 16:36:23 rivoplus volumio[15929]: at process.processTimers (node:internal/timers:514:7) Oct 16 16:36:23 rivoplus volumio[15929]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:36:24 rivoplus sudo[16391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 16:35' Oct 16 16:36:24 rivoplus sudo[16391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:24 rivoplus sudo[16391]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:24 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:24] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 16 16:36:24 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:24] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 16 16:36:24 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:24.962-04:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 16 16:36:24 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:24.965-04:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 16:36:24 rivoplus systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:36:24 rivoplus sudo[16119]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:25 rivoplus systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 16 16:36:25 rivoplus systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 16:36:25 rivoplus systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 16:36:25 rivoplus systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Oct 16 16:36:25 rivoplus systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 16:36:25 rivoplus systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 16 16:36:25 rivoplus systemd[1]: Started volumio.service - Volumio Backend Module. Oct 16 16:36:25 rivoplus systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 16:36:25 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:25.968-04:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 16:36:26 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:26.971-04:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 16:36:27 rivoplus volumio[16411]: info: ------------------------------------------- Oct 16 16:36:27 rivoplus volumio[16411]: info: ----- Volumio3 ---- Oct 16 16:36:27 rivoplus volumio[16411]: info: ------------------------------------------- Oct 16 16:36:27 rivoplus volumio[16411]: info: ----- System startup ---- Oct 16 16:36:27 rivoplus volumio[16411]: info: ------------------------------------------- Oct 16 16:36:28 rivoplus systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 953. Oct 16 16:36:28 rivoplus systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:28 rivoplus systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:28 rivoplus upmpdcli[16433]: Could not open config: /tmp/upmpdcli.conf Oct 16 16:36:28 rivoplus systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:36:28 rivoplus systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 16 16:36:28 rivoplus volumio[16411]: info: MYVOLUMIO Environment detected Oct 16 16:36:28 rivoplus volumio[16411]: info: Plugin folders cleanup Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning into folder /volumio/app/plugins/ Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category audio_interface Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category miscellanea Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category music_service Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category plugins.json Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category system_controller Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category user_interface Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning into folder /data/plugins/ Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category audio_interface Oct 16 16:36:28 rivoplus volumio[16411]: info: Scanning category music_service Oct 16 16:36:28 rivoplus volumio[16411]: info: Plugin folders cleanup completed Oct 16 16:36:28 rivoplus volumio[16411]: info: ------------------------------------------- Oct 16 16:36:28 rivoplus volumio[16411]: info: ----- Core plugins startup ---- Oct 16 16:36:28 rivoplus volumio[16411]: info: ------------------------------------------- Oct 16 16:36:28 rivoplus volumio[16411]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin bluetooth to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin multiroom to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin upnp to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin metavolumio to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin cd_controller to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin raat to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 16:36:28 rivoplus volumio[16411]: info: Loading plugins from folder /data/plugins/ Oct 16 16:36:28 rivoplus volumio[16411]: info: Loading plugin "system"... Oct 16 16:36:28 rivoplus volumio[16411]: info: Loading plugin "appearance"... Oct 16 16:36:29 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:29] [connect] Successful connection Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "network"... Oct 16 16:36:30 rivoplus volumio[16411]: info: Refreshing Cached IP Addresses Oct 16 16:36:30 rivoplus sudo[16440]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:36:30 rivoplus sudo[16440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:30 rivoplus sudo[16442]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:36:30 rivoplus sudo[16442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "services"... Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "volumio5onboarding"... Oct 16 16:36:30 rivoplus sudo[16440]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:30 rivoplus sudo[16442]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:30 rivoplus sudo[16448]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 16:36:30 rivoplus sudo[16448]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "alsa_controller"... Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "wizard"... Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "networkfs"... Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus volumio[16411]: info: Starting Udev Watcher for removable devices Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus volumio[16411]: info: Ignoring mount for partition: BOOT Oct 16 16:36:30 rivoplus volumio[16411]: info: Ignoring mount for partition: volumio Oct 16 16:36:30 rivoplus volumio[16411]: info: Ignoring mount for partition: volumio_data Oct 16 16:36:30 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "volumio_command_line_client"... Oct 16 16:36:30 rivoplus volumio[16411]: info: Plugin upnp is not enabled Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "my_music"... Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:30 rivoplus volumio[16411]: info: Loading plugin "mpd"... Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus volumio[16411]: info: Plugin upnp_browser is not enabled Oct 16 16:36:31 rivoplus volumio[16411]: info: Loading plugin "bluetooth"... Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:31 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin bluetooth Oct 16 16:36:31 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin bluetooth Oct 16 16:36:31 rivoplus volumio[16411]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Oct 16 16:36:31 rivoplus volumio[16411]: info: Loading plugin "alarm-clock"... Oct 16 16:36:31 rivoplus volumio[16411]: info: Loading plugin "manifestui"... Oct 16 16:36:32 rivoplus volumio[16411]: info: Plugin metavolumio is not enabled Oct 16 16:36:32 rivoplus volumio[16411]: info: Loading plugin "novaui"... Oct 16 16:36:32 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin novaui Oct 16 16:36:32 rivoplus volumio[16411]: info: Plugin airplay_emulation is not enabled Oct 16 16:36:32 rivoplus volumio[16411]: info: Plugin cd_controller is not enabled Oct 16 16:36:32 rivoplus volumio[16411]: info: Loading plugin "last_100"... Oct 16 16:36:32 rivoplus volumio[16411]: info: Plugin qobuzconnect is not enabled Oct 16 16:36:32 rivoplus volumio[16411]: info: Loading plugin "raat"... Oct 16 16:36:32 rivoplus volumio[16411]: info: RAAT Plugin loaded Oct 16 16:36:32 rivoplus volumio[16411]: info: Adding restartRAATSocket REST API Endpoint Oct 16 16:36:32 rivoplus volumio[16411]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Oct 16 16:36:32 rivoplus volumio[16411]: info: Loading plugin "streaming_services"... Oct 16 16:36:32 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 0 Oct 16 16:36:32 rivoplus sudo[16448]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:33 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:33.157-04:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Oct 16 16:36:33 rivoplus volumio[16411]: info: Plugin tidalconnect is not enabled Oct 16 16:36:33 rivoplus volumio[16411]: info: Loading plugin "webradio"... Oct 16 16:36:34 rivoplus volumio[16411]: info: Loading plugin "i2s_dacs"... Oct 16 16:36:34 rivoplus volumio[16411]: info: I2S DAC not set, start Auto-detection Oct 16 16:36:34 rivoplus volumio[16411]: info: Loading plugin "volumiodiscovery"... Oct 16 16:36:34 rivoplus volumio[16411]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:34 rivoplus volumio[16411]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:34 rivoplus volumio[16411]: *** WARNING *** For more information see Oct 16 16:36:34 rivoplus volumio[16411]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:34 rivoplus node[16411]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:34 rivoplus volumio[16411]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:34 rivoplus volumio[16411]: *** WARNING *** For more information see Oct 16 16:36:34 rivoplus node[16411]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:34 rivoplus node[16411]: *** WARNING *** For more information see Oct 16 16:36:34 rivoplus node[16411]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:34 rivoplus node[16411]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:34 rivoplus node[16411]: *** WARNING *** For more information see Oct 16 16:36:34 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 16:36:34 rivoplus volumio[16411]: info: Discovery: Started advertising with name: Rivoplus Oct 16 16:36:34 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:36:34 rivoplus volumio[16411]: info: Loading plugin "bandcamp"... Oct 16 16:36:37 rivoplus volumio[16411]: info: Loading plugin "calmradio"... Oct 16 16:36:37 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:37.973-04:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:46692->127.0.0.1:3000: i/o timeout" Oct 16 16:36:38 rivoplus volumio[16411]: info: Loading plugin "mixcloud"... Oct 16 16:36:38 rivoplus volumio[16411]: info: Loading plugin "soundcloud"... Oct 16 16:36:39 rivoplus volumio[16411]: info: Plugin multiroom is not enabled Oct 16 16:36:39 rivoplus volumio[16411]: info: Loading plugin "outputs"... Oct 16 16:36:39 rivoplus volumio[16411]: info: Loading plugin "albumart"... Oct 16 16:36:39 rivoplus volumio[16411]: info: Plugin example_plugin is not enabled Oct 16 16:36:39 rivoplus volumio[16411]: info: Loading plugin "hi_res_audio"... Oct 16 16:36:40 rivoplus volumio[16476]: Forking 3 albumart workers Oct 16 16:36:41 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin hi_res_audio Oct 16 16:36:41 rivoplus volumio[16411]: info: Loading plugin "inputs"... Oct 16 16:36:41 rivoplus volumio[16485]: Starting albumart workers Oct 16 16:36:41 rivoplus volumio[16483]: Starting albumart workers Oct 16 16:36:42 rivoplus volumio[16484]: Starting albumart workers Oct 16 16:36:42 rivoplus volumio[16411]: info: Loading plugin "qobuz"... Oct 16 16:36:42 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:42] [connect] Successful connection Oct 16 16:36:43 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:43.155-04:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 16 16:36:43 rivoplus systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 954. Oct 16 16:36:43 rivoplus systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:43 rivoplus systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:43 rivoplus upmpdcli[16546]: Could not open config: /tmp/upmpdcli.conf Oct 16 16:36:43 rivoplus systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:36:43 rivoplus systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 16 16:36:43 rivoplus volumio[16411]: info: Loading plugin "smart_inputs"... Oct 16 16:36:44 rivoplus volumio[16411]: info: Loading plugin "tidal"... Oct 16 16:36:45 rivoplus volumio[16411]: info: Loading plugin "rivopluscontrol"... Oct 16 16:36:45 rivoplus volumio[16411]: info: Adding this device properties Oct 16 16:36:45 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 16 16:36:45 rivoplus volumio[16411]: info: Setting Additional Device Volumio Properties: [object Object] Oct 16 16:36:45 rivoplus volumio[16411]: info: Loading plugin "updater_comm"... Oct 16 16:36:45 rivoplus volumio[16411]: info: Loading plugin "cec_controller"... Oct 16 16:36:45 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin cec_controller Oct 16 16:36:45 rivoplus volumio[16411]: info: Plugin mpdemulation is not enabled Oct 16 16:36:45 rivoplus volumio[16411]: info: Loading plugin "rest_api"... Oct 16 16:36:45 rivoplus volumio[16411]: info: Loading plugin "websocket"... Oct 16 16:36:45 rivoplus volumio[16411]: info: Starting Socket.io Server version 1.7.4 Oct 16 16:36:45 rivoplus volumio[16411]: info: Loading plugin "fusiondsp"... Oct 16 16:36:46 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin fusiondsp Oct 16 16:36:46 rivoplus volumio[16411]: info: Loading plugin "dmd2_music"... Oct 16 16:36:47 rivoplus volumio[16411]: info: Loading plugin "myb"... Oct 16 16:36:47 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin myb Oct 16 16:36:47 rivoplus volumio[16411]: info: Loading plugin "podcast"... Oct 16 16:36:48 rivoplus volumio[16411]: info: ControllerPodcast::constructor Oct 16 16:36:48 rivoplus volumio[16411]: info: Loading plugin "radio_paradise"... Oct 16 16:36:48 rivoplus volumio[16411]: info: Applying required configuration parameters for plugin radio_paradise Oct 16 16:36:48 rivoplus volumio[16411]: info: [1792183008487] [RadioParadise] API delay: 5 Oct 16 16:36:48 rivoplus volumio[16411]: info: Loading i18n strings for locale en Oct 16 16:36:48 rivoplus volumio[16411]: Updating browse sources language Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::initPlayerControls Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: Express server listening on port 3000 Oct 16 16:36:48 rivoplus volumio[16411]: [Metrics] WebUI: 21s 586.19ms Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreStateMachine::resetVolumioState Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreStateMachine::getcurrentVolume Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreStateMachine::pushState Oct 16 16:36:48 rivoplus volumio[16411]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:48 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:36:48 rivoplus volumio[16411]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 16:36:48 rivoplus volumio[16411]: info: Completed loading Core Plugins Oct 16 16:36:48 rivoplus volumio[16411]: info: Preparing to generate the ALSA configuration file Oct 16 16:36:48 rivoplus volumio[16411]: info: Volumio Network Manager: Network status updated: 1 Oct 16 16:36:48 rivoplus volumio[16411]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 16:36:48 rivoplus volumio[16411]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 16 16:36:48 rivoplus volumio[16411]: info: Reading ALSA contributions from plugins. Oct 16 16:36:48 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:48.975-04:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:46698->127.0.0.1:3000: i/o timeout" Oct 16 16:36:49 rivoplus volumio[16411]: info: Reloading queue from file Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreStateMachine::setRepeat false single undefined Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreStateMachine::pushState Oct 16 16:36:49 rivoplus volumio[16411]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreStateMachine::setRandom false Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreStateMachine::pushState Oct 16 16:36:49 rivoplus volumio[16411]: info: CorePlayQueue::getTrack 0 Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreCommandRouter::volumioPushState Oct 16 16:36:49 rivoplus volumio[16411]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.179 UA: Mozilla/5.0 (iPad; CPU OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: websocket Total Clients: 1 Oct 16 16:36:49 rivoplus volumio[16411]: info: Preload queue cleared Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreCommandRouter::volumioAddQueueItems Oct 16 16:36:49 rivoplus volumio[16411]: info: CoreStateMachine::addQueueItems Oct 16 16:36:49 rivoplus volumio[16411]: info: CorePlayQueue::addQueueItems Oct 16 16:36:49 rivoplus volumio[16411]: info: Preload queue cleared Oct 16 16:36:49 rivoplus volumio[16411]: info: Adding Item to queue: https://stream.radioparadise.com/flacm Oct 16 16:36:49 rivoplus volumio[16411]: info: Exploding uri https://stream.radioparadise.com/flacm in service radio_paradise Oct 16 16:36:49 rivoplus volumio[16411]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:36:49 rivoplus volumio[16411]: TypeError: Cannot read properties of undefined (reading 'rparadise') Oct 16 16:36:49 rivoplus volumio[16411]: at ControllerRadioParadise.explodeUri (/data/plugins/music_service/radio_paradise/index.js:350:45) Oct 16 16:36:49 rivoplus volumio[16411]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Oct 16 16:36:49 rivoplus volumio[16411]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 16 16:36:49 rivoplus volumio[16411]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Oct 16 16:36:49 rivoplus volumio[16411]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Oct 16 16:36:49 rivoplus volumio[16411]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Oct 16 16:36:49 rivoplus volumio[16411]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:448:28) Oct 16 16:36:49 rivoplus volumio[16411]: at CoreCommandRouter.addPlay (/volumio/app/index.js:472:10) Oct 16 16:36:49 rivoplus volumio[16411]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:482:17) Oct 16 16:36:49 rivoplus volumio[16411]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Oct 16 16:36:49 rivoplus volumio[16411]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:36:50 rivoplus sudo[16574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 16:35' Oct 16 16:36:50 rivoplus sudo[16574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:50 rivoplus sudo[16574]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:51 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:51.206-04:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:46702->127.0.0.1:3000: read: connection reset by peer" Oct 16 16:36:51 rivoplus systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:36:51 rivoplus systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 16 16:36:51 rivoplus systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 16:36:51 rivoplus systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 16:36:51 rivoplus systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Oct 16 16:36:51 rivoplus systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 16:36:51 rivoplus systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 16 16:36:51 rivoplus systemd[1]: Started volumio.service - Volumio Backend Module. Oct 16 16:36:51 rivoplus systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 16:36:52 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:52.209-04:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 16:36:53 rivoplus volumio[16614]: info: ------------------------------------------- Oct 16 16:36:53 rivoplus volumio[16614]: info: ----- Volumio3 ---- Oct 16 16:36:53 rivoplus volumio[16614]: info: ------------------------------------------- Oct 16 16:36:53 rivoplus volumio[16614]: info: ----- System startup ---- Oct 16 16:36:53 rivoplus volumio[16614]: info: ------------------------------------------- Oct 16 16:36:54 rivoplus volumio[16614]: info: MYVOLUMIO Environment detected Oct 16 16:36:54 rivoplus volumio[16614]: info: Plugin folders cleanup Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning into folder /volumio/app/plugins/ Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category audio_interface Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category miscellanea Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category music_service Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category plugins.json Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category system_controller Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category user_interface Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning into folder /data/plugins/ Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category audio_interface Oct 16 16:36:54 rivoplus volumio[16614]: info: Scanning category music_service Oct 16 16:36:54 rivoplus volumio[16614]: info: Plugin folders cleanup completed Oct 16 16:36:54 rivoplus volumio[16614]: info: ------------------------------------------- Oct 16 16:36:54 rivoplus volumio[16614]: info: ----- Core plugins startup ---- Oct 16 16:36:54 rivoplus volumio[16614]: info: ------------------------------------------- Oct 16 16:36:54 rivoplus volumio[16614]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin bluetooth to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin multiroom to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin upnp to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin metavolumio to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin cd_controller to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin raat to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 16:36:54 rivoplus volumio[16614]: info: Loading plugins from folder /data/plugins/ Oct 16 16:36:54 rivoplus volumio[16614]: info: Loading plugin "system"... Oct 16 16:36:54 rivoplus volumio[16614]: info: Loading plugin "appearance"... Oct 16 16:36:55 rivoplus volumio[16614]: info: Loading plugin "network"... Oct 16 16:36:55 rivoplus volumio[16614]: info: Refreshing Cached IP Addresses Oct 16 16:36:55 rivoplus sudo[16642]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:36:55 rivoplus sudo[16642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:55 rivoplus sudo[16644]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:36:55 rivoplus sudo[16644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:55 rivoplus volumio[16614]: info: Loading plugin "services"... Oct 16 16:36:55 rivoplus volumio[16614]: info: Loading plugin "volumio5onboarding"... Oct 16 16:36:56 rivoplus sudo[16642]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:56 rivoplus sudo[16644]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "alsa_controller"... Oct 16 16:36:56 rivoplus sudo[16649]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 16:36:56 rivoplus sudo[16649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "wizard"... Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "networkfs"... Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus volumio[16614]: info: Starting Udev Watcher for removable devices Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus volumio[16614]: info: Ignoring mount for partition: BOOT Oct 16 16:36:56 rivoplus volumio[16614]: info: Ignoring mount for partition: volumio Oct 16 16:36:56 rivoplus volumio[16614]: info: Ignoring mount for partition: volumio_data Oct 16 16:36:56 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "volumio_command_line_client"... Oct 16 16:36:56 rivoplus volumio[16614]: info: Plugin upnp is not enabled Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "my_music"... Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "mpd"... Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus volumio[16614]: info: Plugin upnp_browser is not enabled Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "bluetooth"... Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin bluetooth Oct 16 16:36:56 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin bluetooth Oct 16 16:36:56 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Oct 16 16:36:56 rivoplus volumio[16614]: info: Loading plugin "alarm-clock"... Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:56 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 8 Oct 16 16:36:57 rivoplus volumio[16614]: info: Loading plugin "manifestui"... Oct 16 16:36:57 rivoplus volumio[16614]: info: Plugin metavolumio is not enabled Oct 16 16:36:57 rivoplus volumio[16614]: info: Loading plugin "novaui"... Oct 16 16:36:57 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin novaui Oct 16 16:36:57 rivoplus volumio[16614]: info: Plugin airplay_emulation is not enabled Oct 16 16:36:57 rivoplus volumio[16614]: info: Plugin cd_controller is not enabled Oct 16 16:36:57 rivoplus volumio[16614]: info: Loading plugin "last_100"... Oct 16 16:36:57 rivoplus volumio[16614]: info: Plugin qobuzconnect is not enabled Oct 16 16:36:57 rivoplus volumio[16614]: info: Loading plugin "raat"... Oct 16 16:36:57 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:36:57] [connect] Successful connection Oct 16 16:36:57 rivoplus volumio[16614]: info: RAAT Plugin loaded Oct 16 16:36:57 rivoplus volumio[16614]: info: Adding restartRAATSocket REST API Endpoint Oct 16 16:36:57 rivoplus volumio[16614]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Oct 16 16:36:57 rivoplus volumio[16614]: info: Loading plugin "streaming_services"... Oct 16 16:36:58 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc050c31000 drv_status 0x0 e_type 69 e_states 0 Oct 16 16:36:58 rivoplus sudo[16649]: pam_unix(sudo:session): session closed for user root Oct 16 16:36:58 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:36:58.540-04:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.179:63958,00:00:00:00:00:00%06 @ 0x2594630" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Oct 16 16:36:58 rivoplus volumio[16614]: info: Plugin tidalconnect is not enabled Oct 16 16:36:58 rivoplus volumio[16614]: info: Loading plugin "webradio"... Oct 16 16:36:58 rivoplus systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 955. Oct 16 16:36:58 rivoplus systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:58 rivoplus systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:36:58 rivoplus upmpdcli[16675]: Could not open config: /tmp/upmpdcli.conf Oct 16 16:36:58 rivoplus systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:36:58 rivoplus systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 16 16:36:59 rivoplus volumio[16614]: info: Loading plugin "i2s_dacs"... Oct 16 16:36:59 rivoplus volumio[16614]: info: I2S DAC not set, start Auto-detection Oct 16 16:36:59 rivoplus volumio[16614]: info: Loading plugin "volumiodiscovery"... Oct 16 16:36:59 rivoplus volumio[16614]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:59 rivoplus volumio[16614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:59 rivoplus volumio[16614]: *** WARNING *** For more information see Oct 16 16:36:59 rivoplus volumio[16614]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:59 rivoplus volumio[16614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:59 rivoplus node[16614]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:59 rivoplus volumio[16614]: *** WARNING *** For more information see Oct 16 16:36:59 rivoplus node[16614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:59 rivoplus node[16614]: *** WARNING *** For more information see Oct 16 16:36:59 rivoplus node[16614]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 16:36:59 rivoplus node[16614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:36:59 rivoplus node[16614]: *** WARNING *** For more information see Oct 16 16:36:59 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 16:36:59 rivoplus volumio[16614]: info: Discovery: Started advertising with name: Rivoplus Oct 16 16:36:59 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:36:59 rivoplus volumio[16614]: info: Loading plugin "bandcamp"... Oct 16 16:37:01 rivoplus volumio[16614]: info: Loading plugin "calmradio"... Oct 16 16:37:03 rivoplus volumio[16614]: info: Loading plugin "mixcloud"... Oct 16 16:37:03 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:37:03.210-04:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:46710->127.0.0.1:3000: i/o timeout" Oct 16 16:37:03 rivoplus volumio[16614]: info: Loading plugin "soundcloud"... Oct 16 16:37:04 rivoplus volumio[16614]: info: Plugin multiroom is not enabled Oct 16 16:37:04 rivoplus volumio[16614]: info: Loading plugin "outputs"... Oct 16 16:37:04 rivoplus volumio[16614]: info: Loading plugin "albumart"... Oct 16 16:37:04 rivoplus volumio[16614]: info: Plugin example_plugin is not enabled Oct 16 16:37:04 rivoplus volumio[16614]: info: Loading plugin "hi_res_audio"... Oct 16 16:37:05 rivoplus volumio[16678]: Forking 3 albumart workers Oct 16 16:37:06 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin hi_res_audio Oct 16 16:37:06 rivoplus volumio[16614]: info: Loading plugin "inputs"... Oct 16 16:37:06 rivoplus volumio[16685]: Starting albumart workers Oct 16 16:37:06 rivoplus volumio[16686]: Starting albumart workers Oct 16 16:37:06 rivoplus volumio[16687]: Starting albumart workers Oct 16 16:37:06 rivoplus volumio[16614]: info: Loading plugin "qobuz"... Oct 16 16:37:08 rivoplus volumio[16614]: info: Loading plugin "smart_inputs"... Oct 16 16:37:08 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:37:08.534-04:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 16 16:37:08 rivoplus volumio[16614]: info: Loading plugin "tidal"... Oct 16 16:37:09 rivoplus volumio[16614]: info: Loading plugin "rivopluscontrol"... Oct 16 16:37:10 rivoplus volumio[16614]: info: Adding this device properties Oct 16 16:37:10 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 16 16:37:10 rivoplus volumio[16614]: info: Setting Additional Device Volumio Properties: [object Object] Oct 16 16:37:10 rivoplus volumio[16614]: info: Loading plugin "updater_comm"... Oct 16 16:37:10 rivoplus volumio[16614]: info: Loading plugin "cec_controller"... Oct 16 16:37:10 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin cec_controller Oct 16 16:37:10 rivoplus volumio[16614]: info: Plugin mpdemulation is not enabled Oct 16 16:37:10 rivoplus volumio[16614]: info: Loading plugin "rest_api"... Oct 16 16:37:10 rivoplus volumio[16614]: info: Loading plugin "websocket"... Oct 16 16:37:10 rivoplus volumio[16614]: info: Starting Socket.io Server version 1.7.4 Oct 16 16:37:10 rivoplus volumio[16614]: info: Loading plugin "fusiondsp"... Oct 16 16:37:10 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin fusiondsp Oct 16 16:37:11 rivoplus volumio[16614]: info: Loading plugin "dmd2_music"... Oct 16 16:37:12 rivoplus volumio[16614]: info: Loading plugin "myb"... Oct 16 16:37:12 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:37:12] [connect] Successful connection Oct 16 16:37:12 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin myb Oct 16 16:37:12 rivoplus volumio[16614]: info: Loading plugin "podcast"... Oct 16 16:37:12 rivoplus volumio[16614]: info: ControllerPodcast::constructor Oct 16 16:37:13 rivoplus volumio[16614]: info: Loading plugin "radio_paradise"... Oct 16 16:37:13 rivoplus volumio[16614]: info: Applying required configuration parameters for plugin radio_paradise Oct 16 16:37:13 rivoplus volumio[16614]: info: [1792183033279] [RadioParadise] API delay: 5 Oct 16 16:37:13 rivoplus volumio[16614]: info: Loading i18n strings for locale en Oct 16 16:37:13 rivoplus volumio[16614]: Updating browse sources language Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::initPlayerControls Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: Express server listening on port 3000 Oct 16 16:37:13 rivoplus volumio[16614]: [Metrics] WebUI: 20s 509.48ms Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreStateMachine::resetVolumioState Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreStateMachine::getcurrentVolume Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:13 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:37:13 rivoplus volumio[16614]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 16:37:13 rivoplus volumio[16614]: info: Completed loading Core Plugins Oct 16 16:37:13 rivoplus volumio[16614]: info: Preparing to generate the ALSA configuration file Oct 16 16:37:13 rivoplus volumio[16614]: info: Volumio Network Manager: Network status updated: 1 Oct 16 16:37:13 rivoplus volumio[16614]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 16:37:13 rivoplus volumio[16614]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 16 16:37:13 rivoplus volumio[16614]: info: Reading ALSA contributions from plugins. Oct 16 16:37:13 rivoplus volumio[16614]: info: Reloading queue from file Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:13 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:13 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:13 rivoplus volumio[16614]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.179 UA: Mozilla/5.0 (iPad; CPU OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: websocket Total Clients: 1 Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreStateMachine::setRepeat false single undefined Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:13 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:13 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreStateMachine::setRandom false Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:14 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:14 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: websocket Total Clients: 2 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus volumio[16614]: info: Received Get System Version Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:37:14 rivoplus volumio[16614]: info: Received Get System Info Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:14 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:14 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 16 16:37:14 rivoplus systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 956. Oct 16 16:37:14 rivoplus systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:37:14 rivoplus systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 16 16:37:14 rivoplus sudo[16766]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 16 16:37:14 rivoplus sudo[16766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio5-onboarding[4605]: time=2026-10-16T16:37:14.213-04:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:46716->127.0.0.1:3000: i/o timeout" Oct 16 16:37:14 rivoplus sudo[16774]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:37:14 rivoplus sudo[16774]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: CALLMETHOD: miscellanea novaui getTheme [object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: novaui , getTheme Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 16 16:37:14 rivoplus sudo[16774]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus upmpdcli[16759]: Could not open config: /tmp/upmpdcli.conf Oct 16 16:37:14 rivoplus sudo[16766]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus sudo[16781]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 16:37:14 rivoplus sudo[16781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 16:37:14 rivoplus sudo[16784]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:37:14 rivoplus systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 16 16:37:14 rivoplus systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:14 rivoplus sudo[16792]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:37:14 rivoplus sudo[16784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreStateMachine::getQueue Oct 16 16:37:14 rivoplus sudo[16792]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: CorePlayQueue::getQueue Oct 16 16:37:14 rivoplus sudo[16781]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus sudo[16794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:37:14 rivoplus sudo[16794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus sudo[16784]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus sudo[16792]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus sudo[16794]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:14 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:14 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:14 rivoplus volumio[16614]: info: Discovery: adding 34818ac3-59d5-4df6-9b99-92d8916d10d2 Oct 16 16:37:14 rivoplus volumio[16614]: info: Discovery: Found device Rivoplus Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:14 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:14 rivoplus volumio[16614]: info: Asound.conf file unchanged, so no further update is needed Oct 16 16:37:14 rivoplus volumio[16614]: info: Output device has changed, restarting MPD Oct 16 16:37:14 rivoplus volumio[16614]: info: ___________ START PLUGINS ___________ Oct 16 16:37:14 rivoplus sudo[16804]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 16:37:14 rivoplus sudo[16804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: ControllerMpd::onStart: Initializing MPD Oct 16 16:37:14 rivoplus volumio[16614]: info: Creating MPD Configuration file Oct 16 16:37:14 rivoplus sudo[16804]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus sudo[16806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 16:37:14 rivoplus sudo[16806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus sudo[16809]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 16 16:37:14 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: [FUNC] onStart Oct 16 16:37:14 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Oct 16 16:37:14 rivoplus sudo[16809]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Oct 16 16:37:14 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Oct 16 16:37:14 rivoplus sudo[16813]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 16:37:14 rivoplus sudo[16813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: [1792183034615] CoreMusicLibrary::Adding element Last_100 Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus sudo[16813]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus sudo[16815]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 16:37:14 rivoplus sudo[16815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: Starting RAAT Plugin Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 16:37:14 rivoplus volumio[16614]: info: Additional UI Settings Added for plugin music_service/raat Oct 16 16:37:14 rivoplus volumio[16614]: info: Registering DSP Elements listener and retrieving current ones Oct 16 16:37:14 rivoplus volumio[16614]: info: Additional DSP elements updated Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:14 rivoplus volumio[16614]: info: Updating RAAT Signal Path Oct 16 16:37:14 rivoplus volumio[16614]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 16:37:14 rivoplus volumio[16614]: info: Streaming services startup Oct 16 16:37:14 rivoplus sudo[16809]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus volumio[16614]: info: Starting Streaming Daemon Oct 16 16:37:14 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 16 16:37:14 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 16:37:14 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 16 16:37:14 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 16:37:14 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 16:37:14 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 16:37:14 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: [1792183034740] CoreMusicLibrary::Adding element Webradio Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 16 16:37:14 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 16:37:14 rivoplus sudo[16822]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 16:37:14 rivoplus sudo[16822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 16 16:37:14 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 16:37:14 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:37:14 rivoplus volumio[16614]: info: Initializing BBC Radios Oct 16 16:37:14 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 16:37:14 rivoplus bluetoothd[3431]: Path / reserved for Adv Monitor app :1.332 Oct 16 16:37:14 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 16:37:14 rivoplus sudo[16822]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: [1792183034865] CoreMusicLibrary::Adding element Bandcamp Discover Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:14 rivoplus bluetoothd[3431]: Adv Monitor app :1.332 disconnected from D-Bus Oct 16 16:37:14 rivoplus volumio[16614]: info: Adding Calm Radio to Browse Sources Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: [1792183034873] CoreMusicLibrary::Adding element Calm Radio Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Calm Radio Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: [1792183034886] CoreMusicLibrary::Adding element Mixcloud Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Calm Radio Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Mixcloud Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:14 rivoplus volumio[16614]: info: [1792183034898] CoreMusicLibrary::Adding element SoundCloud Oct 16 16:37:14 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Calm Radio Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source Mixcloud Oct 16 16:37:14 rivoplus volumio[16614]: Cannot find translation for source SoundCloud Oct 16 16:37:14 rivoplus volumio[16614]: error: Hi Res Audio Failed Login: Missing Login Data Oct 16 16:37:14 rivoplus volumio[16614]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 16 16:37:14 rivoplus volumio[16614]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 16 16:37:14 rivoplus volumio[16614]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 16 16:37:14 rivoplus volumio[16614]: info: Touch Event Listener Process Starting Oct 16 16:37:14 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 16 16:37:14 rivoplus volumio[16614]: info: Adding inputs REST Endpoints Oct 16 16:37:14 rivoplus volumio[16614]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 16 16:37:14 rivoplus volumio[16614]: info: Scanning Audio Inputs Oct 16 16:37:14 rivoplus sudo[16843]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 16 16:37:14 rivoplus sudo[16843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:14 rivoplus volumio[16614]: info: Checking against Known Cards name Oct 16 16:37:14 rivoplus volumio[16614]: info: Checking against Known Cards name Oct 16 16:37:14 rivoplus volumio[16614]: info: Checking against Known Cards name Oct 16 16:37:14 rivoplus volumio[16614]: info: Checking against Known Cards name Oct 16 16:37:14 rivoplus volumio[16614]: info: Checking against Known Cards name Oct 16 16:37:14 rivoplus volumio[16614]: info: Adding Server instance for streaming Oct 16 16:37:15 rivoplus sudo[16850]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 16 16:37:15 rivoplus sudo[16850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:15 rivoplus sudo[16850]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus sudo[16853]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 16 16:37:15 rivoplus sudo[16853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:15 rivoplus sudo[16853]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus sudo[16856]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 16 16:37:15 rivoplus sudo[16856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:15 rivoplus sudo[16856]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus sudo[16859]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 16 16:37:15 rivoplus sudo[16859]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:15 rivoplus sudo[16859]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus volumio[16614]: info: Apply VIM3L Onboard LEDs Settings Oct 16 16:37:15 rivoplus volumio[16614]: info: Turning On Onboard LEDs Oct 16 16:37:15 rivoplus volumio[16614]: info: Starting CEC Event listener Oct 16 16:37:15 rivoplus sudo[16863]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 16:37:15 rivoplus sudo[16863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:15 rivoplus sudo[16863]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus volumio[16614]: info: FusionDsp - CamillaDSP binary found. Oct 16 16:37:15 rivoplus sudo[16837]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 16:37:15 rivoplus sudo[16837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 16:37:15 rivoplus volumio[16614]: info: Loading i18n strings for locale en Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:15 rivoplus volumio[16614]: info: FusionDsp - mixtype--------------------- None Oct 16 16:37:15 rivoplus sudo[16837]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus volumio[16614]: info: Stopping AccessToken refresher cron for DMD2 Music Oct 16 16:37:15 rivoplus sudo[16868]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 16:37:15 rivoplus sudo[16868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:15 rivoplus sudo[16868]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:15 rivoplus volumio[16614]: info: AccessToken refresher cron started for DMD2 Music Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:15 rivoplus volumio[16614]: info: [1792183035384] CoreMusicLibrary::Adding element Podcast Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Calm Radio Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Mixcloud Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source SoundCloud Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Podcast Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:37:15 rivoplus volumio[16614]: info: [1792183035393] CoreMusicLibrary::Adding element Radio Paradise Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Calm Radio Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Mixcloud Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source SoundCloud Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Podcast Oct 16 16:37:15 rivoplus volumio[16614]: Cannot find translation for source Radio Paradise Oct 16 16:37:15 rivoplus volumio[16614]: info: Volumio Calling Home Oct 16 16:37:15 rivoplus volumio[16614]: (node:16614) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Oct 16 16:37:15 rivoplus volumio[16614]: (Use `node --trace-deprecation ...` to show where the warning was created) Oct 16 16:37:15 rivoplus volumio[16614]: info: Stopping AccessToken refresher cron for QOBUZ Oct 16 16:37:15 rivoplus volumio[16614]: info: AccessToken refresher cron started for QOBUZ Oct 16 16:37:15 rivoplus volumio[16614]: info: Adding TIDAL REST API Endpoints Oct 16 16:37:15 rivoplus volumio[16614]: info: Preparing to generate the ALSA configuration file Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: appearance , registerThirdPartyUI Oct 16 16:37:15 rivoplus volumio[16614]: info: Registering Third Party UI: {"uiName":"nova","uiPath":"/data/nova/current","uiPrettyName":"Nova"} Oct 16 16:37:15 rivoplus volumio[16614]: info: UI already registered: {"uiName":"nova","uiPath":"/data/nova/current","uiPrettyName":"Nova"} Oct 16 16:37:15 rivoplus volumio[16614]: info: Nova UI: serving version 0.261012.0 Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentUpdaterChannel Oct 16 16:37:15 rivoplus volumio[16614]: info: Adding QOBUZ REST API Endpoints Oct 16 16:37:15 rivoplus volumio[16614]: info: Nova UI: checking for updates on the stable channel: https://static.vlmapi.io/volumio/assets/v4/themes/nova/manifest.json Oct 16 16:37:15 rivoplus volumio[16614]: info: Discovery: this is already registered, 34818ac3-59d5-4df6-9b99-92d8916d10d2 Oct 16 16:37:15 rivoplus volumio[16614]: info: Discovery: Found device Rivoplus Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:15 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:15 rivoplus volumio[16614]: info: Serial port opened successfully Oct 16 16:37:15 rivoplus volumio[16614]: info: Sending serial start messages Oct 16 16:37:15 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:15 rivoplus volumio[16614]: info: Reporting MCU Network Status: 1 Oct 16 16:37:15 rivoplus volumio[16614]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 16 16:37:15 rivoplus volumio[16614]: info: Reading ALSA contributions from plugins. Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 16 16:37:16 rivoplus volumio[16614]: error: Cannot start Volumio Streaming Daemon Oct 16 16:37:16 rivoplus volumio[16614]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 16 16:37:16 rivoplus volumio[16614]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 16 16:37:16 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Oct 16 16:37:16 rivoplus volumio[16614]: info: MPD Permissions set Oct 16 16:37:16 rivoplus volumio[16614]: info: MPD Permissions set Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:16 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:16 rivoplus sudo[16881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Oct 16 16:37:16 rivoplus sudo[16881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:16 rivoplus volumio[16614]: info: Volumio called home Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:16 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:16 rivoplus sudo[16881]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:16 rivoplus volumio-remote-updater[2910]: [2026-10-16 16:37:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1792183032 101 Oct 16 16:37:16 rivoplus volumio[16614]: 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: 2 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting Device Volume Override Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 16 16:37:16 rivoplus volumio[16614]: info: Updating Volume Controller Parameters: Device: 5 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 16 16:37:16 rivoplus volumio[16614]: info: Disabling external Volume Control Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting Additional System Software info: Hardware Revision: 1.0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting HW Firmware info: undefined Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting HW Version info: 1.0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting HW Firmware info: 0.3.0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 16:37:16 rivoplus volumio[16614]: info: Setting HW Version info: 1.0 Oct 16 16:37:16 rivoplus volumio[16614]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 16 16:37:16 rivoplus volumio[16614]: info: MCU Signalled Headphone Mode Disabled Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 16 16:37:16 rivoplus volumio[16614]: info: Reporting Headphone State: false Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus volumio[16614]: info: Updating RAAT Signal Path Oct 16 16:37:16 rivoplus volumio[16614]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 16:37:16 rivoplus volumio[16614]: info: MCU Signalled Sleep Mode Disabled Oct 16 16:37:16 rivoplus volumio[16614]: info: Enabling Advanced system settings configuration Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Oct 16 16:37:16 rivoplus volumio[16614]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 16:37:16 rivoplus volumio[16614]: info: MCU Signalled Auto Boot Mode On Power Active Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:16 rivoplus sudo[16915]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Oct 16 16:37:16 rivoplus sudo[16915]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:16 rivoplus sudo[16915]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:16 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) Oct 16 16:37:16 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Oct 16 16:37:16 rivoplus volumio[16614]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Oct 16 16:37:16 rivoplus volumio[16614]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Oct 16 16:37:16 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Oct 16 16:37:16 rivoplus volumio[16614]: info: Nova UI: update check: up to date Oct 16 16:37:16 rivoplus volumio[16614]: info: MP1 GPIO: Signalled system ready via GPIO Oct 16 16:37:16 rivoplus sudo[16918]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Oct 16 16:37:16 rivoplus sudo[16918]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:16 rivoplus sudo[16918]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:16 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 16 16:37:16 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 16 16:37:16 rivoplus volumio[16614]: info: Adding Inputs via Serial API Oct 16 16:37:16 rivoplus volumio[16614]: info: Adding Advanced Audio Settings via Serial API Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 16:37:16 rivoplus volumio[16614]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 16:37:16 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 16 16:37:16 rivoplus volumio[16614]: info: Asound.conf file unchanged, so no further update is needed Oct 16 16:37:16 rivoplus volumio[16614]: info: Output device has changed, restarting MPD Oct 16 16:37:16 rivoplus volumio[16614]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:16 rivoplus sudo[16923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 16:37:16 rivoplus sudo[16923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:16 rivoplus volumio[16614]: verbose: New Socket.io Connection to 192.168.1.115:3000 from 192.168.1.179 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:16 rivoplus sudo[16923]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:16 rivoplus sudo[16925]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 16:37:16 rivoplus sudo[16925]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::servicePushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received inputs Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:16 rivoplus volumio[16614]: Cannot find translation for source Bandcamp Discover Oct 16 16:37:16 rivoplus volumio[16614]: Cannot find translation for source Calm Radio Oct 16 16:37:16 rivoplus volumio[16614]: Cannot find translation for source Mixcloud Oct 16 16:37:16 rivoplus volumio[16614]: Cannot find translation for source SoundCloud Oct 16 16:37:16 rivoplus volumio[16614]: Cannot find translation for source Podcast Oct 16 16:37:16 rivoplus volumio[16614]: Cannot find translation for source Radio Paradise Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:37:16 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 16 16:37:16 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 16:37:16 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 16 16:37:16 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Oct 16 16:37:16 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 16:37:16 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 16:37:16 rivoplus volumio[16614]: info: MPD Permissions set Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreStateMachine::pushState Oct 16 16:37:16 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:16 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:17 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:17 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:17 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:17 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to 192.168.1.115:3000 from 192.168.1.179 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:17 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:37:17 rivoplus volumio[16614]: info: Not Reporting Auto name since its the default one Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 16:37:17 rivoplus volumio[16614]: info: MCU Signalled Playback Inactive Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:17 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus sudo[16945]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 16 16:37:17 rivoplus sudo[16945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus sudo[16930]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 16:37:17 rivoplus sudo[16930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus sudo[16930]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:17 rivoplus sudo[16945]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus sudo[16948]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 16 16:37:17 rivoplus sudo[16948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Oct 16 16:37:17 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 16 16:37:17 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 16 16:37:17 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 16 16:37:17 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 16 16:37:17 rivoplus sudo[16948]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:17 rivoplus volumio[16614]: info: Raat Daemon started successfully Oct 16 16:37:17 rivoplus volumio[16614]: info: Executing endpoint restartRAATSocket Oct 16 16:37:17 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 16 16:37:17 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:17 rivoplus volumio[16614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 16 16:37:18 rivoplus volumio[16614]: info: Turning Off Onboard LEDs Oct 16 16:37:18 rivoplus sudo[16964]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 16:37:18 rivoplus sudo[16964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:18 rivoplus sudo[16964]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:18 rivoplus volumio[16614]: info: CoreCommandRouter::servicePushState Oct 16 16:37:18 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:18 rivoplus volumio[16614]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received raat Oct 16 16:37:18 rivoplus volumio[16614]: info: CoreCommandRouter::servicePushState Oct 16 16:37:18 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:18 rivoplus volumio[16614]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received raat Oct 16 16:37:18 rivoplus sudo[16967]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 16:37:18 rivoplus sudo[16967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:18 rivoplus sudo[16967]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:18 rivoplus volumio[16614]: info: Onboard LEDs initialized Oct 16 16:37:19 rivoplus volumio[16614]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.179 UA: Mozilla/5.0 (iPad; CPU OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: websocket Total Clients: 8 Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 16 16:37:19 rivoplus volumio[16614]: info: Received Get System Version Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:37:19 rivoplus volumio[16614]: info: Received Get System Info Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 16:37:19 rivoplus volumio[16614]: info: Discovery: Getting this device information Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:19 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 16 16:37:19 rivoplus sudo[16970]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 16 16:37:19 rivoplus sudo[16970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:19 rivoplus sudo[16970]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:19 rivoplus sudo[16975]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:37:19 rivoplus sudo[16975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:19 rivoplus sudo[16984]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:37:19 rivoplus sudo[16984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:19 rivoplus volumio[16614]: info: CALLMETHOD: miscellanea novaui getTheme [object Object] Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: novaui , getTheme Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 16:37:19 rivoplus sudo[16975]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetState Oct 16 16:37:19 rivoplus volumio[16614]: info: CorePlayQueue::getTrack 0 Oct 16 16:37:19 rivoplus sudo[16990]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreStateMachine::getQueue Oct 16 16:37:19 rivoplus volumio[16614]: info: CorePlayQueue::getQueue Oct 16 16:37:19 rivoplus sudo[16990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:19 rivoplus sudo[16994]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:37:19 rivoplus sudo[16994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:19 rivoplus volumio[16614]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri Oct 16 16:37:19 rivoplus sudo[16984]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:19 rivoplus sudo[16997]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:37:19 rivoplus sudo[16997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 16:37:19 rivoplus sudo[16994]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:19 rivoplus sudo[16990]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:19 rivoplus sudo[16997]: pam_unix(sudo:session): session closed for user root Oct 16 16:37:19 rivoplus volumio[16614]: info: Preload queue cleared Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: https://stream.radioparadise.com/rock-flacm Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: bandcamp/track@startIndex=0@trackUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Ftrack%2Fsong-for-a-lonely-woman@albumUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Falbum%2Fvol-1-childs-dance@artistUrl=https%3A%2F%2Fartblakey.bandcamp.com@explode:o=%7B%22title%22%3A%22Song%20For%20A%20Lonely%20Woman%22%2C%22artist%22%3A%22Art%20Blakey%20%26%20The%20Jazz%20Messengers%22%2C%22album%22%3A%22Vol.%201%3A%20Child's%20Dance%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2Fa1649826565_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Ftrack%40trackUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Ftrack%252Fsong-for-a-lonely-woman%40albumUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Falbum%252Fvol-1-childs-dance%40artistUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%22%7D Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: https://stream.radioparadise.com/flacm Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm Oct 16 16:37:19 rivoplus volumio[16614]: info: Preload queue cleared Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: https://stream.radioparadise.com/rock-flacm Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: bandcamp/track@startIndex=0@trackUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Ftrack%2Fsong-for-a-lonely-woman@albumUrl=https%3A%2F%2Fartblakey.bandcamp.com%2Falbum%2Fvol-1-childs-dance@artistUrl=https%3A%2F%2Fartblakey.bandcamp.com@explode:o=%7B%22title%22%3A%22Song%20For%20A%20Lonely%20Woman%22%2C%22artist%22%3A%22Art%20Blakey%20%26%20The%20Jazz%20Messengers%22%2C%22album%22%3A%22Vol.%201%3A%20Child's%20Dance%22%2C%22albumart%22%3A%22https%3A%2F%2Ff4.bcbits.com%2Fimg%2Fa1649826565_16.jpg%22%2C%22uri%22%3A%22bandcamp%2Ftrack%40trackUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Ftrack%252Fsong-for-a-lonely-woman%40albumUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%252Falbum%252Fvol-1-childs-dance%40artistUrl%3Dhttps%253A%252F%252Fartblakey.bandcamp.com%22%7D Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: https://stream.radioparadise.com/flacm Oct 16 16:37:19 rivoplus volumio[16614]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm Oct 16 16:37:19 rivoplus volumio[16614]: info: Exploding uri https://stream.radioparadise.com/rock-flacm in service radio_paradise Oct 16 16:37:19 rivoplus volumio[16614]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/rock-flacm" Oct 16 16:37:19 rivoplus volumio[16614]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:37:19 rivoplus volumio[16614]: TypeError: Cannot read properties of undefined (reading 'then') Oct 16 16:37:19 rivoplus volumio[16614]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31) Oct 16 16:37:19 rivoplus volumio[16614]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 16 16:37:19 rivoplus volumio[16614]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Oct 16 16:37:19 rivoplus volumio[16614]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Oct 16 16:37:19 rivoplus volumio[16614]: at listOnTimeout (node:internal/timers:573:17) Oct 16 16:37:19 rivoplus volumio[16614]: at process.processTimers (node:internal/timers:514:7) Oct 16 16:37:19 rivoplus volumio[16614]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:37:20 rivoplus sudo[17013]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 16:36' Oct 16 16:37:20 rivoplus sudo[17013]: 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 19:25:00 UTC 2026" VOLUMIO_VERSION="4.209" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="8dac812ca078a701f8c50cfd99202138"