-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2026-04-11 09:38:15 CEST. -- Apr 11 09:37:39 stanzetta systemd-timedated[931]: Changed local time to Sat Apr 11 09:37:39 2026 Apr 11 09:37:39 stanzetta sudo[929]: pam_unix(sudo:session): session closed for user root Apr 11 09:37:39 stanzetta volumio-time-update[471]: volumio-time-update-util: System time updated successfully. Apr 11 09:37:39 stanzetta systemd[1]: Starting Daily apt download activities... Apr 11 09:37:39 stanzetta systemd[1]: Started Volumio Time Update Utility. Apr 11 09:37:41 stanzetta nmbd[826]: [2026/04/11 09:37:41.429119, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 11 09:37:41 stanzetta systemd[1]: Started Samba NMB Daemon. Apr 11 09:37:41 stanzetta nmbd[826]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 11 09:37:41 stanzetta systemd[1]: Starting Samba Winbind Daemon... Apr 11 09:37:42 stanzetta winbindd[951]: [2026/04/11 09:37:42.241060, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 11 09:37:42 stanzetta winbindd[951]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 11 09:37:43 stanzetta volumio-remote-updater[462]: [2026-04-11 09:37:43] [connect] Successful connection Apr 11 09:37:44 stanzetta winbindd[951]: [2026/04/11 09:37:44.795985, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 11 09:37:44 stanzetta systemd[1]: Started Samba Winbind Daemon. Apr 11 09:37:44 stanzetta winbindd[951]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 11 09:37:44 stanzetta systemd[1]: Starting Samba SMB Daemon... Apr 11 09:37:44 stanzetta volumio[907]: info: ------------------------------------------- Apr 11 09:37:44 stanzetta volumio[907]: info: ----- Volumio3 ---- Apr 11 09:37:44 stanzetta volumio[907]: info: ------------------------------------------- Apr 11 09:37:44 stanzetta volumio[907]: info: ----- System startup ---- Apr 11 09:37:44 stanzetta volumio[907]: info: ------------------------------------------- Apr 11 09:37:45 stanzetta systemd[1]: apt-daily.service: Succeeded. Apr 11 09:37:45 stanzetta systemd[1]: Started Daily apt download activities. Apr 11 09:37:45 stanzetta systemd[1]: Starting Daily apt upgrade and clean activities... Apr 11 09:37:46 stanzetta smbd[972]: [2026/04/11 09:37:46.085915, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 11 09:37:46 stanzetta smbd[972]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 11 09:37:46 stanzetta systemd[1]: Started Samba SMB Daemon. Apr 11 09:37:46 stanzetta systemd[1]: Reached target Multi-User System. Apr 11 09:37:46 stanzetta systemd[1]: Reached target Graphical Interface. Apr 11 09:37:46 stanzetta systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 11 09:37:46 stanzetta systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 11 09:37:46 stanzetta systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 11 09:37:48 stanzetta volumio[907]: info: MYVOLUMIO Environment detected Apr 11 09:37:49 stanzetta systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 11 09:37:49 stanzetta systemd[1]: Started Daily apt upgrade and clean activities. Apr 11 09:37:49 stanzetta systemd[1]: Startup finished in 18.356s (kernel) + 30.245s (userspace) = 48.602s. Apr 11 09:37:49 stanzetta volumio[907]: info: Plugin folders cleanup Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning into folder /volumio/app/plugins/ Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category audio_interface Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category miscellanea Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category music_service Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category plugins.json Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category system_controller Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category user_interface Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning into folder /data/plugins/ Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category audio_interface Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category music_service Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category system_hardware Apr 11 09:37:49 stanzetta volumio[907]: info: Scanning category user_interface Apr 11 09:37:49 stanzetta volumio[907]: info: Plugin folders cleanup completed Apr 11 09:37:49 stanzetta volumio[907]: info: ------------------------------------------- Apr 11 09:37:49 stanzetta volumio[907]: info: ----- Core plugins startup ---- Apr 11 09:37:49 stanzetta volumio[907]: info: ------------------------------------------- Apr 11 09:37:49 stanzetta volumio[907]: info: Loading plugins from folder /volumio/app/plugins/ Apr 11 09:37:49 stanzetta volumio[907]: info: Adding plugin upnp to MyMusic Plugins Apr 11 09:37:49 stanzetta volumio[907]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 11 09:37:49 stanzetta volumio[907]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 11 09:37:49 stanzetta volumio[907]: info: Loading plugins from folder /data/plugins/ Apr 11 09:37:49 stanzetta volumio[907]: info: Loading plugin "system"... Apr 11 09:37:49 stanzetta volumio[907]: info: Loading plugin "appearance"... Apr 11 09:37:51 stanzetta volumio[907]: info: Loading plugin "network"... Apr 11 09:37:51 stanzetta volumio[907]: info: Refreshing Cached IP Addresses Apr 11 09:37:51 stanzetta sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 09:37:51 stanzetta sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:37:51 stanzetta sudo[1057]: pam_unix(sudo:session): session closed for user root Apr 11 09:37:51 stanzetta sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 09:37:51 stanzetta volumio[907]: info: Loading plugin "services"... Apr 11 09:37:51 stanzetta sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:37:51 stanzetta volumio[907]: info: Loading plugin "volumio5onboarding"... Apr 11 09:37:51 stanzetta sudo[1059]: pam_unix(sudo:session): session closed for user root Apr 11 09:37:51 stanzetta volumio[907]: info: Loading plugin "alsa_controller"... Apr 11 09:37:52 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 09:37:52 stanzetta volumio[907]: info: Loading plugin "wizard"... Apr 11 09:37:52 stanzetta volumio[907]: info: Loading plugin "networkfs"... Apr 11 09:37:52 stanzetta volumio[907]: info: Starting Udev Watcher for removable devices Apr 11 09:37:52 stanzetta sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.1.50/Volume_2/Musica /mnt/NAS/Volume_2 Apr 11 09:37:52 stanzetta sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:37:52 stanzetta volumio[907]: info: Ignoring mount for partition: boot Apr 11 09:37:52 stanzetta volumio[907]: info: Ignoring mount for partition: volumio Apr 11 09:37:52 stanzetta volumio[907]: info: Ignoring mount for partition: volumio_data Apr 11 09:37:52 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 09:37:52 stanzetta volumio[907]: info: Loading plugin "volumio_command_line_client"... Apr 11 09:37:52 stanzetta volumio[907]: info: Loading plugin "upnp"... Apr 11 09:37:52 stanzetta volumio[907]: info: [1775893072395] Starting Upmpd Daemon Apr 11 09:37:52 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 09:37:52 stanzetta volumio[907]: info: Loading plugin "my_music"... Apr 11 09:37:52 stanzetta volumio[907]: info: Loading plugin "mpd"... Apr 11 09:37:52 stanzetta kernel: Key type cifs.spnego registered Apr 11 09:37:52 stanzetta kernel: Key type cifs.idmap registered Apr 11 09:37:52 stanzetta kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Apr 11 09:37:52 stanzetta kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Apr 11 09:37:52 stanzetta kernel: CIFS: Attempting to mount //192.168.1.50/Volume_2/Musica Apr 11 09:37:52 stanzetta sudo[1080]: pam_unix(sudo:session): session closed for user root Apr 11 09:37:54 stanzetta volumio[907]: info: Loading plugin "upnp_browser"... Apr 11 09:37:54 stanzetta systemd[1]: systemd-fsckd.service: Succeeded. Apr 11 09:37:55 stanzetta volumio[907]: info: Starting UPNP Browser Apr 11 09:37:55 stanzetta volumio[907]: info: Loading plugin "alarm-clock"... Apr 11 09:37:55 stanzetta volumio[907]: info: Loading plugin "airplay_emulation"... Apr 11 09:37:55 stanzetta volumio[907]: info: Starting Shairport Sync Apr 11 09:37:55 stanzetta volumio[907]: info: Loading plugin "last_100"... Apr 11 09:37:55 stanzetta volumio[907]: info: Loading plugin "webradio"... Apr 11 09:37:56 stanzetta volumio[907]: info: Loading plugin "i2s_dacs"... Apr 11 09:37:56 stanzetta volumio[907]: info: Loading plugin "volumiodiscovery"... Apr 11 09:37:56 stanzetta volumio[907]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 11 09:37:56 stanzetta volumio[907]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 09:37:56 stanzetta volumio[907]: *** WARNING *** For more information see Apr 11 09:37:56 stanzetta node[907]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 11 09:37:56 stanzetta volumio[907]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 11 09:37:56 stanzetta volumio[907]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 09:37:56 stanzetta volumio[907]: *** WARNING *** For more information see Apr 11 09:37:56 stanzetta node[907]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 09:37:56 stanzetta node[907]: *** WARNING *** For more information see Apr 11 09:37:56 stanzetta node[907]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 11 09:37:56 stanzetta node[907]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 09:37:56 stanzetta node[907]: *** WARNING *** For more information see Apr 11 09:37:56 stanzetta volumio[907]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 11 09:37:56 stanzetta volumio[907]: info: Discovery: Started advertising with name: Stanzetta Apr 11 09:37:56 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 09:37:56 stanzetta volumio[907]: info: Loading plugin "mixcloud"... Apr 11 09:37:57 stanzetta volumio[907]: info: Loading plugin "spop"... Apr 11 09:37:58 stanzetta volumio-remote-updater[462]: [2026-04-11 09:37:58] [connect] Successful connection Apr 11 09:38:03 stanzetta volumio[907]: info: Loading plugin "outputs"... Apr 11 09:38:03 stanzetta volumio[907]: info: Loading plugin "albumart"... Apr 11 09:38:03 stanzetta volumio[907]: info: Plugin example_plugin is not enabled Apr 11 09:38:03 stanzetta volumio[907]: info: Loading plugin "inputs"... Apr 11 09:38:03 stanzetta volumio[907]: info: Loading plugin "updater_comm"... Apr 11 09:38:04 stanzetta volumio[907]: info: Plugin mpdemulation is not enabled Apr 11 09:38:04 stanzetta volumio[907]: info: Loading plugin "rest_api"... Apr 11 09:38:04 stanzetta volumio[907]: info: Loading plugin "websocket"... Apr 11 09:38:04 stanzetta volumio[907]: info: Starting Socket.io Server version 2.3.0 Apr 11 09:38:04 stanzetta volumio[907]: info: Loading plugin "fusiondsp"... Apr 11 09:38:04 stanzetta volumio[907]: Forking 3 albumart workers Apr 11 09:38:04 stanzetta volumio[907]: info: Applying required configuration parameters for plugin fusiondsp Apr 11 09:38:05 stanzetta volumio[907]: info: Loading plugin "radio_paradise"... Apr 11 09:38:06 stanzetta volumio[907]: info: Applying required configuration parameters for plugin radio_paradise Apr 11 09:38:06 stanzetta volumio[907]: info: [1775893086075] [RadioParadise] API delay: 5 Apr 11 09:38:06 stanzetta volumio[907]: info: Loading plugin "mpd_oled"... Apr 11 09:38:06 stanzetta volumio[907]: Starting albumart workers Apr 11 09:38:06 stanzetta volumio[907]: Starting albumart workers Apr 11 09:38:06 stanzetta volumio[907]: Starting albumart workers Apr 11 09:38:06 stanzetta volumio[907]: info: Applying required configuration parameters for plugin mpd_oled Apr 11 09:38:06 stanzetta volumio[907]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Apr 11 09:38:06 stanzetta volumio[907]: info: Loading plugin "ferrum_streaming_control_technology"... Apr 11 09:38:07 stanzetta volumio[907]: info: Applying required configuration parameters for plugin ferrum_streaming_control_technology Apr 11 09:38:07 stanzetta volumio[907]: info: Loading i18n strings for locale it Apr 11 09:38:07 stanzetta volumio[907]: Updating browse sources language Apr 11 09:38:07 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::initPlayerControls Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 09:38:08 stanzetta volumio[907]: Express server listening on port 3000 Apr 11 09:38:08 stanzetta volumio[907]: [Metrics] WebUI: 28s 293.47ms Apr 11 09:38:08 stanzetta volumio[907]: info: CoreStateMachine::resetVolumioState Apr 11 09:38:08 stanzetta volumio[907]: info: CoreStateMachine::getcurrentVolume Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 09:38:08 stanzetta sudo[1178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 09:38:08 stanzetta sudo[1178]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:08 stanzetta sudo[1178]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:08 stanzetta sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 09:38:08 stanzetta sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:08 stanzetta sudo[1180]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:08 stanzetta volumio[907]: info: Volumio Network Manager: Network status updated: 1 Apr 11 09:38:08 stanzetta volumio[907]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 11 09:38:08 stanzetta volumio[907]: verbose: New Socket.io Connection to 192.168.1.4:3000 from 192.168.1.5 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 11 09:38:08 stanzetta volumio[907]: verbose: New Socket.io Connection to 192.168.1.4:3000 from 192.168.1.5 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 11 09:38:08 stanzetta volumio[907]: verbose: New Socket.io Connection to 192.168.1.4:3000 from 192.168.1.5 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Apr 11 09:38:08 stanzetta volumio[907]: verbose: New Socket.io Connection to 192.168.1.4:3000 from 192.168.1.5 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Apr 11 09:38:08 stanzetta volumio[907]: info: VolumeController:: Volume=undefined Mute =false Apr 11 09:38:08 stanzetta volumio[907]: info: CoreStateMachine::pushState Apr 11 09:38:08 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::volumioPushState Apr 11 09:38:08 stanzetta volumio[907]: info: CoreStateMachine::updateTrackBlock Apr 11 09:38:08 stanzetta volumio[907]: info: CorePlayQueue::getTrackBlock Apr 11 09:38:08 stanzetta volumio[907]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:09 stanzetta volumio[907]: info: Reloading queue from file Apr 11 09:38:09 stanzetta systemd[1]: systemd-timedated.service: Succeeded. Apr 11 09:38:09 stanzetta volumio[907]: info: Setting Device type: Raspberry PI Apr 11 09:38:09 stanzetta volumio[907]: info: CoreStateMachine::setRepeat null single undefined Apr 11 09:38:09 stanzetta volumio[907]: info: CoreStateMachine::pushState Apr 11 09:38:09 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::volumioPushState Apr 11 09:38:09 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:09 stanzetta volumio[907]: info: Completed loading Core Plugins Apr 11 09:38:09 stanzetta volumio[907]: info: Preparing to generate the ALSA configuration file Apr 11 09:38:09 stanzetta volumio[907]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 11 09:38:09 stanzetta volumio[907]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 11 09:38:09 stanzetta volumio[907]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 11 09:38:09 stanzetta volumio[907]: info: Reading ALSA contributions from plugins. Apr 11 09:38:09 stanzetta volumio[907]: info: VolumeController:: Volume=undefined Mute =false Apr 11 09:38:09 stanzetta volumio[907]: info: CoreStateMachine::pushState Apr 11 09:38:09 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::volumioPushState Apr 11 09:38:09 stanzetta sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 11 09:38:09 stanzetta sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:09 stanzetta volumio[907]: info: Discovery: adding 1da44f0c-764f-465c-8a3f-e3b7d6ef0a6b Apr 11 09:38:09 stanzetta volumio[907]: info: Discovery: Found device Salotto Apr 11 09:38:09 stanzetta volumio[907]: info: Discovery: Connecting to remote: 192.168.1.5 Apr 11 09:38:09 stanzetta systemd[1]: Started UPnP Renderer front-end to MPD. Apr 11 09:38:09 stanzetta volumio[907]: info: Discovery: adding 4c782ab5-50df-4281-af81-c8f79f66fbf6 Apr 11 09:38:09 stanzetta volumio[907]: info: Discovery: Found device Stanzetta Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::volumioGetState Apr 11 09:38:09 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:09 stanzetta sudo[1195]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:09 stanzetta volumio[907]: info: Upmpdcli Daemon Started Apr 11 09:38:09 stanzetta volumio[907]: info: Discovery: Connected to remote: 192.168.1.5 Apr 11 09:38:09 stanzetta volumio[907]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 11 09:38:09 stanzetta volumio[907]: info: Asound.conf file unchanged, so no further update is needed Apr 11 09:38:09 stanzetta volumio[907]: info: Output device has changed, restarting MPD Apr 11 09:38:09 stanzetta volumio[907]: info: Output device has changed, restarting Shairport Sync Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:09 stanzetta sudo[1199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 09:38:09 stanzetta sudo[1199]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:09 stanzetta sudo[1199]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:09 stanzetta sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 09:38:09 stanzetta sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:09 stanzetta volumio[907]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 09:38:09 stanzetta volumio[907]: info: ___________ START PLUGINS ___________ Apr 11 09:38:09 stanzetta volumio[907]: info: ControllerMpd::onStart: Initializing MPD Apr 11 09:38:09 stanzetta volumio[907]: info: Creating MPD Configuration file Apr 11 09:38:09 stanzetta sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Apr 11 09:38:09 stanzetta sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:09 stanzetta systemd[1]: Listening on mpd.socket. Apr 11 09:38:09 stanzetta systemd[1]: Starting Music Player Daemon... Apr 11 09:38:09 stanzetta sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 09:38:09 stanzetta sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 09:38:09 stanzetta volumio[907]: info: [1775893089927] CoreMusicLibrary::Adding element Server multimediali Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:38:09 stanzetta sudo[1211]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:09 stanzetta sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 09:38:09 stanzetta sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:09 stanzetta volumio[907]: info: UPNP Browser: Client initialized successfully Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:09 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:10 stanzetta systemd[1]: Started Volumio5 Onboarding Server. Apr 11 09:38:10 stanzetta sudo[1209]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:10 stanzetta systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 11 09:38:10 stanzetta systemd[1]: mpd.service: Succeeded. Apr 11 09:38:10 stanzetta systemd[1]: Stopped Music Player Daemon. Apr 11 09:38:10 stanzetta systemd[1]: Starting Music Player Daemon... Apr 11 09:38:10 stanzetta sudo[1222]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 11 09:38:10 stanzetta sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:10 stanzetta sudo[1222]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Apr 11 09:38:10 stanzetta sudo[1222]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:10 stanzetta volumio[907]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:10 stanzetta volumio[907]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 09:38:10 stanzetta volumio[907]: info: [1775893090852] CoreMusicLibrary::Adding element Last_100 Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 09:38:10 stanzetta volumio[907]: info: [1775893090858] CoreMusicLibrary::Adding element Webradio Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:38:10 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 09:38:10 stanzetta volumio[907]: info: Initializing BBC Radios Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 09:38:11 stanzetta volumio[907]: info: [1775893091038] CoreMusicLibrary::Adding element Mixcloud Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:38:11 stanzetta volumio[907]: Cannot find translation for source Mixcloud Apr 11 09:38:11 stanzetta volumio[907]: info: Creating Spotify config file Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:11 stanzetta volumio[907]: info: Loading i18n strings for locale it Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:11 stanzetta volumio[907]: info: FusionDsp - mixtype--------------------- undefined Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 09:38:11 stanzetta volumio[907]: info: [1775893091334] CoreMusicLibrary::Adding element Radio Paradise Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 09:38:11 stanzetta volumio[907]: Cannot find translation for source Mixcloud Apr 11 09:38:11 stanzetta volumio[907]: Cannot find translation for source Radio Paradise Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 11 09:38:11 stanzetta fsct-plugin[907]: Starting service tasks Apr 11 09:38:11 stanzetta fsct-plugin[907]: Service tasks started successfully Apr 11 09:38:11 stanzetta fsct-plugin[907]: Failed to initialize device 1d6b:0002: BOS descriptor not available, unsupported usb version 2.00 Apr 11 09:38:11 stanzetta volumio[907]: info: Volumio Calling Home Apr 11 09:38:11 stanzetta fsct-plugin[907]: Failed to initialize device 0424:2514: BOS descriptor not available, unsupported usb version 2.00 Apr 11 09:38:11 stanzetta fsct-plugin[907]: Failed to initialize device 0424:2514: BOS descriptor not available, unsupported usb version 2.00 Apr 11 09:38:11 stanzetta sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Apr 11 09:38:11 stanzetta fsct-plugin[907]: Failed to initialize device 0424:7800: IO error -> Permission denied (os error 13) Apr 11 09:38:11 stanzetta sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:11 stanzetta sudo[1247]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:11 stanzetta sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Apr 11 09:38:11 stanzetta sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:11 stanzetta volumio[907]: info: Preparing to generate the ALSA configuration file Apr 11 09:38:11 stanzetta volumio[907]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 11 09:38:11 stanzetta volumio[907]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Apr 11 09:38:11 stanzetta volumio[907]: info: Reading ALSA contributions from plugins. Apr 11 09:38:11 stanzetta volumio[907]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh Apr 11 09:38:11 stanzetta volumio[907]: info: MPD Permissions set Apr 11 09:38:11 stanzetta volumio[907]: info: MPD Permissions set Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::volumioGetState Apr 11 09:38:11 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:11 stanzetta volumio[907]: info: FSCT Started Apr 11 09:38:11 stanzetta volumio5-onboarding[1218]: time=2026-04-11T09:38:11.862+02:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z Apr 11 09:38:11 stanzetta volumio[907]: verbose: New Socket.io Connection to 192.168.1.4:3000 from 192.168.1.5 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 11 09:38:11 stanzetta volumio[907]: info: Volumio called home Apr 11 09:38:11 stanzetta volumio[907]: info: Spotify config file written Apr 11 09:38:11 stanzetta volumio[907]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh Apr 11 09:38:11 stanzetta volumio[907]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:11 stanzetta sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:11 stanzetta sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:11 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: No need to fix Spotify hosts Apr 11 09:38:12 stanzetta systemd[1]: Started go-librespot Daemon. Apr 11 09:38:12 stanzetta go-librespot[1270]: go-librespot daemon starting... Apr 11 09:38:12 stanzetta sudo[1260]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:12 stanzetta volumio[907]: 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: 7 Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 11 09:38:12 stanzetta volumio[907]: 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: 7 Apr 11 09:38:12 stanzetta volumio[907]: info: Received Get System Info Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 09:38:12 stanzetta volumio[907]: info: Discovery: Getting this device information Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::volumioGetState Apr 11 09:38:12 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 09:38:12 stanzetta volumio5-onboarding[1218]: time=2026-04-11T09:38:12.521+02:00 level=INFO msg="system info for 823a3f628eb77c9ca651a1429d034727" deviceName=Stanzetta deviceVariant=volumio deviceModel= softwareVersion=3.912 Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::volumioGetState Apr 11 09:38:12 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:12 stanzetta volumio[907]: info: Starting Shairport Sync Apr 11 09:38:12 stanzetta volumio[907]: info: Starting Shairport Sync Apr 11 09:38:12 stanzetta volumio[907]: info: Starting Shairport Sync Apr 11 09:38:12 stanzetta sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 09:38:12 stanzetta sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:12 stanzetta volumio[907]: info: Received Get System Info Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 09:38:12 stanzetta volumio[907]: info: Discovery: Getting this device information Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::volumioGetState Apr 11 09:38:12 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 09:38:12 stanzetta systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 09:38:12 stanzetta sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 09:38:12 stanzetta sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:12 stanzetta systemd[1]: shairport-sync.service: Succeeded. Apr 11 09:38:12 stanzetta systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 09:38:12 stanzetta sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 09:38:12 stanzetta sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::volumioGetState Apr 11 09:38:12 stanzetta volumio[907]: info: CorePlayQueue::getTrack 0 Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 09:38:12 stanzetta volumio5-onboarding[1218]: time=2026-04-11T09:38:12.815+02:00 level=INFO msg="enabling local network discovery" Apr 11 09:38:12 stanzetta systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 09:38:12 stanzetta volumio[907]: info: Asound.conf file unchanged, so no further update is needed Apr 11 09:38:12 stanzetta volumio[907]: info: Output device has changed, restarting MPD Apr 11 09:38:12 stanzetta volumio5-onboarding[1218]: time=2026-04-11T09:38:12.907+02:00 level=INFO msg="enabling BLE discovery" Apr 11 09:38:12 stanzetta sudo[1293]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:12 stanzetta volumio[907]: info: Output device has changed, restarting Shairport Sync Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:12 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 09:38:12 stanzetta systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 09:38:12 stanzetta sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 09:38:12 stanzetta sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:12 stanzetta systemd[1]: shairport-sync.service: Succeeded. Apr 11 09:38:13 stanzetta sudo[1305]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:13 stanzetta systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 09:38:13 stanzetta sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 09:38:13 stanzetta sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:13 stanzetta bluetoothd[700]: src/adapter.c:store_adapter_info() Unable set contents for /usr/var/lib/bluetooth/B8:27:EB:E9:F1:D1/settings: (Failed to create file “/usr/var/lib/bluetooth/B8:27:EB:E9:F1:D1/settings.GP9JN3”: No such file or directory) Apr 11 09:38:13 stanzetta systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 09:38:13 stanzetta go-librespot[1270]: time="2026-04-11T09:38:13+02:00" level=info msg="running go-librespot 0.4.0" Apr 11 09:38:13 stanzetta go-librespot[1270]: time="2026-04-11T09:38:13+02:00" level=debug msg="app state loaded" Apr 11 09:38:13 stanzetta volumio5-onboarding[1218]: time=2026-04-11T09:38:13.118+02:00 level=INFO msg="bootstrapping state" hasInternet=true Apr 11 09:38:13 stanzetta sudo[1298]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:13 stanzetta go-librespot[1270]: time="2026-04-11T09:38:13+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 11 09:38:13 stanzetta sudo[1295]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:13 stanzetta systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 11 09:38:13 stanzetta systemd[1]: mpd.service: Succeeded. Apr 11 09:38:13 stanzetta systemd[1]: Stopped Music Player Daemon. Apr 11 09:38:13 stanzetta volumio[907]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 09:38:13 stanzetta volumio[907]: info: Preparing to generate the ALSA configuration file Apr 11 09:38:13 stanzetta systemd[1]: Starting Music Player Daemon... Apr 11 09:38:13 stanzetta volumio[907]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 11 09:38:13 stanzetta volumio[907]: SPOTIFY: BQDPMcKhbXBAcKick-c-OlMKwDAhnP6WZDP92BdgkYnG8bkHH75p-Fk5lAeTSRMPk39J4nFkvPrAGpAVzr7vYTtuOPxpBYkzb06p-KA6IKol_KJZtJMNBLoC35-ddvb-GeODuVpP9g4jO2yubcS6Xn2tkaqCK0V7QMg7Wt9BGrz8RXIwXEL4bUpIXI30T0NiNMX71fr8sgw16hIOkpz7z1dv8Kw6J80x5JDyPOQ7t5fG5DrouBR1WJzEwwuQ-55B3wP5dZJS7W_tgZhIVTLAirWToVyU0YEUwg Apr 11 09:38:13 stanzetta volumio[907]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Apr 11 09:38:13 stanzetta volumio[907]: info: New Spotify access token = BQDPMcKhbXBAcKick-c-OlMKwDAhnP6WZDP92BdgkYnG8bkHH75p-Fk5lAeTSRMPk39J4nFkvPrAGpAVzr7vYTtuOPxpBYkzb06p-KA6IKol_KJZtJMNBLoC35-ddvb-GeODuVpP9g4jO2yubcS6Xn2tkaqCK0V7QMg7Wt9BGrz8RXIwXEL4bUpIXI30T0NiNMX71fr8sgw16hIOkpz7z1dv8Kw6J80x5JDyPOQ7t5fG5DrouBR1WJzEwwuQ-55B3wP5dZJS7W_tgZhIVTLAirWToVyU0YEUwg Apr 11 09:38:13 stanzetta volumio[907]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 11 09:38:13 stanzetta volumio[907]: info: camilladsp service started and running in background, instance 1 Apr 11 09:38:13 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 09:38:13 stanzetta sudo[1315]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 11 09:38:13 stanzetta sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:13 stanzetta sudo[1315]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Apr 11 09:38:13 stanzetta sudo[1315]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:13 stanzetta volumio[907]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 11 09:38:13 stanzetta volumio[907]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 11 09:38:13 stanzetta volumio[907]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 11 09:38:13 stanzetta volumio[907]: info: FusionDsp loaded Apr 11 09:38:13 stanzetta volumio[907]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 09:38:13 stanzetta sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 11 09:38:13 stanzetta sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 09:38:13 stanzetta volumio[907]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 11 09:38:13 stanzetta volumio[907]: info: Adding Signal Path Element [object Object] Apr 11 09:38:13 stanzetta volumio[907]: info: Adding fusiondspeq DSP Signal Path Element Apr 11 09:38:13 stanzetta volumio[907]: info: FusionDsp - ---- installed callbackRead Apr 11 09:38:13 stanzetta volumio[907]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 09:38:13 stanzetta volumio[907]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 11 09:38:13 stanzetta volumio[907]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 11 09:38:13 stanzetta volumio[907]: at onErrorNT (internal/child_process.js:465:16) Apr 11 09:38:13 stanzetta volumio[907]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 11 09:38:13 stanzetta volumio[907]: at runNextTicks (internal/process/task_queues.js:62:3) Apr 11 09:38:13 stanzetta volumio[907]: at listOnTimeout (internal/timers.js:523:9) Apr 11 09:38:13 stanzetta volumio[907]: at processTimers (internal/timers.js:497:7) { Apr 11 09:38:13 stanzetta volumio[907]: errno: -2, Apr 11 09:38:13 stanzetta volumio[907]: code: 'ENOENT', Apr 11 09:38:13 stanzetta volumio[907]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 11 09:38:13 stanzetta volumio[907]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 11 09:38:13 stanzetta volumio[907]: spawnargs: [ Apr 11 09:38:13 stanzetta volumio[907]: '-p', Apr 11 09:38:13 stanzetta volumio[907]: 9876, Apr 11 09:38:13 stanzetta volumio[907]: '-o', Apr 11 09:38:13 stanzetta volumio[907]: '/tmp/camilladsp.log', Apr 11 09:38:13 stanzetta volumio[907]: '-l', Apr 11 09:38:13 stanzetta volumio[907]: 'warn', Apr 11 09:38:13 stanzetta volumio[907]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 11 09:38:13 stanzetta volumio[907]: ] Apr 11 09:38:13 stanzetta volumio[907]: } Apr 11 09:38:13 stanzetta volumio[907]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 09:38:13 stanzetta systemd[1]: Started FusionDsp Daemon. Apr 11 09:38:13 stanzetta sudo[1331]: pam_unix(sudo:session): session closed for user root Apr 11 09:38:13 stanzetta volumio-remote-updater[462]: [2026-04-11 09:38:13] [connect] Successful connection Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=info msg="zeroconf server listening on port 40865" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="obtained new client token: AACalSgsrI62XFGG3Bz+wZzbYhMrQWe+n9L+3ZKG6+MqE6oTWueCH2Ytnt1oqgTVpeFv5JKiTE09ArwUe0EQqXfnprjQdVhL2KygQDx6AeUsdaq8Zp3TT81AQAKZPD/yTRJ4I0bIzwTADAfJQVxm57enXmqUgCwCVpRyeTsD0iFHoWAWAYArvQgpCMuzMKmdjOWrMXCkk6Chu0imricEGj1ajj6GL5REB4MPQmBdZGl8ZOnbA5qrQFZuCw==" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Apr 11 09:38:14 stanzetta volumio[1333]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Apr 11 09:38:14 stanzetta systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Apr 11 09:38:14 stanzetta systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="completed keyexchange" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="completed challenge" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=info msg="authenticated AP" username="11******71" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=info msg="authenticated Login5" username="11******71" Apr 11 09:38:14 stanzetta go-librespot[1270]: time="2026-04-11T09:38:14+02:00" level=debug msg="initializing zeroconf session" username="11******71" Apr 11 09:38:15 stanzetta sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 09:37 Apr 11 09:38:15 stanzetta sudo[1344]: 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="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"