-- Logs begin at Sat 2024-11-16 17:25:18 CET, end at Thu 2024-11-28 17:03:51 CET. -- Nov 28 17:02:01 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Nov 28 17:02:01 volumio systemd[1]: Started Daily apt upgrade and clean activities. Nov 28 17:02:02 volumio smbd[718]: [2024/11/28 17:02:02.096908, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 28 17:02:02 volumio smbd[718]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 28 17:02:02 volumio systemd[1]: Started Samba SMB Daemon. Nov 28 17:02:02 volumio systemd[1]: Reached target Multi-User System. Nov 28 17:02:02 volumio systemd[1]: Reached target Graphical Interface. Nov 28 17:02:02 volumio volumio-remote-updater[402]: [2024-11-28 17:02:02] [info] asio async_connect error: system:111 (Connection refused) Nov 28 17:02:02 volumio volumio-remote-updater[402]: [2024-11-28 17:02:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 28 17:02:02 volumio volumio-remote-updater[402]: [2024-11-28 17:02:02] [error] handle_connect error: Underlying Transport Error Nov 28 17:02:02 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 28 17:02:02 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 28 17:02:02 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 28 17:02:02 volumio systemd[1]: Startup finished in 29.959s (kernel) + 1min 38.987s (userspace) = 2min 8.946s. Nov 28 17:02:12 volumio volumio-remote-updater[402]: [2024-11-28 17:02:12] [connect] Successful connection Nov 28 17:02:14 volumio volumio[686]: info: ------------------------------------------- Nov 28 17:02:14 volumio volumio[686]: info: ----- Volumio3 ---- Nov 28 17:02:14 volumio volumio[686]: info: ------------------------------------------- Nov 28 17:02:14 volumio volumio[686]: info: ----- System startup ---- Nov 28 17:02:14 volumio volumio[686]: info: ------------------------------------------- Nov 28 17:02:21 volumio volumio[686]: info: MYVOLUMIO Environment detected Nov 28 17:02:21 volumio volumio[686]: info: Plugin folders cleanup Nov 28 17:02:22 volumio volumio[686]: info: Scanning into folder /volumio/app/plugins/ Nov 28 17:02:22 volumio volumio[686]: info: Scanning category audio_interface Nov 28 17:02:22 volumio volumio[686]: info: Scanning category miscellanea Nov 28 17:02:22 volumio volumio[686]: info: Scanning category music_service Nov 28 17:02:22 volumio volumio[686]: info: Scanning category plugins.json Nov 28 17:02:22 volumio volumio[686]: info: Scanning category system_controller Nov 28 17:02:22 volumio volumio[686]: info: Scanning category user_interface Nov 28 17:02:22 volumio volumio[686]: info: Scanning into folder /data/plugins/ Nov 28 17:02:22 volumio volumio[686]: info: Scanning category audio_interface Nov 28 17:02:22 volumio volumio[686]: info: Scanning category music_service Nov 28 17:02:22 volumio volumio[686]: info: Plugin folders cleanup completed Nov 28 17:02:22 volumio volumio[686]: info: ------------------------------------------- Nov 28 17:02:22 volumio volumio[686]: info: ----- Core plugins startup ---- Nov 28 17:02:22 volumio volumio[686]: info: ------------------------------------------- Nov 28 17:02:22 volumio volumio[686]: info: Loading plugins from folder /volumio/app/plugins/ Nov 28 17:02:22 volumio volumio[686]: info: Adding plugin upnp to MyMusic Plugins Nov 28 17:02:22 volumio volumio[686]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 28 17:02:22 volumio volumio[686]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 28 17:02:22 volumio volumio[686]: info: Loading plugins from folder /data/plugins/ Nov 28 17:02:22 volumio volumio[686]: info: Loading plugin "system"... Nov 28 17:02:22 volumio volumio[686]: info: Loading plugin "appearance"... Nov 28 17:02:23 volumio systemd[1]: systemd-timedated.service: Succeeded. Nov 28 17:02:27 volumio volumio-remote-updater[402]: [2024-11-28 17:02:27] [connect] Successful connection Nov 28 17:02:27 volumio ntpd[569]: Soliciting pool server 217.144.138.234 Nov 28 17:02:28 volumio ntpd[569]: Soliciting pool server 188.245.97.96 Nov 28 17:02:28 volumio ntpd[569]: Soliciting pool server 136.243.7.20 Nov 28 17:02:28 volumio ntpd[569]: Soliciting pool server 195.201.19.162 Nov 28 17:02:29 volumio ntpd[569]: Soliciting pool server 131.188.3.223 Nov 28 17:02:29 volumio ntpd[569]: Soliciting pool server 85.215.189.120 Nov 28 17:02:29 volumio ntpd[569]: Soliciting pool server 212.18.3.18 Nov 28 17:02:30 volumio ntpd[569]: Soliciting pool server 85.214.83.151 Nov 28 17:02:30 volumio ntpd[569]: Soliciting pool server 78.47.56.71 Nov 28 17:02:30 volumio ntpd[569]: Soliciting pool server 94.130.184.193 Nov 28 17:02:30 volumio ntpd[569]: Soliciting pool server 162.159.200.123 Nov 28 17:02:31 volumio volumio[686]: info: Loading plugin "network"... Nov 28 17:02:31 volumio ntpd[569]: Soliciting pool server 144.91.67.138 Nov 28 17:02:31 volumio ntpd[569]: Soliciting pool server 88.198.7.62 Nov 28 17:02:31 volumio ntpd[569]: Soliciting pool server 79.133.44.138 Nov 28 17:02:31 volumio volumio[686]: info: Refreshing Cached IP Addresses Nov 28 17:02:31 volumio sudo[823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 17:02:31 volumio sudo[823]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:02:31 volumio sudo[825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 17:02:31 volumio sudo[825]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:02:31 volumio volumio[686]: info: Loading plugin "services"... Nov 28 17:02:31 volumio sudo[823]: pam_unix(sudo:session): session closed for user root Nov 28 17:02:32 volumio volumio[686]: info: Loading plugin "alsa_controller"... Nov 28 17:02:32 volumio sudo[825]: pam_unix(sudo:session): session closed for user root Nov 28 17:02:32 volumio ntpd[569]: Soliciting pool server 79.133.44.136 Nov 28 17:02:32 volumio ntpd[569]: Soliciting pool server 2a01:4f8:1c0c:4bc0::1 Nov 28 17:02:32 volumio sudo[833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 28 17:02:32 volumio sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:02:32 volumio sudo[833]: pam_unix(sudo:session): session closed for user root Nov 28 17:02:32 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 17:02:32 volumio volumio[686]: info: Loading plugin "wizard"... Nov 28 17:02:32 volumio volumio[686]: info: Loading plugin "networkfs"... Nov 28 17:02:33 volumio ntpd[569]: Soliciting pool server 62.75.236.38 Nov 28 17:02:33 volumio volumio[686]: info: Starting Udev Watcher for removable devices Nov 28 17:02:33 volumio sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=smbshare,password=u46z4cy28,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.160/Medien/01_Musik/00_CD_Sammlung_flac /mnt/NAS/Medien Nov 28 17:02:33 volumio sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:02:33 volumio volumio[686]: info: Ignoring mount for partition: boot Nov 28 17:02:33 volumio volumio[686]: info: Ignoring mount for partition: volumio Nov 28 17:02:33 volumio volumio[686]: info: Ignoring mount for partition: volumio_data Nov 28 17:02:33 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 28 17:02:33 volumio volumio[686]: info: Loading plugin "volumio_command_line_client"... Nov 28 17:02:33 volumio volumio[686]: info: Loading plugin "upnp"... Nov 28 17:02:33 volumio volumio[686]: info: [1732809753954] Starting Upmpd Daemon Nov 28 17:02:33 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 28 17:02:34 volumio volumio[686]: info: Loading plugin "my_music"... Nov 28 17:02:34 volumio volumio[686]: info: Loading plugin "mpd"... Nov 28 17:02:34 volumio kernel: Key type cifs.spnego registered Nov 28 17:02:34 volumio kernel: Key type cifs.idmap registered Nov 28 17:02:34 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. Nov 28 17:02:34 volumio kernel: CIFS: Attempting to mount //192.168.1.160/Medien/01_Musik/00_CD_Sammlung_flac Nov 28 17:02:46 volumio ntpd[569]: receive: Unexpected origin timestamp 0xeaf3129b.400f516d does not match aorg 0000000000.00000000 from server@94.130.184.193 xmt 0xeaf312a6.6d2527ff Nov 28 17:02:46 volumio ntpd[569]: receive: Unexpected origin timestamp 0xeaf3129b.401f5068 does not match aorg 0000000000.00000000 from server@78.47.56.71 xmt 0xeaf312a6.6dc49788 Nov 28 17:02:46 volumio ntpd[569]: receive: Unexpected origin timestamp 0xeaf3129b.403ea54a does not match aorg 0000000000.00000000 from server@188.245.97.96 xmt 0xeaf312a6.6dddae8e Nov 28 17:02:46 volumio ntpd[569]: receive: Unexpected origin timestamp 0xeaf3129b.402ef69a does not match aorg 0000000000.00000000 from server@136.243.7.20 xmt 0xeaf312a6.6e005f28 Nov 28 17:02:46 volumio ntpd[569]: receive: Unexpected origin timestamp 0xeaf3129b.3fd16b1b does not match aorg 0000000000.00000000 from server@144.91.67.138 xmt 0xeaf312a6.6e956ab4 Nov 28 17:02:47 volumio sudo[853]: pam_unix(sudo:session): session closed for user root Nov 28 17:02:49 volumio volumio[686]: info: Loading plugin "upnp_browser"... Nov 28 17:02:52 volumio volumio[686]: info: Loading plugin "alarm-clock"... Nov 28 17:02:53 volumio volumio-remote-updater[402]: [2024-11-28 17:02:53] [connect] Successful connection Nov 28 17:02:54 volumio volumio[686]: info: Plugin airplay_emulation is not enabled Nov 28 17:02:54 volumio volumio[686]: info: Loading plugin "last_100"... Nov 28 17:02:54 volumio volumio[686]: info: Loading plugin "webradio"... Nov 28 17:02:55 volumio volumio[686]: info: Loading plugin "i2s_dacs"... Nov 28 17:02:55 volumio volumio[686]: info: I2S DAC not set, start Auto-detection Nov 28 17:02:55 volumio volumio[686]: info: Loading plugin "volumiodiscovery"... Nov 28 17:02:55 volumio volumio[686]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 28 17:02:55 volumio volumio[686]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 28 17:02:55 volumio volumio[686]: *** WARNING *** For more information see Nov 28 17:02:55 volumio volumio[686]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 28 17:02:55 volumio node[686]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 28 17:02:55 volumio node[686]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 28 17:02:55 volumio node[686]: *** WARNING *** For more information see Nov 28 17:02:55 volumio node[686]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 28 17:02:55 volumio volumio[686]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 28 17:02:55 volumio volumio[686]: *** WARNING *** For more information see Nov 28 17:02:55 volumio node[686]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 28 17:02:55 volumio node[686]: *** WARNING *** For more information see Nov 28 17:02:55 volumio volumio[686]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 28 17:02:55 volumio volumio[686]: info: Discovery: Started advertising with name: Volumio Nov 28 17:02:55 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 28 17:02:55 volumio volumio[686]: info: Loading plugin "spop"... Nov 28 17:03:05 volumio volumio[686]: info: Loading plugin "outputs"... Nov 28 17:03:05 volumio volumio[686]: info: Loading plugin "albumart"... Nov 28 17:03:05 volumio volumio[686]: info: Plugin example_plugin is not enabled Nov 28 17:03:05 volumio volumio[686]: info: Loading plugin "inputs"... Nov 28 17:03:05 volumio volumio[686]: info: Loading plugin "updater_comm"... Nov 28 17:03:08 volumio volumio-remote-updater[402]: [2024-11-28 17:03:08] [connect] Successful connection Nov 28 17:03:09 volumio volumio[686]: info: Plugin mpdemulation is not enabled Nov 28 17:03:09 volumio volumio[686]: info: Loading plugin "rest_api"... Nov 28 17:03:09 volumio volumio[686]: info: Loading plugin "websocket"... Nov 28 17:03:09 volumio volumio[686]: info: Starting Socket.io Server version 2.3.0 Nov 28 17:03:09 volumio volumio[686]: info: Loading plugin "fusiondsp"... Nov 28 17:03:11 volumio volumio[686]: Forking 1 albumart workers Nov 28 17:03:13 volumio volumio[686]: info: Applying required configuration parameters for plugin fusiondsp Nov 28 17:03:14 volumio volumio[686]: info: Loading i18n strings for locale de Nov 28 17:03:15 volumio volumio[686]: Updating browse sources language Nov 28 17:03:15 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 17:03:17 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 17:03:17 volumio volumio[686]: info: CoreCommandRouter::initPlayerControls Nov 28 17:03:17 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:17 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:17 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:17 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:18 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 17:03:18 volumio volumio[686]: Express server listening on port 3000 Nov 28 17:03:18 volumio volumio[686]: [Metrics] WebUI: 56s 968.63ms Nov 28 17:03:18 volumio volumio[686]: info: CoreStateMachine::resetVolumioState Nov 28 17:03:18 volumio volumio[686]: info: CoreStateMachine::getcurrentVolume Nov 28 17:03:18 volumio volumio[686]: info: CoreCommandRouter::volumioRetrievevolume Nov 28 17:03:18 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 17:03:19 volumio sudo[962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 17:03:19 volumio sudo[962]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:19 volumio sudo[964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 17:03:19 volumio sudo[962]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:19 volumio sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:20 volumio sudo[964]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:20 volumio volumio[686]: info: Volumio Network Manager: Network status updated: 1 Nov 28 17:03:20 volumio volumio[686]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 28 17:03:20 volumio volumio[686]: wlan0 Interface doesn't support scanning. Nov 28 17:03:20 volumio volumio[686]: info: Cannot use regular scanning, forcing with ap-force Nov 28 17:03:20 volumio sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 28 17:03:20 volumio sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:20 volumio sudo[970]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:20 volumio volumio[686]: command failed: No such device (-19) Nov 28 17:03:20 volumio volumio[686]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 28 17:03:20 volumio volumio[686]: command failed: No such device (-19) Nov 28 17:03:23 volumio volumio-remote-updater[402]: [2024-11-28 17:03:23] [connect] Successful connection Nov 28 17:03:23 volumio volumio[686]: info: CoreStateMachine::pushState Nov 28 17:03:23 volumio volumio[686]: info: CorePlayQueue::getTrack 0 Nov 28 17:03:23 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 17:03:23 volumio volumio[686]: info: CoreCommandRouter::volumioPushState Nov 28 17:03:23 volumio volumio[686]: info: CoreStateMachine::updateTrackBlock Nov 28 17:03:23 volumio volumio[686]: info: CorePlayQueue::getTrackBlock Nov 28 17:03:23 volumio volumio[686]: info: CoreCommandRouter::volumioRetrievevolume Nov 28 17:03:24 volumio volumio[686]: info: Reloading queue from file Nov 28 17:03:24 volumio volumio[686]: Starting albumart workers Nov 28 17:03:24 volumio volumio-remote-updater[402]: [2024-11-28 17:03:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732809803 101 Nov 28 17:03:24 volumio volumio[686]: 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 Nov 28 17:03:24 volumio volumio[686]: info: CoreStateMachine::setRepeat true single undefined Nov 28 17:03:24 volumio volumio[686]: info: CoreStateMachine::pushState Nov 28 17:03:24 volumio volumio[686]: info: CorePlayQueue::getTrack 0 Nov 28 17:03:24 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 17:03:24 volumio volumio[686]: info: CoreCommandRouter::volumioPushState Nov 28 17:03:25 volumio volumio[686]: info: CoreStateMachine::setRandom false Nov 28 17:03:25 volumio volumio[686]: info: CoreStateMachine::pushState Nov 28 17:03:25 volumio volumio[686]: info: CorePlayQueue::getTrack 0 Nov 28 17:03:25 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 17:03:25 volumio volumio[686]: info: CoreCommandRouter::volumioPushState Nov 28 17:03:25 volumio volumio[686]: info: Setting Device type: Raspberry PI Nov 28 17:03:25 volumio volumio[686]: info: CoreStateMachine::pushState Nov 28 17:03:25 volumio volumio[686]: info: CorePlayQueue::getTrack 0 Nov 28 17:03:25 volumio volumio[686]: info: CoreCommandRouter::volumioPushState Nov 28 17:03:25 volumio volumio[686]: info: Completed loading Core Plugins Nov 28 17:03:26 volumio volumio[686]: info: Preparing to generate the ALSA configuration file Nov 28 17:03:26 volumio sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 28 17:03:26 volumio sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:26 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 28 17:03:26 volumio sudo[1041]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:26 volumio volumio[686]: info: Discovery: adding 3e0b4502-f55d-49fe-b8ff-3ea74f43bb9d Nov 28 17:03:26 volumio volumio[686]: info: Discovery: Found device Volumio Nov 28 17:03:26 volumio volumio[686]: info: CoreCommandRouter::volumioGetState Nov 28 17:03:26 volumio volumio[686]: info: CorePlayQueue::getTrack 0 Nov 28 17:03:26 volumio volumio[686]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 28 17:03:26 volumio volumio[686]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 28 17:03:26 volumio volumio[686]: info: Reading ALSA contributions from plugins. Nov 28 17:03:27 volumio volumio[686]: info: Upmpdcli Daemon Started Nov 28 17:03:27 volumio volumio[686]: info: Asound.conf file unchanged, so no further update is needed Nov 28 17:03:27 volumio volumio[686]: info: Output device has changed, restarting MPD Nov 28 17:03:27 volumio volumio[686]: info: ___________ START PLUGINS ___________ Nov 28 17:03:27 volumio sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 28 17:03:27 volumio sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:27 volumio volumio[686]: info: ControllerMpd::onStart: Initializing MPD Nov 28 17:03:27 volumio sudo[1045]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:27 volumio volumio[686]: info: Creating MPD Configuration file Nov 28 17:03:27 volumio sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 28 17:03:27 volumio sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:28 volumio systemd[1]: Stopping Music Player Daemon... Nov 28 17:03:28 volumio systemd[1]: mpd.service: Succeeded. Nov 28 17:03:28 volumio systemd[1]: Stopped Music Player Daemon. Nov 28 17:03:28 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 17:03:28 volumio systemd[1]: Starting Music Player Daemon... Nov 28 17:03:28 volumio volumio[686]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 28 17:03:28 volumio volumio[686]: info: [1732809808804] CoreMusicLibrary::Adding element Medienserver Nov 28 17:03:28 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 17:03:29 volumio sudo[1051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 28 17:03:29 volumio sudo[1051]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:29 volumio sudo[1051]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:29 volumio sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 28 17:03:29 volumio sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:29 volumio sudo[1054]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 28 17:03:29 volumio sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:30 volumio sudo[1054]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:30 volumio volumio[686]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 28 17:03:30 volumio volumio[686]: info: [1732809810302] CoreMusicLibrary::Adding element Last_100 Nov 28 17:03:30 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 17:03:30 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 28 17:03:30 volumio systemd[1]: mpd.service: Succeeded. Nov 28 17:03:30 volumio systemd[1]: Stopped Music Player Daemon. Nov 28 17:03:30 volumio volumio[686]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 28 17:03:30 volumio volumio[686]: info: [1732809810406] CoreMusicLibrary::Adding element Webradio Nov 28 17:03:30 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 17:03:30 volumio systemd[1]: Starting Music Player Daemon... Nov 28 17:03:30 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 17:03:30 volumio volumio[686]: info: Initializing BBC Radios Nov 28 17:03:31 volumio sudo[1059]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 28 17:03:31 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:31 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:31 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 17:03:31 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 17:03:32 volumio volumio[686]: info: Creating Spotify config file Nov 28 17:03:32 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:34 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 28 17:03:34 volumio systemd[1]: mpd.service: Failed with result 'protocol'. Nov 28 17:03:34 volumio systemd[1]: Failed to start Music Player Daemon. Nov 28 17:03:34 volumio sudo[1053]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:35 volumio sudo[1047]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:35 volumio systemd[1]: Starting Music Player Daemon... Nov 28 17:03:35 volumio volumio[686]: info: Loading i18n strings for locale de Nov 28 17:03:36 volumio sudo[1076]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 28 17:03:36 volumio sudo[1076]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:36 volumio sudo[1076]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:36 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 28 17:03:36 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:36 volumio volumio[686]: info: FusionDsp - mixtype--------------------- Software Nov 28 17:03:37 volumio volumio[686]: info: Volumio Calling Home Nov 28 17:03:39 volumio volumio[686]: info: Preparing to generate the ALSA configuration file Nov 28 17:03:41 volumio volumio[686]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 28 17:03:41 volumio volumio[686]: info: camilladsp service started and running in background, instance 1 Nov 28 17:03:41 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 17:03:41 volumio volumio[686]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 28 17:03:41 volumio volumio[686]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 28 17:03:41 volumio volumio[686]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 28 17:03:41 volumio volumio[686]: info: FusionDsp loaded Nov 28 17:03:41 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 17:03:42 volumio sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 28 17:03:42 volumio sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 17:03:42 volumio volumio[686]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 28 17:03:42 volumio volumio[686]: info: Adding Signal Path Element [object Object] Nov 28 17:03:42 volumio volumio[686]: info: Adding fusiondspeq DSP Signal Path Element Nov 28 17:03:42 volumio volumio[686]: info: FusionDsp - ---- installed callbackRead Nov 28 17:03:42 volumio sudo[1114]: pam_unix(sudo:session): session closed for user root Nov 28 17:03:42 volumio volumio[686]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 17:03:42 volumio volumio[686]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 28 17:03:42 volumio volumio[686]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Nov 28 17:03:42 volumio volumio[686]: at onErrorNT (internal/child_process.js:465:16) Nov 28 17:03:42 volumio volumio[686]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 28 17:03:42 volumio volumio[686]: at runNextTicks (internal/process/task_queues.js:62:3) Nov 28 17:03:42 volumio volumio[686]: at listOnTimeout (internal/timers.js:523:9) Nov 28 17:03:42 volumio volumio[686]: at processTimers (internal/timers.js:497:7) { Nov 28 17:03:42 volumio volumio[686]: errno: -2, Nov 28 17:03:42 volumio volumio[686]: code: 'ENOENT', Nov 28 17:03:42 volumio volumio[686]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 28 17:03:42 volumio volumio[686]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 28 17:03:42 volumio volumio[686]: spawnargs: [ Nov 28 17:03:42 volumio volumio[686]: '-p', Nov 28 17:03:42 volumio volumio[686]: 9876, Nov 28 17:03:42 volumio volumio[686]: '-o', Nov 28 17:03:42 volumio volumio[686]: '/tmp/camilladsp.log', Nov 28 17:03:42 volumio volumio[686]: '-l', Nov 28 17:03:42 volumio volumio[686]: 'warn', Nov 28 17:03:42 volumio volumio[686]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 28 17:03:42 volumio volumio[686]: ] Nov 28 17:03:42 volumio volumio[686]: } Nov 28 17:03:42 volumio volumio[686]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 17:03:51 volumio sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 17:02 Nov 28 17:03:51 volumio sudo[1139]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"