Oct 13 12:37:00 rivo volumio[4364]: info: Loading plugin "metavolumio"... Oct 13 12:37:01 rivo volumio[4364]: info: Loading plugin "novaui"... Oct 13 12:37:01 rivo volumio[4364]: info: Applying required configuration parameters for plugin novaui Oct 13 12:37:01 rivo volumio[4364]: info: Plugin airplay_emulation is not enabled Oct 13 12:37:01 rivo volumio[4364]: info: Plugin cd_controller is not enabled Oct 13 12:37:01 rivo volumio[4364]: info: Loading plugin "last_100"... Oct 13 12:37:01 rivo volumio[4364]: info: Plugin qobuzconnect is not enabled Oct 13 12:37:01 rivo volumio[4364]: info: Plugin raat is not enabled Oct 13 12:37:01 rivo volumio[4364]: info: Loading plugin "streaming_services"... Oct 13 12:37:02 rivo volumio[4364]: info: Plugin tidalconnect is not enabled Oct 13 12:37:02 rivo volumio[4364]: info: Loading plugin "webradio"... Oct 13 12:37:02 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:03 rivo volumio[4364]: info: Loading plugin "i2s_dacs"... Oct 13 12:37:03 rivo volumio[4364]: info: I2S DAC not set, start Auto-detection Oct 13 12:37:03 rivo volumio[4364]: info: Loading plugin "volumiodiscovery"... Oct 13 12:37:03 rivo volumio[4364]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:03 rivo volumio[4364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:03 rivo volumio[4364]: *** WARNING *** For more information see Oct 13 12:37:03 rivo volumio[4364]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:03 rivo node[4364]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:03 rivo volumio[4364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:03 rivo volumio[4364]: *** WARNING *** For more information see Oct 13 12:37:03 rivo node[4364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:03 rivo node[4364]: *** WARNING *** For more information see Oct 13 12:37:03 rivo node[4364]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:03 rivo node[4364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:03 rivo volumio[4364]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 13 12:37:03 rivo node[4364]: *** WARNING *** For more information see Oct 13 12:37:03 rivo volumio[4364]: info: Discovery: Started advertising with name: Rivo Oct 13 12:37:03 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:03 rivo volumio[4364]: info: Plugin rp2 is not enabled Oct 13 12:37:03 rivo volumio[4364]: info: Plugin multiroom is not enabled Oct 13 12:37:03 rivo volumio[4364]: info: Loading plugin "outputs"... Oct 13 12:37:03 rivo volumio[4364]: info: Loading plugin "albumart"... Oct 13 12:37:03 rivo volumio[4364]: info: Plugin example_plugin is not enabled Oct 13 12:37:03 rivo volumio[4364]: info: Loading plugin "hi_res_audio"... Oct 13 12:37:04 rivo volumio-remote-updater[2950]: [2026-10-13 12:37:04] [connect] Successful connection Oct 13 12:37:04 rivo volumio[4460]: Forking 3 albumart workers Oct 13 12:37:05 rivo volumio[4364]: info: Applying required configuration parameters for plugin hi_res_audio Oct 13 12:37:05 rivo volumio[4364]: info: Loading plugin "inputs"... Oct 13 12:37:05 rivo volumio[4467]: Starting albumart workers Oct 13 12:37:05 rivo volumio[4468]: Starting albumart workers Oct 13 12:37:05 rivo volumio[4469]: Starting albumart workers Oct 13 12:37:05 rivo volumio[4364]: info: Loading plugin "qobuz"... Oct 13 12:37:07 rivo volumio[4364]: info: Plugin smart_inputs is not enabled Oct 13 12:37:07 rivo volumio[4364]: info: Loading plugin "tidal"... Oct 13 12:37:08 rivo volumio[4364]: info: Loading plugin "rivocontrol"... Oct 13 12:37:08 rivo volumio[4364]: info: Adding this device properties Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 13 12:37:08 rivo volumio[4364]: info: Setting Additional Device Volumio Properties: [object Object] Oct 13 12:37:08 rivo volumio[4364]: info: Loading plugin "updater_comm"... Oct 13 12:37:08 rivo volumio[4364]: info: Loading plugin "cec_controller"... Oct 13 12:37:08 rivo volumio[4364]: info: Applying required configuration parameters for plugin cec_controller Oct 13 12:37:08 rivo volumio[4364]: info: Plugin mpdemulation is not enabled Oct 13 12:37:08 rivo volumio[4364]: info: Loading plugin "rest_api"... Oct 13 12:37:08 rivo volumio[4364]: info: Loading plugin "websocket"... Oct 13 12:37:08 rivo volumio[4364]: info: Starting Socket.io Server version 1.7.4 Oct 13 12:37:08 rivo volumio[4364]: info: Plugin fusiondsp is not enabled Oct 13 12:37:08 rivo volumio[4364]: info: Loading i18n strings for locale en Oct 13 12:37:08 rivo volumio[4364]: Updating browse sources language Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::initPlayerControls Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: Express server listening on port 3000 Oct 13 12:37:08 rivo volumio[4364]: [Metrics] WebUI: 12s 719.19ms Oct 13 12:37:08 rivo volumio[4364]: info: CoreStateMachine::resetVolumioState Oct 13 12:37:08 rivo volumio[4364]: info: CoreStateMachine::getcurrentVolume Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 12:37:08 rivo volumio[4364]: info: CoreStateMachine::pushState Oct 13 12:37:08 rivo volumio[4364]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:08 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:37:08 rivo volumio[4364]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 13 12:37:08 rivo volumio[4364]: info: Completed loading Core Plugins Oct 13 12:37:08 rivo volumio[4364]: info: Preparing to generate the ALSA configuration file Oct 13 12:37:09 rivo volumio[4364]: info: Volumio Network Manager: Network status updated: 1 Oct 13 12:37:09 rivo volumio[4364]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 13 12:37:09 rivo volumio[4364]: verbose: New Socket.io Connection to rivo.local from 192.168.1.31 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/27.0.1 Safari/605.1.15 Engine version: 3 Transport: websocket Total Clients: 1 Oct 13 12:37:09 rivo volumio[4364]: info: Reloading queue from file Oct 13 12:37:09 rivo volumio[4364]: info: CoreStateMachine::setRepeat null single undefined Oct 13 12:37:09 rivo volumio[4364]: info: CoreStateMachine::pushState Oct 13 12:37:09 rivo volumio[4364]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:09 rivo volumio[4364]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:09 rivo volumio[4364]: info: CoreStateMachine::setRandom null Oct 13 12:37:09 rivo volumio[4364]: info: CoreStateMachine::pushState Oct 13 12:37:09 rivo volumio[4364]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:09 rivo volumio[4364]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:09 rivo volumio[4364]: Searching plugin music_service/webradio Oct 13 12:37:09 rivo volumio[4364]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 13 12:37:09 rivo volumio[4364]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:37:09 rivo volumio[4364]: TypeError: Cannot read properties of undefined (reading 'search') Oct 13 12:37:09 rivo volumio[4364]: at ControllerWebradio.searchWithTuneIn (/volumio/app/plugins/music_service/webradio/index.js:1009:34) Oct 13 12:37:09 rivo volumio[4364]: at ControllerWebradio.search (/volumio/app/plugins/music_service/webradio/index.js:866:26) Oct 13 12:37:09 rivo volumio[4364]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 13 12:37:09 rivo volumio[4364]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:477:37) Oct 13 12:37:09 rivo volumio[4364]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Oct 13 12:37:09 rivo volumio[4364]: at Socket.emit (node:events:514:28) Oct 13 12:37:09 rivo volumio[4364]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 13 12:37:09 rivo volumio[4364]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 13 12:37:09 rivo volumio[4364]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:37:10 rivo sudo[4548]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 12:36' Oct 13 12:37:10 rivo sudo[4548]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:10 rivo sudo[4548]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:10 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:10 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 13 12:37:10 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 13 12:37:10 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 13 12:37:11 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Oct 13 12:37:11 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 13 12:37:11 rivo systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 13 12:37:11 rivo systemd[1]: Started volumio.service - Volumio Backend Module. Oct 13 12:37:11 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 13 12:37:12 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:13 rivo volumio[4569]: info: ------------------------------------------- Oct 13 12:37:13 rivo volumio[4569]: info: ----- Volumio3 ---- Oct 13 12:37:13 rivo volumio[4569]: info: ------------------------------------------- Oct 13 12:37:13 rivo volumio[4569]: info: ----- System startup ---- Oct 13 12:37:13 rivo volumio[4569]: info: ------------------------------------------- Oct 13 12:37:13 rivo volumio[4569]: info: MYVOLUMIO Environment detected Oct 13 12:37:14 rivo volumio[4569]: info: Plugin folders cleanup Oct 13 12:37:14 rivo volumio[4569]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category audio_interface Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category miscellanea Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category music_service Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category plugins.json Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category system_controller Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category user_interface Oct 13 12:37:14 rivo volumio[4569]: info: Scanning into folder /data/plugins/ Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category audio_interface Oct 13 12:37:14 rivo volumio[4569]: info: Scanning category music_service Oct 13 12:37:14 rivo volumio[4569]: info: Plugin folders cleanup completed Oct 13 12:37:14 rivo volumio[4569]: info: ------------------------------------------- Oct 13 12:37:14 rivo volumio[4569]: info: ----- Core plugins startup ---- Oct 13 12:37:14 rivo volumio[4569]: info: ------------------------------------------- Oct 13 12:37:14 rivo volumio[4569]: info: Loading plugins from folder /volumio/app/plugins/ Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin bluetooth to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin multiroom to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin upnp to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin metavolumio to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin cd_controller to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin raat to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 13 12:37:14 rivo volumio[4569]: info: Loading plugins from folder /data/plugins/ Oct 13 12:37:14 rivo volumio[4569]: info: Loading plugin "system"... Oct 13 12:37:14 rivo volumio[4569]: info: Loading plugin "appearance"... Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "network"... Oct 13 12:37:15 rivo volumio[4569]: info: Refreshing Cached IP Addresses Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "services"... Oct 13 12:37:15 rivo sudo[4595]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:37:15 rivo sudo[4595]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "volumio5onboarding"... Oct 13 12:37:15 rivo sudo[4595]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "alsa_controller"... Oct 13 12:37:15 rivo sudo[4597]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:37:15 rivo sudo[4597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:15 rivo sudo[4597]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:15 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "wizard"... Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "networkfs"... Oct 13 12:37:15 rivo volumio[4569]: info: Starting Udev Watcher for removable devices Oct 13 12:37:15 rivo volumio[4569]: info: Mounting Device EFI Oct 13 12:37:15 rivo sudo[4626]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 13 12:37:15 rivo sudo[4626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:15 rivo sudo[4626]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:15 rivo volumio[4569]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Oct 13 12:37:15 rivo volumio[4569]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:15 rivo volumio[4569]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 13 12:37:15 rivo volumio[4569]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Oct 13 12:37:15 rivo volumio[4569]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:15 rivo volumio[4569]: info: Mounting Device CORSAIR2 Oct 13 12:37:15 rivo sudo[4632]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/CORSAIR2 -o noatime Oct 13 12:37:15 rivo sudo[4632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:15 rivo sudo[4632]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:15 rivo volumio[4569]: mount: /media/CORSAIR2: /dev/sda2 already mounted on /media/CORSAIR2. Oct 13 12:37:15 rivo volumio[4569]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:15 rivo volumio[4569]: error: Failed to mount CORSAIR2: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/CORSAIR2" -o noatime Oct 13 12:37:15 rivo volumio[4569]: mount: /media/CORSAIR2: /dev/sda2 already mounted on /media/CORSAIR2. Oct 13 12:37:15 rivo volumio[4569]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:15 rivo volumio[4569]: info: Ignoring mount for partition: BOOT Oct 13 12:37:15 rivo volumio[4569]: info: Ignoring mount for partition: volumio Oct 13 12:37:15 rivo volumio[4569]: info: Ignoring mount for partition: volumio_data Oct 13 12:37:15 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "volumio_command_line_client"... Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "upnp"... Oct 13 12:37:15 rivo volumio[4569]: info: [1791884235769] Starting Upmpd Daemon Oct 13 12:37:15 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "my_music"... Oct 13 12:37:15 rivo volumio[4569]: info: Loading plugin "mpd"... Oct 13 12:37:16 rivo volumio[4569]: info: Plugin upnp_browser is not enabled Oct 13 12:37:16 rivo volumio[4569]: info: Plugin bluetooth is not enabled Oct 13 12:37:16 rivo volumio[4569]: info: Loading plugin "alarm-clock"... Oct 13 12:37:16 rivo volumio[4569]: info: Loading plugin "manifestui"... Oct 13 12:37:16 rivo volumio[4569]: info: Loading plugin "metavolumio"... Oct 13 12:37:17 rivo volumio[4569]: info: Loading plugin "novaui"... Oct 13 12:37:17 rivo volumio[4569]: info: Applying required configuration parameters for plugin novaui Oct 13 12:37:17 rivo volumio[4569]: info: Plugin airplay_emulation is not enabled Oct 13 12:37:17 rivo volumio[4569]: info: Plugin cd_controller is not enabled Oct 13 12:37:17 rivo volumio[4569]: info: Loading plugin "last_100"... Oct 13 12:37:17 rivo volumio[4569]: info: Plugin qobuzconnect is not enabled Oct 13 12:37:17 rivo volumio[4569]: info: Plugin raat is not enabled Oct 13 12:37:17 rivo volumio[4569]: info: Loading plugin "streaming_services"... Oct 13 12:37:18 rivo volumio[4569]: info: Plugin tidalconnect is not enabled Oct 13 12:37:18 rivo volumio[4569]: info: Loading plugin "webradio"... Oct 13 12:37:19 rivo volumio-remote-updater[2950]: [2026-10-13 12:37:19] [connect] Successful connection Oct 13 12:37:19 rivo volumio[4569]: info: Loading plugin "i2s_dacs"... Oct 13 12:37:19 rivo volumio[4569]: info: I2S DAC not set, start Auto-detection Oct 13 12:37:19 rivo volumio[4569]: info: Loading plugin "volumiodiscovery"... Oct 13 12:37:20 rivo volumio[4569]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:20 rivo volumio[4569]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:20 rivo volumio[4569]: *** WARNING *** For more information see Oct 13 12:37:20 rivo volumio[4569]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:20 rivo volumio[4569]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:20 rivo node[4569]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:20 rivo volumio[4569]: *** WARNING *** For more information see Oct 13 12:37:20 rivo node[4569]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:20 rivo node[4569]: *** WARNING *** For more information see Oct 13 12:37:20 rivo node[4569]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:20 rivo node[4569]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:20 rivo node[4569]: *** WARNING *** For more information see Oct 13 12:37:20 rivo volumio[4569]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 13 12:37:20 rivo volumio[4569]: info: Discovery: Started advertising with name: Rivo Oct 13 12:37:20 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:20 rivo volumio[4569]: info: Plugin rp2 is not enabled Oct 13 12:37:20 rivo volumio[4569]: info: Plugin multiroom is not enabled Oct 13 12:37:20 rivo volumio[4569]: info: Loading plugin "outputs"... Oct 13 12:37:20 rivo volumio[4569]: info: Loading plugin "albumart"... Oct 13 12:37:20 rivo volumio[4569]: info: Plugin example_plugin is not enabled Oct 13 12:37:20 rivo volumio[4569]: info: Loading plugin "hi_res_audio"... Oct 13 12:37:20 rivo volumio[4639]: Forking 3 albumart workers Oct 13 12:37:21 rivo volumio[4569]: info: Applying required configuration parameters for plugin hi_res_audio Oct 13 12:37:21 rivo volumio[4569]: info: Loading plugin "inputs"... Oct 13 12:37:21 rivo volumio[4647]: Starting albumart workers Oct 13 12:37:22 rivo volumio[4648]: Starting albumart workers Oct 13 12:37:22 rivo volumio[4646]: Starting albumart workers Oct 13 12:37:22 rivo volumio[4569]: info: Loading plugin "qobuz"... Oct 13 12:37:22 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:23 rivo volumio[4569]: info: Plugin smart_inputs is not enabled Oct 13 12:37:23 rivo volumio[4569]: info: Loading plugin "tidal"... Oct 13 12:37:24 rivo volumio[4569]: info: Loading plugin "rivocontrol"... Oct 13 12:37:24 rivo volumio[4569]: info: Adding this device properties Oct 13 12:37:24 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 13 12:37:24 rivo volumio[4569]: info: Setting Additional Device Volumio Properties: [object Object] Oct 13 12:37:24 rivo volumio[4569]: info: Loading plugin "updater_comm"... Oct 13 12:37:24 rivo volumio[4569]: info: Loading plugin "cec_controller"... Oct 13 12:37:25 rivo volumio[4569]: info: Applying required configuration parameters for plugin cec_controller Oct 13 12:37:25 rivo volumio[4569]: info: Plugin mpdemulation is not enabled Oct 13 12:37:25 rivo volumio[4569]: info: Loading plugin "rest_api"... Oct 13 12:37:25 rivo volumio[4569]: info: Loading plugin "websocket"... Oct 13 12:37:25 rivo volumio[4569]: info: Starting Socket.io Server version 1.7.4 Oct 13 12:37:25 rivo volumio[4569]: info: Plugin fusiondsp is not enabled Oct 13 12:37:25 rivo volumio[4569]: info: Loading i18n strings for locale en Oct 13 12:37:25 rivo volumio[4569]: Updating browse sources language Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::initPlayerControls Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: Express server listening on port 3000 Oct 13 12:37:25 rivo volumio[4569]: [Metrics] WebUI: 12s 727.79ms Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::resetVolumioState Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::getcurrentVolume Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::pushState Oct 13 12:37:25 rivo volumio[4569]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:37:25 rivo volumio[4569]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 13 12:37:25 rivo volumio[4569]: info: Completed loading Core Plugins Oct 13 12:37:25 rivo volumio[4569]: info: Preparing to generate the ALSA configuration file Oct 13 12:37:25 rivo volumio[4569]: info: Volumio Network Manager: Network status updated: 1 Oct 13 12:37:25 rivo volumio[4569]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 13 12:37:25 rivo volumio[4569]: verbose: New Socket.io Connection to rivo.local from 192.168.1.31 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/27.0.1 Safari/605.1.15 Engine version: 3 Transport: websocket Total Clients: 1 Oct 13 12:37:25 rivo volumio[4569]: info: Reloading queue from file Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioGetVisibleSources Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:25 rivo volumio[4569]: info: Received Get System Version Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:37:25 rivo volumio[4569]: info: Received Get System Info Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:37:25 rivo volumio[4569]: info: Discovery: Getting this device information Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioGetState Oct 13 12:37:25 rivo volumio[4569]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 13 12:37:25 rivo sudo[4718]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 13 12:37:25 rivo sudo[4718]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4724]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 13 12:37:25 rivo sudo[4724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4729]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 13 12:37:25 rivo sudo[4729]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4718]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo volumio[4569]: info: CALLMETHOD: miscellanea novaui getTheme [object Object] Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: Error getting the SSID Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: novaui , getTheme Oct 13 12:37:25 rivo sudo[4729]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioGetState Oct 13 12:37:25 rivo volumio[4569]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioGetQueue Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::getQueue Oct 13 12:37:25 rivo volumio[4569]: info: CorePlayQueue::getQueue Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: Error getting the SSID Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo sudo[4724]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo sudo[4741]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:37:25 rivo sudo[4741]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4736]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 13 12:37:25 rivo sudo[4736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: Error getting the SSID Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:37:25 rivo sudo[4736]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo sudo[4744]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:37:25 rivo sudo[4744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4741]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo sudo[4744]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::setRepeat null single undefined Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::pushState Oct 13 12:37:25 rivo volumio[4569]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::setRandom null Oct 13 12:37:25 rivo volumio[4569]: info: CoreStateMachine::pushState Oct 13 12:37:25 rivo volumio[4569]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:25 rivo volumio[4569]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:25 rivo sudo[4753]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:37:25 rivo sudo[4753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4755]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:37:25 rivo sudo[4755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:25 rivo sudo[4753]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:25 rivo sudo[4755]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo volumio[4569]: info: Asound.conf file unchanged, so no further update is needed Oct 13 12:37:26 rivo volumio[4569]: info: Output device has changed, restarting MPD Oct 13 12:37:26 rivo volumio[4569]: info: ___________ START PLUGINS ___________ Oct 13 12:37:26 rivo sudo[4762]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 13 12:37:26 rivo sudo[4762]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4762]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo volumio[4569]: info: ControllerMpd::onStart: Initializing MPD Oct 13 12:37:26 rivo sudo[4764]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 13 12:37:26 rivo volumio[4569]: info: Creating MPD Configuration file Oct 13 12:37:26 rivo sudo[4764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 13 12:37:26 rivo sudo[4767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo volumio[4569]: info: Adding METAVOLUMIO REST API Endpoints Oct 13 12:37:26 rivo volumio[4569]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:37:26 rivo volumio[4569]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:37:26 rivo volumio[4569]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:37:26 rivo volumio[4569]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:37:26 rivo volumio[4569]: info: Nova UI: unpacking bundled version 0.260915.4 Oct 13 12:37:26 rivo sudo[4770]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 13 12:37:26 rivo sudo[4770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:37:26 rivo volumio[4569]: info: [1791884246116] CoreMusicLibrary::Adding element Last_100 Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:26 rivo volumio[4569]: info: Streaming services startup Oct 13 12:37:26 rivo volumio[4569]: info: Starting Streaming Daemon Oct 13 12:37:26 rivo sudo[4773]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 13 12:37:26 rivo sudo[4773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4770]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:26 rivo sudo[4767]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:37:26 rivo volumio[4569]: info: [1791884246203] CoreMusicLibrary::Adding element Webradio Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:26 rivo sudo[4781]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 13 12:37:26 rivo sudo[4781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:37:26 rivo volumio[4569]: info: Initializing BBC Radios Oct 13 12:37:26 rivo volumio5-onboarding[4779]: time=2026-10-13T12:37:26.230+03:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 13 12:37:26 rivo systemd[1]: mpd.service: Deactivated successfully. Oct 13 12:37:26 rivo systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 13 12:37:26 rivo systemd[1]: mpd.socket: Deactivated successfully. Oct 13 12:37:26 rivo systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 13 12:37:26 rivo systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 13 12:37:26 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:37:26 rivo volumio[4569]: error: Hi Res Audio Failed Login: Missing Login Data Oct 13 12:37:26 rivo volumio[4569]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 13 12:37:26 rivo volumio[4569]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 13 12:37:26 rivo volumio[4569]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 13 12:37:26 rivo volumio[4569]: info: Touch Event Listener Process Starting Oct 13 12:37:26 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 13 12:37:26 rivo volumio[4569]: info: Adding TIDAL to Browse Sources Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:37:26 rivo volumio[4569]: info: [1791884246319] CoreMusicLibrary::Adding element TIDAL Oct 13 12:37:26 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:26 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Oct 13 12:37:26 rivo volumio[4569]: Cannot find translation for source TIDAL Oct 13 12:37:26 rivo volumio[4569]: info: Refreshing TIDAL token Oct 13 12:37:26 rivo sudo[4781]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo sudo[4814]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 13 12:37:26 rivo sudo[4814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4814]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo sudo[4818]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 13 12:37:26 rivo sudo[4818]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4818]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo sudo[4821]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 13 12:37:26 rivo sudo[4821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4821]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo sudo[4824]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 13 12:37:26 rivo sudo[4824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4824]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo sudo[4827]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 13 12:37:26 rivo sudo[4827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4827]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo volumio[4569]: info: Apply VIM3L Onboard LEDs Settings Oct 13 12:37:26 rivo volumio[4569]: info: Turning On Onboard LEDs Oct 13 12:37:26 rivo volumio[4569]: info: Starting CEC Event listener Oct 13 12:37:26 rivo volumio[4569]: info: Volumio Calling Home Oct 13 12:37:26 rivo sudo[4831]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 13 12:37:26 rivo sudo[4831]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo sudo[4831]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo sudo[4838]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 13 12:37:26 rivo sudo[4838]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:26 rivo volumio[4569]: info: Stopping AccessToken refresher cron for QOBUZ Oct 13 12:37:26 rivo sudo[4838]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:26 rivo volumio[4569]: info: AccessToken refresher cron started for QOBUZ Oct 13 12:37:26 rivo volumio[4569]: info: Adding QOBUZ REST API Endpoints Oct 13 12:37:26 rivo sudo[4815]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 13 12:37:26 rivo sudo[4815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 12:37:26 rivo sudo[4815]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:27 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:27 rivo volumio[4569]: info: Serial port opened successfully Oct 13 12:37:27 rivo volumio[4569]: info: Sending serial start messages Oct 13 12:37:27 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:27 rivo volumio[4569]: info: Reporting MCU Network Status: 1 Oct 13 12:37:27 rivo volumio[4569]: info: MP1 GPIO: Signalled system ready via GPIO Oct 13 12:37:27 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 13 12:37:27 rivo volumio[4569]: Searching all installed plugins Oct 13 12:37:27 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:27 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: , search Oct 13 12:37:27 rivo volumio[4569]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 13 12:37:27 rivo volumio[4569]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:37:27 rivo volumio[4569]: TypeError: Cannot read properties of undefined (reading 'then') Oct 13 12:37:27 rivo volumio[4569]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1596:17) Oct 13 12:37:27 rivo volumio[4569]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 13 12:37:27 rivo volumio[4569]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Oct 13 12:37:27 rivo volumio[4569]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Oct 13 12:37:27 rivo volumio[4569]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Oct 13 12:37:27 rivo volumio[4569]: at Socket.emit (node:events:514:28) Oct 13 12:37:27 rivo volumio[4569]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 13 12:37:27 rivo volumio[4569]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 13 12:37:27 rivo volumio[4569]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:37:28 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:28 rivo sudo[4855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 12:36' Oct 13 12:37:28 rivo sudo[4855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:28 rivo sudo[4855]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:28 rivo volumio5-onboarding[4779]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:42958->127.0.0.1:3000: read: connection reset by peer Oct 13 12:37:28 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:28 rivo sudo[4764]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:28 rivo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:28 rivo sudo[4773]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:28 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Oct 13 12:37:29 rivo systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:29 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:29 rivo volumio5-onboarding[4862]: time=2026-10-13T12:37:29.319+03:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 13 12:37:29 rivo volumio5-onboarding[4862]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: dial tcp 127.0.0.1:3000: connect: connection refused Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 12:37:29 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 13 12:37:29 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 13 12:37:29 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Oct 13 12:37:29 rivo systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:29 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:29 rivo volumio5-onboarding[4876]: time=2026-10-13T12:37:29.514+03:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 13 12:37:29 rivo volumio5-onboarding[4876]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: dial tcp 127.0.0.1:3000: connect: connection refused Oct 13 12:37:29 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 12:37:29 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 13 12:37:29 rivo systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 13 12:37:29 rivo systemd[1]: Started volumio.service - Volumio Backend Module. Oct 13 12:37:29 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 3. Oct 13 12:37:29 rivo systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:29 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:29 rivo volumio5-onboarding[4898]: time=2026-10-13T12:37:29.831+03:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 13 12:37:29 rivo volumio5-onboarding[4898]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: dial tcp 127.0.0.1:3000: connect: connection refused Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:29 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 12:37:30 rivo mpd[4845]: 2026-10-13T12:37:29 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 13 12:37:30 rivo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 4. Oct 13 12:37:30 rivo systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:30 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:30 rivo volumio5-onboarding[4906]: time=2026-10-13T12:37:30.090+03:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 13 12:37:30 rivo volumio5-onboarding[4906]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: dial tcp 127.0.0.1:3000: connect: connection refused Oct 13 12:37:30 rivo systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:30 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 12:37:30 rivo systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 5. Oct 13 12:37:30 rivo systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:30 rivo systemd[1]: volumio5-onboarding.service: Start request repeated too quickly. Oct 13 12:37:30 rivo systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 13 12:37:30 rivo systemd[1]: Failed to start volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:37:30 rivo systemd[1]: Started mpd.service - Music Player Daemon. Oct 13 12:37:31 rivo volumio[4889]: info: ------------------------------------------- Oct 13 12:37:31 rivo volumio[4889]: info: ----- Volumio3 ---- Oct 13 12:37:31 rivo volumio[4889]: info: ------------------------------------------- Oct 13 12:37:31 rivo volumio[4889]: info: ----- System startup ---- Oct 13 12:37:31 rivo volumio[4889]: info: ------------------------------------------- Oct 13 12:37:32 rivo volumio[4889]: info: MYVOLUMIO Environment detected Oct 13 12:37:32 rivo volumio[4889]: info: Plugin folders cleanup Oct 13 12:37:32 rivo volumio[4889]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category audio_interface Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category miscellanea Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category music_service Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category plugins.json Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category system_controller Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category user_interface Oct 13 12:37:32 rivo volumio[4889]: info: Scanning into folder /data/plugins/ Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category audio_interface Oct 13 12:37:32 rivo volumio[4889]: info: Scanning category music_service Oct 13 12:37:32 rivo volumio[4889]: info: Plugin folders cleanup completed Oct 13 12:37:32 rivo volumio[4889]: info: ------------------------------------------- Oct 13 12:37:32 rivo volumio[4889]: info: ----- Core plugins startup ---- Oct 13 12:37:32 rivo volumio[4889]: info: ------------------------------------------- Oct 13 12:37:32 rivo volumio[4889]: info: Loading plugins from folder /volumio/app/plugins/ Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin bluetooth to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin multiroom to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin upnp to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin metavolumio to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin cd_controller to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin raat to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 13 12:37:32 rivo volumio[4889]: info: Loading plugins from folder /data/plugins/ Oct 13 12:37:32 rivo volumio[4889]: info: Loading plugin "system"... Oct 13 12:37:32 rivo volumio[4889]: info: Loading plugin "appearance"... Oct 13 12:37:33 rivo volumio[4889]: info: Loading plugin "network"... Oct 13 12:37:33 rivo volumio[4889]: info: Refreshing Cached IP Addresses Oct 13 12:37:33 rivo sudo[4931]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:37:33 rivo sudo[4931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:33 rivo sudo[4933]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:37:33 rivo volumio[4889]: info: Loading plugin "services"... Oct 13 12:37:33 rivo volumio[4889]: info: Loading plugin "volumio5onboarding"... Oct 13 12:37:33 rivo sudo[4933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:33 rivo sudo[4931]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:33 rivo volumio[4889]: info: Loading plugin "alsa_controller"... Oct 13 12:37:33 rivo sudo[4933]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:34 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "wizard"... Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "networkfs"... Oct 13 12:37:34 rivo volumio[4889]: info: Starting Udev Watcher for removable devices Oct 13 12:37:34 rivo volumio-remote-updater[2950]: [2026-10-13 12:37:34] [connect] Successful connection Oct 13 12:37:34 rivo volumio[4889]: info: Mounting Device EFI Oct 13 12:37:34 rivo sudo[4962]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 13 12:37:34 rivo sudo[4962]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:34 rivo sudo[4962]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:34 rivo volumio[4889]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Oct 13 12:37:34 rivo volumio[4889]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:34 rivo volumio[4889]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 13 12:37:34 rivo volumio[4889]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Oct 13 12:37:34 rivo volumio[4889]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:34 rivo volumio[4889]: info: Mounting Device CORSAIR2 Oct 13 12:37:34 rivo sudo[4968]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/CORSAIR2 -o noatime Oct 13 12:37:34 rivo sudo[4968]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:34 rivo sudo[4968]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:34 rivo volumio[4889]: mount: /media/CORSAIR2: /dev/sda2 already mounted on /media/CORSAIR2. Oct 13 12:37:34 rivo volumio[4889]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:34 rivo volumio[4889]: error: Failed to mount CORSAIR2: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/CORSAIR2" -o noatime Oct 13 12:37:34 rivo volumio[4889]: mount: /media/CORSAIR2: /dev/sda2 already mounted on /media/CORSAIR2. Oct 13 12:37:34 rivo volumio[4889]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:34 rivo volumio[4889]: info: Ignoring mount for partition: BOOT Oct 13 12:37:34 rivo volumio[4889]: info: Ignoring mount for partition: volumio Oct 13 12:37:34 rivo volumio[4889]: info: Ignoring mount for partition: volumio_data Oct 13 12:37:34 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "volumio_command_line_client"... Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "upnp"... Oct 13 12:37:34 rivo volumio[4889]: info: [1791884254320] Starting Upmpd Daemon Oct 13 12:37:34 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "my_music"... Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "mpd"... Oct 13 12:37:34 rivo volumio[4889]: info: Plugin upnp_browser is not enabled Oct 13 12:37:34 rivo volumio[4889]: info: Plugin bluetooth is not enabled Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "alarm-clock"... Oct 13 12:37:34 rivo volumio[4889]: info: Loading plugin "manifestui"... Oct 13 12:37:35 rivo volumio[4889]: info: Loading plugin "metavolumio"... Oct 13 12:37:36 rivo volumio[4889]: info: Loading plugin "novaui"... Oct 13 12:37:36 rivo volumio[4889]: info: Applying required configuration parameters for plugin novaui Oct 13 12:37:36 rivo volumio[4889]: info: Plugin airplay_emulation is not enabled Oct 13 12:37:36 rivo volumio[4889]: info: Plugin cd_controller is not enabled Oct 13 12:37:36 rivo volumio[4889]: info: Loading plugin "last_100"... Oct 13 12:37:36 rivo volumio[4889]: info: Plugin qobuzconnect is not enabled Oct 13 12:37:36 rivo volumio[4889]: info: Plugin raat is not enabled Oct 13 12:37:36 rivo volumio[4889]: info: Loading plugin "streaming_services"... Oct 13 12:37:37 rivo volumio[4889]: info: Plugin tidalconnect is not enabled Oct 13 12:37:37 rivo volumio[4889]: info: Loading plugin "webradio"... Oct 13 12:37:37 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:38 rivo volumio[4889]: info: Loading plugin "i2s_dacs"... Oct 13 12:37:38 rivo volumio[4889]: info: I2S DAC not set, start Auto-detection Oct 13 12:37:38 rivo volumio[4889]: info: Loading plugin "volumiodiscovery"... Oct 13 12:37:38 rivo volumio[4889]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:38 rivo volumio[4889]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:38 rivo volumio[4889]: *** WARNING *** For more information see Oct 13 12:37:38 rivo volumio[4889]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:38 rivo volumio[4889]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:38 rivo node[4889]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:38 rivo volumio[4889]: *** WARNING *** For more information see Oct 13 12:37:38 rivo node[4889]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:38 rivo node[4889]: *** WARNING *** For more information see Oct 13 12:37:38 rivo node[4889]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:38 rivo node[4889]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:38 rivo node[4889]: *** WARNING *** For more information see Oct 13 12:37:38 rivo volumio[4889]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 13 12:37:38 rivo volumio[4889]: info: Discovery: Started advertising with name: Rivo Oct 13 12:37:38 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:38 rivo volumio[4889]: info: Plugin rp2 is not enabled Oct 13 12:37:38 rivo volumio[4889]: info: Plugin multiroom is not enabled Oct 13 12:37:38 rivo volumio[4889]: info: Loading plugin "outputs"... Oct 13 12:37:38 rivo volumio[4889]: info: Loading plugin "albumart"... Oct 13 12:37:38 rivo volumio[4889]: info: Plugin example_plugin is not enabled Oct 13 12:37:38 rivo volumio[4889]: info: Loading plugin "hi_res_audio"... Oct 13 12:37:39 rivo volumio[4975]: Forking 3 albumart workers Oct 13 12:37:40 rivo volumio[4889]: info: Applying required configuration parameters for plugin hi_res_audio Oct 13 12:37:40 rivo volumio[4889]: info: Loading plugin "inputs"... Oct 13 12:37:40 rivo volumio[4984]: Starting albumart workers Oct 13 12:37:40 rivo volumio[4983]: Starting albumart workers Oct 13 12:37:40 rivo volumio[4982]: Starting albumart workers Oct 13 12:37:40 rivo volumio[4889]: info: Loading plugin "qobuz"... Oct 13 12:37:42 rivo volumio[4889]: info: Plugin smart_inputs is not enabled Oct 13 12:37:42 rivo volumio[4889]: info: Loading plugin "tidal"... Oct 13 12:37:42 rivo volumio[4889]: info: Loading plugin "rivocontrol"... Oct 13 12:37:43 rivo volumio[4889]: info: Adding this device properties Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 13 12:37:43 rivo volumio[4889]: info: Setting Additional Device Volumio Properties: [object Object] Oct 13 12:37:43 rivo volumio[4889]: info: Loading plugin "updater_comm"... Oct 13 12:37:43 rivo volumio[4889]: info: Loading plugin "cec_controller"... Oct 13 12:37:43 rivo volumio[4889]: info: Applying required configuration parameters for plugin cec_controller Oct 13 12:37:43 rivo volumio[4889]: info: Plugin mpdemulation is not enabled Oct 13 12:37:43 rivo volumio[4889]: info: Loading plugin "rest_api"... Oct 13 12:37:43 rivo volumio[4889]: info: Loading plugin "websocket"... Oct 13 12:37:43 rivo volumio[4889]: info: Starting Socket.io Server version 1.7.4 Oct 13 12:37:43 rivo volumio[4889]: info: Plugin fusiondsp is not enabled Oct 13 12:37:43 rivo volumio[4889]: info: Loading i18n strings for locale en Oct 13 12:37:43 rivo volumio[4889]: Updating browse sources language Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::initPlayerControls Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: Express server listening on port 3000 Oct 13 12:37:43 rivo volumio[4889]: [Metrics] WebUI: 12s 696.31ms Oct 13 12:37:43 rivo volumio[4889]: info: CoreStateMachine::resetVolumioState Oct 13 12:37:43 rivo volumio[4889]: info: CoreStateMachine::getcurrentVolume Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 12:37:43 rivo volumio[4889]: info: CoreStateMachine::pushState Oct 13 12:37:43 rivo volumio[4889]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:43 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:37:43 rivo volumio[4889]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 13 12:37:43 rivo volumio[4889]: info: Completed loading Core Plugins Oct 13 12:37:43 rivo volumio[4889]: info: Preparing to generate the ALSA configuration file Oct 13 12:37:43 rivo volumio[4889]: info: Volumio Network Manager: Network status updated: 1 Oct 13 12:37:44 rivo volumio[4889]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 13 12:37:44 rivo volumio[4889]: verbose: New Socket.io Connection to rivo.local from 192.168.1.31 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/27.0.1 Safari/605.1.15 Engine version: 3 Transport: websocket Total Clients: 1 Oct 13 12:37:44 rivo volumio[4889]: info: Reloading queue from file Oct 13 12:37:44 rivo volumio[4889]: info: CoreStateMachine::setRepeat null single undefined Oct 13 12:37:44 rivo volumio[4889]: info: CoreStateMachine::pushState Oct 13 12:37:44 rivo volumio[4889]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:44 rivo volumio[4889]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:44 rivo volumio[4889]: info: CoreStateMachine::setRandom null Oct 13 12:37:44 rivo volumio[4889]: info: CoreStateMachine::pushState Oct 13 12:37:44 rivo volumio[4889]: info: CorePlayQueue::getTrack 0 Oct 13 12:37:44 rivo volumio[4889]: info: CoreCommandRouter::volumioPushState Oct 13 12:37:44 rivo volumio[4889]: Searching plugin music_service/webradio Oct 13 12:37:44 rivo volumio[4889]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 13 12:37:44 rivo volumio[4889]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:37:44 rivo volumio[4889]: TypeError: Cannot read properties of undefined (reading 'search') Oct 13 12:37:44 rivo volumio[4889]: at ControllerWebradio.searchWithTuneIn (/volumio/app/plugins/music_service/webradio/index.js:1009:34) Oct 13 12:37:44 rivo volumio[4889]: at ControllerWebradio.search (/volumio/app/plugins/music_service/webradio/index.js:866:26) Oct 13 12:37:44 rivo volumio[4889]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 13 12:37:44 rivo volumio[4889]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:477:37) Oct 13 12:37:44 rivo volumio[4889]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Oct 13 12:37:44 rivo volumio[4889]: at Socket.emit (node:events:514:28) Oct 13 12:37:44 rivo volumio[4889]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 13 12:37:44 rivo volumio[4889]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 13 12:37:44 rivo volumio[4889]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:37:45 rivo sudo[5063]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 12:36' Oct 13 12:37:45 rivo sudo[5063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:45 rivo sudo[5063]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:45 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 13 12:37:45 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 13 12:37:45 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 13 12:37:45 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 13 12:37:46 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6. Oct 13 12:37:46 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 13 12:37:46 rivo systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 13 12:37:46 rivo systemd[1]: Started volumio.service - Volumio Backend Module. Oct 13 12:37:46 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 13 12:37:47 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:48 rivo volumio[5084]: info: ------------------------------------------- Oct 13 12:37:48 rivo volumio[5084]: info: ----- Volumio3 ---- Oct 13 12:37:48 rivo volumio[5084]: info: ------------------------------------------- Oct 13 12:37:48 rivo volumio[5084]: info: ----- System startup ---- Oct 13 12:37:48 rivo volumio[5084]: info: ------------------------------------------- Oct 13 12:37:48 rivo volumio[5084]: info: MYVOLUMIO Environment detected Oct 13 12:37:49 rivo volumio[5084]: info: Plugin folders cleanup Oct 13 12:37:49 rivo volumio[5084]: info: Scanning into folder /volumio/app/plugins/ Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category audio_interface Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category miscellanea Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category music_service Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category plugins.json Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category system_controller Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category user_interface Oct 13 12:37:49 rivo volumio[5084]: info: Scanning into folder /data/plugins/ Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category audio_interface Oct 13 12:37:49 rivo volumio[5084]: info: Scanning category music_service Oct 13 12:37:49 rivo volumio[5084]: info: Plugin folders cleanup completed Oct 13 12:37:49 rivo volumio[5084]: info: ------------------------------------------- Oct 13 12:37:49 rivo volumio[5084]: info: ----- Core plugins startup ---- Oct 13 12:37:49 rivo volumio[5084]: info: ------------------------------------------- Oct 13 12:37:49 rivo volumio-remote-updater[2950]: [2026-10-13 12:37:49] [connect] Successful connection Oct 13 12:37:49 rivo volumio[5084]: info: Loading plugins from folder /volumio/app/plugins/ Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin bluetooth to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin multiroom to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin upnp to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin metavolumio to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin cd_controller to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin raat to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 13 12:37:49 rivo volumio[5084]: info: Loading plugins from folder /data/plugins/ Oct 13 12:37:49 rivo volumio[5084]: info: Loading plugin "system"... Oct 13 12:37:49 rivo volumio[5084]: info: Loading plugin "appearance"... Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "network"... Oct 13 12:37:50 rivo volumio[5084]: info: Refreshing Cached IP Addresses Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "services"... Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "volumio5onboarding"... Oct 13 12:37:50 rivo sudo[5114]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:37:50 rivo sudo[5114]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:50 rivo sudo[5112]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:37:50 rivo sudo[5112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "alsa_controller"... Oct 13 12:37:50 rivo sudo[5114]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:50 rivo sudo[5112]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:50 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "wizard"... Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "networkfs"... Oct 13 12:37:50 rivo volumio[5084]: info: Starting Udev Watcher for removable devices Oct 13 12:37:50 rivo volumio[5084]: info: Mounting Device EFI Oct 13 12:37:50 rivo sudo[5143]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 13 12:37:50 rivo sudo[5143]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:50 rivo sudo[5143]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:50 rivo volumio[5084]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Oct 13 12:37:50 rivo volumio[5084]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:50 rivo volumio[5084]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 13 12:37:50 rivo volumio[5084]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Oct 13 12:37:50 rivo volumio[5084]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:50 rivo volumio[5084]: info: Mounting Device CORSAIR2 Oct 13 12:37:50 rivo sudo[5149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/CORSAIR2 -o noatime Oct 13 12:37:50 rivo sudo[5149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:37:50 rivo sudo[5149]: pam_unix(sudo:session): session closed for user root Oct 13 12:37:50 rivo volumio[5084]: mount: /media/CORSAIR2: /dev/sda2 already mounted on /media/CORSAIR2. Oct 13 12:37:50 rivo volumio[5084]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:50 rivo volumio[5084]: error: Failed to mount CORSAIR2: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/CORSAIR2" -o noatime Oct 13 12:37:50 rivo volumio[5084]: mount: /media/CORSAIR2: /dev/sda2 already mounted on /media/CORSAIR2. Oct 13 12:37:50 rivo volumio[5084]: dmesg(1) may have more information after failed mount system call. Oct 13 12:37:50 rivo volumio[5084]: info: Ignoring mount for partition: BOOT Oct 13 12:37:50 rivo volumio[5084]: info: Ignoring mount for partition: volumio Oct 13 12:37:50 rivo volumio[5084]: info: Ignoring mount for partition: volumio_data Oct 13 12:37:50 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "volumio_command_line_client"... Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "upnp"... Oct 13 12:37:50 rivo volumio[5084]: info: [1791884270776] Starting Upmpd Daemon Oct 13 12:37:50 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "my_music"... Oct 13 12:37:50 rivo volumio[5084]: info: Loading plugin "mpd"... Oct 13 12:37:51 rivo volumio[5084]: info: Plugin upnp_browser is not enabled Oct 13 12:37:51 rivo volumio[5084]: info: Plugin bluetooth is not enabled Oct 13 12:37:51 rivo volumio[5084]: info: Loading plugin "alarm-clock"... Oct 13 12:37:51 rivo volumio[5084]: info: Loading plugin "manifestui"... Oct 13 12:37:51 rivo volumio[5084]: info: Loading plugin "metavolumio"... Oct 13 12:37:52 rivo volumio[5084]: info: Loading plugin "novaui"... Oct 13 12:37:52 rivo volumio[5084]: info: Applying required configuration parameters for plugin novaui Oct 13 12:37:52 rivo volumio[5084]: info: Plugin airplay_emulation is not enabled Oct 13 12:37:52 rivo volumio[5084]: info: Plugin cd_controller is not enabled Oct 13 12:37:52 rivo volumio[5084]: info: Loading plugin "last_100"... Oct 13 12:37:52 rivo volumio[5084]: info: Plugin qobuzconnect is not enabled Oct 13 12:37:52 rivo volumio[5084]: info: Plugin raat is not enabled Oct 13 12:37:52 rivo volumio[5084]: info: Loading plugin "streaming_services"... Oct 13 12:37:53 rivo volumio[5084]: info: Plugin tidalconnect is not enabled Oct 13 12:37:53 rivo volumio[5084]: info: Loading plugin "webradio"... Oct 13 12:37:54 rivo volumio[5084]: info: Loading plugin "i2s_dacs"... Oct 13 12:37:54 rivo volumio[5084]: info: I2S DAC not set, start Auto-detection Oct 13 12:37:54 rivo volumio[5084]: info: Loading plugin "volumiodiscovery"... Oct 13 12:37:55 rivo volumio[5084]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:55 rivo volumio[5084]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:55 rivo volumio[5084]: *** WARNING *** For more information see Oct 13 12:37:55 rivo volumio[5084]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:55 rivo volumio[5084]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:55 rivo volumio[5084]: *** WARNING *** For more information see Oct 13 12:37:55 rivo node[5084]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:55 rivo node[5084]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:55 rivo node[5084]: *** WARNING *** For more information see Oct 13 12:37:55 rivo node[5084]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 12:37:55 rivo node[5084]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 12:37:55 rivo node[5084]: *** WARNING *** For more information see Oct 13 12:37:55 rivo volumio[5084]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 13 12:37:55 rivo volumio[5084]: info: Discovery: Started advertising with name: Rivo Oct 13 12:37:55 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 12:37:55 rivo volumio[5084]: info: Plugin rp2 is not enabled Oct 13 12:37:55 rivo volumio[5084]: info: Plugin multiroom is not enabled Oct 13 12:37:55 rivo volumio[5084]: info: Loading plugin "outputs"... Oct 13 12:37:55 rivo volumio[5084]: info: Loading plugin "albumart"... Oct 13 12:37:55 rivo volumio[5084]: info: Plugin example_plugin is not enabled Oct 13 12:37:55 rivo volumio[5084]: info: Loading plugin "hi_res_audio"... Oct 13 12:37:55 rivo volumio[5156]: Forking 3 albumart workers Oct 13 12:37:56 rivo volumio[5084]: info: Applying required configuration parameters for plugin hi_res_audio Oct 13 12:37:56 rivo volumio[5084]: info: Loading plugin "inputs"... Oct 13 12:37:57 rivo volumio[5164]: Starting albumart workers Oct 13 12:37:57 rivo volumio[5165]: Starting albumart workers Oct 13 12:37:57 rivo volumio[5163]: Starting albumart workers Oct 13 12:37:57 rivo volumio[5084]: info: Loading plugin "qobuz"... Oct 13 12:37:57 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:37:58 rivo volumio[5084]: info: Plugin smart_inputs is not enabled Oct 13 12:37:58 rivo volumio[5084]: info: Loading plugin "tidal"... Oct 13 12:37:59 rivo volumio[5084]: info: Loading plugin "rivocontrol"... Oct 13 12:37:59 rivo volumio[5084]: info: Adding this device properties Oct 13 12:37:59 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 13 12:37:59 rivo volumio[5084]: info: Setting Additional Device Volumio Properties: [object Object] Oct 13 12:37:59 rivo volumio[5084]: info: Loading plugin "updater_comm"... Oct 13 12:37:59 rivo volumio[5084]: info: Loading plugin "cec_controller"... Oct 13 12:38:00 rivo volumio[5084]: info: Applying required configuration parameters for plugin cec_controller Oct 13 12:38:00 rivo volumio[5084]: info: Plugin mpdemulation is not enabled Oct 13 12:38:00 rivo volumio[5084]: info: Loading plugin "rest_api"... Oct 13 12:38:00 rivo volumio[5084]: info: Loading plugin "websocket"... Oct 13 12:38:00 rivo volumio[5084]: info: Starting Socket.io Server version 1.7.4 Oct 13 12:38:00 rivo volumio[5084]: info: Plugin fusiondsp is not enabled Oct 13 12:38:00 rivo volumio[5084]: info: Loading i18n strings for locale en Oct 13 12:38:00 rivo volumio[5084]: Updating browse sources language Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::initPlayerControls Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: Express server listening on port 3000 Oct 13 12:38:00 rivo volumio[5084]: [Metrics] WebUI: 12s 697.47ms Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::resetVolumioState Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::getcurrentVolume Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::pushState Oct 13 12:38:00 rivo volumio[5084]: info: CorePlayQueue::getTrack 0 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioPushState Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:38:00 rivo volumio[5084]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 13 12:38:00 rivo volumio[5084]: info: Completed loading Core Plugins Oct 13 12:38:00 rivo volumio[5084]: info: Preparing to generate the ALSA configuration file Oct 13 12:38:00 rivo volumio[5084]: info: Volumio Network Manager: Network status updated: 1 Oct 13 12:38:00 rivo volumio[5084]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 13 12:38:00 rivo volumio[5084]: verbose: New Socket.io Connection to rivo.local from 192.168.1.31 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/27.0.1 Safari/605.1.15 Engine version: 3 Transport: websocket Total Clients: 1 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 13 12:38:00 rivo volumio[5084]: info: Reloading queue from file Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioGetVisibleSources Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:38:00 rivo volumio[5084]: info: Received Get System Version Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:38:00 rivo volumio[5084]: info: Received Get System Info Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 13 12:38:00 rivo volumio[5084]: info: Discovery: Getting this device information Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioGetState Oct 13 12:38:00 rivo volumio[5084]: info: CorePlayQueue::getTrack 0 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 13 12:38:00 rivo sudo[5235]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 13 12:38:00 rivo sudo[5235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5240]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 13 12:38:00 rivo sudo[5240]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5247]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 13 12:38:00 rivo sudo[5235]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo sudo[5247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: Error getting the SSID Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo sudo[5240]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo volumio[5084]: info: CALLMETHOD: miscellanea novaui getTheme [object Object] Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: novaui , getTheme Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: Error getting the SSID Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo sudo[5247]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioGetState Oct 13 12:38:00 rivo volumio[5084]: info: CorePlayQueue::getTrack 0 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioGetQueue Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::getQueue Oct 13 12:38:00 rivo volumio[5084]: info: CorePlayQueue::getQueue Oct 13 12:38:00 rivo sudo[5254]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 13 12:38:00 rivo sudo[5254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5258]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:38:00 rivo sudo[5258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: Error getting the SSID Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo kernel: dhd_ioctl_entry: Interface is down Oct 13 12:38:00 rivo sudo[5254]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo sudo[5263]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:38:00 rivo sudo[5263]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5258]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::setRepeat null single undefined Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::pushState Oct 13 12:38:00 rivo volumio[5084]: info: CorePlayQueue::getTrack 0 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioPushState Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::setRandom null Oct 13 12:38:00 rivo volumio[5084]: info: CoreStateMachine::pushState Oct 13 12:38:00 rivo volumio[5084]: info: CorePlayQueue::getTrack 0 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioPushState Oct 13 12:38:00 rivo sudo[5263]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo volumio[5084]: info: Asound.conf file unchanged, so no further update is needed Oct 13 12:38:00 rivo volumio[5084]: info: Output device has changed, restarting MPD Oct 13 12:38:00 rivo sudo[5271]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 12:38:00 rivo sudo[5271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5273]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 12:38:00 rivo sudo[5273]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo volumio[5084]: info: ___________ START PLUGINS ___________ Oct 13 12:38:00 rivo sudo[5271]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo sudo[5273]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo sudo[5275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 13 12:38:00 rivo sudo[5275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5275]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo volumio[5084]: info: ControllerMpd::onStart: Initializing MPD Oct 13 12:38:00 rivo volumio[5084]: info: Creating MPD Configuration file Oct 13 12:38:00 rivo sudo[5281]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 13 12:38:00 rivo sudo[5281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 13 12:38:00 rivo sudo[5284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo volumio[5084]: info: Adding METAVOLUMIO REST API Endpoints Oct 13 12:38:00 rivo volumio[5084]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:38:00 rivo volumio[5084]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:38:00 rivo volumio[5084]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:38:00 rivo volumio[5084]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 13 12:38:00 rivo volumio[5084]: info: Nova UI: unpacking bundled version 0.260915.4 Oct 13 12:38:00 rivo sudo[5286]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 13 12:38:00 rivo sudo[5286]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo sudo[5286]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:38:00 rivo volumio[5084]: info: [1791884280942] CoreMusicLibrary::Adding element Last_100 Oct 13 12:38:00 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:38:00 rivo volumio[5084]: info: Streaming services startup Oct 13 12:38:00 rivo volumio[5084]: info: Starting Streaming Daemon Oct 13 12:38:00 rivo sudo[5290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 13 12:38:00 rivo sudo[5290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:00 rivo systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 13 12:38:00 rivo systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 13 12:38:00 rivo sudo[5284]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:38:01 rivo volumio[5084]: info: [1791884281012] CoreMusicLibrary::Adding element Webradio Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:38:01 rivo sudo[5296]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 13 12:38:01 rivo sudo[5296]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo volumio[5084]: info: Initializing BBC Radios Oct 13 12:38:01 rivo volumio5-onboarding[5299]: time=2026-10-13T12:38:01.058+03:00 level=INFO msg="running volumio4-device-gateway" version=415db8e7+CHANGES buildDate=2026-09-15T15:08:58Z Oct 13 12:38:01 rivo sudo[5296]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 12:38:01 rivo volumio[5084]: error: Hi Res Audio Failed Login: Missing Login Data Oct 13 12:38:01 rivo volumio[5084]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 13 12:38:01 rivo volumio[5084]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 13 12:38:01 rivo volumio[5084]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 13 12:38:01 rivo systemd[1]: mpd.service: Deactivated successfully. Oct 13 12:38:01 rivo systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 13 12:38:01 rivo systemd[1]: mpd.socket: Deactivated successfully. Oct 13 12:38:01 rivo systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 13 12:38:01 rivo systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 13 12:38:01 rivo volumio[5084]: info: Touch Event Listener Process Starting Oct 13 12:38:01 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 13 12:38:01 rivo volumio[5084]: info: Adding TIDAL to Browse Sources Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:38:01 rivo volumio[5084]: info: [1791884281146] CoreMusicLibrary::Adding element TIDAL Oct 13 12:38:01 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:38:01 rivo volumio[5084]: Cannot find translation for source TIDAL Oct 13 12:38:01 rivo volumio[5084]: info: Refreshing TIDAL token Oct 13 12:38:01 rivo sudo[5331]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 13 12:38:01 rivo sudo[5331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5331]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 13 12:38:01 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Oct 13 12:38:01 rivo sudo[5336]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 13 12:38:01 rivo sudo[5336]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5336]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo sudo[5339]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 13 12:38:01 rivo sudo[5339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5339]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo sudo[5342]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 13 12:38:01 rivo sudo[5342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5342]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo sudo[5345]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 13 12:38:01 rivo sudo[5345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5345]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo volumio[5084]: info: Apply VIM3L Onboard LEDs Settings Oct 13 12:38:01 rivo volumio[5084]: info: Turning On Onboard LEDs Oct 13 12:38:01 rivo volumio[5084]: info: Starting CEC Event listener Oct 13 12:38:01 rivo volumio[5084]: info: Volumio Calling Home Oct 13 12:38:01 rivo sudo[5350]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 13 12:38:01 rivo sudo[5350]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5350]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo sudo[5356]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 13 12:38:01 rivo sudo[5356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:38:01 rivo sudo[5356]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo volumio[5084]: info: Stopping AccessToken refresher cron for QOBUZ Oct 13 12:38:01 rivo volumio[5084]: info: AccessToken refresher cron started for QOBUZ Oct 13 12:38:01 rivo volumio[5084]: info: Adding QOBUZ REST API Endpoints Oct 13 12:38:01 rivo sudo[5334]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 13 12:38:01 rivo sudo[5334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 13 12:38:01 rivo sudo[5334]: pam_unix(sudo:session): session closed for user root Oct 13 12:38:01 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:38:02 rivo volumio[5084]: info: Serial port opened successfully Oct 13 12:38:02 rivo volumio[5084]: info: Sending serial start messages Oct 13 12:38:02 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:38:02 rivo volumio[5084]: info: Reporting MCU Network Status: 1 Oct 13 12:38:02 rivo volumio[5084]: info: MP1 GPIO: Signalled system ready via GPIO Oct 13 12:38:02 rivo volumio[5084]: info: Discovery: adding d8c619e6-8b2e-4df9-a70c-e9093abc295c Oct 13 12:38:02 rivo volumio[5084]: info: Discovery: Found device Rivo Oct 13 12:38:02 rivo volumio[5084]: info: CoreCommandRouter::volumioGetState Oct 13 12:38:02 rivo volumio[5084]: info: CorePlayQueue::getTrack 0 Oct 13 12:38:02 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 13 12:38:02 rivo volumio[5084]: Searching all installed plugins Oct 13 12:38:02 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:38:02 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: , search Oct 13 12:38:02 rivo volumio[5084]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 13 12:38:02 rivo volumio[5084]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:38:02 rivo volumio[5084]: TypeError: Cannot read properties of undefined (reading 'then') Oct 13 12:38:02 rivo volumio[5084]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1596:17) Oct 13 12:38:02 rivo volumio[5084]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 13 12:38:02 rivo volumio[5084]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Oct 13 12:38:02 rivo volumio[5084]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Oct 13 12:38:02 rivo volumio[5084]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Oct 13 12:38:02 rivo volumio[5084]: at Socket.emit (node:events:514:28) Oct 13 12:38:02 rivo volumio[5084]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 13 12:38:02 rivo volumio[5084]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 13 12:38:02 rivo volumio[5084]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:38:02 rivo kernel: cectx ff80023c.aocec: bad iniator with self:CEC RX len 5: 0f 87 00 e0 91 Oct 13 12:38:03 rivo sudo[5373]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 12:37' Oct 13 12:38:03 rivo sudo[5373]: 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="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 18:35:21 UTC 2026" VOLUMIO_VERSION="4.209" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="d06564eaf7a6bebf8f928a4d13807037"