-- Logs begin at Mon 2025-02-10 20:41:33 CET, end at Sun 2025-02-16 21:42:40 CET. -- Feb 16 21:41:21 volumio systemd-timedated[673]: Changed local time to Sun Feb 16 21:41:21 2025 Feb 16 21:41:21 volumio sudo[655]: pam_unix(sudo:session): session closed for user root Feb 16 21:41:21 volumio volumio-time-update[413]: volumio-time-update-util: System time updated successfully. Feb 16 21:41:21 volumio systemd[1]: Started Volumio Time Update Utility. Feb 16 21:41:21 volumio systemd[1]: Starting Daily apt download activities... Feb 16 21:41:23 volumio winbindd[665]: [2025/02/16 21:41:23.196293, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Feb 16 21:41:23 volumio winbindd[665]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 16 21:41:23 volumio systemd[1]: Started Samba Winbind Daemon. Feb 16 21:41:23 volumio winbindd[665]: [2025/02/16 21:41:23.337781, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 16 21:41:23 volumio winbindd[665]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Feb 16 21:41:23 volumio systemd[1]: Starting Samba SMB Daemon... Feb 16 21:41:24 volumio systemd[1]: apt-daily.service: Succeeded. Feb 16 21:41:24 volumio systemd[1]: Started Daily apt download activities. Feb 16 21:41:24 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Feb 16 21:41:26 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Feb 16 21:41:26 volumio systemd[1]: Started Daily apt upgrade and clean activities. Feb 16 21:41:28 volumio volumio-remote-updater[402]: [2025-02-16 21:41:28] [info] asio async_connect error: system:111 (Connection refused) Feb 16 21:41:28 volumio volumio-remote-updater[402]: [2025-02-16 21:41:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Feb 16 21:41:28 volumio volumio-remote-updater[402]: [2025-02-16 21:41:28] [error] handle_connect error: Underlying Transport Error Feb 16 21:41:28 volumio systemd[1]: Started Samba SMB Daemon. Feb 16 21:41:28 volumio smbd[698]: [2025/02/16 21:41:28.097585, 0] ../lib/util/become_daemon.c:138(daemon_ready) Feb 16 21:41:28 volumio systemd[1]: Reached target Multi-User System. Feb 16 21:41:28 volumio smbd[698]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Feb 16 21:41:28 volumio systemd[1]: Reached target Graphical Interface. Feb 16 21:41:28 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 16 21:41:28 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 16 21:41:28 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 16 21:41:28 volumio systemd[1]: Startup finished in 27.126s (kernel) + 1min 3.005s (userspace) = 1min 30.131s. Feb 16 21:41:34 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:41:35 volumio volumio[659]: info: ----- Volumio3 ---- Feb 16 21:41:35 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:41:35 volumio volumio[659]: info: ----- System startup ---- Feb 16 21:41:35 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:41:38 volumio volumio-remote-updater[402]: [2025-02-16 21:41:38] [connect] Successful connection Feb 16 21:41:39 volumio volumio[659]: info: MYVOLUMIO Environment detected Feb 16 21:41:39 volumio volumio[659]: info: Plugin folders cleanup Feb 16 21:41:39 volumio volumio[659]: info: Scanning into folder /volumio/app/plugins/ Feb 16 21:41:39 volumio volumio[659]: info: Scanning category audio_interface Feb 16 21:41:39 volumio volumio[659]: info: Scanning category miscellanea Feb 16 21:41:39 volumio volumio[659]: info: Scanning category music_service Feb 16 21:41:39 volumio volumio[659]: info: Scanning category plugins.json Feb 16 21:41:39 volumio volumio[659]: info: Scanning category system_controller Feb 16 21:41:39 volumio volumio[659]: info: Scanning category user_interface Feb 16 21:41:39 volumio volumio[659]: info: Scanning into folder /data/plugins/ Feb 16 21:41:39 volumio volumio[659]: info: Scanning category audio_interface Feb 16 21:41:39 volumio volumio[659]: info: Scanning category music_service Feb 16 21:41:39 volumio volumio[659]: info: Plugin folders cleanup completed Feb 16 21:41:39 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:41:39 volumio volumio[659]: info: ----- Core plugins startup ---- Feb 16 21:41:39 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:41:39 volumio volumio[659]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 21:41:39 volumio volumio[659]: info: Adding plugin upnp to MyMusic Plugins Feb 16 21:41:39 volumio volumio[659]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 21:41:39 volumio volumio[659]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 21:41:39 volumio volumio[659]: info: Loading plugins from folder /data/plugins/ Feb 16 21:41:39 volumio volumio[659]: info: Loading plugin "system"... Feb 16 21:41:39 volumio volumio[659]: info: Loading plugin "appearance"... Feb 16 21:41:45 volumio volumio[659]: info: Loading plugin "network"... Feb 16 21:41:45 volumio volumio[659]: info: Refreshing Cached IP Addresses Feb 16 21:41:45 volumio volumio[659]: info: Loading plugin "services"... Feb 16 21:41:45 volumio sudo[750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 21:41:45 volumio sudo[748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 21:41:45 volumio sudo[750]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:41:45 volumio volumio[659]: info: Loading plugin "alsa_controller"... Feb 16 21:41:45 volumio sudo[748]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:41:45 volumio sudo[748]: pam_unix(sudo:session): session closed for user root Feb 16 21:41:45 volumio sudo[750]: pam_unix(sudo:session): session closed for user root Feb 16 21:41:45 volumio sudo[757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 16 21:41:45 volumio sudo[757]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:41:46 volumio sudo[757]: pam_unix(sudo:session): session closed for user root Feb 16 21:41:46 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 21:41:46 volumio volumio[659]: info: Loading plugin "wizard"... Feb 16 21:41:46 volumio volumio[659]: info: Loading plugin "networkfs"... Feb 16 21:41:46 volumio volumio[659]: info: Starting Udev Watcher for removable devices Feb 16 21:41:46 volumio sudo[780]: 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.1.164/muza /mnt/NAS/NAS Feb 16 21:41:46 volumio sudo[780]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:41:47 volumio volumio[659]: info: Ignoring mount for partition: boot Feb 16 21:41:47 volumio volumio[659]: info: Ignoring mount for partition: volumio Feb 16 21:41:47 volumio volumio[659]: info: Ignoring mount for partition: volumio_data Feb 16 21:41:47 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 21:41:47 volumio volumio[659]: info: Loading plugin "volumio_command_line_client"... Feb 16 21:41:47 volumio volumio[659]: info: Loading plugin "upnp"... Feb 16 21:41:47 volumio volumio[659]: info: [1739738507184] Starting Upmpd Daemon Feb 16 21:41:47 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 21:41:47 volumio volumio[659]: info: Loading plugin "my_music"... Feb 16 21:41:47 volumio volumio[659]: info: Loading plugin "mpd"... Feb 16 21:41:47 volumio kernel: Key type cifs.spnego registered Feb 16 21:41:47 volumio kernel: Key type cifs.idmap registered Feb 16 21:41:47 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Feb 16 21:41:47 volumio kernel: CIFS: Attempting to mount //192.168.1.164/muza Feb 16 21:41:49 volumio sudo[780]: pam_unix(sudo:session): session closed for user root Feb 16 21:41:50 volumio volumio[659]: info: Loading plugin "upnp_browser"... Feb 16 21:41:51 volumio systemd[1]: systemd-timedated.service: Succeeded. Feb 16 21:41:52 volumio volumio[659]: info: Loading plugin "alarm-clock"... Feb 16 21:41:53 volumio volumio[659]: info: Loading plugin "airplay_emulation"... Feb 16 21:41:53 volumio volumio-remote-updater[402]: [2025-02-16 21:41:53] [connect] Successful connection Feb 16 21:41:53 volumio volumio[659]: info: Starting Shairport Sync Feb 16 21:41:53 volumio volumio[659]: info: Loading plugin "last_100"... Feb 16 21:41:53 volumio volumio[659]: info: Loading plugin "webradio"... Feb 16 21:41:53 volumio volumio[659]: info: Loading plugin "i2s_dacs"... Feb 16 21:41:54 volumio volumio[659]: info: I2S DAC not set, start Auto-detection Feb 16 21:41:54 volumio volumio[659]: info: Loading plugin "volumiodiscovery"... Feb 16 21:41:54 volumio volumio[659]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 21:41:54 volumio node[659]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 21:41:54 volumio volumio[659]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 21:41:54 volumio volumio[659]: *** WARNING *** For more information see Feb 16 21:41:54 volumio volumio[659]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 21:41:54 volumio volumio[659]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 21:41:54 volumio volumio[659]: *** WARNING *** For more information see Feb 16 21:41:54 volumio node[659]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 21:41:54 volumio node[659]: *** WARNING *** For more information see Feb 16 21:41:54 volumio node[659]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 21:41:54 volumio node[659]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 21:41:54 volumio node[659]: *** WARNING *** For more information see Feb 16 21:41:54 volumio volumio[659]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 21:41:54 volumio volumio[659]: info: Discovery: Started advertising with name: Volumio Feb 16 21:41:54 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 21:41:54 volumio volumio[659]: info: Loading plugin "spop"... Feb 16 21:42:00 volumio volumio[659]: info: Loading plugin "outputs"... Feb 16 21:42:01 volumio volumio[659]: info: Loading plugin "albumart"... Feb 16 21:42:01 volumio volumio[659]: info: Plugin example_plugin is not enabled Feb 16 21:42:01 volumio volumio[659]: info: Loading plugin "inputs"... Feb 16 21:42:01 volumio volumio[659]: info: Loading plugin "updater_comm"... Feb 16 21:42:02 volumio ntpd[496]: Soliciting pool server 193.70.94.182 Feb 16 21:42:03 volumio volumio[659]: info: Plugin mpdemulation is not enabled Feb 16 21:42:03 volumio volumio[659]: info: Loading plugin "rest_api"... Feb 16 21:42:03 volumio ntpd[496]: Soliciting pool server 213.222.217.10 Feb 16 21:42:03 volumio volumio[659]: info: Loading plugin "websocket"... Feb 16 21:42:03 volumio volumio[659]: info: Starting Socket.io Server version 2.3.0 Feb 16 21:42:03 volumio volumio[659]: info: Loading plugin "fusiondsp"... Feb 16 21:42:04 volumio ntpd[496]: Soliciting pool server 178.215.228.24 Feb 16 21:42:04 volumio volumio[659]: Forking 1 albumart workers Feb 16 21:42:05 volumio ntpd[496]: Soliciting pool server 83.168.69.6 Feb 16 21:42:05 volumio ntpd[496]: Soliciting pool server 195.123.221.21 Feb 16 21:42:06 volumio volumio[659]: info: Applying required configuration parameters for plugin fusiondsp Feb 16 21:42:06 volumio ntpd[496]: Soliciting pool server 178.239.19.60 Feb 16 21:42:06 volumio ntpd[496]: Soliciting pool server 193.111.32.123 Feb 16 21:42:07 volumio ntpd[496]: Soliciting pool server 193.219.28.60 Feb 16 21:42:07 volumio volumio[659]: info: Loading i18n strings for locale en Feb 16 21:42:07 volumio volumio[659]: Updating browse sources language Feb 16 21:42:07 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 21:42:07 volumio ntpd[496]: Soliciting pool server 149.143.87.82 Feb 16 21:42:07 volumio ntpd[496]: Soliciting pool server 212.127.78.21 Feb 16 21:42:08 volumio volumio-remote-updater[402]: [2025-02-16 21:42:08] [connect] Successful connection Feb 16 21:42:08 volumio ntpd[496]: Soliciting pool server 185.71.60.123 Feb 16 21:42:08 volumio ntpd[496]: Soliciting pool server 156.17.20.254 Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::initPlayerControls Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 21:42:09 volumio volumio[659]: Express server listening on port 3000 Feb 16 21:42:09 volumio volumio[659]: [Metrics] WebUI: 37s 710.78ms Feb 16 21:42:09 volumio ntpd[496]: Soliciting pool server 129.250.35.251 Feb 16 21:42:09 volumio ntpd[496]: Soliciting pool server 91.212.242.20 Feb 16 21:42:09 volumio volumio[659]: info: CoreStateMachine::resetVolumioState Feb 16 21:42:09 volumio volumio[659]: info: CoreStateMachine::getcurrentVolume Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 21:42:09 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 21:42:10 volumio sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 21:42:10 volumio sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:10 volumio sudo[914]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:10 volumio sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 21:42:10 volumio sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:10 volumio sudo[916]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:10 volumio ntpd[496]: Soliciting pool server 2606:4700:f1::1 Feb 16 21:42:10 volumio ntpd[496]: Soliciting pool server 193.59.134.156 Feb 16 21:42:10 volumio volumio[659]: info: Volumio Network Manager: Network status updated: 1 Feb 16 21:42:11 volumio volumio[659]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 16 21:42:11 volumio volumio[659]: wlan0 Interface doesn't support scanning. Feb 16 21:42:11 volumio volumio[659]: info: Cannot use regular scanning, forcing with ap-force Feb 16 21:42:11 volumio sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 16 21:42:11 volumio sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:11 volumio sudo[926]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:11 volumio volumio[659]: command failed: No such device (-19) Feb 16 21:42:11 volumio volumio[659]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 16 21:42:11 volumio volumio[659]: command failed: No such device (-19) Feb 16 21:42:11 volumio ntpd[496]: Soliciting pool server 195.46.37.22 Feb 16 21:42:21 volumio ntpd[496]: receive: Unexpected origin timestamp 0xeb5ccc23.a3d16b5a does not match aorg 0000000000.00000000 from server@193.219.28.60 xmt 0xeb5ccc2d.258d661e Feb 16 21:42:21 volumio volumio-remote-updater[402]: [2025-02-16 21:42:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739738528 101 Feb 16 21:42:21 volumio volumio[659]: Starting albumart workers Feb 16 21:42:21 volumio volumio[659]: 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 16 21:42:21 volumio volumio[659]: info: VolumeController:: Volume=38 Mute =false Feb 16 21:42:21 volumio volumio[659]: info: CoreStateMachine::pushState Feb 16 21:42:21 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Feb 16 21:42:21 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 21:42:21 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Feb 16 21:42:21 volumio volumio[659]: info: CoreStateMachine::updateTrackBlock Feb 16 21:42:21 volumio volumio[659]: info: CorePlayQueue::getTrackBlock Feb 16 21:42:21 volumio volumio[659]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 21:42:22 volumio ntpd[496]: Soliciting pool server 89.161.47.136 Feb 16 21:42:22 volumio volumio[659]: info: Reloading queue from file Feb 16 21:42:22 volumio volumio[659]: info: CoreStateMachine::setRepeat null single undefined Feb 16 21:42:22 volumio volumio[659]: info: CoreStateMachine::pushState Feb 16 21:42:22 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Feb 16 21:42:22 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 21:42:22 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Feb 16 21:42:22 volumio volumio[659]: info: CoreStateMachine::setRandom null Feb 16 21:42:22 volumio volumio[659]: info: CoreStateMachine::pushState Feb 16 21:42:22 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Feb 16 21:42:22 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Feb 16 21:42:22 volumio volumio[659]: info: Setting Device type: Raspberry PI Feb 16 21:42:23 volumio volumio[659]: info: Completed loading Core Plugins Feb 16 21:42:23 volumio volumio[659]: info: Preparing to generate the ALSA configuration file Feb 16 21:42:23 volumio ntpd[496]: Soliciting pool server 46.174.178.150 Feb 16 21:42:23 volumio sudo[938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 16 21:42:23 volumio sudo[938]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:23 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 16 21:42:23 volumio sudo[938]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:23 volumio volumio[659]: info: Discovery: adding 2b87073e-ff38-45cf-acd9-d5f71a3b8cfc Feb 16 21:42:23 volumio volumio[659]: info: Discovery: Found device Volumio Feb 16 21:42:23 volumio volumio[659]: info: CoreCommandRouter::volumioGetState Feb 16 21:42:23 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Feb 16 21:42:23 volumio volumio[659]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 16 21:42:23 volumio volumio[659]: info: Reading ALSA contributions from plugins. Feb 16 21:42:23 volumio volumio[659]: info: Upmpdcli Daemon Started Feb 16 21:42:23 volumio volumio[659]: info: VolumeController:: Volume=38 Mute =false Feb 16 21:42:23 volumio volumio[659]: info: CoreStateMachine::pushState Feb 16 21:42:23 volumio volumio[659]: info: CorePlayQueue::getTrack 0 Feb 16 21:42:23 volumio volumio[659]: info: CoreCommandRouter::volumioPushState Feb 16 21:42:24 volumio volumio[659]: info: Asound.conf file unchanged, so no further update is needed Feb 16 21:42:24 volumio volumio[659]: info: Output device has changed, restarting MPD Feb 16 21:42:24 volumio volumio[659]: info: Output device has changed, restarting Shairport Sync Feb 16 21:42:24 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:24 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 21:42:24 volumio sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 21:42:24 volumio sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:24 volumio sudo[943]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:24 volumio sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 21:42:24 volumio sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:24 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 21:42:25 volumio systemd[1]: mpd.service: Succeeded. Feb 16 21:42:25 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 21:42:25 volumio systemd[1]: Starting Music Player Daemon... Feb 16 21:42:25 volumio volumio[659]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 16 21:42:25 volumio volumio[659]: info: ___________ START PLUGINS ___________ Feb 16 21:42:25 volumio volumio[659]: info: ControllerMpd::onStart: Initializing MPD Feb 16 21:42:25 volumio volumio[659]: info: Creating MPD Configuration file Feb 16 21:42:25 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 21:42:25 volumio sudo[951]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 21:42:25 volumio sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:25 volumio volumio[659]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 21:42:25 volumio sudo[951]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:26 volumio volumio[659]: info: [1739738546004] CoreMusicLibrary::Adding element Media Servers Feb 16 21:42:26 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 21:42:26 volumio sudo[953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 21:42:26 volumio sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:26 volumio sudo[953]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:26 volumio sudo[955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 21:42:26 volumio sudo[955]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:26 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 16 21:42:26 volumio systemd[1]: mpd.service: Succeeded. Feb 16 21:42:26 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 21:42:26 volumio systemd[1]: Starting Music Player Daemon... Feb 16 21:42:26 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:27 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 21:42:27 volumio sudo[965]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 21:42:27 volumio sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:27 volumio sudo[965]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:27 volumio volumio[659]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 16 21:42:27 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:27 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 21:42:28 volumio volumio[659]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 16 21:42:28 volumio volumio[659]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 21:42:28 volumio volumio[659]: info: [1739738548738] CoreMusicLibrary::Adding element Last_100 Feb 16 21:42:28 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 21:42:28 volumio volumio[659]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 21:42:28 volumio volumio[659]: info: [1739738548803] CoreMusicLibrary::Adding element Webradio Feb 16 21:42:28 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 21:42:28 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 21:42:29 volumio volumio[659]: info: Initializing BBC Radios Feb 16 21:42:29 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 21:42:29 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 21:42:30 volumio volumio[659]: info: Creating Spotify config file Feb 16 21:42:30 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:31 volumio volumio[659]: info: Loading i18n strings for locale en Feb 16 21:42:31 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 16 21:42:31 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:31 volumio volumio[659]: info: FusionDsp - mixtype--------------------- Hardware Feb 16 21:42:31 volumio volumio[659]: info: Volumio Calling Home Feb 16 21:42:32 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Feb 16 21:42:32 volumio systemd[1]: mpd.service: Failed with result 'protocol'. Feb 16 21:42:32 volumio systemd[1]: Failed to start Music Player Daemon. Feb 16 21:42:32 volumio sudo[945]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:32 volumio sudo[955]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:32 volumio systemd[1]: Starting Music Player Daemon... Feb 16 21:42:32 volumio volumio[659]: info: Preparing to generate the ALSA configuration file Feb 16 21:42:33 volumio volumio[659]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 16 21:42:33 volumio volumio[659]: info: Reading ALSA contributions from plugins. Feb 16 21:42:33 volumio sudo[1008]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 21:42:33 volumio sudo[1008]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:33 volumio volumio[659]: error: Upnp client error: Error: This socket has been ended by the other party Feb 16 21:42:33 volumio sudo[1008]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:33 volumio volumio[659]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 16 21:42:33 volumio volumio[659]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Feb 16 21:42:33 volumio volumio[659]: See "systemctl status mpd.service" and "journalctl -xe" for details. Feb 16 21:42:33 volumio volumio[659]: info: Completed starting Core Plugins Feb 16 21:42:33 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:42:33 volumio volumio[659]: info: ----- MyVolumio plugins startup ---- Feb 16 21:42:33 volumio volumio[659]: info: ------------------------------------------- Feb 16 21:42:33 volumio volumio[659]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 16 21:42:33 volumio volumio[659]: info: MPD Permissions set Feb 16 21:42:33 volumio volumio[659]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 16 21:42:33 volumio volumio[659]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Feb 16 21:42:33 volumio volumio[659]: See "systemctl status mpd.service" and "journalctl -xe" for details. Feb 16 21:42:33 volumio volumio[659]: info: MPD Permissions set Feb 16 21:42:34 volumio volumio[659]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Feb 16 21:42:34 volumio volumio[659]: info: camilladsp service started and running in background, instance 1 Feb 16 21:42:34 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 21:42:34 volumio volumio[659]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 16 21:42:34 volumio volumio[659]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 16 21:42:34 volumio volumio[659]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 16 21:42:34 volumio volumio[659]: info: FusionDsp loaded Feb 16 21:42:34 volumio volumio[659]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 16 21:42:34 volumio sudo[1021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 16 21:42:34 volumio sudo[1021]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 21:42:34 volumio volumio[659]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 16 21:42:34 volumio volumio[659]: info: Adding Signal Path Element [object Object] Feb 16 21:42:34 volumio volumio[659]: info: Adding fusiondspeq DSP Signal Path Element Feb 16 21:42:34 volumio volumio[659]: info: FusionDsp - ---- installed callbackRead Feb 16 21:42:34 volumio sudo[1021]: pam_unix(sudo:session): session closed for user root Feb 16 21:42:34 volumio volumio[659]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 21:42:34 volumio volumio[659]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 16 21:42:34 volumio volumio[659]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 16 21:42:34 volumio volumio[659]: at onErrorNT (internal/child_process.js:465:16) Feb 16 21:42:34 volumio volumio[659]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 16 21:42:34 volumio volumio[659]: at runNextTicks (internal/process/task_queues.js:62:3) Feb 16 21:42:34 volumio volumio[659]: at listOnTimeout (internal/timers.js:523:9) Feb 16 21:42:34 volumio volumio[659]: at processTimers (internal/timers.js:497:7) { Feb 16 21:42:34 volumio volumio[659]: errno: -2, Feb 16 21:42:34 volumio volumio[659]: code: 'ENOENT', Feb 16 21:42:34 volumio volumio[659]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 16 21:42:34 volumio volumio[659]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 16 21:42:34 volumio volumio[659]: spawnargs: [ Feb 16 21:42:34 volumio volumio[659]: '-p', Feb 16 21:42:34 volumio volumio[659]: 9876, Feb 16 21:42:34 volumio volumio[659]: '-o', Feb 16 21:42:34 volumio volumio[659]: '/tmp/camilladsp.log', Feb 16 21:42:34 volumio volumio[659]: '-l', Feb 16 21:42:34 volumio volumio[659]: 'warn', Feb 16 21:42:34 volumio volumio[659]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 16 21:42:34 volumio volumio[659]: ] Feb 16 21:42:34 volumio volumio[659]: } Feb 16 21:42:34 volumio volumio[659]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 21:42:39 volumio sudo[1046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 21:41 Feb 16 21:42:40 volumio sudo[1046]: 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"