-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2026-02-21 14:30:23 CET. -- Feb 21 14:29:49 volumio systemd-timedated[946]: Changed local time to Sat Feb 21 14:29:49 2026 Feb 21 14:29:49 volumio sudo[944]: pam_unix(sudo:session): session closed for user root Feb 21 14:29:49 volumio volumio-time-update[498]: volumio-time-update-util: System time updated successfully. Feb 21 14:29:49 volumio systemd[1]: Started Volumio Time Update Utility. Feb 21 14:29:49 volumio nmbd[747]: [2026/02/21 14:29:49.034951, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 21 14:29:49 volumio systemd[1]: Started Samba NMB Daemon. Feb 21 14:29:49 volumio nmbd[747]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Feb 21 14:29:49 volumio systemd[1]: Starting Samba Winbind Daemon... Feb 21 14:29:49 volumio winbindd[948]: [2026/02/21 14:29:49.722246, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 21 14:29:49 volumio winbindd[948]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 21 14:29:49 volumio winbindd[948]: [2026/02/21 14:29:49.796930, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 21 14:29:49 volumio systemd[1]: Started Samba Winbind Daemon. Feb 21 14:29:49 volumio winbindd[948]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 21 14:29:49 volumio systemd[1]: Starting Samba SMB Daemon... Feb 21 14:29:50 volumio smbd[953]: [2026/02/21 14:29:50.857659, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 21 14:29:50 volumio systemd[1]: Started Samba SMB Daemon. Feb 21 14:29:50 volumio smbd[953]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 21 14:29:50 volumio systemd[1]: Reached target Multi-User System. Feb 21 14:29:50 volumio systemd[1]: Reached target Graphical Interface. Feb 21 14:29:50 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 21 14:29:51 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 21 14:29:51 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 21 14:29:51 volumio systemd[1]: Startup finished in 15.401s (kernel) + 37.263s (userspace) = 52.664s. Feb 21 14:29:53 volumio volumio[922]: info: ------------------------------------------- Feb 21 14:29:53 volumio volumio[922]: info: ----- Volumio3 ---- Feb 21 14:29:53 volumio volumio[922]: info: ------------------------------------------- Feb 21 14:29:53 volumio volumio[922]: info: ----- System startup ---- Feb 21 14:29:53 volumio volumio[922]: info: ------------------------------------------- Feb 21 14:29:56 volumio volumio[922]: info: MYVOLUMIO Environment detected Feb 21 14:29:56 volumio volumio-remote-updater[487]: [2026-02-21 14:29:56] [connect] Successful connection Feb 21 14:29:56 volumio volumio[922]: info: Plugin folders cleanup Feb 21 14:29:56 volumio volumio[922]: info: Scanning into folder /volumio/app/plugins/ Feb 21 14:29:56 volumio volumio[922]: info: Scanning category audio_interface Feb 21 14:29:56 volumio volumio[922]: info: Scanning category miscellanea Feb 21 14:29:56 volumio volumio[922]: info: Scanning category music_service Feb 21 14:29:56 volumio volumio[922]: info: Scanning category plugins.json Feb 21 14:29:56 volumio volumio[922]: info: Scanning category system_controller Feb 21 14:29:56 volumio volumio[922]: info: Scanning category user_interface Feb 21 14:29:56 volumio volumio[922]: info: Scanning into folder /data/plugins/ Feb 21 14:29:56 volumio volumio[922]: info: Scanning category audio_interface Feb 21 14:29:56 volumio volumio[922]: info: Scanning category music_service Feb 21 14:29:56 volumio volumio[922]: info: Scanning category system_controller Feb 21 14:29:56 volumio volumio[922]: info: Scanning category system_hardware Feb 21 14:29:56 volumio volumio[922]: info: Scanning category user_interface Feb 21 14:29:56 volumio volumio[922]: info: Plugin folders cleanup completed Feb 21 14:29:56 volumio volumio[922]: info: ------------------------------------------- Feb 21 14:29:56 volumio volumio[922]: info: ----- Core plugins startup ---- Feb 21 14:29:56 volumio volumio[922]: info: ------------------------------------------- Feb 21 14:29:56 volumio volumio[922]: info: Loading plugins from folder /volumio/app/plugins/ Feb 21 14:29:56 volumio volumio[922]: info: Adding plugin upnp to MyMusic Plugins Feb 21 14:29:56 volumio volumio[922]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 21 14:29:56 volumio volumio[922]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 21 14:29:56 volumio volumio[922]: info: Loading plugins from folder /data/plugins/ Feb 21 14:29:56 volumio volumio[922]: info: Loading plugin "system"... Feb 21 14:29:56 volumio volumio[922]: info: Loading plugin "appearance"... Feb 21 14:29:59 volumio volumio[922]: info: Loading plugin "network"... Feb 21 14:29:59 volumio volumio[922]: info: Refreshing Cached IP Addresses Feb 21 14:29:59 volumio sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 14:29:59 volumio sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:29:59 volumio sudo[976]: pam_unix(sudo:session): session closed for user root Feb 21 14:29:59 volumio sudo[978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 14:29:59 volumio sudo[978]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:29:59 volumio volumio[922]: info: Loading plugin "services"... Feb 21 14:29:59 volumio sudo[978]: pam_unix(sudo:session): session closed for user root Feb 21 14:29:59 volumio volumio[922]: info: Loading plugin "volumio5onboarding"... Feb 21 14:29:59 volumio sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 21 14:29:59 volumio sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:29:59 volumio volumio[922]: info: Loading plugin "alsa_controller"... Feb 21 14:29:59 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:29:59 volumio volumio[922]: info: Loading plugin "wizard"... Feb 21 14:29:59 volumio volumio[922]: info: Loading plugin "networkfs"... Feb 21 14:30:00 volumio volumio[922]: info: Starting Udev Watcher for removable devices Feb 21 14:30:00 volumio volumio[922]: info: Ignoring mount for partition: boot Feb 21 14:30:00 volumio volumio[922]: info: Ignoring mount for partition: volumio Feb 21 14:30:00 volumio volumio[922]: info: Ignoring mount for partition: volumio_data Feb 21 14:30:00 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 14:30:00 volumio volumio[922]: info: Loading plugin "volumio_command_line_client"... Feb 21 14:30:00 volumio volumio[922]: info: Loading plugin "upnp"... Feb 21 14:30:00 volumio volumio[922]: info: [1771680600199] Starting Upmpd Daemon Feb 21 14:30:00 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 14:30:00 volumio volumio[922]: info: Loading plugin "my_music"... Feb 21 14:30:00 volumio volumio[922]: info: Loading plugin "mpd"... Feb 21 14:30:01 volumio volumio[922]: info: Loading plugin "upnp_browser"... Feb 21 14:30:01 volumio sudo[985]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:01 volumio sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Claudio,password=elefante30,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //TRUENAS/Plex\\Musica /mnt/NAS/Nas Feb 21 14:30:01 volumio sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:01 volumio kernel: Key type cifs.spnego registered Feb 21 14:30:01 volumio kernel: Key type cifs.idmap registered Feb 21 14:30:01 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Feb 21 14:30:01 volumio kernel: CIFS: Attempting to mount //TRUENAS/Plex/Musica Feb 21 14:30:02 volumio kernel: cryptd: max_cpu_qlen set to 1000 Feb 21 14:30:02 volumio volumio[922]: info: Starting UPNP Browser Feb 21 14:30:02 volumio volumio[922]: info: Loading plugin "alarm-clock"... Feb 21 14:30:02 volumio volumio[922]: info: Loading plugin "airplay_emulation"... Feb 21 14:30:02 volumio volumio[922]: info: Starting Shairport Sync Feb 21 14:30:02 volumio volumio[922]: info: Loading plugin "last_100"... Feb 21 14:30:02 volumio volumio[922]: info: Loading plugin "webradio"... Feb 21 14:30:02 volumio sudo[1002]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:03 volumio volumio[922]: info: Loading plugin "i2s_dacs"... Feb 21 14:30:03 volumio volumio[922]: info: Loading plugin "volumiodiscovery"... Feb 21 14:30:03 volumio volumio[922]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 21 14:30:03 volumio volumio[922]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:30:03 volumio volumio[922]: *** WARNING *** For more information see Feb 21 14:30:03 volumio volumio[922]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 21 14:30:03 volumio volumio[922]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:30:03 volumio volumio[922]: *** WARNING *** For more information see Feb 21 14:30:03 volumio node[922]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 21 14:30:03 volumio node[922]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:30:03 volumio node[922]: *** WARNING *** For more information see Feb 21 14:30:03 volumio node[922]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 21 14:30:03 volumio node[922]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 21 14:30:03 volumio node[922]: *** WARNING *** For more information see Feb 21 14:30:03 volumio volumio[922]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 21 14:30:03 volumio volumio[922]: info: Discovery: Started advertising with name: Volumio Feb 21 14:30:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 21 14:30:03 volumio volumio[922]: info: Loading plugin "ytmusic"... Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "outputs"... Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "albumart"... Feb 21 14:30:11 volumio volumio[922]: info: Plugin example_plugin is not enabled Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "inputs"... Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "updater_comm"... Feb 21 14:30:11 volumio volumio-remote-updater[487]: [2026-02-21 14:30:11] [connect] Successful connection Feb 21 14:30:11 volumio volumio[922]: info: Plugin mpdemulation is not enabled Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "rest_api"... Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "websocket"... Feb 21 14:30:11 volumio volumio[922]: info: Starting Socket.io Server version 2.3.0 Feb 21 14:30:11 volumio volumio[922]: info: Loading plugin "fusiondsp"... Feb 21 14:30:12 volumio volumio[922]: Forking 3 albumart workers Feb 21 14:30:12 volumio volumio[922]: info: Applying required configuration parameters for plugin fusiondsp Feb 21 14:30:13 volumio volumio[922]: info: Loading plugin "radio_paradise"... Feb 21 14:30:13 volumio volumio[922]: info: Applying required configuration parameters for plugin radio_paradise Feb 21 14:30:13 volumio volumio[922]: info: [1771680613903] [RadioParadise] API delay: 5 Feb 21 14:30:13 volumio volumio[922]: info: Loading plugin "backup_restore"... Feb 21 14:30:14 volumio volumio[922]: Starting albumart workers Feb 21 14:30:14 volumio volumio[922]: Starting albumart workers Feb 21 14:30:14 volumio volumio[922]: Starting albumart workers Feb 21 14:30:14 volumio volumio[922]: info: Applying required configuration parameters for plugin backup_restore Feb 21 14:30:14 volumio volumio[922]: info: Loading plugin "mpd_oled"... Feb 21 14:30:15 volumio volumio[922]: info: Applying required configuration parameters for plugin mpd_oled Feb 21 14:30:15 volumio volumio[922]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Feb 21 14:30:15 volumio volumio[922]: info: Loading plugin "Systeminfo"... Feb 21 14:30:16 volumio volumio[922]: info: Loading i18n strings for locale it Feb 21 14:30:16 volumio volumio[922]: Updating browse sources language Feb 21 14:30:16 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::initPlayerControls Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:30:17 volumio volumio[922]: Express server listening on port 3000 Feb 21 14:30:17 volumio volumio[922]: [Metrics] WebUI: 25s 520.30ms Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::resetVolumioState Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::getcurrentVolume Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::volumioRetrievevolume Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::pushState Feb 21 14:30:17 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Feb 21 14:30:17 volumio sudo[1115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 21 14:30:17 volumio sudo[1115]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:17 volumio sudo[1115]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:17 volumio sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 21 14:30:17 volumio sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:17 volumio sudo[1117]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:17 volumio volumio[922]: info: Volumio Network Manager: Network status updated: 2 Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:17 volumio volumio[922]: info: Reloading queue from file Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::setRepeat false single undefined Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::pushState Feb 21 14:30:17 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::setRandom false Feb 21 14:30:17 volumio volumio[922]: info: CoreStateMachine::pushState Feb 21 14:30:17 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 14:30:17 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Feb 21 14:30:17 volumio volumio[922]: info: Setting Device type: Raspberry PI Feb 21 14:30:17 volumio volumio[922]: info: Completed loading Core Plugins Feb 21 14:30:17 volumio volumio[922]: info: Preparing to generate the ALSA configuration file Feb 21 14:30:18 volumio volumio[922]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 21 14:30:18 volumio volumio[922]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Feb 21 14:30:18 volumio volumio[922]: info: Reading ALSA contributions from plugins. Feb 21 14:30:18 volumio volumio[922]: info: Discovery: adding 66d1e038-50f5-4aa2-89fc-b15f5d428254 Feb 21 14:30:18 volumio volumio[922]: info: Discovery: Found device Volumio Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::volumioGetState Feb 21 14:30:18 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:18 volumio sudo[1126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 21 14:30:18 volumio sudo[1126]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio volumio[922]: info: Asound.conf file unchanged, so no further update is needed Feb 21 14:30:18 volumio volumio[922]: info: Output device has changed, restarting MPD Feb 21 14:30:18 volumio sudo[1129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 14:30:18 volumio sudo[1129]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio volumio[922]: info: Output device has changed, restarting Shairport Sync Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:18 volumio sudo[1129]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 21 14:30:18 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 14:30:18 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio sudo[1126]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:18 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 14:30:18 volumio volumio[922]: info: ___________ START PLUGINS ___________ Feb 21 14:30:18 volumio systemd[1]: Listening on mpd.socket. Feb 21 14:30:18 volumio systemd[1]: Starting Music Player Daemon... Feb 21 14:30:18 volumio volumio[922]: info: ControllerMpd::onStart: Initializing MPD Feb 21 14:30:18 volumio volumio[922]: info: Creating MPD Configuration file Feb 21 14:30:18 volumio sudo[1140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 21 14:30:18 volumio sudo[1140]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:30:18 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 14:30:18 volumio volumio[922]: info: [1771680618486] CoreMusicLibrary::Adding element Server multimediali Feb 21 14:30:18 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:30:18 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:18 volumio volumio[922]: info: UPNP Browser: Client initialized successfully Feb 21 14:30:18 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 14:30:18 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:18 volumio systemd[1]: Started Volumio5 Onboarding Server. Feb 21 14:30:18 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 21 14:30:18 volumio systemd[1]: mpd.service: Succeeded. Feb 21 14:30:18 volumio systemd[1]: Stopped Music Player Daemon. Feb 21 14:30:18 volumio sudo[1140]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:18 volumio systemd[1]: Starting Music Player Daemon... Feb 21 14:30:18 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:18 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:30:18 volumio volumio[922]: info: [1771680618818] CoreMusicLibrary::Adding element Last_100 Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:30:18 volumio volumio[922]: info: [1771680618826] CoreMusicLibrary::Adding element Webradio Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:30:18 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:30:18 volumio volumio[922]: info: Initializing BBC Radios Feb 21 14:30:18 volumio sudo[1153]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 14:30:18 volumio sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:18 volumio sudo[1153]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 21 14:30:18 volumio sudo[1153]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:30:19 volumio volumio[922]: info: [1771680619049] CoreMusicLibrary::Adding element YouTube Music Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:30:19 volumio volumio[922]: Cannot find translation for source YouTube Music Feb 21 14:30:19 volumio systemd[1]: systemd-timedated.service: Succeeded. Feb 21 14:30:19 volumio volumio[922]: info: Loading i18n strings for locale it Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:19 volumio volumio[922]: info: FusionDsp - mixtype--------------------- None Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 21 14:30:19 volumio volumio[922]: info: [1771680619192] CoreMusicLibrary::Adding element Radio Paradise Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 21 14:30:19 volumio volumio[922]: Cannot find translation for source YouTube Music Feb 21 14:30:19 volumio volumio[922]: Cannot find translation for source Radio Paradise Feb 21 14:30:19 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 21 14:30:19 volumio volumio[922]: info: [MPD_OLED Plugin] Not starting mpd_oled service because oled type is not configured yet Feb 21 14:30:19 volumio volumio[922]: info: Volumio Calling Home Feb 21 14:30:19 volumio volumio[922]: info: Preparing to generate the ALSA configuration file Feb 21 14:30:19 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:19.539+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 21 14:30:19 volumio volumio[922]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 21 14:30:19 volumio volumio[922]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Feb 21 14:30:19 volumio volumio[922]: info: Reading ALSA contributions from plugins. Feb 21 14:30:19 volumio volumio[922]: info: MPD Permissions set Feb 21 14:30:19 volumio volumio[922]: info: MPD Permissions set Feb 21 14:30:19 volumio volumio[922]: info: Upmpdcli Daemon Started Feb 21 14:30:19 volumio volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Feb 21 14:30:19 volumio dbus-daemon[482]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.12' (uid=0 pid=1148 comm="/usr/bin/volumio5-onboarding ") Feb 21 14:30:19 volumio volumio[922]: info: Volumio called home Feb 21 14:30:20 volumio volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Feb 21 14:30:20 volumio systemd[1]: Starting Bluetooth service... Feb 21 14:30:20 volumio volumio[922]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:20 volumio kernel: Bluetooth: Core ver 2.22 Feb 21 14:30:20 volumio kernel: NET: Registered PF_BLUETOOTH protocol family Feb 21 14:30:20 volumio kernel: Bluetooth: HCI device and connection manager initialized Feb 21 14:30:20 volumio kernel: Bluetooth: HCI socket layer initialized Feb 21 14:30:20 volumio kernel: Bluetooth: L2CAP socket layer initialized Feb 21 14:30:20 volumio kernel: Bluetooth: SCO socket layer initialized Feb 21 14:30:20 volumio bluetoothd[1198]: Bluetooth daemon 5.83 Feb 21 14:30:20 volumio bluetoothd[1198]: src/main.c:check_options() Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 21 14:30:20 volumio dbus-daemon[482]: [system] Successfully activated service 'org.bluez' Feb 21 14:30:20 volumio systemd[1]: Started Bluetooth service. Feb 21 14:30:20 volumio bluetoothd[1198]: Starting SDP server Feb 21 14:30:20 volumio bluetoothd[1198]: Excluding (cli) hostname Feb 21 14:30:20 volumio bluetoothd[1198]: Excluding (cli) scanparam Feb 21 14:30:20 volumio bluetoothd[1198]: Excluding (cli) battery Feb 21 14:30:20 volumio bluetoothd[1198]: Bluetooth management interface 1.22 initialized Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.670+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci0 error="bluetooth: adapter /org/bluez/hci0 does not exist" Feb 21 14:30:20 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 21 14:30:20 volumio kernel: Bluetooth: BNEP filters: protocol multicast Feb 21 14:30:20 volumio kernel: Bluetooth: BNEP socket layer initialized Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.681+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci1 error="bluetooth: adapter /org/bluez/hci1 does not exist" Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.688+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci2 error="bluetooth: adapter /org/bluez/hci2 does not exist" Feb 21 14:30:20 volumio volumio[922]: info: Starting Shairport Sync Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.694+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci3 error="bluetooth: adapter /org/bluez/hci3 does not exist" Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.699+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci4 error="bluetooth: adapter /org/bluez/hci4 does not exist" Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.699+01:00 level=WARN msg="no Bluetooth adapter found, BLE discovery disabled" Feb 21 14:30:20 volumio volumio[922]: info: Starting Shairport Sync Feb 21 14:30:20 volumio volumio[922]: info: Starting Shairport Sync Feb 21 14:30:20 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 14:30:20 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:20 volumio sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 14:30:20 volumio sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 21 14:30:20 volumio sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 21 14:30:20 volumio sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:20 volumio systemd[1]: shairport-sync.service: Succeeded. Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::volumioGetState Feb 21 14:30:20 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 21 14:30:20 volumio volumio[922]: info: Received Get System Info Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 14:30:20 volumio volumio[922]: info: Discovery: Getting this device information Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::volumioGetState Feb 21 14:30:20 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:20 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 14:30:20 volumio volumio5-onboarding[1148]: time=2026-02-21T14:30:20.950+01:00 level=INFO msg="system info for 76b523eead87e6fc82000eca842c5576" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=3.908 Feb 21 14:30:21 volumio volumio[922]: info: Asound.conf file unchanged, so no further update is needed Feb 21 14:30:21 volumio volumio[922]: info: Output device has changed, restarting MPD Feb 21 14:30:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 21 14:30:21 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 21 14:30:21 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 21 14:30:21 volumio systemd[1]: shairport-sync.service: Succeeded. Feb 21 14:30:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 21 14:30:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 21 14:30:21 volumio sudo[1222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 21 14:30:21 volumio sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:21 volumio sudo[1214]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:21 volumio sudo[1222]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:21 volumio sudo[1217]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:21 volumio volumio[922]: info: Output device has changed, restarting Shairport Sync Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 21 14:30:21 volumio sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 21 14:30:21 volumio sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:21 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 21 14:30:21 volumio systemd[1]: mpd.service: Succeeded. Feb 21 14:30:21 volumio systemd[1]: Stopped Music Player Daemon. Feb 21 14:30:21 volumio volumio[922]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 21 14:30:21 volumio volumio[922]: info: Preparing to generate the ALSA configuration file Feb 21 14:30:21 volumio systemd[1]: Starting Music Player Daemon... Feb 21 14:30:21 volumio volumio[922]: info: Received Get System Info Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 21 14:30:21 volumio volumio[922]: info: Discovery: Getting this device information Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::volumioGetState Feb 21 14:30:21 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 14:30:21 volumio volumio[922]: info: camilladsp service started and running in background, instance 1 Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 21 14:30:21 volumio volumio[922]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 21 14:30:21 volumio volumio[922]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 21 14:30:21 volumio volumio[922]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 21 14:30:21 volumio volumio[922]: info: FusionDsp loaded Feb 21 14:30:21 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 21 14:30:21 volumio sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 21 14:30:21 volumio sudo[1233]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 21 14:30:21 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:21 volumio sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 21 14:30:21 volumio sudo[1233]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 21 14:30:21 volumio sudo[1233]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:21 volumio volumio[922]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 21 14:30:21 volumio volumio[922]: info: Adding Signal Path Element [object Object] Feb 21 14:30:21 volumio volumio[922]: info: Adding fusiondspeq DSP Signal Path Element Feb 21 14:30:21 volumio volumio[922]: info: FusionDsp - ---- installed callbackRead Feb 21 14:30:21 volumio volumio[922]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 14:30:21 volumio volumio[922]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 21 14:30:21 volumio volumio[922]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 21 14:30:21 volumio volumio[922]: at onErrorNT (internal/child_process.js:465:16) Feb 21 14:30:21 volumio volumio[922]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 21 14:30:21 volumio volumio[922]: at runNextTicks (internal/process/task_queues.js:62:3) Feb 21 14:30:21 volumio volumio[922]: at listOnTimeout (internal/timers.js:523:9) Feb 21 14:30:21 volumio volumio[922]: at processTimers (internal/timers.js:497:7) { Feb 21 14:30:21 volumio volumio[922]: errno: -2, Feb 21 14:30:21 volumio volumio[922]: code: 'ENOENT', Feb 21 14:30:21 volumio volumio[922]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 21 14:30:21 volumio volumio[922]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 21 14:30:21 volumio volumio[922]: spawnargs: [ Feb 21 14:30:21 volumio volumio[922]: '-p', Feb 21 14:30:21 volumio volumio[922]: 9876, Feb 21 14:30:21 volumio volumio[922]: '-o', Feb 21 14:30:21 volumio volumio[922]: '/tmp/camilladsp.log', Feb 21 14:30:21 volumio volumio[922]: '-l', Feb 21 14:30:21 volumio volumio[922]: 'warn', Feb 21 14:30:21 volumio volumio[922]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 21 14:30:21 volumio volumio[922]: ] Feb 21 14:30:21 volumio volumio[922]: } Feb 21 14:30:21 volumio volumio[922]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 14:30:21 volumio systemd[1]: Started FusionDsp Daemon. Feb 21 14:30:21 volumio sudo[1249]: pam_unix(sudo:session): session closed for user root Feb 21 14:30:23 volumio sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 14:29 Feb 21 14:30:23 volumio sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"