-- Logs begin at Fri 2025-04-04 09:11:13 AWST, end at Tue 2025-04-15 16:17:08 AWST. -- Apr 15 16:16:55 rivoplus systemd-timedated[3347]: Changed local time to Tue Apr 15 16:16:55 2025 Apr 15 16:16:55 rivoplus sudo[3336]: pam_unix(sudo:session): session closed for user root Apr 15 16:16:55 rivoplus volumio-time-update[2834]: volumio-time-update-util: System time updated successfully. Apr 15 16:16:55 rivoplus systemd[1]: Started Volumio Time Update Utility. Apr 15 16:16:55 rivoplus systemd[1]: Starting Daily apt download activities... Apr 15 16:16:55 rivoplus systemd[1]: Starting Daily man-db regeneration... Apr 15 16:16:55 rivoplus volumio[3117]: Starting albumart workers Apr 15 16:16:55 rivoplus volumio[3117]: Starting albumart workers Apr 15 16:16:55 rivoplus volumio[3117]: Starting albumart workers Apr 15 16:16:55 rivoplus ntpd[3305]: ntpd exiting on signal 15 (Terminated) Apr 15 16:16:55 rivoplus ntpd[3305]: 203.14.0.250 local addr 192.168.15.10 -> Apr 15 16:16:55 rivoplus systemd[1]: Stopping Network Time Service... Apr 15 16:16:55 rivoplus systemd[1]: ntp.service: Succeeded. Apr 15 16:16:55 rivoplus systemd[1]: Stopped Network Time Service. Apr 15 16:16:55 rivoplus systemd[1]: Starting Network Time Service... Apr 15 16:16:55 rivoplus ntpd[3380]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 15 16:16:55 rivoplus ntpd[3380]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 104:103 Apr 15 16:16:55 rivoplus systemd[1]: Started Network Time Service. Apr 15 16:16:55 rivoplus dhcpcd[2851]: forked to background, child pid 3390 Apr 15 16:16:55 rivoplus dhcpcd[2851]: forked to background, child pid 3390 Apr 15 16:16:55 rivoplus systemd[1]: Started DHCP Client Daemon. Apr 15 16:16:55 rivoplus ntpd[3388]: proto: precision = 1.250 usec (-20) Apr 15 16:16:55 rivoplus ntpd[3388]: Listen and drop on 0 v6wildcard [::]:123 Apr 15 16:16:55 rivoplus ntpd[3388]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 15 16:16:55 rivoplus ntpd[3388]: Listen normally on 2 lo 127.0.0.1:123 Apr 15 16:16:55 rivoplus ntpd[3388]: Listen normally on 3 eth0 192.168.15.10:123 Apr 15 16:16:55 rivoplus ntpd[3388]: Listening on routing socket on fd #20 for interface updates Apr 15 16:16:55 rivoplus ntpd[3388]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Apr 15 16:16:55 rivoplus ntpd[3388]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Apr 15 16:16:55 rivoplus nmbd[3071]: [2025/04/15 16:16:55.839291, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 15 16:16:55 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 16:16:55 rivoplus systemd[1]: Started Samba NMB Daemon. Apr 15 16:16:55 rivoplus nmbd[3071]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 15 16:16:55 rivoplus systemd[1]: Starting Samba Winbind Daemon... Apr 15 16:16:56 rivoplus volumio[3117]: info: Applying required configuration parameters for plugin hi_res_audio Apr 15 16:16:56 rivoplus volumio[3117]: info: Loading plugin "inputs"... Apr 15 16:16:56 rivoplus winbindd[3401]: [2025/04/15 16:16:56.460932, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 15 16:16:56 rivoplus winbindd[3401]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 15 16:16:56 rivoplus winbindd[3401]: [2025/04/15 16:16:56.475691, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 15 16:16:56 rivoplus systemd[1]: Started Samba Winbind Daemon. Apr 15 16:16:56 rivoplus winbindd[3401]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 15 16:16:56 rivoplus systemd[1]: Starting Samba SMB Daemon... Apr 15 16:16:56 rivoplus systemd[1]: man-db.service: Succeeded. Apr 15 16:16:56 rivoplus systemd[1]: Started Daily man-db regeneration. Apr 15 16:16:57 rivoplus smbd[3436]: [2025/04/15 16:16:57.082683, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 15 16:16:57 rivoplus systemd[1]: Started Samba SMB Daemon. Apr 15 16:16:57 rivoplus smbd[3436]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 15 16:16:57 rivoplus systemd[1]: Reached target Multi-User System. Apr 15 16:16:57 rivoplus systemd[1]: Reached target Graphical Interface. Apr 15 16:16:57 rivoplus systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 15 16:16:57 rivoplus systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 15 16:16:57 rivoplus volumio-remote-updater[2854]: [2025-04-15 16:16:57] [connect] Successful connection Apr 15 16:16:57 rivoplus systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 15 16:16:57 rivoplus volumio[3117]: info: Loading plugin "qobuz"... Apr 15 16:16:58 rivoplus systemd[1]: apt-daily.service: Succeeded. Apr 15 16:16:58 rivoplus systemd[1]: Started Daily apt download activities. Apr 15 16:16:58 rivoplus systemd[1]: Starting Daily apt upgrade and clean activities... Apr 15 16:16:59 rivoplus volumio[3117]: info: Plugin smart_inputs is not enabled Apr 15 16:16:59 rivoplus volumio[3117]: info: Loading plugin "tidal"... Apr 15 16:16:59 rivoplus systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 15 16:16:59 rivoplus systemd[1]: Started Daily apt upgrade and clean activities. Apr 15 16:16:59 rivoplus systemd[1]: Startup finished in 12.837s (kernel) + 26.025s (userspace) = 38.863s. Apr 15 16:17:01 rivoplus volumio[3117]: info: Loading plugin "rivopluscontrol"... Apr 15 16:17:01 rivoplus volumio[3117]: info: Adding this device properties Apr 15 16:17:01 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Apr 15 16:17:01 rivoplus volumio[3117]: info: Setting Additional Device Volumio Properties: [object Object] Apr 15 16:17:01 rivoplus volumio[3117]: info: Loading plugin "updater_comm"... Apr 15 16:17:01 rivoplus volumio[3117]: info: Loading plugin "cec_controller"... Apr 15 16:17:02 rivoplus volumio[3117]: info: Applying required configuration parameters for plugin cec_controller Apr 15 16:17:02 rivoplus volumio[3117]: info: Plugin mpdemulation is not enabled Apr 15 16:17:02 rivoplus volumio[3117]: info: Loading plugin "rest_api"... Apr 15 16:17:02 rivoplus volumio[3117]: info: Loading plugin "websocket"... Apr 15 16:17:02 rivoplus volumio[3117]: info: Starting Socket.io Server version 2.3.0 Apr 15 16:17:02 rivoplus volumio[3117]: info: Loading plugin "fusiondsp"... Apr 15 16:17:04 rivoplus volumio[3117]: info: Applying required configuration parameters for plugin fusiondsp Apr 15 16:17:04 rivoplus volumio[3117]: info: Loading i18n strings for locale en Apr 15 16:17:04 rivoplus volumio[3117]: Updating browse sources language Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::initPlayerControls Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: Express server listening on port 3000 Apr 15 16:17:04 rivoplus volumio[3117]: [Metrics] WebUI: 20s 291.77ms Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreStateMachine::resetVolumioState Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreStateMachine::getcurrentVolume Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::volumioRetrievevolume Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreStateMachine::pushState Apr 15 16:17:04 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::volumioPushState Apr 15 16:17:04 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 16:17:04 rivoplus volumio[3117]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 15 16:17:04 rivoplus volumio[3117]: info: Completed loading Core Plugins Apr 15 16:17:04 rivoplus volumio[3117]: info: Preparing to generate the ALSA configuration file Apr 15 16:17:05 rivoplus volumio[3117]: info: Volumio Network Manager: Network status updated: 0 Apr 15 16:17:05 rivoplus volumio[3117]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 15 16:17:05 rivoplus volumio[3117]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 15 16:17:05 rivoplus volumio[3117]: info: Reading ALSA contributions from plugins. Apr 15 16:17:05 rivoplus volumio[3117]: info: Reloading queue from file Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreStateMachine::setRepeat null single undefined Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreStateMachine::pushState Apr 15 16:17:05 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::volumioPushState Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreStateMachine::setRandom null Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreStateMachine::pushState Apr 15 16:17:05 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::volumioPushState Apr 15 16:17:05 rivoplus volumio[3117]: info: Asound.conf file unchanged, so no further update is needed Apr 15 16:17:05 rivoplus volumio[3117]: info: Output device has changed, restarting MPD Apr 15 16:17:05 rivoplus sudo[3549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 15 16:17:05 rivoplus sudo[3549]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus volumio[3117]: info: ___________ START PLUGINS ___________ Apr 15 16:17:05 rivoplus sudo[3549]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus volumio[3117]: info: ControllerMpd::onStart: Initializing MPD Apr 15 16:17:05 rivoplus volumio[3117]: info: Creating MPD Configuration file Apr 15 16:17:05 rivoplus sudo[3551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 15 16:17:05 rivoplus sudo[3551]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus systemd[1]: Stopping Music Player Daemon... Apr 15 16:17:05 rivoplus sudo[3555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 15 16:17:05 rivoplus sudo[3555]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3555]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus sudo[3557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 15 16:17:05 rivoplus sudo[3557]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding METAVOLUMIO REST API Endpoints Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 15 16:17:05 rivoplus volumio[3117]: info: [1744705025395] CoreMusicLibrary::Adding element Last_100 Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 16:17:05 rivoplus volumio[3117]: info: Streaming services startup Apr 15 16:17:05 rivoplus volumio[3117]: info: Starting Streaming Daemon Apr 15 16:17:05 rivoplus sudo[3563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 15 16:17:05 rivoplus sudo[3563]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3563]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 15 16:17:05 rivoplus volumio[3117]: info: [1744705025522] CoreMusicLibrary::Adding element Webradio Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 15 16:17:05 rivoplus systemd[1]: mpd.service: Succeeded. Apr 15 16:17:05 rivoplus volumio[3117]: info: Initializing BBC Radios Apr 15 16:17:05 rivoplus systemd[1]: Stopped Music Player Daemon. Apr 15 16:17:05 rivoplus systemd[1]: Starting Music Player Daemon... Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 15 16:17:05 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 16:17:05 rivoplus volumio[3117]: error: Hi Res Audio Failed Login: Missing Login Data Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 15 16:17:05 rivoplus volumio[3117]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 15 16:17:05 rivoplus volumio[3117]: info: Initializing Serial Communication on port /dev/ttyS3 Apr 15 16:17:05 rivoplus volumio[3117]: info: Touch Event Listener Process Starting Apr 15 16:17:05 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Apr 15 16:17:05 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Apr 15 16:17:05 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Apr 15 16:17:05 rivoplus volumio[3117]: info: Refreshing QOBUZ token Apr 15 16:17:05 rivoplus sudo[3582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Apr 15 16:17:05 rivoplus sudo[3582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3582]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus sudo[3570]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 15 16:17:05 rivoplus sudo[3570]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3570]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus sudo[3591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Apr 15 16:17:05 rivoplus sudo[3591]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3591]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus sudo[3595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Apr 15 16:17:05 rivoplus sudo[3595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3595]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus sudo[3598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Apr 15 16:17:05 rivoplus sudo[3598]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3598]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus sudo[3601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Apr 15 16:17:05 rivoplus sudo[3601]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:05 rivoplus sudo[3601]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:05 rivoplus volumio[3117]: info: Apply VIM3L Onboard LEDs Settings Apr 15 16:17:05 rivoplus volumio[3117]: info: Turning On Onboard LEDs Apr 15 16:17:06 rivoplus sudo[3605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Apr 15 16:17:06 rivoplus sudo[3605]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:06 rivoplus volumio[3117]: info: Starting CEC Event listener Apr 15 16:17:06 rivoplus volumio[3117]: info: Loading i18n strings for locale en Apr 15 16:17:06 rivoplus sudo[3605]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: FusionDsp - mixtype--------------------- None Apr 15 16:17:06 rivoplus volumio[3117]: info: Volumio Calling Home Apr 15 16:17:06 rivoplus sudo[3609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Apr 15 16:17:06 rivoplus sudo[3609]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:06 rivoplus sudo[3609]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:06 rivoplus volumio[3117]: info: Preparing to generate the ALSA configuration file Apr 15 16:17:06 rivoplus volumio[3117]: info: Stopping AccessToken refresher cron Apr 15 16:17:06 rivoplus volumio[3117]: info: AccessToken refresher cron started Apr 15 16:17:06 rivoplus volumio[3117]: info: Adding TIDAL REST API Endpoints Apr 15 16:17:06 rivoplus volumio[3117]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 15 16:17:06 rivoplus volumio[3117]: info: Discovery: adding 8fc38d11-067e-4a43-af74-5cec64254c51 Apr 15 16:17:06 rivoplus volumio[3117]: info: Discovery: Found device Rivoplus Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::volumioGetState Apr 15 16:17:06 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:06 rivoplus volumio[3117]: info: Serial port opened successfully Apr 15 16:17:06 rivoplus volumio[3117]: info: Sending serial start messages Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: Reporting MCU Network Status: 0 Apr 15 16:17:06 rivoplus volumio[3117]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 15 16:17:06 rivoplus volumio[3117]: info: Reading ALSA contributions from plugins. Apr 15 16:17:06 rivoplus volumio[3117]: info: Touch Event Listener Process Closed Apr 15 16:17:06 rivoplus volumio[3117]: error: Cannot start Volumio Streaming Daemon Apr 15 16:17:06 rivoplus volumio[3117]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 15 16:17:06 rivoplus volumio[3117]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 15 16:17:06 rivoplus volumio[3117]: info: MPD Permissions set Apr 15 16:17:06 rivoplus volumio[3117]: info: MPD Permissions set Apr 15 16:17:06 rivoplus volumio[3117]: info: Discovery: A device disappeared from network Apr 15 16:17:06 rivoplus volumio[3117]: info: Discovery: Device rivoplus disappeared from network Apr 15 16:17:06 rivoplus volumio[3117]: 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 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting Device Volume Override Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 15 16:17:06 rivoplus volumio[3117]: info: Updating Volume Controller Parameters: Device: 5 Name: SPL Diamond Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 15 16:17:06 rivoplus volumio[3117]: info: Disabling external Volume Control Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreStateMachine::pushState Apr 15 16:17:06 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::volumioPushState Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting Additional System Software info: Hardware Revision: 1.0 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting HW Firmware info: undefined Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting HW Version info: 1.0 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.2.7 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting HW Firmware info: 0.2.7 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 15 16:17:06 rivoplus volumio[3117]: info: Setting HW Version info: 1.0 Apr 15 16:17:06 rivoplus volumio[3117]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 15 16:17:06 rivoplus volumio[3117]: info: MCU Signalled Headphone Mode Disabled Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Apr 15 16:17:06 rivoplus volumio[3117]: info: MCU Signalled Sleep Mode Disabled Apr 15 16:17:06 rivoplus volumio[3117]: info: Enabling Advanced system settings configuration Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Apr 15 16:17:06 rivoplus volumio[3117]: info: Additional UI Settings Added for plugin music_service/inputs Apr 15 16:17:06 rivoplus volumio[3117]: info: MCU Signalled Auto Boot Mode On Power Disabled Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreStateMachine::pushState Apr 15 16:17:06 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 16:17:06 rivoplus volumio[3117]: info: CoreCommandRouter::volumioPushState Apr 15 16:17:06 rivoplus sudo[3634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Apr 15 16:17:06 rivoplus sudo[3634]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:06 rivoplus sudo[3634]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:06 rivoplus volumio[3117]: 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 16:17:06 rivoplus volumio[3117]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Apr 15 16:17:07 rivoplus volumio[3117]: info: Volumio called home Apr 15 16:17:07 rivoplus volumio[3117]: info: Discovery: adding 8fc38d11-067e-4a43-af74-5cec64254c51 Apr 15 16:17:07 rivoplus volumio[3117]: info: Discovery: Found device Rivoplus Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::volumioGetState Apr 15 16:17:07 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:07 rivoplus sudo[3637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Apr 15 16:17:07 rivoplus sudo[3637]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:07 rivoplus sudo[3637]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:07 rivoplus volumio[3117]: info: Access Token successfully retrieved Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 15 16:17:07 rivoplus volumio[3117]: info: [1744705027134] CoreMusicLibrary::Adding element QOBUZ Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 16:17:07 rivoplus volumio[3117]: Cannot find translation for source QOBUZ Apr 15 16:17:07 rivoplus volumio[3117]: info: Stopping AccessToken refresher cron for QOBUZ Apr 15 16:17:07 rivoplus volumio[3117]: info: AccessToken refresher cron started for QOBUZ Apr 15 16:17:07 rivoplus volumio[3117]: info: Adding QOBUZ REST API Endpoints Apr 15 16:17:07 rivoplus volumio[3117]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::volumioGetState Apr 15 16:17:07 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:07 rivoplus volumio[3117]: info: Adding Inputs via Serial API Apr 15 16:17:07 rivoplus volumio[3117]: info: Adding Advanced Audio Settings via Serial API Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 15 16:17:07 rivoplus volumio[3117]: info: Additional UI Settings Added for plugin music_service/inputs Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::volumioGetState Apr 15 16:17:07 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:07 rivoplus volumio[3117]: info: Asound.conf file unchanged, so no further update is needed Apr 15 16:17:07 rivoplus volumio[3117]: info: Output device has changed, restarting MPD Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus sudo[3643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 15 16:17:07 rivoplus sudo[3643]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:07 rivoplus volumio[3117]: info: MP1 GPIO: Signalled system ready via GPIO Apr 15 16:17:07 rivoplus sudo[3643]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:07 rivoplus sudo[3645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 15 16:17:07 rivoplus sudo[3645]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::servicePushState Apr 15 16:17:07 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:07 rivoplus volumio[3117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received inputs Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::volumiosetSourceActiveno-source Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 16:17:07 rivoplus volumio[3117]: Cannot find translation for source QOBUZ Apr 15 16:17:07 rivoplus volumio[3117]: info: MPD Permissions set Apr 15 16:17:07 rivoplus systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 15 16:17:07 rivoplus systemd[1]: mpd.service: Succeeded. Apr 15 16:17:07 rivoplus systemd[1]: Stopped Music Player Daemon. Apr 15 16:17:07 rivoplus systemd[1]: Starting Music Player Daemon... Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:07 rivoplus sudo[3648]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 15 16:17:07 rivoplus sudo[3648]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:07 rivoplus sudo[3648]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreStateMachine::pushState Apr 15 16:17:07 rivoplus volumio[3117]: info: CorePlayQueue::getTrack 0 Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 16:17:07 rivoplus volumio[3117]: info: CoreCommandRouter::volumioPushState Apr 15 16:17:08 rivoplus volumio[3117]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Apr 15 16:17:08 rivoplus volumio[3117]: info: camilladsp service started and running in background, instance 1 Apr 15 16:17:08 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 16:17:08 rivoplus volumio[3117]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 15 16:17:08 rivoplus volumio[3117]: 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 16:17:08 rivoplus volumio[3117]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 15 16:17:08 rivoplus volumio[3117]: info: FusionDsp loaded Apr 15 16:17:08 rivoplus volumio[3117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 16:17:08 rivoplus sudo[3668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 15 16:17:08 rivoplus sudo[3668]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 16:17:08 rivoplus volumio[3117]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 15 16:17:08 rivoplus volumio[3117]: info: Adding Signal Path Element [object Object] Apr 15 16:17:08 rivoplus volumio[3117]: info: Adding fusiondspeq DSP Signal Path Element Apr 15 16:17:08 rivoplus volumio[3117]: info: FusionDsp - ---- installed callbackRead Apr 15 16:17:08 rivoplus volumio[3117]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 16:17:08 rivoplus volumio[3117]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 15 16:17:08 rivoplus volumio[3117]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Apr 15 16:17:08 rivoplus volumio[3117]: at onErrorNT (internal/child_process.js:472:16) Apr 15 16:17:08 rivoplus volumio[3117]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Apr 15 16:17:08 rivoplus volumio[3117]: errno: -2, Apr 15 16:17:08 rivoplus volumio[3117]: code: 'ENOENT', Apr 15 16:17:08 rivoplus volumio[3117]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 15 16:17:08 rivoplus volumio[3117]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 15 16:17:08 rivoplus volumio[3117]: spawnargs: [ Apr 15 16:17:08 rivoplus volumio[3117]: '-p', Apr 15 16:17:08 rivoplus volumio[3117]: 9876, Apr 15 16:17:08 rivoplus volumio[3117]: '-o', Apr 15 16:17:08 rivoplus volumio[3117]: '/tmp/camilladsp.log', Apr 15 16:17:08 rivoplus volumio[3117]: '-l', Apr 15 16:17:08 rivoplus volumio[3117]: 'warn', Apr 15 16:17:08 rivoplus volumio[3117]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 15 16:17:08 rivoplus volumio[3117]: ] Apr 15 16:17:08 rivoplus volumio[3117]: } Apr 15 16:17:08 rivoplus volumio[3117]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 16:17:08 rivoplus systemd[1]: Started FusionDsp Daemon. Apr 15 16:17:08 rivoplus sudo[3668]: pam_unix(sudo:session): session closed for user root Apr 15 16:17:08 rivoplus sudo[3680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-15 16:16 Apr 15 16:17:08 rivoplus sudo[3680]: 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"