-- Logs begin at Wed 2025-07-30 03:08:44 CEST, end at Fri 2025-10-24 22:34:08 CEST. -- Oct 24 22:33:09 wc systemd-timedated[833]: Changed local time to Fri Oct 24 22:33:09 2025 Oct 24 22:33:09 wc sudo[831]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:09 wc volumio-time-update[409]: volumio-time-update-util: System time updated successfully. Oct 24 22:33:09 wc systemd[1]: Started Volumio Time Update Utility. Oct 24 22:33:09 wc systemd[1]: Starting Daily apt download activities... Oct 24 22:33:09 wc systemd[1]: Started Samba NMB Daemon. Oct 24 22:33:09 wc nmbd[527]: [2025/10/24 22:33:09.358718, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 24 22:33:09 wc nmbd[527]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 24 22:33:09 wc systemd[1]: Starting Samba Winbind Daemon... Oct 24 22:33:09 wc nmbd[527]: [2025/10/24 22:33:09.542162, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 24 22:33:09 wc nmbd[527]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.80 for name WORKGROUP<1d>. Oct 24 22:33:09 wc nmbd[527]: This response was from IP 192.168.0.242, reporting an IP address of 192.168.0.242. Oct 24 22:33:13 wc winbindd[837]: [2025/10/24 22:33:13.010988, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 24 22:33:13 wc winbindd[837]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 24 22:33:13 wc systemd[1]: Started Samba Winbind Daemon. Oct 24 22:33:13 wc winbindd[837]: [2025/10/24 22:33:13.129357, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 24 22:33:13 wc winbindd[837]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 24 22:33:13 wc systemd[1]: Starting Samba SMB Daemon... Oct 24 22:33:16 wc systemd[1]: apt-daily.service: Succeeded. Oct 24 22:33:16 wc systemd[1]: Started Daily apt download activities. Oct 24 22:33:16 wc systemd[1]: Starting Daily apt upgrade and clean activities... Oct 24 22:33:17 wc volumio-remote-updater[395]: [2025-10-24 22:33:17] [info] asio async_connect error: system:111 (Connection refused) Oct 24 22:33:17 wc volumio-remote-updater[395]: [2025-10-24 22:33:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 24 22:33:17 wc volumio-remote-updater[395]: [2025-10-24 22:33:17] [error] handle_connect error: Underlying Transport Error Oct 24 22:33:18 wc smbd[866]: [2025/10/24 22:33:18.615554, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 24 22:33:18 wc systemd[1]: Started Samba SMB Daemon. Oct 24 22:33:18 wc smbd[866]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 24 22:33:18 wc systemd[1]: Reached target Multi-User System. Oct 24 22:33:18 wc systemd[1]: Reached target Graphical Interface. Oct 24 22:33:18 wc systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 24 22:33:19 wc systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 24 22:33:19 wc systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 24 22:33:20 wc systemd[1]: systemd-hostnamed.service: Succeeded. Oct 24 22:33:22 wc systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 24 22:33:22 wc systemd[1]: Started Daily apt upgrade and clean activities. Oct 24 22:33:22 wc systemd[1]: Startup finished in 21.336s (kernel) + 1min 17.201s (userspace) = 1min 38.537s. Oct 24 22:33:24 wc volumio[810]: info: ------------------------------------------- Oct 24 22:33:24 wc volumio[810]: info: ----- Volumio3 ---- Oct 24 22:33:24 wc volumio[810]: info: ------------------------------------------- Oct 24 22:33:24 wc volumio[810]: info: ----- System startup ---- Oct 24 22:33:24 wc volumio[810]: info: ------------------------------------------- Oct 24 22:33:27 wc volumio-remote-updater[395]: [2025-10-24 22:33:27] [connect] Successful connection Oct 24 22:33:28 wc volumio[810]: info: MYVOLUMIO Environment detected Oct 24 22:33:29 wc volumio[810]: info: Plugin folders cleanup Oct 24 22:33:29 wc volumio[810]: info: Scanning into folder /volumio/app/plugins/ Oct 24 22:33:29 wc volumio[810]: info: Scanning category audio_interface Oct 24 22:33:29 wc volumio[810]: info: Scanning category miscellanea Oct 24 22:33:29 wc volumio[810]: info: Scanning category music_service Oct 24 22:33:29 wc volumio[810]: info: Scanning category plugins.json Oct 24 22:33:29 wc volumio[810]: info: Scanning category system_controller Oct 24 22:33:29 wc volumio[810]: info: Scanning category user_interface Oct 24 22:33:29 wc volumio[810]: info: Scanning into folder /data/plugins/ Oct 24 22:33:29 wc volumio[810]: info: Scanning category music_service Oct 24 22:33:29 wc volumio[810]: info: Plugin folders cleanup completed Oct 24 22:33:29 wc volumio[810]: info: ------------------------------------------- Oct 24 22:33:29 wc volumio[810]: info: ----- Core plugins startup ---- Oct 24 22:33:29 wc volumio[810]: info: ------------------------------------------- Oct 24 22:33:29 wc volumio[810]: info: Loading plugins from folder /volumio/app/plugins/ Oct 24 22:33:29 wc volumio[810]: info: Adding plugin upnp to MyMusic Plugins Oct 24 22:33:29 wc volumio[810]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 24 22:33:29 wc volumio[810]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 24 22:33:29 wc volumio[810]: info: Loading plugins from folder /data/plugins/ Oct 24 22:33:29 wc volumio[810]: info: Loading plugin "system"... Oct 24 22:33:29 wc volumio[810]: info: Loading plugin "appearance"... Oct 24 22:33:35 wc volumio[810]: info: Loading plugin "network"... Oct 24 22:33:35 wc volumio[810]: info: Refreshing Cached IP Addresses Oct 24 22:33:35 wc volumio[810]: info: Loading plugin "services"... Oct 24 22:33:35 wc sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 22:33:35 wc sudo[1001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 24 22:33:35 wc sudo[1001]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:35 wc sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:36 wc volumio[810]: info: Loading plugin "alsa_controller"... Oct 24 22:33:36 wc sudo[1003]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:36 wc sudo[1001]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:36 wc sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 24 22:33:36 wc sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:36 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 22:33:36 wc volumio[810]: info: Loading plugin "wizard"... Oct 24 22:33:36 wc volumio[810]: info: Loading plugin "networkfs"... Oct 24 22:33:36 wc volumio[810]: info: Starting Udev Watcher for removable devices Oct 24 22:33:37 wc sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=pi,password=1216351341,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.242/SAMBA /mnt/NAS/SAMBA Oct 24 22:33:37 wc sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:37 wc volumio[810]: info: Ignoring mount for partition: boot Oct 24 22:33:37 wc volumio[810]: info: Ignoring mount for partition: volumio Oct 24 22:33:37 wc volumio[810]: info: Ignoring mount for partition: volumio_data Oct 24 22:33:37 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 24 22:33:37 wc volumio[810]: info: Loading plugin "volumio_command_line_client"... Oct 24 22:33:37 wc sudo[1006]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:37 wc volumio[810]: info: Plugin upnp is not enabled Oct 24 22:33:37 wc volumio[810]: info: Loading plugin "my_music"... Oct 24 22:33:37 wc volumio[810]: info: Loading plugin "mpd"... Oct 24 22:33:37 wc kernel: Key type cifs.spnego registered Oct 24 22:33:37 wc kernel: Key type cifs.idmap registered Oct 24 22:33:37 wc 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. Oct 24 22:33:37 wc kernel: CIFS: Attempting to mount //192.168.0.242/SAMBA Oct 24 22:33:38 wc sudo[1029]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:39 wc systemd[1]: systemd-timedated.service: Succeeded. Oct 24 22:33:39 wc volumio[810]: info: Plugin upnp_browser is not enabled Oct 24 22:33:39 wc volumio[810]: info: Loading plugin "alarm-clock"... Oct 24 22:33:40 wc volumio[810]: info: Plugin airplay_emulation is not enabled Oct 24 22:33:40 wc volumio[810]: info: Loading plugin "last_100"... Oct 24 22:33:41 wc volumio[810]: info: Loading plugin "webradio"... Oct 24 22:33:41 wc volumio[810]: info: Loading plugin "i2s_dacs"... Oct 24 22:33:41 wc volumio[810]: info: Loading plugin "volumiodiscovery"... Oct 24 22:33:41 wc volumio[810]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 24 22:33:41 wc node[810]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 24 22:33:41 wc volumio[810]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 24 22:33:41 wc volumio[810]: *** WARNING *** For more information see Oct 24 22:33:41 wc volumio[810]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 24 22:33:41 wc volumio[810]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 24 22:33:41 wc volumio[810]: *** WARNING *** For more information see Oct 24 22:33:41 wc node[810]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 24 22:33:41 wc node[810]: *** WARNING *** For more information see Oct 24 22:33:41 wc node[810]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 24 22:33:41 wc node[810]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 24 22:33:41 wc node[810]: *** WARNING *** For more information see Oct 24 22:33:41 wc volumio[810]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 24 22:33:41 wc volumio[810]: info: Discovery: Started advertising with name: WC Oct 24 22:33:42 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 24 22:33:42 wc volumio[810]: info: Plugin spop is not enabled Oct 24 22:33:42 wc volumio[810]: info: Loading plugin "outputs"... Oct 24 22:33:42 wc volumio[810]: info: Loading plugin "albumart"... Oct 24 22:33:42 wc volumio[810]: info: Plugin example_plugin is not enabled Oct 24 22:33:42 wc volumio[810]: info: Loading plugin "inputs"... Oct 24 22:33:42 wc volumio-remote-updater[395]: [2025-10-24 22:33:42] [connect] Successful connection Oct 24 22:33:42 wc volumio[810]: info: Loading plugin "updater_comm"... Oct 24 22:33:44 wc volumio[810]: info: Plugin mpdemulation is not enabled Oct 24 22:33:44 wc volumio[810]: info: Loading plugin "rest_api"... Oct 24 22:33:45 wc volumio[810]: info: Loading plugin "websocket"... Oct 24 22:33:45 wc volumio[810]: info: Starting Socket.io Server version 2.3.0 Oct 24 22:33:45 wc volumio[810]: info: Loading i18n strings for locale de Oct 24 22:33:45 wc volumio[810]: Updating browse sources language Oct 24 22:33:45 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 22:33:45 wc volumio[810]: Forking 1 albumart workers Oct 24 22:33:46 wc ntpd[531]: Soliciting pool server 128.140.109.119 Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::initPlayerControls Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 22:33:47 wc volumio[810]: Express server listening on port 3000 Oct 24 22:33:47 wc volumio[810]: [Metrics] WebUI: 26s 582.97ms Oct 24 22:33:47 wc volumio[810]: info: CoreStateMachine::resetVolumioState Oct 24 22:33:47 wc volumio[810]: info: CoreStateMachine::getcurrentVolume Oct 24 22:33:47 wc volumio[810]: info: CoreCommandRouter::volumioRetrievevolume Oct 24 22:33:48 wc ntpd[531]: Soliciting pool server 213.239.234.28 Oct 24 22:33:48 wc ntpd[531]: Soliciting pool server 51.75.67.47 Oct 24 22:33:48 wc volumio[810]: info: Volumio Network Manager: Network status updated: 2 Oct 24 22:33:48 wc ntpd[531]: Soliciting pool server 188.68.34.173 Oct 24 22:33:48 wc ntpd[531]: Soliciting pool server 85.215.189.120 Oct 24 22:33:49 wc ntpd[531]: Soliciting pool server 134.60.1.27 Oct 24 22:33:49 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.113 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 24 22:33:49 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.102 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 24 22:33:49 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.99 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 24 22:33:49 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.113 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 24 22:33:49 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.102 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 24 22:33:49 wc ntpd[531]: Soliciting pool server 130.61.133.198 Oct 24 22:33:49 wc ntpd[531]: Soliciting pool server 157.90.16.34 Oct 24 22:33:49 wc ntpd[531]: Soliciting pool server 45.82.120.253 Oct 24 22:33:50 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.99 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 24 22:33:50 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.113 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 24 22:33:50 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.102 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 24 22:33:50 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.99 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Oct 24 22:33:50 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:50 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:50 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 22:33:50 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:50 wc volumio[810]: info: CoreStateMachine::updateTrackBlock Oct 24 22:33:50 wc volumio[810]: info: CorePlayQueue::getTrackBlock Oct 24 22:33:50 wc volumio[810]: info: CoreCommandRouter::volumioRetrievevolume Oct 24 22:33:50 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:50 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:50 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:50 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:50 wc ntpd[531]: Soliciting pool server 148.251.54.81 Oct 24 22:33:50 wc ntpd[531]: Soliciting pool server 91.98.67.74 Oct 24 22:33:50 wc ntpd[531]: Soliciting pool server 5.45.97.204 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:51 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:51 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 22:33:51 wc volumio[810]: info: Cannot read play queue from file Oct 24 22:33:51 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:51 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:51 wc volumio[810]: info: CoreStateMachine::setRepeat null single undefined Oct 24 22:33:51 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:51 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:51 wc volumio[810]: info: CoreStateMachine::setRandom true Oct 24 22:33:51 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:51 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:51 wc volumio[810]: info: Setting Device type: Raspberry PI Oct 24 22:33:51 wc volumio[810]: info: Listing playlists Oct 24 22:33:51 wc volumio[810]: info: Listing playlists Oct 24 22:33:51 wc volumio[810]: info: Oct 24 22:33:51 wc volumio[810]: ---------------------------- Client requests Volume 50 Oct 24 22:33:51 wc volumio[810]: info: VolumeController::SetAlsaVolume50 Oct 24 22:33:51 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:51 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 22:33:51 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:51 wc ntpd[531]: Soliciting pool server 79.133.44.139 Oct 24 22:33:51 wc ntpd[531]: Soliciting pool server 2a03:4000:1e:130::123 Oct 24 22:33:52 wc volumio[810]: info: Oct 24 22:33:52 wc volumio[810]: ---------------------------- Client requests Volume 50 Oct 24 22:33:52 wc volumio[810]: info: VolumeController::SetAlsaVolume50 Oct 24 22:33:52 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:52 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:52 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:52 wc volumio[810]: info: Completed loading Core Plugins Oct 24 22:33:52 wc volumio[810]: info: Preparing to generate the ALSA configuration file Oct 24 22:33:52 wc volumio[810]: info: Oct 24 22:33:52 wc volumio[810]: ---------------------------- Client requests Volume 50 Oct 24 22:33:52 wc volumio[810]: info: VolumeController::SetAlsaVolume50 Oct 24 22:33:52 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:52 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:52 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:52 wc volumio[810]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 24 22:33:52 wc volumio[810]: info: Reading ALSA contributions from plugins. Oct 24 22:33:53 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.113 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Oct 24 22:33:53 wc volumio[810]: info: Oct 24 22:33:53 wc volumio[810]: ---------------------------- Client requests Random true Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioRandom Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::writePlayerControls Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: info: CoreStateMachine::setRandom true Oct 24 22:33:53 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:53 wc volumio[810]: info: Oct 24 22:33:53 wc volumio[810]: ---------------------------- Client requests Random true Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioRandom Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::writePlayerControls Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: info: CoreStateMachine::setRandom true Oct 24 22:33:53 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:53 wc volumio[810]: info: Discovery: adding 4eafa67a-dc6e-4837-9947-5761bc470cb8 Oct 24 22:33:53 wc volumio[810]: info: Discovery: Found device WC Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.102 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 24 22:33:53 wc volumio[810]: Starting albumart workers Oct 24 22:33:53 wc volumio[810]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.99 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 24 22:33:53 wc volumio[810]: info: Oct 24 22:33:53 wc volumio[810]: ---------------------------- Client requests Random true Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioRandom Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::writePlayerControls Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: info: CoreStateMachine::setRandom true Oct 24 22:33:53 wc volumio[810]: info: CoreStateMachine::pushState Oct 24 22:33:53 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:53 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:33:53 wc volumio[810]: info: Discovery: adding 06459c18-b434-48b2-8377-6ce0327572a0 Oct 24 22:33:53 wc volumio[810]: info: Discovery: Found device Tivoli Audio Oct 24 22:33:54 wc volumio[810]: info: Discovery: Connecting to remote: 192.168.0.99 Oct 24 22:33:54 wc volumio[810]: info: Discovery: adding 189c9483-7980-4071-bc76-5e11a79b3ad8 Oct 24 22:33:54 wc volumio[810]: info: Discovery: Found device Kinderzimmer Oct 24 22:33:54 wc volumio[810]: info: Discovery: Connecting to remote: 192.168.0.113 Oct 24 22:33:54 wc volumio[810]: info: Oct 24 22:33:54 wc volumio[810]: ---------------------------- Client requests Volumio Play Playlist Lullaby Oct 24 22:33:54 wc volumio[810]: info: Play playlist Lullaby Oct 24 22:33:54 wc volumio[810]: info: Oct 24 22:33:54 wc volumio[810]: ---------------------------- Client requests Volumio Play Playlist Lullaby Oct 24 22:33:54 wc volumio[810]: info: Play playlist Lullaby Oct 24 22:33:54 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 24 22:33:54 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 24 22:33:54 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 24 22:33:54 wc volumio[810]: info: Oct 24 22:33:54 wc volumio[810]: ---------------------------- Client requests Volumio Play Playlist Lullaby Oct 24 22:33:54 wc volumio[810]: info: Play playlist Lullaby Oct 24 22:33:54 wc volumio[810]: info: Discovery: adding 6a4f79cd-e46c-4295-a6ea-3358ca887812 Oct 24 22:33:54 wc volumio[810]: info: Discovery: Found device Schlafzimmer Oct 24 22:33:54 wc volumio[810]: info: Discovery: Connecting to remote: 192.168.0.102 Oct 24 22:33:56 wc ntpd[531]: receive: Unexpected origin timestamp 0xeca66132.fc301ac7 does not match aorg 0000000000.00000000 from server@51.75.67.47 xmt 0xeca66134.c7567f4a Oct 24 22:33:57 wc volumio[810]: info: Discovery: Connected to remote: 192.168.0.99 Oct 24 22:33:57 wc volumio[810]: info: Discovery: Connected to remote: 192.168.0.113 Oct 24 22:33:57 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:57 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:57 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:57 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:57 wc volumio[810]: info: CoreCommandRouter::volumioGetState Oct 24 22:33:57 wc volumio[810]: info: CorePlayQueue::getTrack 0 Oct 24 22:33:57 wc volumio[810]: info: Discovery: Connected to remote: 192.168.0.102 Oct 24 22:33:58 wc volumio[810]: info: Asound.conf file unchanged, so no further update is needed Oct 24 22:33:58 wc volumio[810]: info: Output device has changed, restarting MPD Oct 24 22:33:58 wc volumio[810]: info: ___________ START PLUGINS ___________ Oct 24 22:33:58 wc sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 24 22:33:58 wc sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:58 wc volumio[810]: info: ControllerMpd::onStart: Initializing MPD Oct 24 22:33:58 wc volumio[810]: info: Creating MPD Configuration file Oct 24 22:33:58 wc sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 24 22:33:58 wc sudo[1128]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:58 wc sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:58 wc volumio[810]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 24 22:33:58 wc systemd[1]: Stopping Music Player Daemon... Oct 24 22:33:59 wc volumio[810]: info: [1761338039035] CoreMusicLibrary::Adding element Last_100 Oct 24 22:33:59 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 22:33:59 wc volumio-remote-updater[395]: [2025-10-24 22:33:59] [connect] Successful connection Oct 24 22:33:59 wc systemd[1]: mpd.service: Succeeded. Oct 24 22:33:59 wc systemd[1]: Stopped Music Player Daemon. Oct 24 22:33:59 wc systemd[1]: Starting Music Player Daemon... Oct 24 22:33:59 wc sudo[1138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 24 22:33:59 wc volumio[810]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 24 22:33:59 wc volumio[810]: info: [1761338039573] CoreMusicLibrary::Adding element Webradio Oct 24 22:33:59 wc sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:59 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 22:33:59 wc sudo[1138]: pam_unix(sudo:session): session closed for user root Oct 24 22:33:59 wc sudo[1140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 24 22:33:59 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 22:33:59 wc sudo[1140]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:33:59 wc volumio[810]: info: Initializing BBC Radios Oct 24 22:34:00 wc sudo[1145]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 24 22:34:00 wc sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:34:00 wc sudo[1145]: pam_unix(sudo:session): session closed for user root Oct 24 22:34:00 wc systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 24 22:34:00 wc systemd[1]: mpd.service: Succeeded. Oct 24 22:34:00 wc systemd[1]: Stopped Music Player Daemon. Oct 24 22:34:00 wc systemd[1]: Starting Music Player Daemon... Oct 24 22:34:00 wc volumio[810]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Oct 24 22:34:00 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 22:34:00 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 22:34:00 wc volumio[810]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 22:34:00 wc sudo[1157]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 24 22:34:00 wc volumio[810]: info: Volumio Calling Home Oct 24 22:34:00 wc sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:34:01 wc sudo[1157]: pam_unix(sudo:session): session closed for user root Oct 24 22:34:03 wc volumio[810]: info: CoreCommandRouter::volumioClearQueue Oct 24 22:34:03 wc volumio[810]: info: CoreStateMachine::ClearQueue Oct 24 22:34:03 wc volumio[810]: info: CoreStateMachine::stop Oct 24 22:34:03 wc volumio[810]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 22:34:03 wc volumio[810]: info: CorePlayQueue::clearPlayQueue Oct 24 22:34:03 wc volumio[810]: info: CorePlayQueue::saveQueue Oct 24 22:34:03 wc volumio[810]: info: CoreCommandRouter::volumioPushState Oct 24 22:34:03 wc volumio[810]: info: CoreCommandRouter::volumioPushQueue Oct 24 22:34:03 wc volumio[810]: info: CoreCommandRouter::volumioAddQueueItems Oct 24 22:34:03 wc volumio[810]: info: CoreStateMachine::addQueueItems Oct 24 22:34:03 wc volumio[810]: info: CorePlayQueue::addQueueItems Oct 24 22:34:03 wc volumio[810]: info: Preload queue cleared Oct 24 22:34:03 wc volumio[810]: info: Adding Item to queue: mnt/NAS/SAMBA/Lullaby/Hey Jude - Lullaby Renditions of The Beatles - Rockabye Baby!.mp3 Oct 24 22:34:03 wc volumio[810]: info: Exploding uri mnt/NAS/SAMBA/Lullaby/Hey Jude - Lullaby Renditions of The Beatles - Rockabye Baby!.mp3 in service mpd Oct 24 22:34:03 wc volumio[810]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 22:34:03 wc volumio[810]: TypeError: Cannot read property 'then' of undefined Oct 24 22:34:03 wc volumio[810]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19) Oct 24 22:34:03 wc volumio[810]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21) Oct 24 22:34:03 wc volumio[810]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Oct 24 22:34:03 wc volumio[810]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 24 22:34:03 wc volumio[810]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Oct 24 22:34:03 wc volumio[810]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Oct 24 22:34:03 wc volumio[810]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:249:25) Oct 24 22:34:03 wc volumio[810]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:448:28) Oct 24 22:34:03 wc volumio[810]: at /volumio/app/playlistManager.js:726:30 Oct 24 22:34:03 wc volumio[810]: at /volumio/node_modules/jsonfile/index.js:46:5 Oct 24 22:34:03 wc volumio[810]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 22:34:08 wc sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 22:33 Oct 24 22:34:08 wc sudo[1190]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"