Oct 11 19:18:54 rivoessential-dev0 systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 11 19:18:54 rivoessential-dev0 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 11 19:18:54 rivoessential-dev0 systemd[1]: setdatetime-helper.service: Consumed 3.370s CPU time. Oct 11 19:18:54 rivoessential-dev0 systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 11 19:18:54 rivoessential-dev0 systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Oct 11 19:18:54 rivoessential-dev0 nmbd[1799]: [2026/10/11 19:18:54.252321, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Oct 11 19:18:54 rivoessential-dev0 systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Oct 11 19:18:54 rivoessential-dev0 nmbd[1799]: register_name_response: Answer name <00> differs from question name <00>. Oct 11 19:18:54 rivoessential-dev0 nmbd[1799]: [2026/10/11 19:18:54.269523, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Oct 11 19:18:54 rivoessential-dev0 nmbd[1799]: register_name_response: Answer name <03> differs from question name <03>. Oct 11 19:18:54 rivoessential-dev0 nmbd[1799]: [2026/10/11 19:18:54.274981, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Oct 11 19:18:54 rivoessential-dev0 nmbd[1799]: register_name_response: Answer name <20> differs from question name <20>. Oct 11 19:18:54 rivoessential-dev0 systemd[1]: e2scrub_all.service: Deactivated successfully. Oct 11 19:18:54 rivoessential-dev0 systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Oct 11 19:18:54 rivoessential-dev0 systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 195.32.70.195 Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 95.110.254.234 Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 162.159.200.123 Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 81.56.230.156 Oct 11 19:18:54 rivoessential-dev0 ntpd[1554]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Oct 11 19:18:54 rivoessential-dev0 smbd[2773]: [2026/10/11 19:18:54.659469, 0] ../../source3/smbd/server.c:1741(main) Oct 11 19:18:54 rivoessential-dev0 smbd[2773]: smbd version 4.17.12-Debian started. Oct 11 19:18:54 rivoessential-dev0 smbd[2773]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Oct 11 19:18:54 rivoessential-dev0 winbindd[2727]: [2026/10/11 19:18:54.844595, 0] ../../source3/winbindd/winbindd_idmap.c:372(wb_parent_idmap_setup_lookupname_done) Oct 11 19:18:54 rivoessential-dev0 winbindd[2727]: wb_parent_idmap_setup_lookupname_done: Lookup domain name 'RIVOESSENTIAL-DEV0' failed 'NT_STATUS_IO_TIMEOUT' Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Started smbd.service - Samba SMB Daemon. Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Reached target graphical.target - Graphical Interface. Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Oct 11 19:18:55 rivoessential-dev0 systemd[1]: dpkg-db-backup.service: Deactivated successfully. Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 172.232.208.229 Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 172.232.209.103 Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 89.46.74.148 Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: Pool taking: 93.94.88.50 Oct 11 19:18:55 rivoessential-dev0 ntpd[1554]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Oct 11 19:18:55 rivoessential-dev0 volumiobt[2818]: INFO [BTSTART] Ensuring Bluetooth directory exists... Oct 11 19:18:55 rivoessential-dev0 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Oct 11 19:18:55 rivoessential-dev0 systemd[1]: Startup finished in 20.415s (kernel) + 55.400s (userspace) = 1min 15.816s. Oct 11 19:18:55 rivoessential-dev0 sudo[2819]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Oct 11 19:18:55 rivoessential-dev0 sudo[2819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:18:55 rivoessential-dev0 sudo[2819]: pam_unix(sudo:session): session closed for user root Oct 11 19:18:55 rivoessential-dev0 sudo[2821]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Oct 11 19:18:55 rivoessential-dev0 sudo[2821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:18:55 rivoessential-dev0 sudo[2821]: pam_unix(sudo:session): session closed for user root Oct 11 19:18:55 rivoessential-dev0 volumiobt[2823]: INFO [BTSTART] Powering on Bluetooth if needed... Oct 11 19:18:55 rivoessential-dev0 volumiobt[2826]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [176B blob data] Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [157B blob data] Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [157B blob data] Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [113B blob data] Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [bluetoothctl]> discoverable on Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [bluetoothctl]> pairable on Oct 11 19:18:55 rivoessential-dev0 volumiobt[2827]: [bluetoothctl]> Oct 11 19:18:55 rivoessential-dev0 volumiobt[2828]: INFO [BTSTART] Registering Bluetooth agent... Oct 11 19:18:56 rivoessential-dev0 volumiobt[2829]: [NEW] Media /org/bluez/hci0 Oct 11 19:18:56 rivoessential-dev0 volumiobt[2829]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Oct 11 19:18:56 rivoessential-dev0 volumiobt[2829]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Oct 11 19:18:56 rivoessential-dev0 volumiobt[2830]: No agent is registered Oct 11 19:18:56 rivoessential-dev0 volumiobt[2830]: [NEW] Media /org/bluez/hci0 Oct 11 19:18:56 rivoessential-dev0 volumiobt[2830]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Oct 11 19:18:56 rivoessential-dev0 volumiobt[2830]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Oct 11 19:18:56 rivoessential-dev0 volumiobt[2831]: INFO [BTSTART] Agent registered successfully. Oct 11 19:18:56 rivoessential-dev0 volumiobt[2832]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Oct 11 19:18:57 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Oct 11 19:18:57 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:18:57 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:18:57 rivoessential-dev0 upmpdcli[2835]: Could not open config: /tmp/upmpdcli.conf Oct 11 19:18:57 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 11 19:18:57 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 11 19:18:57 rivoessential-dev0 volumio[2577]: info: MYVOLUMIO Environment detected Oct 11 19:18:57 rivoessential-dev0 winbindd[2749]: [2026/10/11 19:18:57.918067, 0] ../../source3/winbindd/winbindd_dual.c:162(child_write_response) Oct 11 19:18:57 rivoessential-dev0 winbindd[2749]: Could not write result Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Plugin folders cleanup Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning into folder /volumio/app/plugins/ Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category audio_interface Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category miscellanea Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category music_service Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category plugins.json Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category system_controller Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category user_interface Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning into folder /data/plugins/ Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Scanning category music_service Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Plugin folders cleanup completed Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: ------------------------------------------- Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: ----- Core plugins startup ---- Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: ------------------------------------------- Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Loading plugins from folder /volumio/app/plugins/ Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin bluetooth to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin multiroom to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin upnp to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin metavolumio to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin cd_controller to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin raat to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Loading plugins from folder /data/plugins/ Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Adding plugin rtlsdr_radio to MyMusic Plugins Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Loading plugin "system"... Oct 11 19:18:58 rivoessential-dev0 volumio[2577]: info: Loading plugin "appearance"... Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Connecting to system D-Bus Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Connected to system D-Bus Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 bluezutils [INFO] Found adapter at: /org/bluez/hci0 Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Found Bluetooth adapter: /org/bluez/hci0 Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Set DiscoverableTimeout to infinite Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Enabled Discoverable mode Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Agent registered at /local/a2dpagent Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] Agent set as default Oct 11 19:18:58 rivoessential-dev0 volumiobt[2833]: 2026-10-11 19:18:58 a2dp-agent [INFO] A2DP agent running, waiting for connections... Oct 11 19:19:02 rivoessential-dev0 volumio[2577]: info: Loading plugin "network"... Oct 11 19:19:02 rivoessential-dev0 volumio[2577]: info: Refreshing Cached IP Addresses Oct 11 19:19:02 rivoessential-dev0 volumio[2577]: info: Loading plugin "services"... Oct 11 19:19:02 rivoessential-dev0 sudo[2850]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 19:19:02 rivoessential-dev0 volumio[2577]: info: Loading plugin "volumio5onboarding"... Oct 11 19:19:02 rivoessential-dev0 sudo[2850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:02 rivoessential-dev0 sudo[2848]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 19:19:02 rivoessential-dev0 sudo[2848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:02 rivoessential-dev0 sudo[2850]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:02 rivoessential-dev0 sudo[2848]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:02 rivoessential-dev0 volumio[2577]: info: Loading plugin "alsa_controller"... Oct 11 19:19:02 rivoessential-dev0 sudo[2861]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 11 19:19:02 rivoessential-dev0 sudo[2861]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Loading plugin "wizard"... Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Loading plugin "networkfs"... Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Starting Udev Watcher for removable devices Oct 11 19:19:03 rivoessential-dev0 sudo[2861]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Mounting Device ISSD Oct 11 19:19:03 rivoessential-dev0 sudo[2884]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/mmcblk0p1 /mnt/INTERNAL/ -o noatime Oct 11 19:19:03 rivoessential-dev0 sudo[2884]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:03 rivoessential-dev0 kernel: exFAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Oct 11 19:19:03 rivoessential-dev0 sudo[2884]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Binding Internal Memory position Oct 11 19:19:03 rivoessential-dev0 sudo[2889]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -o bind /mnt/INTERNAL /data/INTERNAL Oct 11 19:19:03 rivoessential-dev0 sudo[2889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:03 rivoessential-dev0 sudo[2889]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Ignoring mount for partition: BOOT Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Ignoring mount for partition: volumio Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Ignoring mount for partition: volumio_data Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Loading plugin "volumio_command_line_client"... Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Loading plugin "upnp"... Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: [1791739143875] Starting Upmpd Daemon Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Loading plugin "my_music"... Oct 11 19:19:03 rivoessential-dev0 volumio[2577]: info: Loading plugin "mpd"... Oct 11 19:19:05 rivoessential-dev0 volumio[2577]: info: Loading plugin "upnp_browser"... Oct 11 19:19:05 rivoessential-dev0 sshd[2844]: Accepted password for volumio from 192.168.1.210 port 50487 ssh2 Oct 11 19:19:05 rivoessential-dev0 sshd[2844]: pam_unix(sshd:session): session opened for user volumio(uid=1000) by (uid=0) Oct 11 19:19:05 rivoessential-dev0 systemd[1]: Created slice user-1000.slice - User Slice of UID 1000. Oct 11 19:19:05 rivoessential-dev0 systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Oct 11 19:19:06 rivoessential-dev0 systemd-logind[1300]: New session 1 of user volumio. Oct 11 19:19:06 rivoessential-dev0 systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Oct 11 19:19:06 rivoessential-dev0 systemd[1]: Starting user@1000.service - User Manager for UID 1000... Oct 11 19:19:06 rivoessential-dev0 (systemd)[2896]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0) Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Queued start job for default target default.target. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Created slice app.slice - User Application Slice. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Reached target paths.target - Paths. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Reached target timers.target - Timers. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Reached target sockets.target - Sockets. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Reached target basic.target - Basic System. Oct 11 19:19:08 rivoessential-dev0 systemd[1]: Started user@1000.service - User Manager for UID 1000. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Started mpris-proxy.service - Bluetooth mpris proxy. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Reached target default.target - Main User Target. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: Startup finished in 1.665s. Oct 11 19:19:08 rivoessential-dev0 mpris-proxy[2912]: Can't get on session bus Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: mpris-proxy.service: Main process exited, code=exited, status=1/FAILURE Oct 11 19:19:08 rivoessential-dev0 systemd[1]: Started session-1.scope - Session 1 of User volumio. Oct 11 19:19:08 rivoessential-dev0 systemd[2896]: mpris-proxy.service: Failed with result 'exit-code'. Oct 11 19:19:08 rivoessential-dev0 volumio[2577]: info: Starting UPNP Browser Oct 11 19:19:08 rivoessential-dev0 volumio[2577]: info: Loading plugin "bluetooth"... Oct 11 19:19:08 rivoessential-dev0 sshd[2844]: pam_env(sshd:session): deprecated reading of user environment enabled Oct 11 19:19:08 rivoessential-dev0 volumio-remote-updater[1313]: [2026-10-11 19:19:08] [connect] Successful connection Oct 11 19:19:08 rivoessential-dev0 volumio[2577]: info: Applying required configuration parameters for plugin bluetooth Oct 11 19:19:09 rivoessential-dev0 volumio[2577]: info: Applying required configuration parameters for plugin bluetooth Oct 11 19:19:09 rivoessential-dev0 volumio[2577]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Oct 11 19:19:09 rivoessential-dev0 volumio[2577]: info: Loading plugin "alarm-clock"... Oct 11 19:19:09 rivoessential-dev0 volumio[2577]: info: Loading plugin "manifestui"... Oct 11 19:19:09 rivoessential-dev0 volumio[2577]: info: Loading plugin "metavolumio"... Oct 11 19:19:12 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Oct 11 19:19:12 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:19:12 rivoessential-dev0 sudo[2928]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f Oct 11 19:19:12 rivoessential-dev0 sudo[2928]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Oct 11 19:19:12 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:19:12 rivoessential-dev0 upmpdcli[2930]: Could not open config: /tmp/upmpdcli.conf Oct 11 19:19:12 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 11 19:19:12 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 11 19:19:13 rivoessential-dev0 volumio[2577]: info: Loading plugin "airplay_emulation"... Oct 11 19:19:13 rivoessential-dev0 volumio[2577]: info: Starting Shairport Sync Oct 11 19:19:13 rivoessential-dev0 volumio[2577]: info: Loading plugin "cd_controller"... Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: Loading plugin "last_100"... Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: Loading plugin "qobuzconnect"... Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: Loading plugin "raat"... Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: RAAT Plugin loaded Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: Adding restartRAATSocket REST API Endpoint Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Oct 11 19:19:14 rivoessential-dev0 volumio[2577]: info: Loading plugin "streaming_services"... Oct 11 19:19:17 rivoessential-dev0 volumio[2577]: info: Loading plugin "tidalconnect"... Oct 11 19:19:18 rivoessential-dev0 volumio[2577]: info: Loading plugin "webradio"... Oct 11 19:19:18 rivoessential-dev0 volumio[2577]: info: Loading plugin "i2s_dacs"... Oct 11 19:19:18 rivoessential-dev0 volumio[2577]: info: I2S DAC not set, start Auto-detection Oct 11 19:19:18 rivoessential-dev0 volumio[2577]: info: Loading plugin "volumiodiscovery"... Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: *** WARNING *** For more information see Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: *** 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:19:19 rivoessential-dev0 volumio[2577]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: *** WARNING *** For more information see Oct 11 19:19:19 rivoessential-dev0 node[2577]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 19:19:19 rivoessential-dev0 node[2577]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 19:19:19 rivoessential-dev0 node[2577]: *** WARNING *** For more information see Oct 11 19:19:19 rivoessential-dev0 node[2577]: *** 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:19:19 rivoessential-dev0 node[2577]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 19:19:19 rivoessential-dev0 node[2577]: *** WARNING *** For more information see Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: info: Discovery: Started advertising with name: RivoEssential-dev0 Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 19:19:19 rivoessential-dev0 volumio[2577]: info: Loading plugin "spop"... Oct 11 19:19:22 rivoessential-dev0 volumio[2577]: info: Loading plugin "multiroom"... Oct 11 19:19:23 rivoessential-dev0 volumio-remote-updater[1313]: [2026-10-11 19:19:23] [connect] Successful connection Oct 11 19:19:26 rivoessential-dev0 volumio[2577]: info: Applying required configuration parameters for plugin multiroom Oct 11 19:19:26 rivoessential-dev0 sudo[2967]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Oct 11 19:19:26 rivoessential-dev0 sudo[2967]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:26 rivoessential-dev0 sudo[2967]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: MRS: MultiRoom plugin initialized Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: MRS: STOPPING SNAPCLIENT Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: MRS: Snap server stop Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: MRS: STOPPING volumioStreaming Oct 11 19:19:27 rivoessential-dev0 sudo[2984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Oct 11 19:19:27 rivoessential-dev0 sudo[2984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:27 rivoessential-dev0 sudo[2986]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Oct 11 19:19:27 rivoessential-dev0 sudo[2986]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: Loading plugin "outputs"... Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: Loading plugin "albumart"... Oct 11 19:19:27 rivoessential-dev0 sudo[2988]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Oct 11 19:19:27 rivoessential-dev0 sudo[2988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:27 rivoessential-dev0 sudo[2991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 11 19:19:27 rivoessential-dev0 sudo[2991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: Plugin example_plugin is not enabled Oct 11 19:19:27 rivoessential-dev0 volumio[2577]: info: Loading plugin "hi_res_audio"... Oct 11 19:19:27 rivoessential-dev0 sudo[2991]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:28 rivoessential-dev0 sudo[2984]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:28 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Oct 11 19:19:28 rivoessential-dev0 sudo[2986]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:28 rivoessential-dev0 volumio[2994]: Forking 3 albumart workers Oct 11 19:19:28 rivoessential-dev0 sudo[2988]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:28 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:19:28 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:19:29 rivoessential-dev0 upmpdcli[3032]: Could not open config: /tmp/upmpdcli.conf Oct 11 19:19:29 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 11 19:19:29 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 11 19:19:31 rivoessential-dev0 volumio[3007]: Starting albumart workers Oct 11 19:19:31 rivoessential-dev0 volumio[3005]: Starting albumart workers Oct 11 19:19:31 rivoessential-dev0 volumio[3006]: Starting albumart workers Oct 11 19:19:32 rivoessential-dev0 volumio[2577]: info: Applying required configuration parameters for plugin hi_res_audio Oct 11 19:19:32 rivoessential-dev0 volumio[2577]: info: Loading plugin "inputs"... Oct 11 19:19:34 rivoessential-dev0 volumio[2577]: info: Loading plugin "qobuz"... Oct 11 19:19:38 rivoessential-dev0 volumio[2577]: info: Plugin smart_inputs is not enabled Oct 11 19:19:38 rivoessential-dev0 volumio[2577]: info: Loading plugin "tidal"... Oct 11 19:19:38 rivoessential-dev0 volumio-remote-updater[1313]: [2026-10-11 19:19:38] [connect] Successful connection Oct 11 19:19:38 rivoessential-dev0 dbus-daemon[1252]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30012ms) Oct 11 19:19:41 rivoessential-dev0 volumio[2577]: info: Loading plugin "rivoessentialcontrol"... Oct 11 19:19:41 rivoessential-dev0 volumio[2577]: info: Adding this device properties Oct 11 19:19:41 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 11 19:19:41 rivoessential-dev0 volumio[2577]: info: Setting Additional Device Volumio Properties: [object Object] Oct 11 19:19:41 rivoessential-dev0 volumio[2577]: info: Loading plugin "updater_comm"... Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Plugin mpdemulation is not enabled Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Loading plugin "rest_api"... Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Loading plugin "websocket"... Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Starting Socket.io Server version 1.7.4 Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Loading plugin "motherearthradio"... Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Loading plugin "radio_paradise"... Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Applying required configuration parameters for plugin radio_paradise Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: [1791739182926] [RadioParadise] API delay: 5 Oct 11 19:19:42 rivoessential-dev0 volumio[2577]: info: Loading plugin "rtlsdr_radio"... Oct 11 19:19:44 rivoessential-dev0 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Oct 11 19:19:44 rivoessential-dev0 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:19:44 rivoessential-dev0 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 11 19:19:44 rivoessential-dev0 volumio[2577]: info: [RTL-SDR Radio] Loaded FM region data Oct 11 19:19:44 rivoessential-dev0 volumio[2577]: info: Loading i18n strings for locale en Oct 11 19:19:44 rivoessential-dev0 volumio[2577]: Updating browse sources language Oct 11 19:19:44 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 19:19:44 rivoessential-dev0 upmpdcli[3083]: Could not open config: /tmp/upmpdcli.conf Oct 11 19:19:44 rivoessential-dev0 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 11 19:19:44 rivoessential-dev0 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::initPlayerControls Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: Express server listening on port 3000 Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: [Metrics] WebUI: 54s 110.00ms Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreStateMachine::resetVolumioState Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreStateMachine::getcurrentVolume Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::volumioRetrievevolume Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreStateMachine::pushState Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CorePlayQueue::getTrack 0 Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::volumioPushState Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 19:19:45 rivoessential-dev0 sudo[3094]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 19:19:45 rivoessential-dev0 sudo[3094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: Completed loading Core Plugins Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: Preparing to generate the ALSA configuration file Oct 11 19:19:45 rivoessential-dev0 sudo[3096]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 19:19:45 rivoessential-dev0 sudo[3096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 19:19:45 rivoessential-dev0 sudo[3096]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:45 rivoessential-dev0 sudo[3094]: pam_unix(sudo:session): session closed for user root Oct 11 19:19:45 rivoessential-dev0 volumio[2577]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: info: Reading ALSA contributions from plugins. Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: info: Volumio Network Manager: Network status updated: 2 Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: Error: write EPIPE Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at writeGeneric (node:internal/stream_base_commons:151:3) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at Socket._writeGeneric (node:net:952:11) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at Socket._write (node:net:964:8) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at writeOrBuffer (node:internal/streams/writable:399:12) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at _write (node:internal/streams/writable:340:10) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at Writable.write (node:internal/streams/writable:344:10) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at auth (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/handshake.js:67:10) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at Socket. (/volumio/app/plugins/audio_interface/bluetooth/node_modules/dbus-next/lib/connection.js:137:32) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at Object.onceWrapper (node:events:628:28) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at Socket.emit (node:events:514:28) Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: at PipeConnectWrap.afterConnect [as oncomplete] (node:net:1580:10) { Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: errno: -32, Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: code: 'EPIPE', Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: syscall: 'write' Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: } Oct 11 19:19:46 rivoessential-dev0 volumio[2577]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 19:19:47 rivoessential-dev0 sudo[3114]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-11 19:18' Oct 11 19:19:47 rivoessential-dev0 sudo[3114]: 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"