Oct 11 19:46:22 rivoessential-dev0 volumio-remote-updater[1270]: [2026-10-11 19:46:22] [connect] Successful connection
Oct 11 19:46:22 rivoessential-dev0 systemd[1]: setdatetime-helper.service: Deactivated successfully.
Oct 11 19:46:22 rivoessential-dev0 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Oct 11 19:46:22 rivoessential-dev0 systemd[1]: setdatetime-helper.service: Consumed 2.769s CPU time.
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: Pool skipping: 204.216.214.76
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: Pool skipping: 85.199.214.99
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: Pool taking: 162.159.200.1
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: Pool skipping: 172.232.208.229
Oct 11 19:46:22 rivoessential-dev0 ntpd[1493]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8
Oct 11 19:46:23 rivoessential-dev0 smbd[2778]: [2026/10/11 19:46:23.460671, 0] ../../source3/smbd/server.c:1741(main)
Oct 11 19:46:23 rivoessential-dev0 smbd[2778]: smbd version 4.17.12-Debian started.
Oct 11 19:46:23 rivoessential-dev0 smbd[2778]: Copyright Andrew Tridgell and the Samba Team 1992-2022
Oct 11 19:46:23 rivoessential-dev0 ntpd[1493]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
Oct 11 19:46:24 rivoessential-dev0 ntpd[1493]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
Oct 11 19:46:24 rivoessential-dev0 ntpd[1493]: DNS: Pool skipping: 172.232.209.103
Oct 11 19:46:24 rivoessential-dev0 ntpd[1493]: DNS: Pool taking: 81.56.230.156
Oct 11 19:46:24 rivoessential-dev0 ntpd[1493]: DNS: Pool taking: 89.46.74.148
Oct 11 19:46:24 rivoessential-dev0 ntpd[1493]: DNS: Pool taking: 93.94.88.51
Oct 11 19:46:24 rivoessential-dev0 ntpd[1493]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: MYVOLUMIO Environment detected
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Started smbd.service - Samba SMB Daemon.
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Reached target multi-user.target - Multi-User System.
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Reached target graphical.target - Graphical Interface.
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP...
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Started volumiobt.service - Volumio Bluetooth Module.
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP.
Oct 11 19:46:25 rivoessential-dev0 volumiobt[2794]: INFO [BTSTART] Ensuring Bluetooth directory exists...
Oct 11 19:46:25 rivoessential-dev0 systemd[1]: Startup finished in 20.152s (kernel) + 57.419s (userspace) = 1min 17.572s.
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Plugin folders cleanup
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning into folder /volumio/app/plugins/
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category audio_interface
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category miscellanea
Oct 11 19:46:25 rivoessential-dev0 sudo[2795]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth
Oct 11 19:46:25 rivoessential-dev0 sudo[2795]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category music_service
Oct 11 19:46:25 rivoessential-dev0 sudo[2795]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category plugins.json
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category system_controller
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category user_interface
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning into folder /data/plugins/
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Scanning category music_service
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Plugin folders cleanup completed
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: -------------------------------------------
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: ----- Core plugins startup ----
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: -------------------------------------------
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Loading plugins from folder /volumio/app/plugins/
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin bluetooth to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin multiroom to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin upnp to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin metavolumio to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 sudo[2797]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth
Oct 11 19:46:25 rivoessential-dev0 sudo[2797]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin airplay_emulation to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin cd_controller to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin qobuzconnect to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin raat to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin smart_inputs to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 sudo[2797]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin tidalconnect to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin upnp_browser to MyMusic Plugins
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Loading plugins from folder /data/plugins/
Oct 11 19:46:25 rivoessential-dev0 volumiobt[2799]: INFO [BTSTART] Powering on Bluetooth if needed...
Oct 11 19:46:25 rivoessential-dev0 volumio[2565]: info: Adding plugin rtlsdr_radio to MyMusic Plugins
Oct 11 19:46:26 rivoessential-dev0 volumio[2565]: info: Loading plugin "system"...
Oct 11 19:46:26 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3.
Oct 11 19:46:26 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:46:26 rivoessential-dev0 volumio[2565]: info: Loading plugin "appearance"...
Oct 11 19:46:26 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2807]: INFO [BTSTART] Making Bluetooth discoverable and pairable...
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [176B blob data]
Oct 11 19:46:26 rivoessential-dev0 upmpdcli[2806]: Could not open config: /tmp/upmpdcli.conf
Oct 11 19:46:26 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [157B blob data]
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [157B blob data]
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [113B blob data]
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [bluetoothctl]> discoverable on
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [bluetoothctl]> pairable on
Oct 11 19:46:26 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2808]: [bluetoothctl]>
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2809]: INFO [BTSTART] Registering Bluetooth agent...
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2810]: [NEW] Media /org/bluez/hci0
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2810]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2810]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2812]: No agent is registered
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2812]: [NEW] Media /org/bluez/hci0
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2812]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2812]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2813]: INFO [BTSTART] Agent registered successfully.
Oct 11 19:46:26 rivoessential-dev0 volumiobt[2814]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)...
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Connecting to system D-Bus
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Connected to system D-Bus
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 bluezutils [INFO] Found adapter at: /org/bluez/hci0
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Found Bluetooth adapter: /org/bluez/hci0
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Set DiscoverableTimeout to infinite
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Enabled Discoverable mode
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Agent registered at /local/a2dpagent
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] Agent set as default
Oct 11 19:46:28 rivoessential-dev0 volumiobt[2815]: 2026-10-11 19:46:28 a2dp-agent [INFO] A2DP agent running, waiting for connections...
Oct 11 19:46:29 rivoessential-dev0 sshd[2716]: Accepted password for volumio from 192.168.1.210 port 51371 ssh2
Oct 11 19:46:29 rivoessential-dev0 sshd[2716]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0)
Oct 11 19:46:29 rivoessential-dev0 systemd-logind[1262]: New session 1 of user volumio.
Oct 11 19:46:29 rivoessential-dev0 systemd[1]: Created slice user-1000.slice - User Slice of UID 1000.
Oct 11 19:46:29 rivoessential-dev0 systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000...
Oct 11 19:46:30 rivoessential-dev0 systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000.
Oct 11 19:46:30 rivoessential-dev0 systemd[1]: Starting user@1000.service - User Manager for UID 1000...
Oct 11 19:46:30 rivoessential-dev0 (systemd)[2818]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0)
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Loading plugin "network"...
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Refreshing Cached IP Addresses
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Loading plugin "services"...
Oct 11 19:46:31 rivoessential-dev0 sudo[2834]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 11 19:46:31 rivoessential-dev0 sudo[2834]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:31 rivoessential-dev0 sudo[2836]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Loading plugin "volumio5onboarding"...
Oct 11 19:46:31 rivoessential-dev0 sudo[2836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:31 rivoessential-dev0 sudo[2834]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Loading plugin "alsa_controller"...
Oct 11 19:46:31 rivoessential-dev0 sudo[2836]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:31 rivoessential-dev0 sudo[2847]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 11 19:46:31 rivoessential-dev0 sudo[2847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Loading plugin "wizard"...
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Loading plugin "networkfs"...
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Starting Udev Watcher for removable devices
Oct 11 19:46:31 rivoessential-dev0 sudo[2847]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:31 rivoessential-dev0 volumio[2565]: info: Mounting Device ISSD
Oct 11 19:46:31 rivoessential-dev0 sudo[2870]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/mmcblk0p1 /mnt/INTERNAL/ -o noatime
Oct 11 19:46:31 rivoessential-dev0 sudo[2870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:32 rivoessential-dev0 kernel: exFAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Oct 11 19:46:32 rivoessential-dev0 sudo[2870]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Binding Internal Memory position
Oct 11 19:46:32 rivoessential-dev0 sudo[2875]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -o bind /mnt/INTERNAL /data/INTERNAL
Oct 11 19:46:32 rivoessential-dev0 sudo[2875]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Queued start job for default target default.target.
Oct 11 19:46:32 rivoessential-dev0 sudo[2875]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Created slice app.slice - User Application Slice.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Reached target paths.target - Paths.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Reached target timers.target - Timers.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Listening on dirmngr.socket - GnuPG network certificate management daemon.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers).
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted).
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation).
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Reached target sockets.target - Sockets.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Reached target basic.target - Basic System.
Oct 11 19:46:32 rivoessential-dev0 systemd[1]: Started user@1000.service - User Manager for UID 1000.
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Ignoring mount for partition: BOOT
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Ignoring mount for partition: volumio
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Ignoring mount for partition: volumio_data
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Loading plugin "volumio_command_line_client"...
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Loading plugin "upnp"...
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Started mpris-proxy.service - Bluetooth mpris proxy.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Reached target default.target - Main User Target.
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: Startup finished in 1.749s.
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: [1791740792439] Starting Upmpd Daemon
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 11 19:46:32 rivoessential-dev0 systemd[1]: Started session-1.scope - Session 1 of User volumio.
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Loading plugin "my_music"...
Oct 11 19:46:32 rivoessential-dev0 mpris-proxy[2881]: Can't get on session bus
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: mpris-proxy.service: Main process exited, code=exited, status=1/FAILURE
Oct 11 19:46:32 rivoessential-dev0 systemd[2818]: mpris-proxy.service: Failed with result 'exit-code'.
Oct 11 19:46:32 rivoessential-dev0 volumio[2565]: info: Loading plugin "mpd"...
Oct 11 19:46:32 rivoessential-dev0 sshd[2716]: pam_env(sshd:session): deprecated reading of user environment enabled
Oct 11 19:46:33 rivoessential-dev0 volumio[2565]: info: Loading plugin "upnp_browser"...
Oct 11 19:46:36 rivoessential-dev0 volumio[2565]: info: Starting UPNP Browser
Oct 11 19:46:36 rivoessential-dev0 volumio[2565]: info: Loading plugin "bluetooth"...
Oct 11 19:46:36 rivoessential-dev0 sudo[2898]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f
Oct 11 19:46:36 rivoessential-dev0 sudo[2898]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000)
Oct 11 19:46:37 rivoessential-dev0 volumio-remote-updater[1270]: [2026-10-11 19:46:37] [connect] Successful connection
Oct 11 19:46:37 rivoessential-dev0 volumio[2565]: info: Applying required configuration parameters for plugin bluetooth
Oct 11 19:46:37 rivoessential-dev0 volumio[2565]: info: Applying required configuration parameters for plugin bluetooth
Oct 11 19:46:37 rivoessential-dev0 volumio[2565]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart
Oct 11 19:46:37 rivoessential-dev0 volumio[2565]: info: Loading plugin "alarm-clock"...
Oct 11 19:46:37 rivoessential-dev0 volumio[2565]: info: Loading plugin "manifestui"...
Oct 11 19:46:38 rivoessential-dev0 volumio[2565]: info: Loading plugin "metavolumio"...
Oct 11 19:46:41 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4.
Oct 11 19:46:41 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:46:41 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:46:41 rivoessential-dev0 upmpdcli[2903]: Could not open config: /tmp/upmpdcli.conf
Oct 11 19:46:41 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Oct 11 19:46:41 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Oct 11 19:46:42 rivoessential-dev0 volumio[2565]: info: Loading plugin "airplay_emulation"...
Oct 11 19:46:42 rivoessential-dev0 volumio[2565]: info: Starting Shairport Sync
Oct 11 19:46:42 rivoessential-dev0 volumio[2565]: info: Loading plugin "cd_controller"...
Oct 11 19:46:42 rivoessential-dev0 volumio[2565]: info: Loading plugin "last_100"...
Oct 11 19:46:42 rivoessential-dev0 volumio[2565]: info: Loading plugin "qobuzconnect"...
Oct 11 19:46:42 rivoessential-dev0 volumio[2565]: info: Loading plugin "raat"...
Oct 11 19:46:43 rivoessential-dev0 volumio[2565]: info: RAAT Plugin loaded
Oct 11 19:46:43 rivoessential-dev0 volumio[2565]: info: Adding restartRAATSocket REST API Endpoint
Oct 11 19:46:43 rivoessential-dev0 volumio[2565]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat
Oct 11 19:46:43 rivoessential-dev0 volumio[2565]: info: Loading plugin "streaming_services"...
Oct 11 19:46:46 rivoessential-dev0 volumio[2565]: info: Loading plugin "tidalconnect"...
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: Loading plugin "webradio"...
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: Loading plugin "i2s_dacs"...
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: I2S DAC not set, start Auto-detection
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: Loading plugin "volumiodiscovery"...
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: *** WARNING *** For more information see
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 11 19:46:47 rivoessential-dev0 node[2565]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: *** WARNING *** For more information see
Oct 11 19:46:47 rivoessential-dev0 node[2565]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 11 19:46:47 rivoessential-dev0 node[2565]: *** WARNING *** For more information see
Oct 11 19:46:47 rivoessential-dev0 node[2565]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 11 19:46:47 rivoessential-dev0 node[2565]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 11 19:46:47 rivoessential-dev0 node[2565]: *** WARNING *** For more information see
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: Discovery: Started advertising with name: RivoEssential-dev0
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 11 19:46:47 rivoessential-dev0 volumio[2565]: info: Loading plugin "spop"...
Oct 11 19:46:50 rivoessential-dev0 volumio[2565]: info: Loading plugin "multiroom"...
Oct 11 19:46:52 rivoessential-dev0 volumio-remote-updater[1270]: [2026-10-11 19:46:52] [connect] Successful connection
Oct 11 19:46:55 rivoessential-dev0 volumio[2565]: info: Applying required configuration parameters for plugin multiroom
Oct 11 19:46:55 rivoessential-dev0 sudo[2937]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Oct 11 19:46:55 rivoessential-dev0 sudo[2937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:55 rivoessential-dev0 sudo[2937]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:55 rivoessential-dev0 volumio[2565]: info: MRS: MultiRoom plugin initialized
Oct 11 19:46:55 rivoessential-dev0 volumio[2565]: info: MRS: STOPPING SNAPCLIENT
Oct 11 19:46:55 rivoessential-dev0 volumio[2565]: info: MRS: Snap server stop
Oct 11 19:46:55 rivoessential-dev0 volumio[2565]: info: MRS: STOPPING volumioStreaming
Oct 11 19:46:55 rivoessential-dev0 sudo[2954]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Oct 11 19:46:55 rivoessential-dev0 sudo[2954]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:55 rivoessential-dev0 sudo[2956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Oct 11 19:46:55 rivoessential-dev0 sudo[2956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:56 rivoessential-dev0 volumio[2565]: info: Loading plugin "outputs"...
Oct 11 19:46:56 rivoessential-dev0 volumio[2565]: info: Loading plugin "albumart"...
Oct 11 19:46:56 rivoessential-dev0 sudo[2959]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Oct 11 19:46:56 rivoessential-dev0 sudo[2959]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:56 rivoessential-dev0 sudo[2961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Oct 11 19:46:56 rivoessential-dev0 sudo[2961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:46:56 rivoessential-dev0 volumio[2565]: info: Plugin example_plugin is not enabled
Oct 11 19:46:56 rivoessential-dev0 volumio[2565]: info: Loading plugin "hi_res_audio"...
Oct 11 19:46:56 rivoessential-dev0 sudo[2961]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:56 rivoessential-dev0 sudo[2954]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:56 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5.
Oct 11 19:46:56 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:46:56 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:46:57 rivoessential-dev0 upmpdcli[2975]: Could not open config: /tmp/upmpdcli.conf
Oct 11 19:46:57 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Oct 11 19:46:57 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Oct 11 19:46:57 rivoessential-dev0 sudo[2956]: pam_unix(sudo:session): session closed for user root
Oct 11 19:46:57 rivoessential-dev0 volumio[2964]: Forking 3 albumart workers
Oct 11 19:46:57 rivoessential-dev0 sudo[2959]: pam_unix(sudo:session): session closed for user root
Oct 11 19:47:00 rivoessential-dev0 volumio[2565]: info: Applying required configuration parameters for plugin hi_res_audio
Oct 11 19:47:00 rivoessential-dev0 volumio[2565]: info: Loading plugin "inputs"...
Oct 11 19:47:00 rivoessential-dev0 volumio[2978]: Starting albumart workers
Oct 11 19:47:00 rivoessential-dev0 volumio[2976]: Starting albumart workers
Oct 11 19:47:00 rivoessential-dev0 volumio[2977]: Starting albumart workers
Oct 11 19:47:02 rivoessential-dev0 volumio[2565]: info: Loading plugin "qobuz"...
Oct 11 19:47:06 rivoessential-dev0 volumio[2565]: info: Plugin smart_inputs is not enabled
Oct 11 19:47:06 rivoessential-dev0 volumio[2565]: info: Loading plugin "tidal"...
Oct 11 19:47:07 rivoessential-dev0 volumio-remote-updater[1270]: [2026-10-11 19:47:07] [connect] Successful connection
Oct 11 19:47:07 rivoessential-dev0 dbus-daemon[1247]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30008ms)
Oct 11 19:47:10 rivoessential-dev0 volumio[2565]: info: Loading plugin "rivoessentialcontrol"...
Oct 11 19:47:10 rivoessential-dev0 volumio[2565]: info: Adding this device properties
Oct 11 19:47:10 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties
Oct 11 19:47:10 rivoessential-dev0 volumio[2565]: info: Setting Additional Device Volumio Properties: [object Object]
Oct 11 19:47:10 rivoessential-dev0 volumio[2565]: info: Loading plugin "updater_comm"...
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Plugin mpdemulation is not enabled
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Loading plugin "rest_api"...
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Loading plugin "websocket"...
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Starting Socket.io Server version 1.7.4
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Loading plugin "motherearthradio"...
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Loading plugin "radio_paradise"...
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Applying required configuration parameters for plugin radio_paradise
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: [1791740831908] [RadioParadise] API delay: 5
Oct 11 19:47:11 rivoessential-dev0 volumio[2565]: info: Loading plugin "rtlsdr_radio"...
Oct 11 19:47:12 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6.
Oct 11 19:47:12 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:47:12 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Oct 11 19:47:12 rivoessential-dev0 upmpdcli[3053]: Could not open config: /tmp/upmpdcli.conf
Oct 11 19:47:12 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Oct 11 19:47:12 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Oct 11 19:47:13 rivoessential-dev0 volumio[2565]: info: [RTL-SDR Radio] Loaded FM region data
Oct 11 19:47:13 rivoessential-dev0 volumio[2565]: info: Loading i18n strings for locale en
Oct 11 19:47:13 rivoessential-dev0 volumio[2565]: Updating browse sources language
Oct 11 19:47:13 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::initPlayerControls
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: Express server listening on port 3000
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: [Metrics] WebUI: 54s 601.51ms
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreStateMachine::resetVolumioState
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreStateMachine::getcurrentVolume
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::volumioRetrievevolume
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreStateMachine::pushState
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CorePlayQueue::getTrack 0
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::volumioPushState
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: Completed loading Core Plugins
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: Preparing to generate the ALSA configuration file
Oct 11 19:47:14 rivoessential-dev0 sudo[3064]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 11 19:47:14 rivoessential-dev0 sudo[3064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:47:14 rivoessential-dev0 sudo[3066]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 11 19:47:14 rivoessential-dev0 sudo[3066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 11 19:47:14 rivoessential-dev0 sudo[3064]: pam_unix(sudo:session): session closed for user root
Oct 11 19:47:14 rivoessential-dev0 sudo[3066]: pam_unix(sudo:session): session closed for user root
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: Reading ALSA contributions from plugins.
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: info: Volumio Network Manager: Network status updated: 2
Oct 11 19:47:14 rivoessential-dev0 volumio[2565]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: Error: write EPIPE
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at afterWriteDispatched (node:internal/stream_base_commons:160:15)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at writeGeneric (node:internal/stream_base_commons:151:3)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at Socket._writeGeneric (node:net:952:11)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at Socket._write (node:net:964:8)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at writeOrBuffer (node:internal/streams/writable:399:12)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at _write (node:internal/streams/writable:340:10)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at Writable.write (node:internal/streams/writable:344:10)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at auth (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:67:10)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at Socket. (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:137:32)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at Object.onceWrapper (node:events:628:28)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at Socket.emit (node:events:514:28)
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1580:10) {
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: errno: -32,
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: code: 'EPIPE',
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: syscall: 'write'
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: }
Oct 11 19:47:15 rivoessential-dev0 volumio[2565]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 11 19:47:16 rivoessential-dev0 sudo[3084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-11 19:46'
Oct 11 19:47:16 rivoessential-dev0 sudo[3084]: 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="ce8ab316df529fbed67af5e7f945e96c679114ce"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="e4cc75aeb55d8e9f68ae0a0f0d560517e2d633d6"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivoessential"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Oct 6 13:10:12 UTC 2026"
VOLUMIO_VERSION="4.221"
VOLUMIO_HARDWARE="vmod-a0"
VOLUMIO_DEVICENAME="VMOD-A0"
VOLUMIO_VENDOR_MODEL="Volumio Rivo Essential"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo Essential"
VOLUMIO_HASH="af147ef0deef7a12f1720292c976941b"