-- Logs begin at Fri 2025-04-04 09:11:13 AWST, end at Tue 2025-04-15 15:54:17 AWST. -- Apr 15 15:54:05 rivoplus systemd-timedated[3391]: Changed local time to Tue Apr 15 15:54:05 2025 Apr 15 15:54:05 rivoplus sudo[3389]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:05 rivoplus volumio-time-update[2835]: volumio-time-update-util: System time updated successfully. Apr 15 15:54:05 rivoplus systemd[1]: Started Volumio Time Update Utility. Apr 15 15:54:05 rivoplus systemd[1]: Starting Daily man-db regeneration... Apr 15 15:54:05 rivoplus systemd[1]: Starting Daily apt download activities... Apr 15 15:54:05 rivoplus volumio[3125]: Starting albumart workers Apr 15 15:54:05 rivoplus volumio[3125]: Starting albumart workers Apr 15 15:54:05 rivoplus volumio[3125]: Starting albumart workers Apr 15 15:54:05 rivoplus kernel: nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based firewall rule not found. Use the iptables CT target to attach helpers instead. Apr 15 15:54:05 rivoplus nmbd[3086]: [2025/04/15 15:54:05.866390, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 15 15:54:05 rivoplus nmbd[3086]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 15 15:54:05 rivoplus systemd[1]: Started Samba NMB Daemon. Apr 15 15:54:05 rivoplus systemd[1]: Starting Samba Winbind Daemon... Apr 15 15:54:06 rivoplus volumio[3125]: info: Applying required configuration parameters for plugin hi_res_audio Apr 15 15:54:06 rivoplus volumio[3125]: info: Loading plugin "inputs"... Apr 15 15:54:06 rivoplus systemd[1]: man-db.service: Succeeded. Apr 15 15:54:06 rivoplus systemd[1]: Started Daily man-db regeneration. Apr 15 15:54:06 rivoplus winbindd[3425]: [2025/04/15 15:54:06.407831, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 15 15:54:06 rivoplus winbindd[3425]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 15 15:54:06 rivoplus winbindd[3425]: [2025/04/15 15:54:06.425493, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 15 15:54:06 rivoplus winbindd[3425]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 15 15:54:06 rivoplus systemd[1]: Started Samba Winbind Daemon. Apr 15 15:54:06 rivoplus systemd[1]: Starting Samba SMB Daemon... Apr 15 15:54:07 rivoplus smbd[3456]: [2025/04/15 15:54:07.041703, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 15 15:54:07 rivoplus systemd[1]: Started Samba SMB Daemon. Apr 15 15:54:07 rivoplus smbd[3456]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 15 15:54:07 rivoplus systemd[1]: Reached target Multi-User System. Apr 15 15:54:07 rivoplus systemd[1]: Reached target Graphical Interface. Apr 15 15:54:07 rivoplus systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 15 15:54:07 rivoplus volumio[3125]: info: Loading plugin "qobuz"... Apr 15 15:54:07 rivoplus systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 15 15:54:07 rivoplus systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 15 15:54:07 rivoplus volumio-remote-updater[2860]: [2025-04-15 15:54:07] [connect] Successful connection Apr 15 15:54:07 rivoplus systemd[1]: apt-daily.service: Succeeded. Apr 15 15:54:07 rivoplus systemd[1]: Started Daily apt download activities. Apr 15 15:54:07 rivoplus systemd[1]: Starting Daily apt upgrade and clean activities... Apr 15 15:54:09 rivoplus volumio[3125]: info: Plugin smart_inputs is not enabled Apr 15 15:54:09 rivoplus volumio[3125]: info: Loading plugin "tidal"... Apr 15 15:54:09 rivoplus systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 15 15:54:09 rivoplus systemd[1]: Started Daily apt upgrade and clean activities. Apr 15 15:54:09 rivoplus systemd[1]: Startup finished in 12.977s (kernel) + 25.693s (userspace) = 38.671s. Apr 15 15:54:11 rivoplus volumio[3125]: info: Loading plugin "rivopluscontrol"... Apr 15 15:54:11 rivoplus volumio[3125]: info: Adding this device properties Apr 15 15:54:11 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Apr 15 15:54:11 rivoplus volumio[3125]: info: Setting Additional Device Volumio Properties: [object Object] Apr 15 15:54:11 rivoplus volumio[3125]: info: Loading plugin "updater_comm"... Apr 15 15:54:11 rivoplus volumio[3125]: info: Loading plugin "cec_controller"... Apr 15 15:54:12 rivoplus volumio[3125]: info: Applying required configuration parameters for plugin cec_controller Apr 15 15:54:12 rivoplus volumio[3125]: info: Plugin mpdemulation is not enabled Apr 15 15:54:12 rivoplus volumio[3125]: info: Loading plugin "rest_api"... Apr 15 15:54:12 rivoplus volumio[3125]: info: Loading plugin "websocket"... Apr 15 15:54:12 rivoplus volumio[3125]: info: Starting Socket.io Server version 2.3.0 Apr 15 15:54:12 rivoplus volumio[3125]: info: Loading plugin "fusiondsp"... Apr 15 15:54:12 rivoplus volumio[3125]: info: Applying required configuration parameters for plugin fusiondsp Apr 15 15:54:12 rivoplus volumio[3125]: info: Loading i18n strings for locale en Apr 15 15:54:12 rivoplus volumio[3125]: Updating browse sources language Apr 15 15:54:12 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::initPlayerControls Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: Express server listening on port 3000 Apr 15 15:54:13 rivoplus volumio[3125]: [Metrics] WebUI: 20s 265.61ms Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::resetVolumioState Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::getcurrentVolume Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::volumioRetrievevolume Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::pushState Apr 15 15:54:13 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::volumioPushState Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 15 15:54:13 rivoplus volumio[3125]: info: Completed loading Core Plugins Apr 15 15:54:13 rivoplus volumio[3125]: info: Preparing to generate the ALSA configuration file Apr 15 15:54:13 rivoplus volumio[3125]: info: Volumio Network Manager: Network status updated: 0 Apr 15 15:54:13 rivoplus volumio[3125]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 15 15:54:13 rivoplus volumio[3125]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 15 15:54:13 rivoplus volumio[3125]: info: Reading ALSA contributions from plugins. Apr 15 15:54:13 rivoplus volumio[3125]: info: Reloading queue from file Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::setRepeat null single undefined Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::pushState Apr 15 15:54:13 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::volumioPushState Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::setRandom null Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreStateMachine::pushState Apr 15 15:54:13 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::volumioPushState Apr 15 15:54:13 rivoplus volumio[3125]: info: Asound.conf file unchanged, so no further update is needed Apr 15 15:54:13 rivoplus volumio[3125]: info: Output device has changed, restarting MPD Apr 15 15:54:13 rivoplus sudo[3570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 15 15:54:13 rivoplus sudo[3570]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus volumio[3125]: info: ___________ START PLUGINS ___________ Apr 15 15:54:13 rivoplus sudo[3570]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:13 rivoplus volumio[3125]: info: ControllerMpd::onStart: Initializing MPD Apr 15 15:54:13 rivoplus volumio[3125]: info: Creating MPD Configuration file Apr 15 15:54:13 rivoplus sudo[3572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 15 15:54:13 rivoplus sudo[3572]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 15 15:54:13 rivoplus sudo[3576]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3576]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:13 rivoplus systemd[1]: Stopping Music Player Daemon... Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding METAVOLUMIO REST API Endpoints Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 15 15:54:13 rivoplus volumio[3125]: info: [1744703653581] CoreMusicLibrary::Adding element Last_100 Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 15:54:13 rivoplus volumio[3125]: info: Streaming services startup Apr 15 15:54:13 rivoplus volumio[3125]: info: Starting Streaming Daemon Apr 15 15:54:13 rivoplus sudo[3579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 15 15:54:13 rivoplus sudo[3579]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 15 15:54:13 rivoplus sudo[3582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3582]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 15 15:54:13 rivoplus volumio[3125]: info: [1744703653674] CoreMusicLibrary::Adding element Webradio Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 15 15:54:13 rivoplus volumio[3125]: info: Initializing BBC Radios Apr 15 15:54:13 rivoplus systemd[1]: mpd.service: Succeeded. Apr 15 15:54:13 rivoplus systemd[1]: Stopped Music Player Daemon. Apr 15 15:54:13 rivoplus systemd[1]: Starting Music Player Daemon... Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 15 15:54:13 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:54:13 rivoplus volumio[3125]: error: Hi Res Audio Failed Login: Missing Login Data Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 15 15:54:13 rivoplus volumio[3125]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 15 15:54:13 rivoplus volumio[3125]: info: Initializing Serial Communication on port /dev/ttyS3 Apr 15 15:54:13 rivoplus volumio[3125]: info: Touch Event Listener Process Starting Apr 15 15:54:13 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Apr 15 15:54:13 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Apr 15 15:54:13 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Apr 15 15:54:13 rivoplus volumio[3125]: info: Refreshing QOBUZ token Apr 15 15:54:13 rivoplus sudo[3609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Apr 15 15:54:13 rivoplus sudo[3609]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3609]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:13 rivoplus sudo[3595]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 15 15:54:13 rivoplus sudo[3595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3595]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:13 rivoplus sudo[3617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Apr 15 15:54:13 rivoplus sudo[3617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:13 rivoplus sudo[3617]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus sudo[3622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Apr 15 15:54:14 rivoplus sudo[3622]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:14 rivoplus sudo[3622]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus sudo[3625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Apr 15 15:54:14 rivoplus sudo[3625]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:14 rivoplus sudo[3625]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus sudo[3628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Apr 15 15:54:14 rivoplus sudo[3628]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:14 rivoplus sudo[3628]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus volumio[3125]: info: Apply VIM3L Onboard LEDs Settings Apr 15 15:54:14 rivoplus volumio[3125]: info: Turning On Onboard LEDs Apr 15 15:54:14 rivoplus sudo[3632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Apr 15 15:54:14 rivoplus sudo[3632]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:14 rivoplus volumio[3125]: info: Starting CEC Event listener Apr 15 15:54:14 rivoplus sudo[3632]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus volumio[3125]: info: Loading i18n strings for locale en Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: FusionDsp - mixtype--------------------- None Apr 15 15:54:14 rivoplus volumio[3125]: info: Volumio Calling Home Apr 15 15:54:14 rivoplus sudo[3636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Apr 15 15:54:14 rivoplus sudo[3636]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:14 rivoplus sudo[3636]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus volumio[3125]: info: Preparing to generate the ALSA configuration file Apr 15 15:54:14 rivoplus volumio[3125]: info: Stopping AccessToken refresher cron Apr 15 15:54:14 rivoplus volumio[3125]: info: AccessToken refresher cron started Apr 15 15:54:14 rivoplus volumio[3125]: info: Adding TIDAL REST API Endpoints Apr 15 15:54:14 rivoplus volumio[3125]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 15 15:54:14 rivoplus volumio[3125]: info: Discovery: adding 8fc38d11-067e-4a43-af74-5cec64254c51 Apr 15 15:54:14 rivoplus volumio[3125]: info: Discovery: Found device Rivoplus Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::volumioGetState Apr 15 15:54:14 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:14 rivoplus volumio[3125]: info: Serial port opened successfully Apr 15 15:54:14 rivoplus volumio[3125]: info: Sending serial start messages Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: Reporting MCU Network Status: 0 Apr 15 15:54:14 rivoplus volumio[3125]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 15 15:54:14 rivoplus volumio[3125]: info: Reading ALSA contributions from plugins. Apr 15 15:54:14 rivoplus volumio[3125]: info: Touch Event Listener Process Closed Apr 15 15:54:14 rivoplus volumio[3125]: error: Cannot start Volumio Streaming Daemon Apr 15 15:54:14 rivoplus volumio[3125]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 15 15:54:14 rivoplus volumio[3125]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 15 15:54:14 rivoplus volumio[3125]: info: MPD Permissions set Apr 15 15:54:14 rivoplus volumio[3125]: info: MPD Permissions set Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting Device Volume Override Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 15 15:54:14 rivoplus volumio[3125]: info: Updating Volume Controller Parameters: Device: 5 Name: SPL Diamond Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 15 15:54:14 rivoplus volumio[3125]: info: Disabling external Volume Control Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreStateMachine::pushState Apr 15 15:54:14 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::volumioPushState Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreStateMachine::pushState Apr 15 15:54:14 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::volumioPushState Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting Additional System Software info: Hardware Revision: 1.0 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting HW Firmware info: undefined Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting HW Version info: 1.0 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.2.7 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting HW Firmware info: 0.2.7 Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 15 15:54:14 rivoplus volumio[3125]: info: Setting HW Version info: 1.0 Apr 15 15:54:14 rivoplus volumio[3125]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 15 15:54:14 rivoplus volumio[3125]: info: MCU Signalled Headphone Mode Disabled Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Apr 15 15:54:14 rivoplus volumio[3125]: info: MCU Signalled Sleep Mode Disabled Apr 15 15:54:14 rivoplus volumio[3125]: info: Enabling Advanced system settings configuration Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Apr 15 15:54:14 rivoplus volumio[3125]: info: Additional UI Settings Added for plugin music_service/inputs Apr 15 15:54:14 rivoplus volumio[3125]: info: MCU Signalled Auto Boot Mode On Power Disabled Apr 15 15:54:14 rivoplus sudo[3645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Apr 15 15:54:14 rivoplus sudo[3645]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:14 rivoplus volumio[3125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 15 15:54:14 rivoplus sudo[3645]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:54:14 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Apr 15 15:54:15 rivoplus volumio[3125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 15 15:54:15 rivoplus volumio[3125]: info: Discovery: A device disappeared from network Apr 15 15:54:15 rivoplus volumio[3125]: info: Discovery: Device rivoplus disappeared from network Apr 15 15:54:15 rivoplus sudo[3664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Apr 15 15:54:15 rivoplus sudo[3664]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:15 rivoplus sudo[3664]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:15 rivoplus volumio[3125]: info: Volumio called home Apr 15 15:54:15 rivoplus volumio[3125]: info: Adding Inputs via Serial API Apr 15 15:54:15 rivoplus volumio[3125]: info: Adding Advanced Audio Settings via Serial API Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 15 15:54:15 rivoplus volumio[3125]: info: Additional UI Settings Added for plugin music_service/inputs Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::volumioGetState Apr 15 15:54:15 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreStateMachine::pushState Apr 15 15:54:15 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::volumioPushState Apr 15 15:54:15 rivoplus volumio[3125]: info: MP1 GPIO: Signalled system ready via GPIO Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::volumioGetState Apr 15 15:54:15 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:15 rivoplus volumio[3125]: info: Access Token successfully retrieved Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 15 15:54:15 rivoplus volumio[3125]: info: [1744703655433] CoreMusicLibrary::Adding element QOBUZ Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 15:54:15 rivoplus volumio[3125]: Cannot find translation for source QOBUZ Apr 15 15:54:15 rivoplus volumio[3125]: info: Stopping AccessToken refresher cron for QOBUZ Apr 15 15:54:15 rivoplus volumio[3125]: info: AccessToken refresher cron started for QOBUZ Apr 15 15:54:15 rivoplus volumio[3125]: info: Adding QOBUZ REST API Endpoints Apr 15 15:54:15 rivoplus volumio[3125]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 15 15:54:15 rivoplus volumio[3125]: info: Asound.conf file unchanged, so no further update is needed Apr 15 15:54:15 rivoplus volumio[3125]: info: Output device has changed, restarting MPD Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus sudo[3671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 15 15:54:15 rivoplus sudo[3671]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::servicePushState Apr 15 15:54:15 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:15 rivoplus volumio[3125]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received inputs Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::volumiosetSourceActiveno-source Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 15:54:15 rivoplus volumio[3125]: Cannot find translation for source QOBUZ Apr 15 15:54:15 rivoplus sudo[3671]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:15 rivoplus sudo[3673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 15 15:54:15 rivoplus sudo[3673]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:15 rivoplus volumio[3125]: info: Discovery: adding 8fc38d11-067e-4a43-af74-5cec64254c51 Apr 15 15:54:15 rivoplus volumio[3125]: info: Discovery: Found device Rivoplus Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::volumioGetState Apr 15 15:54:15 rivoplus volumio[3125]: info: CorePlayQueue::getTrack 0 Apr 15 15:54:15 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 15 15:54:15 rivoplus systemd[1]: mpd.service: Succeeded. Apr 15 15:54:15 rivoplus systemd[1]: Stopped Music Player Daemon. Apr 15 15:54:15 rivoplus volumio[3125]: info: MPD Permissions set Apr 15 15:54:15 rivoplus systemd[1]: Starting Music Player Daemon... Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 15 15:54:15 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:15 rivoplus sudo[3676]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 15 15:54:15 rivoplus sudo[3676]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:15 rivoplus sudo[3676]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:16 rivoplus volumio[3125]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Apr 15 15:54:16 rivoplus volumio[3125]: info: camilladsp service started and running in background, instance 1 Apr 15 15:54:16 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 15:54:16 rivoplus volumio[3125]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 15 15:54:16 rivoplus volumio[3125]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 15 15:54:16 rivoplus volumio[3125]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 15 15:54:16 rivoplus volumio[3125]: info: FusionDsp loaded Apr 15 15:54:16 rivoplus volumio[3125]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 15:54:16 rivoplus sudo[3696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 15 15:54:16 rivoplus sudo[3696]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 15:54:16 rivoplus volumio[3125]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 15 15:54:16 rivoplus volumio[3125]: info: Adding Signal Path Element [object Object] Apr 15 15:54:16 rivoplus volumio[3125]: info: Adding fusiondspeq DSP Signal Path Element Apr 15 15:54:16 rivoplus volumio[3125]: info: FusionDsp - ---- installed callbackRead Apr 15 15:54:16 rivoplus volumio[3125]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 15:54:16 rivoplus volumio[3125]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 15 15:54:16 rivoplus volumio[3125]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Apr 15 15:54:16 rivoplus volumio[3125]: at onErrorNT (internal/child_process.js:472:16) Apr 15 15:54:16 rivoplus volumio[3125]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Apr 15 15:54:16 rivoplus volumio[3125]: errno: -2, Apr 15 15:54:16 rivoplus volumio[3125]: code: 'ENOENT', Apr 15 15:54:16 rivoplus volumio[3125]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 15 15:54:16 rivoplus volumio[3125]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 15 15:54:16 rivoplus volumio[3125]: spawnargs: [ Apr 15 15:54:16 rivoplus volumio[3125]: '-p', Apr 15 15:54:16 rivoplus volumio[3125]: 9876, Apr 15 15:54:16 rivoplus volumio[3125]: '-o', Apr 15 15:54:16 rivoplus volumio[3125]: '/tmp/camilladsp.log', Apr 15 15:54:16 rivoplus volumio[3125]: '-l', Apr 15 15:54:16 rivoplus volumio[3125]: 'warn', Apr 15 15:54:16 rivoplus volumio[3125]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 15 15:54:16 rivoplus volumio[3125]: ] Apr 15 15:54:16 rivoplus volumio[3125]: } Apr 15 15:54:16 rivoplus volumio[3125]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 15:54:16 rivoplus systemd[1]: Started FusionDsp Daemon. Apr 15 15:54:16 rivoplus sudo[3696]: pam_unix(sudo:session): session closed for user root Apr 15 15:54:17 rivoplus sudo[3708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-15 15:53 Apr 15 15:54:17 rivoplus sudo[3708]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:42:11 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="4f5519a96ae5ba7dcfda362cc37343d4"