-- Logs begin at Fri 2025-04-04 05:23:13 CEST, end at Sat 2025-04-19 16:11:41 CEST. -- Apr 19 16:10:41 wc systemd-timedated[813]: Changed local time to Sat Apr 19 16:10:41 2025 Apr 19 16:10:41 wc sudo[805]: pam_unix(sudo:session): session closed for user root Apr 19 16:10:41 wc volumio-time-update[386]: volumio-time-update-util: System time updated successfully. Apr 19 16:10:41 wc systemd[1]: Started Volumio Time Update Utility. Apr 19 16:10:41 wc systemd[1]: Starting Daily apt download activities... Apr 19 16:10:41 wc nmbd[516]: [2025/04/19 16:10:41.737412, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 19 16:10:41 wc nmbd[516]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.80 for name WORKGROUP<1d>. Apr 19 16:10:41 wc nmbd[516]: This response was from IP 192.168.0.242, reporting an IP address of 192.168.0.242. Apr 19 16:10:42 wc winbindd[792]: [2025/04/19 16:10:42.444766, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Apr 19 16:10:42 wc winbindd[792]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Apr 19 16:10:42 wc winbindd[792]: [2025/04/19 16:10:42.578183, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 19 16:10:42 wc systemd[1]: Started Samba Winbind Daemon. Apr 19 16:10:42 wc winbindd[792]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Apr 19 16:10:42 wc systemd[1]: Starting Samba SMB Daemon... Apr 19 16:10:47 wc volumio-remote-updater[353]: [2025-04-19 16:10:47] [info] asio async_connect error: system:111 (Connection refused) Apr 19 16:10:47 wc volumio-remote-updater[353]: [2025-04-19 16:10:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 16:10:47 wc volumio-remote-updater[353]: [2025-04-19 16:10:47] [error] handle_connect error: Underlying Transport Error Apr 19 16:10:48 wc systemd[1]: Started Samba SMB Daemon. Apr 19 16:10:48 wc smbd[842]: [2025/04/19 16:10:48.042585, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 19 16:10:48 wc systemd[1]: Reached target Multi-User System. Apr 19 16:10:48 wc smbd[842]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 19 16:10:48 wc systemd[1]: Reached target Graphical Interface. Apr 19 16:10:48 wc systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 19 16:10:48 wc systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 19 16:10:48 wc systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 19 16:10:48 wc systemd[1]: apt-daily.service: Succeeded. Apr 19 16:10:48 wc systemd[1]: Started Daily apt download activities. Apr 19 16:10:48 wc systemd[1]: Starting Daily apt upgrade and clean activities... Apr 19 16:10:53 wc systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 19 16:10:53 wc systemd[1]: Started Daily apt upgrade and clean activities. Apr 19 16:10:53 wc systemd[1]: Startup finished in 21.079s (kernel) + 1min 15.403s (userspace) = 1min 36.482s. Apr 19 16:10:54 wc systemd[1]: systemd-hostnamed.service: Succeeded. Apr 19 16:10:57 wc volumio[816]: info: ------------------------------------------- Apr 19 16:10:57 wc volumio[816]: info: ----- Volumio3 ---- Apr 19 16:10:57 wc volumio[816]: info: ------------------------------------------- Apr 19 16:10:57 wc volumio[816]: info: ----- System startup ---- Apr 19 16:10:57 wc volumio[816]: info: ------------------------------------------- Apr 19 16:10:57 wc volumio-remote-updater[353]: [2025-04-19 16:10:57] [connect] Successful connection Apr 19 16:11:01 wc volumio[816]: info: MYVOLUMIO Environment detected Apr 19 16:11:01 wc volumio[816]: info: Plugin folders cleanup Apr 19 16:11:01 wc volumio[816]: info: Scanning into folder /volumio/app/plugins/ Apr 19 16:11:01 wc volumio[816]: info: Scanning category audio_interface Apr 19 16:11:01 wc volumio[816]: info: Scanning category miscellanea Apr 19 16:11:01 wc volumio[816]: info: Scanning category music_service Apr 19 16:11:01 wc volumio[816]: info: Scanning category plugins.json Apr 19 16:11:01 wc volumio[816]: info: Scanning category system_controller Apr 19 16:11:01 wc volumio[816]: info: Scanning category user_interface Apr 19 16:11:01 wc volumio[816]: info: Scanning into folder /data/plugins/ Apr 19 16:11:01 wc volumio[816]: info: Scanning category music_service Apr 19 16:11:01 wc volumio[816]: info: Plugin folders cleanup completed Apr 19 16:11:01 wc volumio[816]: info: ------------------------------------------- Apr 19 16:11:01 wc volumio[816]: info: ----- Core plugins startup ---- Apr 19 16:11:01 wc volumio[816]: info: ------------------------------------------- Apr 19 16:11:01 wc volumio[816]: info: Loading plugins from folder /volumio/app/plugins/ Apr 19 16:11:01 wc volumio[816]: info: Adding plugin upnp to MyMusic Plugins Apr 19 16:11:01 wc volumio[816]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 19 16:11:01 wc volumio[816]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 19 16:11:01 wc volumio[816]: info: Loading plugins from folder /data/plugins/ Apr 19 16:11:02 wc volumio[816]: info: Loading plugin "system"... Apr 19 16:11:02 wc volumio[816]: info: Loading plugin "appearance"... Apr 19 16:11:07 wc volumio[816]: info: Loading plugin "network"... Apr 19 16:11:07 wc volumio[816]: info: Refreshing Cached IP Addresses Apr 19 16:11:08 wc volumio[816]: info: Loading plugin "services"... Apr 19 16:11:08 wc sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 19 16:11:08 wc sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:08 wc volumio[816]: info: Loading plugin "alsa_controller"... Apr 19 16:11:08 wc sudo[996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 19 16:11:08 wc sudo[996]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:08 wc sudo[998]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:08 wc sudo[996]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:08 wc sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 19 16:11:08 wc sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:08 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 16:11:08 wc volumio[816]: info: Loading plugin "wizard"... Apr 19 16:11:08 wc volumio[816]: info: Loading plugin "networkfs"... Apr 19 16:11:09 wc volumio[816]: info: Starting Udev Watcher for removable devices Apr 19 16:11:09 wc sudo[1024]: 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 Apr 19 16:11:09 wc sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:09 wc volumio[816]: info: Ignoring mount for partition: boot Apr 19 16:11:09 wc volumio[816]: info: Ignoring mount for partition: volumio Apr 19 16:11:09 wc volumio[816]: info: Ignoring mount for partition: volumio_data Apr 19 16:11:09 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 19 16:11:09 wc volumio[816]: info: Loading plugin "volumio_command_line_client"... Apr 19 16:11:09 wc volumio[816]: info: Plugin upnp is not enabled Apr 19 16:11:09 wc sudo[1002]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:09 wc volumio[816]: info: Loading plugin "my_music"... Apr 19 16:11:09 wc volumio[816]: info: Loading plugin "mpd"... Apr 19 16:11:10 wc kernel: Key type cifs.spnego registered Apr 19 16:11:10 wc kernel: Key type cifs.idmap registered Apr 19 16:11:10 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. Apr 19 16:11:10 wc kernel: CIFS: Attempting to mount //192.168.0.242/SAMBA Apr 19 16:11:11 wc systemd[1]: systemd-timedated.service: Succeeded. Apr 19 16:11:11 wc sudo[1024]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:12 wc volumio[816]: info: Plugin upnp_browser is not enabled Apr 19 16:11:12 wc volumio[816]: info: Loading plugin "alarm-clock"... Apr 19 16:11:12 wc volumio-remote-updater[353]: [2025-04-19 16:11:12] [connect] Successful connection Apr 19 16:11:13 wc volumio[816]: info: Plugin airplay_emulation is not enabled Apr 19 16:11:13 wc volumio[816]: info: Loading plugin "last_100"... Apr 19 16:11:13 wc volumio[816]: info: Loading plugin "webradio"... Apr 19 16:11:13 wc volumio[816]: info: Loading plugin "i2s_dacs"... Apr 19 16:11:13 wc volumio[816]: info: Loading plugin "volumiodiscovery"... Apr 19 16:11:14 wc volumio[816]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 19 16:11:14 wc node[816]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 19 16:11:14 wc volumio[816]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 16:11:14 wc volumio[816]: *** WARNING *** For more information see Apr 19 16:11:14 wc volumio[816]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 19 16:11:14 wc volumio[816]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 16:11:14 wc volumio[816]: *** WARNING *** For more information see Apr 19 16:11:14 wc node[816]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 16:11:14 wc node[816]: *** WARNING *** For more information see Apr 19 16:11:14 wc node[816]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 19 16:11:14 wc node[816]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 16:11:14 wc node[816]: *** WARNING *** For more information see Apr 19 16:11:14 wc volumio[816]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 19 16:11:14 wc volumio[816]: info: Discovery: Started advertising with name: WC Apr 19 16:11:14 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 19 16:11:14 wc volumio[816]: info: Plugin spop is not enabled Apr 19 16:11:14 wc volumio[816]: info: Loading plugin "outputs"... Apr 19 16:11:14 wc volumio[816]: info: Loading plugin "albumart"... Apr 19 16:11:14 wc volumio[816]: info: Plugin example_plugin is not enabled Apr 19 16:11:14 wc volumio[816]: info: Loading plugin "inputs"... Apr 19 16:11:14 wc volumio[816]: info: Loading plugin "updater_comm"... Apr 19 16:11:16 wc volumio[816]: info: Plugin mpdemulation is not enabled Apr 19 16:11:16 wc volumio[816]: info: Loading plugin "rest_api"... Apr 19 16:11:17 wc volumio[816]: info: Loading plugin "websocket"... Apr 19 16:11:17 wc volumio[816]: info: Starting Socket.io Server version 2.3.0 Apr 19 16:11:17 wc volumio[816]: info: Loading i18n strings for locale de Apr 19 16:11:17 wc volumio[816]: Updating browse sources language Apr 19 16:11:17 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 19 16:11:17 wc volumio[816]: Forking 1 albumart workers Apr 19 16:11:18 wc ntpd[520]: Soliciting pool server 162.159.200.123 Apr 19 16:11:19 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 16:11:19 wc volumio[816]: info: CoreCommandRouter::initPlayerControls Apr 19 16:11:19 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 16:11:19 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 16:11:19 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 16:11:19 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 16:11:19 wc volumio[816]: Express server listening on port 3000 Apr 19 16:11:19 wc volumio[816]: [Metrics] WebUI: 25s 846.66ms Apr 19 16:11:19 wc ntpd[520]: Soliciting pool server 141.144.246.224 Apr 19 16:11:19 wc ntpd[520]: Soliciting pool server 194.50.19.204 Apr 19 16:11:20 wc volumio[816]: info: CoreStateMachine::resetVolumioState Apr 19 16:11:20 wc volumio[816]: info: CoreStateMachine::getcurrentVolume Apr 19 16:11:20 wc volumio[816]: info: CoreCommandRouter::volumioRetrievevolume Apr 19 16:11:20 wc volumio[816]: info: Volumio Network Manager: Network status updated: 2 Apr 19 16:11:20 wc ntpd[520]: Soliciting pool server 185.252.140.125 Apr 19 16:11:20 wc ntpd[520]: Soliciting pool server 185.232.69.65 Apr 19 16:11:21 wc ntpd[520]: Soliciting pool server 51.75.67.47 Apr 19 16:11:21 wc ntpd[520]: Soliciting pool server 158.220.97.17 Apr 19 16:11:21 wc ntpd[520]: Soliciting pool server 212.132.97.26 Apr 19 16:11:21 wc volumio[816]: 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: 1 Apr 19 16:11:21 wc volumio[816]: 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 Apr 19 16:11:21 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:21 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:21 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 16:11:22 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:22 wc volumio[816]: info: CoreStateMachine::updateTrackBlock Apr 19 16:11:22 wc volumio[816]: info: CorePlayQueue::getTrackBlock Apr 19 16:11:22 wc volumio[816]: info: CoreCommandRouter::volumioRetrievevolume Apr 19 16:11:22 wc volumio[816]: info: CoreCommandRouter::volumioGetState Apr 19 16:11:22 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:22 wc volumio[816]: info: CoreCommandRouter::volumioGetState Apr 19 16:11:22 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:22 wc volumio[816]: info: CoreCommandRouter::volumioGetState Apr 19 16:11:22 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:22 wc ntpd[520]: Soliciting pool server 213.209.109.45 Apr 19 16:11:22 wc ntpd[520]: Soliciting pool server 62.108.36.235 Apr 19 16:11:22 wc ntpd[520]: Soliciting pool server 167.235.139.237 Apr 19 16:11:22 wc volumio[816]: info: Reloading queue from file Apr 19 16:11:22 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 16:11:23 wc volumio[816]: 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 Apr 19 16:11:23 wc volumio[816]: 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: 4 Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:23 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:23 wc volumio[816]: info: Setting Device type: Raspberry PI Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::setRepeat null single undefined Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:23 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::setRandom true Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:23 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:23 wc volumio[816]: info: Apr 19 16:11:23 wc volumio[816]: ---------------------------- Client requests Volume 50 Apr 19 16:11:23 wc volumio[816]: info: VolumeController::SetAlsaVolume50 Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:23 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:23 wc volumio[816]: info: Apr 19 16:11:23 wc volumio[816]: ---------------------------- Client requests Volume 50 Apr 19 16:11:23 wc volumio[816]: info: VolumeController::SetAlsaVolume50 Apr 19 16:11:23 wc ntpd[520]: Soliciting pool server 167.235.69.67 Apr 19 16:11:23 wc ntpd[520]: Soliciting pool server 2a12:edc0:4:be15::1 Apr 19 16:11:23 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:23 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:23 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:23 wc volumio[816]: info: Apr 19 16:11:23 wc volumio[816]: ---------------------------- Client requests Volume 50 Apr 19 16:11:23 wc volumio[816]: info: VolumeController::SetAlsaVolume50 Apr 19 16:11:24 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:24 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:24 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:24 wc volumio[816]: info: Completed loading Core Plugins Apr 19 16:11:24 wc volumio[816]: info: Preparing to generate the ALSA configuration file Apr 19 16:11:24 wc volumio[816]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 19 16:11:24 wc volumio[816]: info: Reading ALSA contributions from plugins. Apr 19 16:11:24 wc ntpd[520]: Soliciting pool server 5.45.97.204 Apr 19 16:11:24 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 19 16:11:25 wc volumio[816]: info: Discovery: adding 4eafa67a-dc6e-4837-9947-5761bc470cb8 Apr 19 16:11:25 wc volumio[816]: info: Discovery: Found device WC Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioGetState Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: Apr 19 16:11:25 wc volumio[816]: ---------------------------- Client requests Random true Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioRandom Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::writePlayerControls Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: CoreStateMachine::setRandom true Apr 19 16:11:25 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:25 wc volumio[816]: info: Apr 19 16:11:25 wc volumio[816]: ---------------------------- Client requests Random true Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioRandom Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::writePlayerControls Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: CoreStateMachine::setRandom true Apr 19 16:11:25 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:25 wc volumio[816]: info: Apr 19 16:11:25 wc volumio[816]: ---------------------------- Client requests Random true Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioRandom Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::writePlayerControls Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: CoreStateMachine::setRandom true Apr 19 16:11:25 wc volumio[816]: info: CoreStateMachine::pushState Apr 19 16:11:25 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:25 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:25 wc volumio[816]: info: Discovery: adding 06459c18-b434-48b2-8377-6ce0327572a0 Apr 19 16:11:25 wc volumio[816]: info: Discovery: Found device Tivoli Audio Apr 19 16:11:25 wc volumio[816]: Starting albumart workers Apr 19 16:11:25 wc volumio[816]: info: Discovery: Connecting to remote: 192.168.0.99 Apr 19 16:11:26 wc volumio[816]: info: CoreCommandRouter::volumioGetState Apr 19 16:11:26 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:26 wc volumio[816]: info: CoreCommandRouter::volumioGetState Apr 19 16:11:26 wc volumio[816]: info: CorePlayQueue::getTrack 0 Apr 19 16:11:26 wc volumio[816]: info: Apr 19 16:11:26 wc volumio[816]: ---------------------------- Client requests Volumio Play Playlist Sea Apr 19 16:11:26 wc volumio[816]: info: Play playlist Sea Apr 19 16:11:26 wc volumio[816]: info: Apr 19 16:11:26 wc volumio[816]: ---------------------------- Client requests Volumio Play Playlist Sea Apr 19 16:11:26 wc volumio[816]: info: Play playlist Sea Apr 19 16:11:26 wc volumio[816]: info: Apr 19 16:11:26 wc volumio[816]: ---------------------------- Client requests Volumio Play Playlist Sea Apr 19 16:11:26 wc volumio[816]: info: Play playlist Sea Apr 19 16:11:26 wc volumio[816]: info: Discovery: adding 6a4f79cd-e46c-4295-a6ea-3358ca887812 Apr 19 16:11:26 wc volumio[816]: info: Discovery: Found device Schlafzimmer Apr 19 16:11:26 wc volumio[816]: info: Discovery: Connecting to remote: 192.168.0.102 Apr 19 16:11:26 wc volumio[816]: info: Discovery: Connected to remote: 192.168.0.99 Apr 19 16:11:27 wc volumio[816]: info: Discovery: Connected to remote: 192.168.0.102 Apr 19 16:11:27 wc volumio[816]: info: Asound.conf file unchanged, so no further update is needed Apr 19 16:11:27 wc volumio[816]: info: Output device has changed, restarting MPD Apr 19 16:11:27 wc volumio-remote-updater[353]: [2025-04-19 16:11:27] [connect] Successful connection Apr 19 16:11:27 wc volumio[816]: info: ___________ START PLUGINS ___________ Apr 19 16:11:27 wc sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 16:11:27 wc volumio[816]: info: ControllerMpd::onStart: Initializing MPD Apr 19 16:11:27 wc sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:27 wc volumio[816]: info: Creating MPD Configuration file Apr 19 16:11:27 wc sudo[1122]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:27 wc sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 16:11:27 wc sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:27 wc volumio[816]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 19 16:11:27 wc volumio[816]: info: [1745071887910] CoreMusicLibrary::Adding element Last_100 Apr 19 16:11:27 wc systemd[1]: Stopping Music Player Daemon... Apr 19 16:11:27 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 19 16:11:28 wc systemd[1]: mpd.service: Succeeded. Apr 19 16:11:28 wc systemd[1]: Stopped Music Player Daemon. Apr 19 16:11:28 wc volumio[816]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 19 16:11:28 wc volumio[816]: info: [1745071888316] CoreMusicLibrary::Adding element Webradio Apr 19 16:11:28 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 19 16:11:28 wc systemd[1]: Starting Music Player Daemon... Apr 19 16:11:28 wc sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 19 16:11:28 wc sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:28 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 16:11:28 wc sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 19 16:11:28 wc sudo[1128]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:28 wc volumio[816]: info: Initializing BBC Radios Apr 19 16:11:28 wc sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9e4ea7d does not match aorg 0000000000.00000000 from server@141.144.246.224 xmt 0xebae2d94.1ffaf84e Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9df9c2b does not match aorg 0000000000.00000000 from server@194.50.19.204 xmt 0xebae2d94.201c779c Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9aeaf5a does not match aorg 0000000000.00000000 from server@167.235.69.67 xmt 0xebae2d94.1fc0f17e Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9da5e92 does not match aorg 0000000000.00000000 from server@185.232.69.65 xmt 0xebae2d94.204ea5de Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9bd81e8 does not match aorg 0000000000.00000000 from server@213.209.109.45 xmt 0xebae2d94.203f5e12 Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9c918a4 does not match aorg 0000000000.00000000 from server@51.75.67.47 xmt 0xebae2d94.21354956 Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9d4a252 does not match aorg 0000000000.00000000 from server@185.252.140.125 xmt 0xebae2d94.20b81654 Apr 19 16:11:32 wc ntpd[520]: receive: Unexpected origin timestamp 0xebae2d90.c9c3a7f1 does not match aorg 0000000000.00000000 from server@212.132.97.26 xmt 0xebae2d94.208b02ba Apr 19 16:11:32 wc volumio[816]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Apr 19 16:11:32 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 16:11:32 wc systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 19 16:11:32 wc systemd[1]: mpd.service: Succeeded. Apr 19 16:11:32 wc systemd[1]: Stopped Music Player Daemon. Apr 19 16:11:32 wc systemd[1]: Starting Music Player Daemon... Apr 19 16:11:33 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 16:11:33 wc volumio[816]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 16:11:33 wc sudo[1136]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 19 16:11:33 wc sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 16:11:33 wc sudo[1136]: pam_unix(sudo:session): session closed for user root Apr 19 16:11:33 wc volumio[816]: info: Volumio Calling Home Apr 19 16:11:36 wc volumio[816]: info: CoreCommandRouter::volumioClearQueue Apr 19 16:11:36 wc volumio[816]: info: CoreStateMachine::ClearQueue Apr 19 16:11:36 wc volumio[816]: info: CoreStateMachine::stop Apr 19 16:11:36 wc volumio[816]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 19 16:11:36 wc volumio[816]: info: CorePlayQueue::clearPlayQueue Apr 19 16:11:36 wc volumio[816]: info: CorePlayQueue::saveQueue Apr 19 16:11:36 wc volumio[816]: info: CoreCommandRouter::volumioPushState Apr 19 16:11:36 wc volumio[816]: info: CoreCommandRouter::volumioPushQueue Apr 19 16:11:36 wc volumio[816]: info: CoreCommandRouter::volumioAddQueueItems Apr 19 16:11:36 wc volumio[816]: info: CoreStateMachine::addQueueItems Apr 19 16:11:36 wc volumio[816]: info: CorePlayQueue::addQueueItems Apr 19 16:11:36 wc volumio[816]: info: Preload queue cleared Apr 19 16:11:36 wc volumio[816]: info: Adding Item to queue: mnt/NAS/SAMBA/Sea/meeresrauschen_mit_m_wen_entspannung_meditation_-4280798598044045452.mp3 Apr 19 16:11:36 wc volumio[816]: info: Exploding uri mnt/NAS/SAMBA/Sea/meeresrauschen_mit_m_wen_entspannung_meditation_-4280798598044045452.mp3 in service mpd Apr 19 16:11:36 wc volumio[816]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 16:11:36 wc volumio[816]: TypeError: Cannot read property 'then' of undefined Apr 19 16:11:36 wc volumio[816]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19) Apr 19 16:11:36 wc volumio[816]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21) Apr 19 16:11:36 wc volumio[816]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Apr 19 16:11:36 wc volumio[816]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Apr 19 16:11:36 wc volumio[816]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Apr 19 16:11:36 wc volumio[816]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Apr 19 16:11:36 wc volumio[816]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Apr 19 16:11:36 wc volumio[816]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:448:28) Apr 19 16:11:36 wc volumio[816]: at /volumio/app/playlistManager.js:726:30 Apr 19 16:11:36 wc volumio[816]: at /volumio/node_modules/jsonfile/index.js:46:5 Apr 19 16:11:36 wc volumio[816]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 16:11:41 wc sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-19 16:10 Apr 19 16:11:41 wc sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"