-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2025-02-15 18:42:20 CET. -- Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "network"... Feb 15 18:41:01 volumio volumio[14587]: info: Refreshing Cached IP Addresses Feb 15 18:41:01 volumio sudo[14618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 18:41:01 volumio sudo[14618]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:01 volumio sudo[14618]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:01 volumio sudo[14620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 18:41:01 volumio sudo[14620]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:01 volumio sudo[14620]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "services"... Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "alsa_controller"... Feb 15 18:41:01 volumio sudo[14633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 15 18:41:01 volumio sudo[14633]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:01 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "wizard"... Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "networkfs"... Feb 15 18:41:01 volumio sudo[14646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=admin,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.2/Musica /mnt/NAS/Lisinaqnap Feb 15 18:41:01 volumio sudo[14646]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:01 volumio volumio[14587]: info: Starting Udev Watcher for removable devices Feb 15 18:41:01 volumio sudo[14648]: 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.2/Nas/musica /mnt/NAS/Qnap Feb 15 18:41:01 volumio sudo[14648]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:01 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Musica Feb 15 18:41:01 volumio volumio[14587]: info: Ignoring mount for partition: boot Feb 15 18:41:01 volumio volumio[14587]: info: Ignoring mount for partition: volumio Feb 15 18:41:01 volumio volumio[14587]: info: Ignoring mount for partition: volumio_data Feb 15 18:41:01 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "volumio_command_line_client"... Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "upnp"... Feb 15 18:41:01 volumio volumio[14587]: info: [1739641261684] Starting Upmpd Daemon Feb 15 18:41:01 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "my_music"... Feb 15 18:41:01 volumio volumio[14587]: info: Loading plugin "mpd"... Feb 15 18:41:01 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Feb 15 18:41:01 volumio kernel: CIFS: VFS: \\192.168.178.2 Send error in SessSetup = -13 Feb 15 18:41:01 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Feb 15 18:41:01 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Nas/musica Feb 15 18:41:01 volumio sudo[14646]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:02 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.178.2\Nas Feb 15 18:41:02 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Feb 15 18:41:02 volumio sudo[14648]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:02 volumio sudo[14633]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:02 volumio volumio[14587]: info: Loading plugin "upnp_browser"... Feb 15 18:41:02 volumio volumio[14587]: info: Loading plugin "alarm-clock"... Feb 15 18:41:03 volumio volumio[14587]: info: Plugin airplay_emulation is not enabled Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "last_100"... Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "webradio"... Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "i2s_dacs"... Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "volumiodiscovery"... Feb 15 18:41:03 volumio volumio[14587]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:03 volumio volumio[14587]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:03 volumio volumio[14587]: *** WARNING *** For more information see Feb 15 18:41:03 volumio volumio[14587]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:03 volumio volumio[14587]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:03 volumio volumio[14587]: *** WARNING *** For more information see Feb 15 18:41:03 volumio node[14587]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:03 volumio node[14587]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:03 volumio node[14587]: *** WARNING *** For more information see Feb 15 18:41:03 volumio node[14587]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:03 volumio node[14587]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:03 volumio node[14587]: *** WARNING *** For more information see Feb 15 18:41:03 volumio volumio[14587]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 15 18:41:03 volumio volumio[14587]: info: Discovery: Started advertising with name: Volumio Feb 15 18:41:03 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "outputs"... Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "albumart"... Feb 15 18:41:03 volumio volumio[14587]: info: Plugin example_plugin is not enabled Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "inputs"... Feb 15 18:41:03 volumio volumio[14587]: info: Loading plugin "updater_comm"... Feb 15 18:41:04 volumio volumio[14587]: info: Plugin mpdemulation is not enabled Feb 15 18:41:04 volumio volumio[14587]: info: Loading plugin "rest_api"... Feb 15 18:41:04 volumio volumio[14587]: info: Loading plugin "websocket"... Feb 15 18:41:04 volumio volumio[14587]: info: Starting Socket.io Server version 2.3.0 Feb 15 18:41:04 volumio volumio[14587]: info: Loading plugin "fusiondsp"... Feb 15 18:41:04 volumio volumio[14587]: Forking 3 albumart workers Feb 15 18:41:04 volumio volumio[14587]: info: Applying required configuration parameters for plugin fusiondsp Feb 15 18:41:04 volumio volumio[14587]: info: Loading plugin "radio_paradise"... Feb 15 18:41:05 volumio volumio[14587]: info: Applying required configuration parameters for plugin radio_paradise Feb 15 18:41:05 volumio volumio[14587]: info: [1739641265430] [RadioParadise] API delay: 2 Feb 15 18:41:05 volumio volumio[14587]: info: Loading i18n strings for locale it Feb 15 18:41:05 volumio volumio[14587]: Updating browse sources language Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::initPlayerControls Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:05 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:05 volumio volumio[14587]: Express server listening on port 3000 Feb 15 18:41:05 volumio volumio[14587]: [Metrics] WebUI: 9s 282.50ms Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::resetVolumioState Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::getcurrentVolume Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:06 volumio volumio[14587]: info: Volumio Network Manager: Network status updated: 1 Feb 15 18:41:06 volumio volumio[14587]: info: Cannot mount NAS Qnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:06 volumio volumio[14587]: info: Cannot mount NAS Lisinaqnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:06 volumio volumio[14587]: Starting albumart workers Feb 15 18:41:06 volumio volumio[14587]: Starting albumart workers Feb 15 18:41:06 volumio volumio[14587]: Starting albumart workers Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:06 volumio volumio[14587]: info: Reloading queue from file Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::setRepeat null single undefined Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::pushState Feb 15 18:41:06 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::setRandom null Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::pushState Feb 15 18:41:06 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:06 volumio volumio[14587]: info: Setting Device type: Raspberry PI Feb 15 18:41:06 volumio volumio[14587]: info: Completed loading Core Plugins Feb 15 18:41:06 volumio volumio[14587]: info: Preparing to generate the ALSA configuration file Feb 15 18:41:06 volumio volumio[14587]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::pushState Feb 15 18:41:06 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:06 volumio volumio[14587]: info: CoreStateMachine::updateTrackBlock Feb 15 18:41:06 volumio volumio[14587]: info: CorePlayQueue::getTrackBlock Feb 15 18:41:06 volumio volumio[14587]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:06 volumio volumio[14587]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:41:06 volumio volumio[14587]: info: Reading ALSA contributions from plugins. Feb 15 18:41:07 volumio volumio[14587]: info: Discovery: adding 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:41:07 volumio volumio[14587]: info: Discovery: Found device Volumio Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:07 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:07 volumio volumio[14587]: info: Discovery: this is already registered, 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:41:07 volumio volumio[14587]: info: Discovery: Found device Volumio Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:07 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:07 volumio volumio[14587]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:07 volumio volumio[14587]: info: CoreStateMachine::pushState Feb 15 18:41:07 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:07 volumio volumio[14587]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:41:07 volumio volumio[14587]: info: Output device has changed, restarting MPD Feb 15 18:41:07 volumio volumio[14587]: info: ___________ START PLUGINS ___________ Feb 15 18:41:07 volumio volumio[14587]: info: ControllerMpd::onStart: Initializing MPD Feb 15 18:41:07 volumio volumio[14587]: info: Creating MPD Configuration file Feb 15 18:41:07 volumio sudo[14702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:07 volumio sudo[14702]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:07 volumio sudo[14704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:07 volumio sudo[14704]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:07 volumio sudo[14702]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:07 volumio systemd[1]: Stopping Music Player Daemon... Feb 15 18:41:07 volumio sudo[14707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:07 volumio volumio[14587]: info: [1739641267436] CoreMusicLibrary::Adding element Server multimediali Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:07 volumio sudo[14707]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:07 volumio sudo[14710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:07 volumio sudo[14710]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:07 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:07 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:07 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:07 volumio sudo[14707]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:07 volumio volumio[14587]: info: [1739641267609] CoreMusicLibrary::Adding element Last_100 Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:07 volumio volumio[14587]: info: [1739641267615] CoreMusicLibrary::Adding element Webradio Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:07 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 15 18:41:07 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:07 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:07 volumio volumio[14587]: info: Initializing BBC Radios Feb 15 18:41:07 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:07 volumio volumio[14587]: info: Loading i18n strings for locale it Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:07 volumio volumio[14587]: info: FusionDsp - mixtype--------------------- Hardware Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:07 volumio volumio[14587]: info: [1739641267909] CoreMusicLibrary::Adding element Radio Paradise Feb 15 18:41:07 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:07 volumio volumio[14587]: Cannot find translation for source Radio Paradise Feb 15 18:41:07 volumio volumio[14587]: info: Volumio Calling Home Feb 15 18:41:07 volumio sudo[14722]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:07 volumio sudo[14722]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:07 volumio sudo[14722]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:08 volumio volumio[14587]: info: Preparing to generate the ALSA configuration file Feb 15 18:41:08 volumio volumio[14587]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:41:08 volumio volumio[14587]: info: Reading ALSA contributions from plugins. Feb 15 18:41:08 volumio volumio[14587]: info: MPD Permissions set Feb 15 18:41:08 volumio volumio[14587]: info: MPD Permissions set Feb 15 18:41:08 volumio volumio[14587]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 15 18:41:08 volumio volumio[14587]: info: Volumio called home Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:08 volumio volumio[14587]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:08 volumio volumio[14587]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:08 volumio volumio[14587]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:41:08 volumio volumio[14587]: info: Output device has changed, restarting MPD Feb 15 18:41:09 volumio sudo[14765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:09 volumio sudo[14765]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:09 volumio sudo[14765]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:09 volumio sudo[14767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:09 volumio sudo[14767]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:09 volumio volumio[14587]: info: MPD Permissions set Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 15 18:41:09 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:09 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:09 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:09 volumio sudo[14771]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:09 volumio sudo[14771]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:09 volumio sudo[14771]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:09 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 15 18:41:09 volumio systemd[1]: mpd.service: Failed with result 'protocol'. Feb 15 18:41:09 volumio systemd[1]: Failed to start Music Player Daemon. Feb 15 18:41:09 volumio sudo[14710]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:09 volumio sudo[14767]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:09 volumio sudo[14704]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:09 volumio volumio[14587]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 15 18:41:09 volumio volumio[14587]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Feb 15 18:41:09 volumio volumio[14587]: See "systemctl status mpd.service" and "journalctl -xe" for details. Feb 15 18:41:09 volumio volumio[14587]: info: Completed starting Core Plugins Feb 15 18:41:09 volumio volumio[14587]: info: ------------------------------------------- Feb 15 18:41:09 volumio volumio[14587]: info: ----- MyVolumio plugins startup ---- Feb 15 18:41:09 volumio volumio[14587]: info: ------------------------------------------- Feb 15 18:41:09 volumio volumio[14587]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 15 18:41:09 volumio volumio[14587]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 15 18:41:09 volumio volumio[14587]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Feb 15 18:41:09 volumio volumio[14587]: See "systemctl status mpd.service" and "journalctl -xe" for details. Feb 15 18:41:09 volumio volumio[14587]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 15 18:41:09 volumio volumio[14587]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Feb 15 18:41:09 volumio volumio[14587]: See "systemctl status mpd.service" and "journalctl -xe" for details. Feb 15 18:41:09 volumio volumio[14587]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:41:09 volumio volumio[14587]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Feb 15 18:41:09 volumio volumio[14587]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:41:09 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:09 volumio volumio[14587]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Feb 15 18:41:09 volumio volumio[14587]: info: camilladsp service started and running in background, instance 1 Feb 15 18:41:09 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:10 volumio volumio[14587]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:41:10 volumio volumio[14587]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 15 18:41:10 volumio volumio[14587]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:41:10 volumio volumio[14587]: info: FusionDsp loaded Feb 15 18:41:10 volumio volumio[14587]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 18:41:10 volumio sudo[14791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 15 18:41:10 volumio sudo[14791]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:10 volumio volumio[14587]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 15 18:41:10 volumio volumio[14587]: info: Adding Signal Path Element [object Object] Feb 15 18:41:10 volumio volumio[14587]: info: Adding fusiondspeq DSP Signal Path Element Feb 15 18:41:10 volumio volumio[14587]: info: FusionDsp - ---- installed callbackRead Feb 15 18:41:10 volumio volumio[14587]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:41:10 volumio sudo[14791]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:10 volumio volumio[14587]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 15 18:41:10 volumio volumio[14587]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 15 18:41:10 volumio volumio[14587]: at onErrorNT (internal/child_process.js:465:16) Feb 15 18:41:10 volumio volumio[14587]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 15 18:41:10 volumio volumio[14587]: at runNextTicks (internal/process/task_queues.js:62:3) Feb 15 18:41:10 volumio volumio[14587]: at listOnTimeout (internal/timers.js:523:9) Feb 15 18:41:10 volumio volumio[14587]: at processTimers (internal/timers.js:497:7) { Feb 15 18:41:10 volumio volumio[14587]: errno: -2, Feb 15 18:41:10 volumio volumio[14587]: code: 'ENOENT', Feb 15 18:41:10 volumio volumio[14587]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:41:10 volumio volumio[14587]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:41:10 volumio volumio[14587]: spawnargs: [ Feb 15 18:41:10 volumio volumio[14587]: '-p', Feb 15 18:41:10 volumio volumio[14587]: 9876, Feb 15 18:41:10 volumio volumio[14587]: '-o', Feb 15 18:41:10 volumio volumio[14587]: '/tmp/camilladsp.log', Feb 15 18:41:10 volumio volumio[14587]: '-l', Feb 15 18:41:10 volumio volumio[14587]: 'warn', Feb 15 18:41:10 volumio volumio[14587]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 15 18:41:10 volumio volumio[14587]: ] Feb 15 18:41:10 volumio volumio[14587]: } Feb 15 18:41:10 volumio volumio[14587]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:41:10 volumio sudo[14780]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:10 volumio sudo[14780]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:10 volumio sudo[14780]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:11 volumio sudo[14817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 18:40 Feb 15 18:41:11 volumio sudo[14817]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:11 volumio volumio-remote-updater[629]: [2025-02-15 18:41:11] [connect] Successful connection Feb 15 18:41:11 volumio sudo[14817]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:11 volumio volumio-remote-updater[629]: [2025-02-15 18:41:11] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Feb 15 18:41:11 volumio volumio-remote-updater[629]: [2025-02-15 18:41:11] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Feb 15 18:41:11 volumio volumio-remote-updater[629]: [2025-02-15 18:41:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 15 18:41:11 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 15 18:41:11 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 15 18:41:11 volumio systemd[1]: Started dynamicswap service. Feb 15 18:41:11 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:41:11 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 15 18:41:11 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 56. Feb 15 18:41:11 volumio systemd[1]: Stopped Volumio Backend Module. Feb 15 18:41:11 volumio systemd[1]: Started Volumio Backend Module. Feb 15 18:41:11 volumio systemd[1]: Started dynamicswap service. Feb 15 18:41:12 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:41:13 volumio mpd[14801]: Feb 15 18:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 15 18:41:13 volumio systemd[1]: Started Music Player Daemon. Feb 15 18:41:13 volumio mpd_monitor.sh[592]: MPD restarted due to no mpc output. Feb 15 18:41:15 volumio volumio[14829]: info: ------------------------------------------- Feb 15 18:41:15 volumio volumio[14829]: info: ----- Volumio3 ---- Feb 15 18:41:15 volumio volumio[14829]: info: ------------------------------------------- Feb 15 18:41:15 volumio volumio[14829]: info: ----- System startup ---- Feb 15 18:41:15 volumio volumio[14829]: info: ------------------------------------------- Feb 15 18:41:16 volumio volumio[14829]: info: MYVOLUMIO Environment detected Feb 15 18:41:16 volumio volumio[14829]: info: Plugin folders cleanup Feb 15 18:41:16 volumio volumio[14829]: info: Scanning into folder /volumio/app/plugins/ Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category audio_interface Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category miscellanea Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category music_service Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category plugins.json Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category system_controller Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category user_interface Feb 15 18:41:16 volumio volumio[14829]: info: Scanning into folder /data/plugins/ Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category audio_interface Feb 15 18:41:16 volumio volumio[14829]: info: Scanning category music_service Feb 15 18:41:16 volumio volumio[14829]: info: Plugin folders cleanup completed Feb 15 18:41:16 volumio volumio[14829]: info: ------------------------------------------- Feb 15 18:41:16 volumio volumio[14829]: info: ----- Core plugins startup ---- Feb 15 18:41:16 volumio volumio[14829]: info: ------------------------------------------- Feb 15 18:41:16 volumio volumio[14829]: info: Loading plugins from folder /volumio/app/plugins/ Feb 15 18:41:16 volumio volumio[14829]: info: Adding plugin upnp to MyMusic Plugins Feb 15 18:41:16 volumio volumio[14829]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 15 18:41:16 volumio volumio[14829]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 15 18:41:16 volumio volumio[14829]: info: Loading plugins from folder /data/plugins/ Feb 15 18:41:16 volumio volumio[14829]: info: Loading plugin "system"... Feb 15 18:41:17 volumio volumio[14829]: info: Loading plugin "appearance"... Feb 15 18:41:18 volumio volumio[14829]: info: Loading plugin "network"... Feb 15 18:41:18 volumio volumio[14829]: info: Refreshing Cached IP Addresses Feb 15 18:41:18 volumio sudo[14859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 18:41:18 volumio sudo[14859]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:18 volumio sudo[14859]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:18 volumio sudo[14861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 18:41:18 volumio sudo[14861]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:18 volumio volumio[14829]: info: Loading plugin "services"... Feb 15 18:41:18 volumio sudo[14861]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:18 volumio volumio[14829]: info: Loading plugin "alsa_controller"... Feb 15 18:41:18 volumio sudo[14869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 15 18:41:18 volumio sudo[14869]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:19 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:19 volumio volumio[14829]: info: Loading plugin "wizard"... Feb 15 18:41:19 volumio volumio[14829]: info: Loading plugin "networkfs"... Feb 15 18:41:19 volumio volumio[14829]: info: Starting Udev Watcher for removable devices Feb 15 18:41:19 volumio sudo[14887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=admin,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.2/Musica /mnt/NAS/Lisinaqnap Feb 15 18:41:19 volumio sudo[14887]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:19 volumio sudo[14889]: 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.2/Nas/musica /mnt/NAS/Qnap Feb 15 18:41:19 volumio sudo[14889]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:19 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Musica Feb 15 18:41:19 volumio volumio[14829]: info: Ignoring mount for partition: boot Feb 15 18:41:19 volumio volumio[14829]: info: Ignoring mount for partition: volumio Feb 15 18:41:19 volumio volumio[14829]: info: Ignoring mount for partition: volumio_data Feb 15 18:41:19 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:19 volumio volumio[14829]: info: Loading plugin "volumio_command_line_client"... Feb 15 18:41:19 volumio volumio[14829]: info: Loading plugin "upnp"... Feb 15 18:41:19 volumio volumio[14829]: info: [1739641279362] Starting Upmpd Daemon Feb 15 18:41:19 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:19 volumio volumio[14829]: info: Loading plugin "my_music"... Feb 15 18:41:19 volumio volumio[14829]: info: Loading plugin "mpd"... Feb 15 18:41:19 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Feb 15 18:41:19 volumio kernel: CIFS: VFS: \\192.168.178.2 Send error in SessSetup = -13 Feb 15 18:41:19 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Feb 15 18:41:19 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Nas/musica Feb 15 18:41:19 volumio sudo[14887]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:19 volumio sudo[14889]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:19 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.178.2\Nas Feb 15 18:41:19 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Feb 15 18:41:19 volumio sudo[14869]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:20 volumio volumio[14829]: info: Loading plugin "upnp_browser"... Feb 15 18:41:20 volumio volumio[14829]: info: Loading plugin "alarm-clock"... Feb 15 18:41:20 volumio volumio[14829]: info: Plugin airplay_emulation is not enabled Feb 15 18:41:20 volumio volumio[14829]: info: Loading plugin "last_100"... Feb 15 18:41:20 volumio volumio[14829]: info: Loading plugin "webradio"... Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "i2s_dacs"... Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "volumiodiscovery"... Feb 15 18:41:21 volumio volumio[14829]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:21 volumio volumio[14829]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:21 volumio volumio[14829]: *** WARNING *** For more information see Feb 15 18:41:21 volumio volumio[14829]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:21 volumio node[14829]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:21 volumio volumio[14829]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:21 volumio volumio[14829]: *** WARNING *** For more information see Feb 15 18:41:21 volumio node[14829]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:21 volumio node[14829]: *** WARNING *** For more information see Feb 15 18:41:21 volumio node[14829]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:21 volumio node[14829]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:21 volumio node[14829]: *** WARNING *** For more information see Feb 15 18:41:21 volumio volumio[14829]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 15 18:41:21 volumio volumio[14829]: info: Discovery: Started advertising with name: Volumio Feb 15 18:41:21 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "outputs"... Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "albumart"... Feb 15 18:41:21 volumio volumio[14829]: info: Plugin example_plugin is not enabled Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "inputs"... Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "updater_comm"... Feb 15 18:41:21 volumio volumio[14829]: info: Plugin mpdemulation is not enabled Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "rest_api"... Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "websocket"... Feb 15 18:41:21 volumio volumio-remote-updater[629]: [2025-02-15 18:41:21] [connect] Successful connection Feb 15 18:41:21 volumio volumio[14829]: info: Starting Socket.io Server version 2.3.0 Feb 15 18:41:21 volumio volumio[14829]: info: Loading plugin "fusiondsp"... Feb 15 18:41:22 volumio volumio[14829]: Forking 3 albumart workers Feb 15 18:41:22 volumio volumio[14829]: info: Applying required configuration parameters for plugin fusiondsp Feb 15 18:41:22 volumio volumio[14829]: info: Loading plugin "radio_paradise"... Feb 15 18:41:23 volumio volumio[14829]: info: Applying required configuration parameters for plugin radio_paradise Feb 15 18:41:23 volumio volumio[14829]: info: [1739641283160] [RadioParadise] API delay: 2 Feb 15 18:41:23 volumio volumio[14829]: info: Loading i18n strings for locale it Feb 15 18:41:23 volumio volumio[14829]: Updating browse sources language Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::initPlayerControls Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:23 volumio volumio[14829]: Express server listening on port 3000 Feb 15 18:41:23 volumio volumio[14829]: [Metrics] WebUI: 9s 230.67ms Feb 15 18:41:23 volumio volumio[14829]: info: CoreStateMachine::resetVolumioState Feb 15 18:41:23 volumio volumio[14829]: info: CoreStateMachine::getcurrentVolume Feb 15 18:41:23 volumio volumio[14829]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:23 volumio volumio[14829]: info: Volumio Network Manager: Network status updated: 1 Feb 15 18:41:23 volumio volumio[14829]: Starting albumart workers Feb 15 18:41:23 volumio volumio[14829]: info: Cannot mount NAS Qnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:23 volumio volumio[14829]: info: Cannot mount NAS Lisinaqnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:23 volumio volumio-remote-updater[629]: [2025-02-15 18:41:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739641281 101 Feb 15 18:41:24 volumio volumio[14829]: Starting albumart workers Feb 15 18:41:24 volumio volumio[14829]: Starting albumart workers Feb 15 18:41:24 volumio volumio[14829]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:24 volumio volumio[14829]: info: Reloading queue from file Feb 15 18:41:24 volumio volumio[14829]: info: CoreStateMachine::setRepeat null single undefined Feb 15 18:41:24 volumio volumio[14829]: info: CoreStateMachine::pushState Feb 15 18:41:24 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:24 volumio volumio[14829]: info: CoreStateMachine::setRandom null Feb 15 18:41:24 volumio volumio[14829]: info: CoreStateMachine::pushState Feb 15 18:41:24 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:24 volumio volumio[14829]: info: Setting Device type: Raspberry PI Feb 15 18:41:24 volumio volumio[14829]: info: Completed loading Core Plugins Feb 15 18:41:24 volumio volumio[14829]: info: Preparing to generate the ALSA configuration file Feb 15 18:41:24 volumio volumio[14829]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:24 volumio volumio[14829]: info: CoreStateMachine::pushState Feb 15 18:41:24 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:24 volumio volumio[14829]: info: CoreStateMachine::updateTrackBlock Feb 15 18:41:24 volumio volumio[14829]: info: CorePlayQueue::getTrackBlock Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:24 volumio volumio[14829]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:41:24 volumio volumio[14829]: info: Reading ALSA contributions from plugins. Feb 15 18:41:24 volumio volumio[14829]: info: Discovery: adding 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:41:24 volumio volumio[14829]: info: Discovery: Found device Volumio Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:24 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:24 volumio volumio[14829]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:41:24 volumio volumio[14829]: info: Output device has changed, restarting MPD Feb 15 18:41:24 volumio volumio[14829]: info: ___________ START PLUGINS ___________ Feb 15 18:41:24 volumio volumio[14829]: info: ControllerMpd::onStart: Initializing MPD Feb 15 18:41:24 volumio volumio[14829]: info: Creating MPD Configuration file Feb 15 18:41:24 volumio sudo[14944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:24 volumio sudo[14944]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:24 volumio sudo[14944]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:24 volumio sudo[14946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:24 volumio sudo[14946]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:24 volumio volumio[14829]: info: [1739641284714] CoreMusicLibrary::Adding element Server multimediali Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:24 volumio sudo[14949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:24 volumio sudo[14949]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:24 volumio sudo[14949]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:24 volumio sudo[14952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:24 volumio sudo[14952]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:24 volumio systemd[1]: Stopping Music Player Daemon... Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:24 volumio volumio[14829]: info: [1739641284818] CoreMusicLibrary::Adding element Last_100 Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:24 volumio volumio[14829]: info: [1739641284827] CoreMusicLibrary::Adding element Webradio Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:24 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:24 volumio volumio[14829]: info: Initializing BBC Radios Feb 15 18:41:24 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:24 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:24 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:25 volumio volumio[14829]: info: Loading i18n strings for locale it Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:25 volumio volumio[14829]: info: FusionDsp - mixtype--------------------- Hardware Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:25 volumio volumio[14829]: info: [1739641285190] CoreMusicLibrary::Adding element Radio Paradise Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:25 volumio volumio[14829]: Cannot find translation for source Radio Paradise Feb 15 18:41:25 volumio volumio[14829]: info: Volumio Calling Home Feb 15 18:41:25 volumio sudo[14956]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:25 volumio sudo[14956]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:25 volumio sudo[14956]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:25 volumio volumio[14829]: info: Preparing to generate the ALSA configuration file Feb 15 18:41:25 volumio volumio[14829]: info: Discovery: this is already registered, 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:41:25 volumio volumio[14829]: info: Discovery: Found device Volumio Feb 15 18:41:25 volumio volumio[14829]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:25 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:25 volumio volumio[14829]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:41:25 volumio volumio[14829]: info: Reading ALSA contributions from plugins. Feb 15 18:41:26 volumio volumio[14829]: info: MPD Permissions set Feb 15 18:41:26 volumio volumio[14829]: info: MPD Permissions set Feb 15 18:41:26 volumio volumio[14829]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:26 volumio volumio[14829]: info: CoreStateMachine::pushState Feb 15 18:41:26 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:26 volumio volumio[14829]: info: Volumio called home Feb 15 18:41:26 volumio volumio[14829]: 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 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:26 volumio volumio[14829]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:26 volumio volumio[14829]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:41:26 volumio volumio[14829]: info: Output device has changed, restarting MPD Feb 15 18:41:26 volumio sudo[15006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:26 volumio sudo[15006]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:26 volumio sudo[15006]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:26 volumio sudo[15008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:26 volumio sudo[15008]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:26 volumio volumio[14829]: info: MPD Permissions set Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 15 18:41:26 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:26 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:26 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:26 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:27 volumio sudo[15012]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:27 volumio sudo[15012]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:27 volumio sudo[15012]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:27 volumio volumio[14829]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:41:27 volumio volumio[14829]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Feb 15 18:41:27 volumio volumio[14829]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:41:27 volumio volumio[14829]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Feb 15 18:41:27 volumio volumio[14829]: info: camilladsp service started and running in background, instance 1 Feb 15 18:41:27 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:27 volumio volumio[14829]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:41:27 volumio volumio[14829]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 15 18:41:27 volumio volumio[14829]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:41:27 volumio volumio[14829]: info: FusionDsp loaded Feb 15 18:41:27 volumio volumio[14829]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 18:41:27 volumio sudo[15029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 15 18:41:27 volumio sudo[15029]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:27 volumio volumio[14829]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 15 18:41:27 volumio volumio[14829]: info: Adding Signal Path Element [object Object] Feb 15 18:41:27 volumio volumio[14829]: info: Adding fusiondspeq DSP Signal Path Element Feb 15 18:41:27 volumio volumio[14829]: info: FusionDsp - ---- installed callbackRead Feb 15 18:41:27 volumio volumio[14829]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:41:27 volumio sudo[15029]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:27 volumio volumio[14829]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 15 18:41:27 volumio volumio[14829]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 15 18:41:27 volumio volumio[14829]: at onErrorNT (internal/child_process.js:465:16) Feb 15 18:41:27 volumio volumio[14829]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Feb 15 18:41:27 volumio volumio[14829]: errno: -2, Feb 15 18:41:27 volumio volumio[14829]: code: 'ENOENT', Feb 15 18:41:27 volumio volumio[14829]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:41:27 volumio volumio[14829]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:41:27 volumio volumio[14829]: spawnargs: [ Feb 15 18:41:27 volumio volumio[14829]: '-p', Feb 15 18:41:27 volumio volumio[14829]: 9876, Feb 15 18:41:27 volumio volumio[14829]: '-o', Feb 15 18:41:27 volumio volumio[14829]: '/tmp/camilladsp.log', Feb 15 18:41:27 volumio volumio[14829]: '-l', Feb 15 18:41:27 volumio volumio[14829]: 'warn', Feb 15 18:41:27 volumio volumio[14829]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 15 18:41:27 volumio volumio[14829]: ] Feb 15 18:41:27 volumio volumio[14829]: } Feb 15 18:41:27 volumio volumio[14829]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:41:28 volumio sudo[15040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 18:40 Feb 15 18:41:28 volumio sudo[15040]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:28 volumio sudo[15040]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:29 volumio volumio-remote-updater[629]: [2025-02-15 18:41:29] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 15 18:41:29 volumio volumio-remote-updater[629]: [2025-02-15 18:41:29] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 15 18:41:29 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 15 18:41:29 volumio sudo[14952]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:29 volumio sudo[15008]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:29 volumio sudo[14946]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:29 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 15 18:41:29 volumio systemd[1]: Started dynamicswap service. Feb 15 18:41:29 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:41:29 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 15 18:41:29 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 57. Feb 15 18:41:29 volumio systemd[1]: Stopped Volumio Backend Module. Feb 15 18:41:29 volumio systemd[1]: Started Volumio Backend Module. Feb 15 18:41:29 volumio systemd[1]: Started dynamicswap service. Feb 15 18:41:29 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:41:30 volumio mpd[15018]: Feb 15 18:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 15 18:41:30 volumio systemd[1]: Started Music Player Daemon. Feb 15 18:41:32 volumio volumio[15063]: info: ------------------------------------------- Feb 15 18:41:32 volumio volumio[15063]: info: ----- Volumio3 ---- Feb 15 18:41:32 volumio volumio[15063]: info: ------------------------------------------- Feb 15 18:41:32 volumio volumio[15063]: info: ----- System startup ---- Feb 15 18:41:32 volumio volumio[15063]: info: ------------------------------------------- Feb 15 18:41:34 volumio volumio[15063]: info: MYVOLUMIO Environment detected Feb 15 18:41:34 volumio volumio-remote-updater[629]: [2025-02-15 18:41:34] [connect] Successful connection Feb 15 18:41:34 volumio volumio[15063]: info: Plugin folders cleanup Feb 15 18:41:34 volumio volumio[15063]: info: Scanning into folder /volumio/app/plugins/ Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category audio_interface Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category miscellanea Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category music_service Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category plugins.json Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category system_controller Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category user_interface Feb 15 18:41:34 volumio volumio[15063]: info: Scanning into folder /data/plugins/ Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category audio_interface Feb 15 18:41:34 volumio volumio[15063]: info: Scanning category music_service Feb 15 18:41:34 volumio volumio[15063]: info: Plugin folders cleanup completed Feb 15 18:41:34 volumio volumio[15063]: info: ------------------------------------------- Feb 15 18:41:34 volumio volumio[15063]: info: ----- Core plugins startup ---- Feb 15 18:41:34 volumio volumio[15063]: info: ------------------------------------------- Feb 15 18:41:34 volumio volumio[15063]: info: Loading plugins from folder /volumio/app/plugins/ Feb 15 18:41:34 volumio volumio[15063]: info: Adding plugin upnp to MyMusic Plugins Feb 15 18:41:34 volumio volumio[15063]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 15 18:41:34 volumio volumio[15063]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 15 18:41:34 volumio volumio[15063]: info: Loading plugins from folder /data/plugins/ Feb 15 18:41:34 volumio volumio[15063]: info: Loading plugin "system"... Feb 15 18:41:34 volumio volumio[15063]: info: Loading plugin "appearance"... Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "network"... Feb 15 18:41:36 volumio volumio[15063]: info: Refreshing Cached IP Addresses Feb 15 18:41:36 volumio sudo[15095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 18:41:36 volumio sudo[15095]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:36 volumio sudo[15095]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:36 volumio sudo[15097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 18:41:36 volumio sudo[15097]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "services"... Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "alsa_controller"... Feb 15 18:41:36 volumio sudo[15097]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:36 volumio sudo[15105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 15 18:41:36 volumio sudo[15105]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:36 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "wizard"... Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "networkfs"... Feb 15 18:41:36 volumio sudo[15123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=admin,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.2/Musica /mnt/NAS/Lisinaqnap Feb 15 18:41:36 volumio sudo[15123]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:36 volumio volumio[15063]: info: Starting Udev Watcher for removable devices Feb 15 18:41:36 volumio sudo[15125]: 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.2/Nas/musica /mnt/NAS/Qnap Feb 15 18:41:36 volumio sudo[15125]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:36 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Musica Feb 15 18:41:36 volumio volumio[15063]: info: Ignoring mount for partition: boot Feb 15 18:41:36 volumio volumio[15063]: info: Ignoring mount for partition: volumio Feb 15 18:41:36 volumio volumio[15063]: info: Ignoring mount for partition: volumio_data Feb 15 18:41:36 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "volumio_command_line_client"... Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "upnp"... Feb 15 18:41:36 volumio volumio[15063]: info: [1739641296613] Starting Upmpd Daemon Feb 15 18:41:36 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "my_music"... Feb 15 18:41:36 volumio volumio[15063]: info: Loading plugin "mpd"... Feb 15 18:41:36 volumio sudo[15123]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:36 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Feb 15 18:41:36 volumio kernel: CIFS: VFS: \\192.168.178.2 Send error in SessSetup = -13 Feb 15 18:41:36 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Feb 15 18:41:36 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Nas/musica Feb 15 18:41:36 volumio sudo[15125]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:36 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.178.2\Nas Feb 15 18:41:36 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Feb 15 18:41:37 volumio sudo[15105]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:37 volumio volumio[15063]: info: Loading plugin "upnp_browser"... Feb 15 18:41:37 volumio volumio[15063]: info: Loading plugin "alarm-clock"... Feb 15 18:41:38 volumio volumio[15063]: info: Plugin airplay_emulation is not enabled Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "last_100"... Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "webradio"... Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "i2s_dacs"... Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "volumiodiscovery"... Feb 15 18:41:38 volumio volumio[15063]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:38 volumio volumio[15063]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:38 volumio volumio[15063]: *** WARNING *** For more information see Feb 15 18:41:38 volumio volumio[15063]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:38 volumio node[15063]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:38 volumio volumio[15063]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:38 volumio volumio[15063]: *** WARNING *** For more information see Feb 15 18:41:38 volumio node[15063]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:38 volumio node[15063]: *** WARNING *** For more information see Feb 15 18:41:38 volumio node[15063]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:38 volumio node[15063]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:38 volumio node[15063]: *** WARNING *** For more information see Feb 15 18:41:38 volumio volumio[15063]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 15 18:41:38 volumio volumio[15063]: info: Discovery: Started advertising with name: Volumio Feb 15 18:41:38 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "outputs"... Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "albumart"... Feb 15 18:41:38 volumio volumio[15063]: info: Plugin example_plugin is not enabled Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "inputs"... Feb 15 18:41:38 volumio volumio[15063]: info: Loading plugin "updater_comm"... Feb 15 18:41:39 volumio volumio[15063]: info: Plugin mpdemulation is not enabled Feb 15 18:41:39 volumio volumio[15063]: info: Loading plugin "rest_api"... Feb 15 18:41:39 volumio volumio[15063]: info: Loading plugin "websocket"... Feb 15 18:41:39 volumio volumio[15063]: info: Starting Socket.io Server version 2.3.0 Feb 15 18:41:39 volumio volumio[15063]: info: Loading plugin "fusiondsp"... Feb 15 18:41:39 volumio volumio[15063]: Forking 3 albumart workers Feb 15 18:41:39 volumio volumio[15063]: info: Applying required configuration parameters for plugin fusiondsp Feb 15 18:41:40 volumio volumio[15063]: info: Loading plugin "radio_paradise"... Feb 15 18:41:40 volumio volumio[15063]: info: Applying required configuration parameters for plugin radio_paradise Feb 15 18:41:40 volumio volumio[15063]: info: [1739641300525] [RadioParadise] API delay: 2 Feb 15 18:41:40 volumio volumio[15063]: info: Loading i18n strings for locale it Feb 15 18:41:40 volumio volumio[15063]: Updating browse sources language Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::initPlayerControls Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:40 volumio volumio[15063]: Express server listening on port 3000 Feb 15 18:41:40 volumio volumio[15063]: [Metrics] WebUI: 9s 284.25ms Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::resetVolumioState Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::getcurrentVolume Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:41 volumio volumio[15063]: info: Volumio Network Manager: Network status updated: 1 Feb 15 18:41:41 volumio volumio[15063]: info: Cannot mount NAS Qnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:41 volumio volumio[15063]: info: Cannot mount NAS Lisinaqnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:41 volumio volumio[15063]: Starting albumart workers Feb 15 18:41:41 volumio volumio[15063]: Starting albumart workers Feb 15 18:41:41 volumio volumio[15063]: Starting albumart workers Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:41 volumio volumio[15063]: info: Reloading queue from file Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::setRepeat null single undefined Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::pushState Feb 15 18:41:41 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::setRandom null Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::pushState Feb 15 18:41:41 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:41 volumio volumio[15063]: info: Setting Device type: Raspberry PI Feb 15 18:41:41 volumio volumio[15063]: info: Completed loading Core Plugins Feb 15 18:41:41 volumio volumio[15063]: info: Preparing to generate the ALSA configuration file Feb 15 18:41:41 volumio volumio[15063]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::pushState Feb 15 18:41:41 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:41 volumio volumio[15063]: info: CoreStateMachine::updateTrackBlock Feb 15 18:41:41 volumio volumio[15063]: info: CorePlayQueue::getTrackBlock Feb 15 18:41:41 volumio volumio[15063]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:42 volumio volumio[15063]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:41:42 volumio volumio[15063]: info: Reading ALSA contributions from plugins. Feb 15 18:41:42 volumio volumio[15063]: info: Discovery: adding 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:41:42 volumio volumio[15063]: info: Discovery: Found device Volumio Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:42 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:42 volumio volumio[15063]: info: Discovery: this is already registered, 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:41:42 volumio volumio[15063]: info: Discovery: Found device Volumio Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:42 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:42 volumio volumio[15063]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:42 volumio volumio[15063]: info: CoreStateMachine::pushState Feb 15 18:41:42 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:42 volumio volumio[15063]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:41:42 volumio volumio[15063]: info: Output device has changed, restarting MPD Feb 15 18:41:42 volumio volumio[15063]: info: ___________ START PLUGINS ___________ Feb 15 18:41:42 volumio volumio[15063]: info: ControllerMpd::onStart: Initializing MPD Feb 15 18:41:42 volumio volumio[15063]: info: Creating MPD Configuration file Feb 15 18:41:42 volumio sudo[15222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:42 volumio sudo[15222]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:42 volumio sudo[15221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:42 volumio sudo[15221]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:42 volumio sudo[15221]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:42 volumio systemd[1]: Stopping Music Player Daemon... Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:42 volumio volumio[15063]: info: [1739641302647] CoreMusicLibrary::Adding element Server multimediali Feb 15 18:41:42 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:42 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:42 volumio sudo[15235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:42 volumio sudo[15235]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:42 volumio sudo[15240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:42 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:42 volumio sudo[15240]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:42 volumio sudo[15235]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:42 volumio volumio[15063]: info: [1739641302762] CoreMusicLibrary::Adding element Last_100 Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:42 volumio volumio[15063]: info: [1739641302781] CoreMusicLibrary::Adding element Webradio Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:42 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 15 18:41:42 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:42 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:42 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:42 volumio volumio[15063]: info: Initializing BBC Radios Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:42 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:42 volumio volumio[15063]: info: Loading i18n strings for locale it Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: FusionDsp - mixtype--------------------- Hardware Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:41:43 volumio volumio[15063]: info: [1739641303025] CoreMusicLibrary::Adding element Radio Paradise Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:43 volumio volumio[15063]: Cannot find translation for source Radio Paradise Feb 15 18:41:43 volumio volumio[15063]: info: Volumio Calling Home Feb 15 18:41:43 volumio sudo[15244]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:43 volumio sudo[15244]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:43 volumio sudo[15244]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:43 volumio volumio[15063]: info: Preparing to generate the ALSA configuration file Feb 15 18:41:43 volumio volumio[15063]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:41:43 volumio volumio[15063]: info: Reading ALSA contributions from plugins. Feb 15 18:41:43 volumio volumio[15063]: info: MPD Permissions set Feb 15 18:41:43 volumio volumio[15063]: info: MPD Permissions set Feb 15 18:41:43 volumio sudo[15271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 18:41:43 volumio sudo[15271]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:43 volumio sudo[15271]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:43 volumio volumio[15063]: info: Volumio called home Feb 15 18:41:43 volumio sudo[15273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 18:41:43 volumio sudo[15273]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:43 volumio sudo[15273]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:43 volumio volumio[15063]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:43 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:44 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:44 volumio volumio[15063]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:41:44 volumio volumio[15063]: info: Output device has changed, restarting MPD Feb 15 18:41:44 volumio sudo[15285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:41:44 volumio sudo[15285]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:44 volumio sudo[15285]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:44 volumio sudo[15287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:41:44 volumio sudo[15287]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:44 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 15 18:41:44 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:41:44 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:41:44 volumio volumio[15063]: info: MPD Permissions set Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:44 volumio volumio[15063]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::volumioGetState Feb 15 18:41:44 volumio volumio[15063]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:44 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 15 18:41:44 volumio volumio[15063]: info: Listing playlists Feb 15 18:41:44 volumio sudo[15291]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:44 volumio sudo[15291]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:44 volumio sudo[15291]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:45 volumio volumio[15063]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:41:45 volumio volumio[15063]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Feb 15 18:41:45 volumio volumio[15063]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:41:45 volumio volumio[15063]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Feb 15 18:41:45 volumio volumio[15063]: info: camilladsp service started and running in background, instance 1 Feb 15 18:41:45 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:45 volumio volumio[15063]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:41:45 volumio volumio[15063]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 15 18:41:45 volumio volumio[15063]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:41:45 volumio volumio[15063]: info: FusionDsp loaded Feb 15 18:41:45 volumio volumio[15063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 18:41:45 volumio sudo[15308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 15 18:41:45 volumio sudo[15308]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:45 volumio volumio[15063]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 15 18:41:45 volumio volumio[15063]: info: Adding Signal Path Element [object Object] Feb 15 18:41:45 volumio volumio[15063]: info: Adding fusiondspeq DSP Signal Path Element Feb 15 18:41:45 volumio volumio[15063]: info: FusionDsp - ---- installed callbackRead Feb 15 18:41:45 volumio volumio[15063]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:41:45 volumio sudo[15308]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:45 volumio volumio[15063]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 15 18:41:45 volumio volumio[15063]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 15 18:41:45 volumio volumio[15063]: at onErrorNT (internal/child_process.js:465:16) Feb 15 18:41:45 volumio volumio[15063]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Feb 15 18:41:45 volumio volumio[15063]: errno: -2, Feb 15 18:41:45 volumio volumio[15063]: code: 'ENOENT', Feb 15 18:41:45 volumio volumio[15063]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:41:45 volumio volumio[15063]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:41:45 volumio volumio[15063]: spawnargs: [ Feb 15 18:41:45 volumio volumio[15063]: '-p', Feb 15 18:41:45 volumio volumio[15063]: 9876, Feb 15 18:41:45 volumio volumio[15063]: '-o', Feb 15 18:41:45 volumio volumio[15063]: '/tmp/camilladsp.log', Feb 15 18:41:45 volumio volumio[15063]: '-l', Feb 15 18:41:45 volumio volumio[15063]: 'warn', Feb 15 18:41:45 volumio volumio[15063]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 15 18:41:45 volumio volumio[15063]: ] Feb 15 18:41:45 volumio volumio[15063]: } Feb 15 18:41:45 volumio volumio[15063]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:41:45 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 15 18:41:45 volumio systemd[1]: mpd.service: Failed with result 'protocol'. Feb 15 18:41:45 volumio systemd[1]: Failed to start Music Player Daemon. Feb 15 18:41:45 volumio sudo[15287]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:45 volumio sudo[15240]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:45 volumio sudo[15222]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:45 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:41:45 volumio sudo[15320]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:41:45 volumio sudo[15320]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:45 volumio sudo[15320]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:46 volumio sudo[15339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 18:40 Feb 15 18:41:46 volumio sudo[15339]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:46 volumio volumio-remote-updater[629]: [2025-02-15 18:41:46] [connect] Successful connection Feb 15 18:41:46 volumio sudo[15339]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:47 volumio volumio-remote-updater[629]: [2025-02-15 18:41:47] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Feb 15 18:41:47 volumio volumio-remote-updater[629]: [2025-02-15 18:41:47] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Feb 15 18:41:47 volumio volumio-remote-updater[629]: [2025-02-15 18:41:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 15 18:41:47 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 15 18:41:47 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 15 18:41:47 volumio systemd[1]: Started dynamicswap service. Feb 15 18:41:47 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:41:47 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 15 18:41:47 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 58. Feb 15 18:41:47 volumio systemd[1]: Stopped Volumio Backend Module. Feb 15 18:41:47 volumio systemd[1]: Started Volumio Backend Module. Feb 15 18:41:47 volumio systemd[1]: Started dynamicswap service. Feb 15 18:41:47 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:41:48 volumio mpd[15323]: Feb 15 18:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 15 18:41:48 volumio systemd[1]: Started Music Player Daemon. Feb 15 18:41:48 volumio mpd_monitor.sh[592]: MPD restarted due to no mpc output. Feb 15 18:41:50 volumio volumio[15349]: info: ------------------------------------------- Feb 15 18:41:50 volumio volumio[15349]: info: ----- Volumio3 ---- Feb 15 18:41:50 volumio volumio[15349]: info: ------------------------------------------- Feb 15 18:41:50 volumio volumio[15349]: info: ----- System startup ---- Feb 15 18:41:50 volumio volumio[15349]: info: ------------------------------------------- Feb 15 18:41:52 volumio volumio[15349]: info: MYVOLUMIO Environment detected Feb 15 18:41:52 volumio volumio[15349]: info: Plugin folders cleanup Feb 15 18:41:52 volumio volumio[15349]: info: Scanning into folder /volumio/app/plugins/ Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category audio_interface Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category miscellanea Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category music_service Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category plugins.json Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category system_controller Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category user_interface Feb 15 18:41:52 volumio volumio[15349]: info: Scanning into folder /data/plugins/ Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category audio_interface Feb 15 18:41:52 volumio volumio[15349]: info: Scanning category music_service Feb 15 18:41:52 volumio volumio[15349]: info: Plugin folders cleanup completed Feb 15 18:41:52 volumio volumio[15349]: info: ------------------------------------------- Feb 15 18:41:52 volumio volumio[15349]: info: ----- Core plugins startup ---- Feb 15 18:41:52 volumio volumio[15349]: info: ------------------------------------------- Feb 15 18:41:52 volumio volumio[15349]: info: Loading plugins from folder /volumio/app/plugins/ Feb 15 18:41:52 volumio volumio[15349]: info: Adding plugin upnp to MyMusic Plugins Feb 15 18:41:52 volumio volumio[15349]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 15 18:41:52 volumio volumio[15349]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 15 18:41:52 volumio volumio[15349]: info: Loading plugins from folder /data/plugins/ Feb 15 18:41:52 volumio volumio[15349]: info: Loading plugin "system"... Feb 15 18:41:52 volumio volumio[15349]: info: Loading plugin "appearance"... Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "network"... Feb 15 18:41:54 volumio volumio[15349]: info: Refreshing Cached IP Addresses Feb 15 18:41:54 volumio sudo[15379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 18:41:54 volumio sudo[15379]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:54 volumio sudo[15379]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:54 volumio sudo[15381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 18:41:54 volumio sudo[15381]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:54 volumio sudo[15381]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "services"... Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "alsa_controller"... Feb 15 18:41:54 volumio sudo[15390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 15 18:41:54 volumio sudo[15390]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:54 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "wizard"... Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "networkfs"... Feb 15 18:41:54 volumio volumio[15349]: info: Starting Udev Watcher for removable devices Feb 15 18:41:54 volumio sudo[15407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=admin,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.2/Musica /mnt/NAS/Lisinaqnap Feb 15 18:41:54 volumio sudo[15407]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:54 volumio sudo[15409]: 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.2/Nas/musica /mnt/NAS/Qnap Feb 15 18:41:54 volumio sudo[15409]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:41:54 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Musica Feb 15 18:41:54 volumio volumio[15349]: info: Ignoring mount for partition: boot Feb 15 18:41:54 volumio volumio[15349]: info: Ignoring mount for partition: volumio Feb 15 18:41:54 volumio volumio[15349]: info: Ignoring mount for partition: volumio_data Feb 15 18:41:54 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "volumio_command_line_client"... Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "upnp"... Feb 15 18:41:54 volumio volumio[15349]: info: [1739641314629] Starting Upmpd Daemon Feb 15 18:41:54 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "my_music"... Feb 15 18:41:54 volumio volumio[15349]: info: Loading plugin "mpd"... Feb 15 18:41:54 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Feb 15 18:41:54 volumio kernel: CIFS: VFS: \\192.168.178.2 Send error in SessSetup = -13 Feb 15 18:41:54 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Feb 15 18:41:54 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Nas/musica Feb 15 18:41:54 volumio sudo[15407]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:54 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.178.2\Nas Feb 15 18:41:54 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Feb 15 18:41:54 volumio sudo[15409]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:55 volumio sudo[15390]: pam_unix(sudo:session): session closed for user root Feb 15 18:41:55 volumio volumio[15349]: info: Loading plugin "upnp_browser"... Feb 15 18:41:55 volumio volumio[15349]: info: Loading plugin "alarm-clock"... Feb 15 18:41:56 volumio volumio[15349]: info: Plugin airplay_emulation is not enabled Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "last_100"... Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "webradio"... Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "i2s_dacs"... Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "volumiodiscovery"... Feb 15 18:41:56 volumio volumio[15349]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:56 volumio volumio[15349]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:56 volumio volumio[15349]: *** WARNING *** For more information see Feb 15 18:41:56 volumio volumio[15349]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:56 volumio node[15349]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:56 volumio volumio[15349]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:56 volumio volumio[15349]: *** WARNING *** For more information see Feb 15 18:41:56 volumio node[15349]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:56 volumio node[15349]: *** WARNING *** For more information see Feb 15 18:41:56 volumio node[15349]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:41:56 volumio node[15349]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:41:56 volumio node[15349]: *** WARNING *** For more information see Feb 15 18:41:56 volumio volumio[15349]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 15 18:41:56 volumio volumio[15349]: info: Discovery: Started advertising with name: Volumio Feb 15 18:41:56 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "outputs"... Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "albumart"... Feb 15 18:41:56 volumio volumio[15349]: info: Plugin example_plugin is not enabled Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "inputs"... Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "updater_comm"... Feb 15 18:41:56 volumio volumio[15349]: info: Plugin mpdemulation is not enabled Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "rest_api"... Feb 15 18:41:56 volumio volumio[15349]: info: Loading plugin "websocket"... Feb 15 18:41:56 volumio volumio[15349]: info: Starting Socket.io Server version 2.3.0 Feb 15 18:41:57 volumio volumio[15349]: info: Loading plugin "fusiondsp"... Feb 15 18:41:57 volumio volumio-remote-updater[629]: [2025-02-15 18:41:57] [connect] Successful connection Feb 15 18:41:57 volumio volumio[15349]: Forking 3 albumart workers Feb 15 18:41:57 volumio volumio[15349]: info: Applying required configuration parameters for plugin fusiondsp Feb 15 18:41:57 volumio volumio[15349]: info: Loading plugin "radio_paradise"... Feb 15 18:41:58 volumio volumio[15349]: info: Applying required configuration parameters for plugin radio_paradise Feb 15 18:41:58 volumio volumio[15349]: info: [1739641318547] [RadioParadise] API delay: 2 Feb 15 18:41:58 volumio volumio[15349]: info: Loading i18n strings for locale it Feb 15 18:41:58 volumio volumio[15349]: Updating browse sources language Feb 15 18:41:58 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:41:58 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:58 volumio volumio[15349]: info: CoreCommandRouter::initPlayerControls Feb 15 18:41:58 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:58 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:41:58 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:41:59 volumio volumio[15349]: Express server listening on port 3000 Feb 15 18:41:59 volumio volumio[15349]: [Metrics] WebUI: 9s 347.41ms Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::resetVolumioState Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::getcurrentVolume Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:59 volumio volumio[15349]: Starting albumart workers Feb 15 18:41:59 volumio volumio[15349]: Starting albumart workers Feb 15 18:41:59 volumio volumio[15349]: Starting albumart workers Feb 15 18:41:59 volumio volumio[15349]: info: Volumio Network Manager: Network status updated: 1 Feb 15 18:41:59 volumio volumio[15349]: info: Cannot mount NAS Qnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:59 volumio volumio[15349]: info: Cannot mount NAS Lisinaqnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 15 18:41:59 volumio volumio-remote-updater[629]: [2025-02-15 18:41:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739641317 101 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 15 18:41:59 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:41:59 volumio volumio[15349]: info: Reloading queue from file Feb 15 18:41:59 volumio volumio[15349]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::pushState Feb 15 18:41:59 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::updateTrackBlock Feb 15 18:41:59 volumio volumio[15349]: info: CorePlayQueue::getTrackBlock Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::setRepeat null single undefined Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::pushState Feb 15 18:41:59 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::setRandom null Feb 15 18:41:59 volumio volumio[15349]: info: CoreStateMachine::pushState Feb 15 18:41:59 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:41:59 volumio volumio[15349]: info: CoreCommandRouter::volumioPushState Feb 15 18:41:59 volumio volumio[15349]: info: Setting Device type: Raspberry PI Feb 15 18:42:00 volumio volumio[15349]: info: Completed loading Core Plugins Feb 15 18:42:00 volumio volumio[15349]: info: Preparing to generate the ALSA configuration file Feb 15 18:42:00 volumio volumio[15349]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:42:00 volumio volumio[15349]: info: Reading ALSA contributions from plugins. Feb 15 18:42:00 volumio volumio[15349]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Feb 15 18:42:00 volumio volumio[15349]: info: Discovery: adding 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:42:00 volumio volumio[15349]: info: Discovery: Found device Volumio Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:00 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:00 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:00 volumio volumio[15349]: info: Discovery: this is already registered, 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:42:00 volumio volumio[15349]: info: Discovery: Found device Volumio Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:00 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 15 18:42:00 volumio volumio[15349]: info: Listing playlists Feb 15 18:42:00 volumio volumio[15349]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:42:00 volumio volumio[15349]: info: CoreStateMachine::pushState Feb 15 18:42:00 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioPushState Feb 15 18:42:00 volumio volumio[15349]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:42:00 volumio volumio[15349]: info: Output device has changed, restarting MPD Feb 15 18:42:00 volumio volumio[15349]: info: ___________ START PLUGINS ___________ Feb 15 18:42:00 volumio volumio[15349]: info: ControllerMpd::onStart: Initializing MPD Feb 15 18:42:00 volumio volumio[15349]: info: Creating MPD Configuration file Feb 15 18:42:00 volumio sudo[15489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:42:00 volumio sudo[15489]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:00 volumio sudo[15489]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:00 volumio sudo[15491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:42:00 volumio sudo[15491]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:00 volumio sudo[15494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:42:00 volumio sudo[15494]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:42:00 volumio sudo[15494]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:00 volumio volumio[15349]: info: [1739641320725] CoreMusicLibrary::Adding element Server multimediali Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:00 volumio systemd[1]: Stopping Music Player Daemon... Feb 15 18:42:00 volumio sudo[15497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:42:00 volumio sudo[15497]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:00 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:42:00 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:00 volumio volumio[15349]: info: [1739641320815] CoreMusicLibrary::Adding element Last_100 Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:00 volumio volumio[15349]: info: [1739641320831] CoreMusicLibrary::Adding element Webradio Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:42:00 volumio volumio[15349]: info: Initializing BBC Radios Feb 15 18:42:00 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:42:00 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 15 18:42:00 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:42:00 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:42:00 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:42:00 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:42:00 volumio volumio[15349]: info: Loading i18n strings for locale it Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: FusionDsp - mixtype--------------------- Hardware Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:01 volumio volumio[15349]: info: [1739641321014] CoreMusicLibrary::Adding element Radio Paradise Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:01 volumio volumio[15349]: Cannot find translation for source Radio Paradise Feb 15 18:42:01 volumio volumio[15349]: info: Volumio Calling Home Feb 15 18:42:01 volumio sudo[15504]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:42:01 volumio sudo[15504]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:01 volumio sudo[15504]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:01 volumio volumio[15349]: info: Preparing to generate the ALSA configuration file Feb 15 18:42:01 volumio volumio[15349]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:42:01 volumio volumio[15349]: info: Reading ALSA contributions from plugins. Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 15 18:42:01 volumio volumio[15349]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 15 18:42:01 volumio volumio[15349]: info: Received Get System Version Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:42:01 volumio volumio[15349]: info: Received Get System Info Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 15 18:42:01 volumio volumio[15349]: info: Discovery: Getting this device information Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:01 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 18:42:01 volumio volumio[15349]: info: MPD Permissions set Feb 15 18:42:01 volumio volumio[15349]: info: Volumio called home Feb 15 18:42:01 volumio volumio[15349]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:42:01 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:02 volumio volumio[15349]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:02 volumio volumio[15349]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:42:02 volumio volumio[15349]: info: Output device has changed, restarting MPD Feb 15 18:42:02 volumio sudo[15526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:42:02 volumio sudo[15526]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:02 volumio sudo[15526]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:02 volumio sudo[15528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:42:02 volumio volumio[15349]: info: MPD Permissions set Feb 15 18:42:02 volumio sudo[15528]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:42:02 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:02 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 15 18:42:02 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:42:02 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:42:02 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:42:02 volumio sudo[15536]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:42:02 volumio sudo[15536]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:02 volumio sudo[15536]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:03 volumio volumio[15349]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:42:03 volumio volumio[15349]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Feb 15 18:42:03 volumio volumio[15349]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Feb 15 18:42:03 volumio volumio[15349]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Feb 15 18:42:03 volumio volumio[15349]: info: camilladsp service started and running in background, instance 1 Feb 15 18:42:03 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:03 volumio volumio[15349]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:42:03 volumio volumio[15349]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 15 18:42:03 volumio volumio[15349]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 15 18:42:03 volumio volumio[15349]: info: FusionDsp loaded Feb 15 18:42:03 volumio volumio[15349]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 15 18:42:03 volumio sudo[15549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 15 18:42:03 volumio sudo[15549]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:03 volumio volumio[15349]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 15 18:42:03 volumio volumio[15349]: info: Adding Signal Path Element [object Object] Feb 15 18:42:03 volumio volumio[15349]: info: Adding fusiondspeq DSP Signal Path Element Feb 15 18:42:03 volumio volumio[15349]: info: FusionDsp - ---- installed callbackRead Feb 15 18:42:03 volumio volumio[15349]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:42:03 volumio sudo[15549]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:03 volumio volumio[15349]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 15 18:42:03 volumio volumio[15349]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 15 18:42:03 volumio volumio[15349]: at onErrorNT (internal/child_process.js:465:16) Feb 15 18:42:03 volumio volumio[15349]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 15 18:42:03 volumio volumio[15349]: at runNextTicks (internal/process/task_queues.js:62:3) Feb 15 18:42:03 volumio volumio[15349]: at processTimers (internal/timers.js:494:9) { Feb 15 18:42:03 volumio volumio[15349]: errno: -2, Feb 15 18:42:03 volumio volumio[15349]: code: 'ENOENT', Feb 15 18:42:03 volumio volumio[15349]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:42:03 volumio volumio[15349]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 15 18:42:03 volumio volumio[15349]: spawnargs: [ Feb 15 18:42:03 volumio volumio[15349]: '-p', Feb 15 18:42:03 volumio volumio[15349]: 9876, Feb 15 18:42:03 volumio volumio[15349]: '-o', Feb 15 18:42:03 volumio volumio[15349]: '/tmp/camilladsp.log', Feb 15 18:42:03 volumio volumio[15349]: '-l', Feb 15 18:42:03 volumio volumio[15349]: 'warn', Feb 15 18:42:03 volumio volumio[15349]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 15 18:42:03 volumio volumio[15349]: ] Feb 15 18:42:03 volumio volumio[15349]: } Feb 15 18:42:03 volumio volumio[15349]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:42:04 volumio sudo[15574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 18:41 Feb 15 18:42:04 volumio sudo[15574]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:04 volumio sudo[15574]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:04 volumio volumio-remote-updater[629]: [2025-02-15 18:42:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 15 18:42:04 volumio volumio-remote-updater[629]: [2025-02-15 18:42:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 15 18:42:04 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 15 18:42:04 volumio sudo[15528]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:04 volumio sudo[15491]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:04 volumio sudo[15497]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:04 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 15 18:42:04 volumio systemd[1]: Started dynamicswap service. Feb 15 18:42:05 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:42:05 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 15 18:42:05 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 59. Feb 15 18:42:05 volumio systemd[1]: Started dynamicswap service. Feb 15 18:42:05 volumio systemd[1]: Stopped Volumio Backend Module. Feb 15 18:42:05 volumio systemd[1]: Started Volumio Backend Module. Feb 15 18:42:05 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 15 18:42:05 volumio mpd[15538]: Feb 15 18:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 15 18:42:05 volumio systemd[1]: Started Music Player Daemon. Feb 15 18:42:08 volumio volumio[15585]: info: ------------------------------------------- Feb 15 18:42:08 volumio volumio[15585]: info: ----- Volumio3 ---- Feb 15 18:42:08 volumio volumio[15585]: info: ------------------------------------------- Feb 15 18:42:08 volumio volumio[15585]: info: ----- System startup ---- Feb 15 18:42:08 volumio volumio[15585]: info: ------------------------------------------- Feb 15 18:42:09 volumio volumio-remote-updater[629]: [2025-02-15 18:42:09] [connect] Successful connection Feb 15 18:42:09 volumio volumio[15585]: info: MYVOLUMIO Environment detected Feb 15 18:42:09 volumio volumio[15585]: info: Plugin folders cleanup Feb 15 18:42:09 volumio volumio[15585]: info: Scanning into folder /volumio/app/plugins/ Feb 15 18:42:09 volumio volumio[15585]: info: Scanning category audio_interface Feb 15 18:42:09 volumio volumio[15585]: info: Scanning category miscellanea Feb 15 18:42:09 volumio volumio[15585]: info: Scanning category music_service Feb 15 18:42:09 volumio volumio[15585]: info: Scanning category plugins.json Feb 15 18:42:09 volumio volumio[15585]: info: Scanning category system_controller Feb 15 18:42:10 volumio volumio[15585]: info: Scanning category user_interface Feb 15 18:42:10 volumio volumio[15585]: info: Scanning into folder /data/plugins/ Feb 15 18:42:10 volumio volumio[15585]: info: Scanning category audio_interface Feb 15 18:42:10 volumio volumio[15585]: info: Scanning category music_service Feb 15 18:42:10 volumio volumio[15585]: info: Plugin folders cleanup completed Feb 15 18:42:10 volumio volumio[15585]: info: ------------------------------------------- Feb 15 18:42:10 volumio volumio[15585]: info: ----- Core plugins startup ---- Feb 15 18:42:10 volumio volumio[15585]: info: ------------------------------------------- Feb 15 18:42:10 volumio volumio[15585]: info: Loading plugins from folder /volumio/app/plugins/ Feb 15 18:42:10 volumio volumio[15585]: info: Adding plugin upnp to MyMusic Plugins Feb 15 18:42:10 volumio volumio[15585]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 15 18:42:10 volumio volumio[15585]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 15 18:42:10 volumio volumio[15585]: info: Loading plugins from folder /data/plugins/ Feb 15 18:42:10 volumio volumio[15585]: info: Loading plugin "system"... Feb 15 18:42:10 volumio volumio[15585]: info: Loading plugin "appearance"... Feb 15 18:42:11 volumio volumio[15585]: info: Loading plugin "network"... Feb 15 18:42:11 volumio volumio[15585]: info: Refreshing Cached IP Addresses Feb 15 18:42:11 volumio sudo[15617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 15 18:42:11 volumio sudo[15617]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:11 volumio sudo[15617]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:11 volumio sudo[15619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 15 18:42:12 volumio sudo[15619]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:12 volumio sudo[15619]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "services"... Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "alsa_controller"... Feb 15 18:42:12 volumio sudo[15631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 15 18:42:12 volumio sudo[15631]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:12 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "wizard"... Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "networkfs"... Feb 15 18:42:12 volumio sudo[15645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=admin,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.2/Musica /mnt/NAS/Lisinaqnap Feb 15 18:42:12 volumio sudo[15645]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:12 volumio volumio[15585]: info: Starting Udev Watcher for removable devices Feb 15 18:42:12 volumio sudo[15647]: 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.2/Nas/musica /mnt/NAS/Qnap Feb 15 18:42:12 volumio sudo[15647]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:12 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Musica Feb 15 18:42:12 volumio volumio[15585]: info: Ignoring mount for partition: boot Feb 15 18:42:12 volumio volumio[15585]: info: Ignoring mount for partition: volumio Feb 15 18:42:12 volumio volumio[15585]: info: Ignoring mount for partition: volumio_data Feb 15 18:42:12 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "volumio_command_line_client"... Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "upnp"... Feb 15 18:42:12 volumio volumio[15585]: info: [1739641332454] Starting Upmpd Daemon Feb 15 18:42:12 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "my_music"... Feb 15 18:42:12 volumio volumio[15585]: info: Loading plugin "mpd"... Feb 15 18:42:12 volumio sudo[15645]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:12 volumio kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Feb 15 18:42:12 volumio kernel: CIFS: VFS: \\192.168.178.2 Send error in SessSetup = -13 Feb 15 18:42:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Feb 15 18:42:12 volumio kernel: CIFS: Attempting to mount //192.168.178.2/Nas/musica Feb 15 18:42:12 volumio kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.178.2\Nas Feb 15 18:42:12 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Feb 15 18:42:12 volumio sudo[15647]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:12 volumio sudo[15631]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:13 volumio volumio[15585]: info: Loading plugin "upnp_browser"... Feb 15 18:42:13 volumio volumio[15585]: info: Loading plugin "alarm-clock"... Feb 15 18:42:13 volumio volumio[15585]: info: Plugin airplay_emulation is not enabled Feb 15 18:42:13 volumio volumio[15585]: info: Loading plugin "last_100"... Feb 15 18:42:13 volumio volumio[15585]: info: Loading plugin "webradio"... Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "i2s_dacs"... Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "volumiodiscovery"... Feb 15 18:42:14 volumio volumio[15585]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:42:14 volumio volumio[15585]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:42:14 volumio volumio[15585]: *** WARNING *** For more information see Feb 15 18:42:14 volumio volumio[15585]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:42:14 volumio node[15585]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 15 18:42:14 volumio volumio[15585]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:42:14 volumio volumio[15585]: *** WARNING *** For more information see Feb 15 18:42:14 volumio node[15585]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:42:14 volumio node[15585]: *** WARNING *** For more information see Feb 15 18:42:14 volumio node[15585]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 15 18:42:14 volumio node[15585]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 15 18:42:14 volumio node[15585]: *** WARNING *** For more information see Feb 15 18:42:14 volumio volumio[15585]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 15 18:42:14 volumio volumio[15585]: info: Discovery: Started advertising with name: Volumio Feb 15 18:42:14 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "outputs"... Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "albumart"... Feb 15 18:42:14 volumio volumio[15585]: info: Plugin example_plugin is not enabled Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "inputs"... Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "updater_comm"... Feb 15 18:42:14 volumio volumio[15585]: info: Plugin mpdemulation is not enabled Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "rest_api"... Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "websocket"... Feb 15 18:42:14 volumio volumio[15585]: info: Starting Socket.io Server version 2.3.0 Feb 15 18:42:14 volumio volumio[15585]: info: Loading plugin "fusiondsp"... Feb 15 18:42:15 volumio volumio[15585]: Forking 3 albumart workers Feb 15 18:42:15 volumio volumio[15585]: info: Applying required configuration parameters for plugin fusiondsp Feb 15 18:42:15 volumio volumio[15585]: info: Loading plugin "radio_paradise"... Feb 15 18:42:16 volumio volumio[15585]: info: Applying required configuration parameters for plugin radio_paradise Feb 15 18:42:16 volumio volumio[15585]: info: [1739641336174] [RadioParadise] API delay: 2 Feb 15 18:42:16 volumio volumio[15585]: info: Loading i18n strings for locale it Feb 15 18:42:16 volumio volumio[15585]: Updating browse sources language Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::initPlayerControls Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:42:16 volumio volumio[15585]: Express server listening on port 3000 Feb 15 18:42:16 volumio volumio[15585]: [Metrics] WebUI: 9s 174.93ms Feb 15 18:42:16 volumio volumio[15585]: info: CoreStateMachine::resetVolumioState Feb 15 18:42:16 volumio volumio[15585]: info: CoreStateMachine::getcurrentVolume Feb 15 18:42:16 volumio volumio[15585]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:42:16 volumio volumio[15585]: info: Volumio Network Manager: Network status updated: 1 Feb 15 18:42:16 volumio volumio[15585]: info: Cannot mount NAS Qnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:42:16 volumio volumio[15585]: info: Cannot mount NAS Lisinaqnap at system boot, trial number 1 ,retrying in 5 seconds Feb 15 18:42:17 volumio volumio[15585]: Starting albumart workers Feb 15 18:42:17 volumio volumio[15585]: Starting albumart workers Feb 15 18:42:17 volumio volumio[15585]: Starting albumart workers Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:42:17 volumio volumio[15585]: info: Reloading queue from file Feb 15 18:42:17 volumio volumio[15585]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:42:17 volumio volumio[15585]: info: CoreStateMachine::pushState Feb 15 18:42:17 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::volumioPushState Feb 15 18:42:17 volumio volumio[15585]: info: CoreStateMachine::updateTrackBlock Feb 15 18:42:17 volumio volumio[15585]: info: CorePlayQueue::getTrackBlock Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::volumioRetrievevolume Feb 15 18:42:17 volumio volumio[15585]: info: CoreStateMachine::setRepeat null single undefined Feb 15 18:42:17 volumio volumio[15585]: info: CoreStateMachine::pushState Feb 15 18:42:17 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::volumioPushState Feb 15 18:42:17 volumio volumio[15585]: info: CoreStateMachine::setRandom null Feb 15 18:42:17 volumio volumio[15585]: info: CoreStateMachine::pushState Feb 15 18:42:17 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::volumioPushState Feb 15 18:42:17 volumio volumio[15585]: info: Setting Device type: Raspberry PI Feb 15 18:42:17 volumio volumio[15585]: info: Completed loading Core Plugins Feb 15 18:42:17 volumio volumio[15585]: info: Preparing to generate the ALSA configuration file Feb 15 18:42:17 volumio volumio[15585]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:42:17 volumio volumio[15585]: info: Reading ALSA contributions from plugins. Feb 15 18:42:17 volumio volumio[15585]: info: Discovery: adding 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:42:17 volumio volumio[15585]: info: Discovery: Found device Volumio Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:17 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:17 volumio volumio[15585]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 15 18:42:17 volumio volumio[15585]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:17 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:17 volumio volumio[15585]: info: Discovery: this is already registered, 5ea41cbf-f05d-4b3f-97aa-f32bc1e0a603 Feb 15 18:42:18 volumio volumio[15585]: info: Discovery: Found device Volumio Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::volumioGetState Feb 15 18:42:18 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 15 18:42:18 volumio volumio[15585]: info: Listing playlists Feb 15 18:42:18 volumio volumio[15585]: info: VolumeController:: Volume=41 Mute =false Feb 15 18:42:18 volumio volumio[15585]: info: CoreStateMachine::pushState Feb 15 18:42:18 volumio volumio[15585]: info: CorePlayQueue::getTrack 0 Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::volumioPushState Feb 15 18:42:18 volumio volumio[15585]: info: Asound.conf file unchanged, so no further update is needed Feb 15 18:42:18 volumio volumio[15585]: info: Output device has changed, restarting MPD Feb 15 18:42:18 volumio volumio[15585]: info: ___________ START PLUGINS ___________ Feb 15 18:42:18 volumio sudo[15709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:42:18 volumio sudo[15709]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:18 volumio sudo[15709]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:18 volumio volumio[15585]: info: ControllerMpd::onStart: Initializing MPD Feb 15 18:42:18 volumio volumio[15585]: info: Creating MPD Configuration file Feb 15 18:42:18 volumio sudo[15715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:42:18 volumio sudo[15715]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:18 volumio sudo[15727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 15 18:42:18 volumio sudo[15727]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 15 18:42:18 volumio sudo[15727]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:18 volumio systemd[1]: Stopping Music Player Daemon... Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:18 volumio volumio[15585]: info: [1739641338440] CoreMusicLibrary::Adding element Server multimediali Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:18 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:42:18 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:42:18 volumio sudo[15734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 15 18:42:18 volumio sudo[15734]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:18 volumio volumio[15585]: info: [1739641338555] CoreMusicLibrary::Adding element Last_100 Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:18 volumio volumio[15585]: info: [1739641338562] CoreMusicLibrary::Adding element Webradio Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:42:18 volumio volumio[15585]: info: Initializing BBC Radios Feb 15 18:42:18 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:42:18 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 15 18:42:18 volumio systemd[1]: mpd.service: Succeeded. Feb 15 18:42:18 volumio systemd[1]: Stopped Music Player Daemon. Feb 15 18:42:18 volumio systemd[1]: Starting Music Player Daemon... Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 15 18:42:18 volumio volumio[15585]: info: Loading i18n strings for locale it Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 15 18:42:18 volumio volumio[15585]: info: FusionDsp - mixtype--------------------- Hardware Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 15 18:42:18 volumio volumio[15585]: info: [1739641338745] CoreMusicLibrary::Adding element Radio Paradise Feb 15 18:42:18 volumio volumio[15585]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 15 18:42:18 volumio volumio[15585]: Cannot find translation for source Radio Paradise Feb 15 18:42:18 volumio volumio[15585]: info: Volumio Calling Home Feb 15 18:42:18 volumio sudo[15743]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 15 18:42:18 volumio sudo[15743]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 15 18:42:18 volumio sudo[15743]: pam_unix(sudo:session): session closed for user root Feb 15 18:42:18 volumio volumio[15585]: info: Preparing to generate the ALSA configuration file Feb 15 18:42:19 volumio volumio[15585]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 15 18:42:19 volumio volumio[15585]: info: Reading ALSA contributions from plugins. Feb 15 18:42:19 volumio volumio[15585]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:42:19 volumio volumio[15585]: TypeError: Cannot read property 'off' of undefined Feb 15 18:42:19 volumio volumio[15585]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Feb 15 18:42:19 volumio volumio[15585]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Feb 15 18:42:19 volumio volumio[15585]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Feb 15 18:42:19 volumio volumio[15585]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1550:29) Feb 15 18:42:19 volumio volumio[15585]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1395:47) Feb 15 18:42:19 volumio volumio[15585]: at Socket.emit (events.js:315:20) Feb 15 18:42:19 volumio volumio[15585]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 15 18:42:19 volumio volumio[15585]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Feb 15 18:42:19 volumio volumio[15585]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 15 18:42:20 volumio sudo[15764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 18:41 Feb 15 18:42:20 volumio sudo[15764]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"