-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-04-13 14:08:40 CEST. -- Apr 13 14:08:22 volumio-massimo systemd-timedated[1003]: Changed local time to Sun Apr 13 14:08:22 2025 Apr 13 14:08:22 volumio-massimo sudo[998]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:22 volumio-massimo volumio-time-update[579]: volumio-time-update-util: System time updated successfully. Apr 13 14:08:22 volumio-massimo systemd[1]: Starting Daily apt download activities... Apr 13 14:08:22 volumio-massimo systemd[1]: Started Volumio Time Update Utility. Apr 13 14:08:22 volumio-massimo systemd[1]: Reached target Multi-User System. Apr 13 14:08:22 volumio-massimo systemd[1]: Reached target Graphical Interface. Apr 13 14:08:22 volumio-massimo systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 13 14:08:22 volumio-massimo systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 13 14:08:22 volumio-massimo systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 13 14:08:22 volumio-massimo nmbd[759]: [2025/04/13 14:08:22.557713, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 13 14:08:22 volumio-massimo nmbd[759]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.186 for name WORKGROUP<1d>. Apr 13 14:08:22 volumio-massimo nmbd[759]: This response was from IP 192.168.178.71, reporting an IP address of 192.168.178.71. Apr 13 14:08:24 volumio-massimo volumio[966]: info: ------------------------------------------- Apr 13 14:08:24 volumio-massimo volumio[966]: info: ----- Volumio3 ---- Apr 13 14:08:24 volumio-massimo volumio[966]: info: ------------------------------------------- Apr 13 14:08:24 volumio-massimo volumio[966]: info: ----- System startup ---- Apr 13 14:08:24 volumio-massimo volumio[966]: info: ------------------------------------------- Apr 13 14:08:25 volumio-massimo volumio[966]: info: MYVOLUMIO Environment detected Apr 13 14:08:25 volumio-massimo volumio[966]: info: Plugin folders cleanup Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning into folder /volumio/app/plugins/ Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category audio_interface Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category miscellanea Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category music_service Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category plugins.json Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category system_controller Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category user_interface Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning into folder /data/plugins/ Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category audio_interface Apr 13 14:08:25 volumio-massimo volumio[966]: info: Scanning category music_service Apr 13 14:08:25 volumio-massimo volumio[966]: info: Plugin folders cleanup completed Apr 13 14:08:26 volumio-massimo volumio[966]: info: ------------------------------------------- Apr 13 14:08:26 volumio-massimo volumio[966]: info: ----- Core plugins startup ---- Apr 13 14:08:26 volumio-massimo volumio[966]: info: ------------------------------------------- Apr 13 14:08:26 volumio-massimo volumio[966]: info: Loading plugins from folder /volumio/app/plugins/ Apr 13 14:08:26 volumio-massimo volumio[966]: info: Adding plugin upnp to MyMusic Plugins Apr 13 14:08:26 volumio-massimo volumio[966]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 13 14:08:26 volumio-massimo volumio[966]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 13 14:08:26 volumio-massimo volumio[966]: info: Loading plugins from folder /data/plugins/ Apr 13 14:08:26 volumio-massimo volumio[966]: info: Loading plugin "system"... Apr 13 14:08:26 volumio-massimo volumio[966]: info: Loading plugin "appearance"... Apr 13 14:08:26 volumio-massimo systemd[1]: apt-daily.service: Succeeded. Apr 13 14:08:26 volumio-massimo systemd[1]: Started Daily apt download activities. Apr 13 14:08:26 volumio-massimo systemd[1]: Starting Daily apt upgrade and clean activities... Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "network"... Apr 13 14:08:28 volumio-massimo volumio[966]: info: Refreshing Cached IP Addresses Apr 13 14:08:28 volumio-massimo sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 14:08:28 volumio-massimo sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:28 volumio-massimo sudo[1109]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:28 volumio-massimo sudo[1111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 14:08:28 volumio-massimo sudo[1111]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:28 volumio-massimo sudo[1111]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "services"... Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "alsa_controller"... Apr 13 14:08:28 volumio-massimo sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 13 14:08:28 volumio-massimo sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:28 volumio-massimo systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 13 14:08:28 volumio-massimo systemd[1]: Started Daily apt upgrade and clean activities. Apr 13 14:08:28 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "wizard"... Apr 13 14:08:28 volumio-massimo systemd[1]: Startup finished in 17.715s (kernel) + 30.834s (userspace) = 48.550s. Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "networkfs"... Apr 13 14:08:28 volumio-massimo volumio[966]: info: Starting Udev Watcher for removable devices Apr 13 14:08:28 volumio-massimo sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.71/musica /mnt/NAS/Nas_Massimo Apr 13 14:08:28 volumio-massimo sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:28 volumio-massimo volumio[966]: info: Ignoring mount for partition: boot Apr 13 14:08:28 volumio-massimo volumio[966]: info: Ignoring mount for partition: volumio Apr 13 14:08:28 volumio-massimo volumio[966]: info: Ignoring mount for partition: volumio_data Apr 13 14:08:28 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "volumio_command_line_client"... Apr 13 14:08:28 volumio-massimo volumio[966]: info: Plugin upnp is not enabled Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "my_music"... Apr 13 14:08:28 volumio-massimo volumio[966]: info: Loading plugin "mpd"... Apr 13 14:08:28 volumio-massimo kernel: Key type cifs.spnego registered Apr 13 14:08:28 volumio-massimo kernel: Key type cifs.idmap registered Apr 13 14:08:28 volumio-massimo 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. Apr 13 14:08:28 volumio-massimo kernel: CIFS: Attempting to mount //192.168.178.71/musica Apr 13 14:08:28 volumio-massimo kernel: cryptd: max_cpu_qlen set to 1000 Apr 13 14:08:29 volumio-massimo sudo[1122]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:29 volumio-massimo volumio[966]: info: Loading plugin "upnp_browser"... Apr 13 14:08:29 volumio-massimo sudo[1146]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:29 volumio-massimo volumio-remote-updater[585]: [2025-04-13 14:08:29] [connect] Successful connection Apr 13 14:08:29 volumio-massimo volumio[966]: info: Loading plugin "alarm-clock"... Apr 13 14:08:29 volumio-massimo volumio[966]: info: Plugin airplay_emulation is not enabled Apr 13 14:08:29 volumio-massimo volumio[966]: info: Loading plugin "last_100"... Apr 13 14:08:29 volumio-massimo volumio[966]: info: Loading plugin "webradio"... Apr 13 14:08:29 volumio-massimo volumio[966]: info: Loading plugin "i2s_dacs"... Apr 13 14:08:29 volumio-massimo volumio[966]: info: I2S DAC not set, start Auto-detection Apr 13 14:08:29 volumio-massimo volumio[966]: info: Loading plugin "volumiodiscovery"... Apr 13 14:08:30 volumio-massimo volumio[966]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 13 14:08:30 volumio-massimo volumio[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 14:08:30 volumio-massimo volumio[966]: *** WARNING *** For more information see Apr 13 14:08:30 volumio-massimo node[966]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 13 14:08:30 volumio-massimo volumio[966]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 13 14:08:30 volumio-massimo volumio[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 14:08:30 volumio-massimo volumio[966]: *** WARNING *** For more information see Apr 13 14:08:30 volumio-massimo node[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 14:08:30 volumio-massimo node[966]: *** WARNING *** For more information see Apr 13 14:08:30 volumio-massimo node[966]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 13 14:08:30 volumio-massimo node[966]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 13 14:08:30 volumio-massimo node[966]: *** WARNING *** For more information see Apr 13 14:08:30 volumio-massimo volumio[966]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 13 14:08:30 volumio-massimo volumio[966]: info: Discovery: Started advertising with name: Volumio Massimo Apr 13 14:08:30 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 14:08:30 volumio-massimo volumio[966]: info: Loading plugin "spop"... Apr 13 14:08:32 volumio-massimo systemd[1]: systemd-fsckd.service: Succeeded. Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "outputs"... Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "albumart"... Apr 13 14:08:33 volumio-massimo volumio[966]: info: Plugin example_plugin is not enabled Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "inputs"... Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "updater_comm"... Apr 13 14:08:33 volumio-massimo volumio[966]: info: Plugin mpdemulation is not enabled Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "rest_api"... Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "websocket"... Apr 13 14:08:33 volumio-massimo volumio[966]: info: Starting Socket.io Server version 2.3.0 Apr 13 14:08:33 volumio-massimo volumio[966]: info: Loading plugin "fusiondsp"... Apr 13 14:08:33 volumio-massimo volumio[966]: Forking 3 albumart workers Apr 13 14:08:33 volumio-massimo volumio[966]: info: Applying required configuration parameters for plugin fusiondsp Apr 13 14:08:34 volumio-massimo volumio[966]: info: Loading i18n strings for locale it Apr 13 14:08:34 volumio-massimo volumio[966]: Updating browse sources language Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::initPlayerControls Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: Starting albumart workers Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: Express server listening on port 3000 Apr 13 14:08:34 volumio-massimo volumio[966]: [Metrics] WebUI: 11s 401.35ms Apr 13 14:08:34 volumio-massimo volumio[966]: Starting albumart workers Apr 13 14:08:34 volumio-massimo volumio[966]: Starting albumart workers Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreStateMachine::resetVolumioState Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreStateMachine::getcurrentVolume Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioRetrievevolume Apr 13 14:08:34 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 14:08:34 volumio-massimo volumio[966]: info: Volumio Network Manager: Network status updated: 2 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 14:08:35 volumio-massimo volumio[966]: info: Discovery: Getting this device information Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioGetState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:08:35 volumio-massimo volumio[966]: info: Reloading queue from file Apr 13 14:08:35 volumio-massimo volumio[966]: info: VolumeController:: Volume=100 Mute =false Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::pushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioPushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::updateTrackBlock Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrackBlock Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioRetrievevolume Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::setRepeat null single undefined Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::pushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioPushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::setRandom null Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::pushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioPushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: Setting Device type: Raspberry PI Apr 13 14:08:35 volumio-massimo volumio[966]: info: Completed loading Core Plugins Apr 13 14:08:35 volumio-massimo volumio[966]: info: Preparing to generate the ALSA configuration file Apr 13 14:08:35 volumio-massimo volumio[966]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 13 14:08:35 volumio-massimo volumio[966]: info: Reading ALSA contributions from plugins. Apr 13 14:08:35 volumio-massimo volumio[966]: info: Asound.conf file unchanged, so no further update is needed Apr 13 14:08:35 volumio-massimo volumio[966]: info: Output device has changed, restarting MPD Apr 13 14:08:35 volumio-massimo volumio[966]: info: ___________ START PLUGINS ___________ Apr 13 14:08:35 volumio-massimo sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 14:08:35 volumio-massimo sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:35 volumio-massimo sudo[1254]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:35 volumio-massimo volumio[966]: info: ControllerMpd::onStart: Initializing MPD Apr 13 14:08:35 volumio-massimo volumio[966]: info: Creating MPD Configuration file Apr 13 14:08:35 volumio-massimo sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 14:08:35 volumio-massimo sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 14:08:35 volumio-massimo sudo[1259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 14:08:35 volumio-massimo volumio[966]: info: [1744546115490] CoreMusicLibrary::Adding element Server multimediali Apr 13 14:08:35 volumio-massimo sudo[1259]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:35 volumio-massimo sudo[1259]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:08:35 volumio-massimo sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 14:08:35 volumio-massimo systemd[1]: Stopping Music Player Daemon... Apr 13 14:08:35 volumio-massimo sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 14:08:35 volumio-massimo volumio[966]: info: [1744546115526] CoreMusicLibrary::Adding element Last_100 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 14:08:35 volumio-massimo volumio[966]: info: [1744546115530] CoreMusicLibrary::Adding element Webradio Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 14:08:35 volumio-massimo volumio[966]: info: Initializing BBC Radios Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 14:08:35 volumio-massimo volumio[966]: info: Creating Spotify config file Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:35 volumio-massimo volumio[966]: info: Loading i18n strings for locale it Apr 13 14:08:35 volumio-massimo systemd[1]: mpd.service: Succeeded. Apr 13 14:08:35 volumio-massimo systemd[1]: Stopped Music Player Daemon. Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:35 volumio-massimo volumio[966]: info: FusionDsp - mixtype--------------------- Hardware Apr 13 14:08:35 volumio-massimo volumio[966]: info: Volumio Calling Home Apr 13 14:08:35 volumio-massimo systemd[1]: Starting Music Player Daemon... Apr 13 14:08:35 volumio-massimo volumio[966]: info: Preparing to generate the ALSA configuration file Apr 13 14:08:35 volumio-massimo sudo[1275]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 13 14:08:35 volumio-massimo sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:35 volumio-massimo sudo[1275]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:35 volumio-massimo volumio[966]: info: Discovery: adding 4147c53a-0843-45c8-b36e-f82a57c1d576 Apr 13 14:08:35 volumio-massimo volumio[966]: info: Discovery: Found device Volumio Massimo Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioGetState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:35 volumio-massimo volumio[966]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 13 14:08:35 volumio-massimo volumio[966]: info: Reading ALSA contributions from plugins. Apr 13 14:08:35 volumio-massimo volumio[966]: info: MPD Permissions set Apr 13 14:08:35 volumio-massimo volumio[966]: info: MPD Permissions set Apr 13 14:08:35 volumio-massimo volumio[966]: info: VolumeController:: Volume=100 Mute =false Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreStateMachine::pushState Apr 13 14:08:35 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:35 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioPushState Apr 13 14:08:35 volumio-massimo volumio[966]: verbose: New Socket.io Connection to 192.168.178.186:3000 from 192.168.178.160 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Apr 13 14:08:35 volumio-massimo volumio[966]: info: Spotify config file written Apr 13 14:08:36 volumio-massimo sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 13 14:08:36 volumio-massimo sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:36 volumio-massimo volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 13 14:08:36 volumio-massimo volumio[966]: info: No need to fix Spotify hosts Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: Volumio called home Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioGetState Apr 13 14:08:36 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::volumioGetState Apr 13 14:08:36 volumio-massimo volumio[966]: info: CorePlayQueue::getTrack 0 Apr 13 14:08:36 volumio-massimo volumio[966]: info: Asound.conf file unchanged, so no further update is needed Apr 13 14:08:36 volumio-massimo volumio[966]: info: Output device has changed, restarting MPD Apr 13 14:08:36 volumio-massimo sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 14:08:36 volumio-massimo sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:36 volumio-massimo sudo[1293]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:36 volumio-massimo sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 14:08:36 volumio-massimo sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:36 volumio-massimo volumio[966]: info: MPD Permissions set Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 14:08:36 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:36 volumio-massimo systemd[1]: Started go-librespot Daemon. Apr 13 14:08:36 volumio-massimo sudo[1282]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:36 volumio-massimo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 13 14:08:36 volumio-massimo systemd[1]: mpd.service: Succeeded. Apr 13 14:08:36 volumio-massimo systemd[1]: Stopped Music Player Daemon. Apr 13 14:08:36 volumio-massimo systemd[1]: Starting Music Player Daemon... Apr 13 14:08:36 volumio-massimo sudo[1303]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 13 14:08:36 volumio-massimo sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:36 volumio-massimo sudo[1303]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:36 volumio-massimo go-librespot[1302]: go-librespot daemon starting... Apr 13 14:08:37 volumio-massimo sh[513]: timed out Apr 13 14:08:37 volumio-massimo dhcpcd[554]: timed out Apr 13 14:08:37 volumio-massimo sh[513]: dhcpcd exited Apr 13 14:08:37 volumio-massimo dhcpcd[554]: dhcpcd exited Apr 13 14:08:37 volumio-massimo sh[513]: ifup: failed to bring up eth0 Apr 13 14:08:37 volumio-massimo systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 13 14:08:37 volumio-massimo systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 13 14:08:38 volumio-massimo systemd[1]: systemd-hostnamed.service: Succeeded. Apr 13 14:08:39 volumio-massimo mpd[1306]: Apr 13 14:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 14:08:39 volumio-massimo systemd[1]: Started Music Player Daemon. Apr 13 14:08:39 volumio-massimo sudo[1262]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:39 volumio-massimo sudo[1256]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:39 volumio-massimo sudo[1295]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:39 volumio-massimo volumio[966]: info: camilladsp service started and running in background, instance 1 Apr 13 14:08:39 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 14:08:39 volumio-massimo volumio[966]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 13 14:08:39 volumio-massimo volumio[966]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 13 14:08:39 volumio-massimo volumio[966]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 13 14:08:39 volumio-massimo volumio[966]: info: FusionDsp loaded Apr 13 14:08:39 volumio-massimo volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 14:08:39 volumio-massimo sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 13 14:08:39 volumio-massimo sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 14:08:39 volumio-massimo volumio[966]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 13 14:08:39 volumio-massimo volumio[966]: info: Adding Signal Path Element [object Object] Apr 13 14:08:39 volumio-massimo volumio[966]: info: Adding fusiondspeq DSP Signal Path Element Apr 13 14:08:39 volumio-massimo volumio[966]: info: FusionDsp - ---- installed callbackRead Apr 13 14:08:39 volumio-massimo volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 14:08:39 volumio-massimo sudo[1343]: pam_unix(sudo:session): session closed for user root Apr 13 14:08:39 volumio-massimo volumio[966]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 13 14:08:39 volumio-massimo volumio[966]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 13 14:08:39 volumio-massimo volumio[966]: at onErrorNT (internal/child_process.js:465:16) Apr 13 14:08:39 volumio-massimo volumio[966]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Apr 13 14:08:39 volumio-massimo volumio[966]: errno: -2, Apr 13 14:08:39 volumio-massimo volumio[966]: code: 'ENOENT', Apr 13 14:08:39 volumio-massimo volumio[966]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 13 14:08:39 volumio-massimo volumio[966]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 13 14:08:39 volumio-massimo volumio[966]: spawnargs: [ Apr 13 14:08:39 volumio-massimo volumio[966]: '-p', Apr 13 14:08:39 volumio-massimo volumio[966]: 9876, Apr 13 14:08:39 volumio-massimo volumio[966]: '-o', Apr 13 14:08:39 volumio-massimo volumio[966]: '/tmp/camilladsp.log', Apr 13 14:08:39 volumio-massimo volumio[966]: '-l', Apr 13 14:08:39 volumio-massimo volumio[966]: 'warn', Apr 13 14:08:39 volumio-massimo volumio[966]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 13 14:08:39 volumio-massimo volumio[966]: ] Apr 13 14:08:39 volumio-massimo volumio[966]: } Apr 13 14:08:39 volumio-massimo volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+02:00" level=info msg="running go-librespot 0.2.0" Apr 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+02:00" level=debug msg="app state loaded" Apr 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+02:00" level=debug msg="stored credentials not found" Apr 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+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 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+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 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+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 13 14:08:40 volumio-massimo go-librespot[1302]: time="2025-04-13T14:08:40+02:00" level=info msg="zeroconf server listening on port 41349" Apr 13 14:08:40 volumio-massimo sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-13 14:07 Apr 13 14:08:40 volumio-massimo sudo[1355]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"