-- Logs begin at Fri 2024-11-15 05:56:00 CET, end at Sat 2024-11-30 18:03:28 CET. -- Nov 30 18:02:22 wc systemd-timedated[846]: Changed local time to Sat Nov 30 18:02:22 2024 Nov 30 18:02:22 wc sudo[844]: pam_unix(sudo:session): session closed for user root Nov 30 18:02:22 wc volumio-time-update[394]: volumio-time-update-util: System time updated successfully. Nov 30 18:02:22 wc systemd[1]: Starting Daily apt download activities... Nov 30 18:02:22 wc systemd[1]: Started Volumio Time Update Utility. Nov 30 18:02:22 wc volumio-remote-updater[354]: [2024-11-30 18:02:22] [info] asio async_connect error: system:111 (Connection refused) Nov 30 18:02:22 wc volumio-remote-updater[354]: [2024-11-30 18:02:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 30 18:02:22 wc volumio-remote-updater[354]: [2024-11-30 18:02:22] [error] handle_connect error: Underlying Transport Error Nov 30 18:02:22 wc nmbd[560]: [2024/11/30 18:02:22.895791, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 30 18:02:22 wc nmbd[560]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.80 for name WORKGROUP<1d>. Nov 30 18:02:22 wc nmbd[560]: This response was from IP 192.168.0.66, reporting an IP address of 192.168.0.66. Nov 30 18:02:25 wc smbd[842]: [2024/11/30 18:02:25.017426, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 30 18:02:25 wc smbd[842]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 30 18:02:25 wc systemd[1]: Started Samba SMB Daemon. Nov 30 18:02:25 wc systemd[1]: Reached target Multi-User System. Nov 30 18:02:25 wc systemd[1]: Reached target Graphical Interface. Nov 30 18:02:25 wc systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 30 18:02:25 wc systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 30 18:02:25 wc systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 30 18:02:28 wc systemd[1]: apt-daily.service: Succeeded. Nov 30 18:02:28 wc systemd[1]: Started Daily apt download activities. Nov 30 18:02:28 wc systemd[1]: Starting Daily apt upgrade and clean activities... Nov 30 18:02:32 wc systemd[1]: apt-daily-upgrade.service: Succeeded. Nov 30 18:02:32 wc volumio-remote-updater[354]: [2024-11-30 18:02:32] [info] asio async_connect error: system:111 (Connection refused) Nov 30 18:02:32 wc volumio-remote-updater[354]: [2024-11-30 18:02:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 30 18:02:32 wc volumio-remote-updater[354]: [2024-11-30 18:02:32] [error] handle_connect error: Underlying Transport Error Nov 30 18:02:32 wc systemd[1]: Started Daily apt upgrade and clean activities. Nov 30 18:02:32 wc systemd[1]: Startup finished in 25.908s (kernel) + 1min 30.663s (userspace) = 1min 56.571s. Nov 30 18:02:33 wc systemd[1]: systemd-hostnamed.service: Succeeded. Nov 30 18:02:36 wc volumio[819]: info: ------------------------------------------- Nov 30 18:02:36 wc volumio[819]: info: ----- Volumio3 ---- Nov 30 18:02:36 wc volumio[819]: info: ------------------------------------------- Nov 30 18:02:36 wc volumio[819]: info: ----- System startup ---- Nov 30 18:02:36 wc volumio[819]: info: ------------------------------------------- Nov 30 18:02:40 wc volumio[819]: info: MYVOLUMIO Environment detected Nov 30 18:02:41 wc volumio[819]: info: Plugin folders cleanup Nov 30 18:02:41 wc volumio[819]: info: Scanning into folder /volumio/app/plugins/ Nov 30 18:02:41 wc volumio[819]: info: Scanning category audio_interface Nov 30 18:02:41 wc volumio[819]: info: Scanning category miscellanea Nov 30 18:02:41 wc volumio[819]: info: Scanning category music_service Nov 30 18:02:41 wc volumio[819]: info: Scanning category plugins.json Nov 30 18:02:41 wc volumio[819]: info: Scanning category system_controller Nov 30 18:02:41 wc volumio[819]: info: Scanning category user_interface Nov 30 18:02:41 wc volumio[819]: info: Scanning into folder /data/plugins/ Nov 30 18:02:41 wc volumio[819]: info: Scanning category music_service Nov 30 18:02:41 wc volumio[819]: info: Plugin folders cleanup completed Nov 30 18:02:41 wc volumio[819]: info: ------------------------------------------- Nov 30 18:02:41 wc volumio[819]: info: ----- Core plugins startup ---- Nov 30 18:02:41 wc volumio[819]: info: ------------------------------------------- Nov 30 18:02:41 wc volumio[819]: info: Loading plugins from folder /volumio/app/plugins/ Nov 30 18:02:41 wc volumio[819]: info: Adding plugin upnp to MyMusic Plugins Nov 30 18:02:41 wc volumio[819]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 30 18:02:41 wc volumio[819]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 30 18:02:41 wc volumio[819]: info: Loading plugins from folder /data/plugins/ Nov 30 18:02:41 wc volumio[819]: info: Loading plugin "system"... Nov 30 18:02:41 wc volumio[819]: info: Loading plugin "appearance"... Nov 30 18:02:42 wc volumio-remote-updater[354]: [2024-11-30 18:02:42] [connect] Successful connection Nov 30 18:02:46 wc volumio[819]: info: Loading plugin "network"... Nov 30 18:02:46 wc volumio[819]: info: Refreshing Cached IP Addresses Nov 30 18:02:47 wc volumio[819]: info: Loading plugin "services"... Nov 30 18:02:47 wc sudo[1014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 30 18:02:47 wc sudo[1014]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:02:47 wc sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 30 18:02:47 wc sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:02:47 wc volumio[819]: info: Loading plugin "alsa_controller"... Nov 30 18:02:47 wc sudo[1016]: pam_unix(sudo:session): session closed for user root Nov 30 18:02:47 wc sudo[1014]: pam_unix(sudo:session): session closed for user root Nov 30 18:02:47 wc sudo[1023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 30 18:02:47 wc sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:02:47 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 30 18:02:47 wc volumio[819]: info: Loading plugin "wizard"... Nov 30 18:02:47 wc volumio[819]: info: Loading plugin "networkfs"... Nov 30 18:02:48 wc volumio[819]: info: Starting Udev Watcher for removable devices Nov 30 18:02:48 wc sudo[1042]: 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.66/SAMBA /mnt/NAS/SAMBA Nov 30 18:02:48 wc sudo[1042]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:02:48 wc volumio[819]: info: Ignoring mount for partition: boot Nov 30 18:02:48 wc volumio[819]: info: Ignoring mount for partition: volumio Nov 30 18:02:48 wc volumio[819]: info: Ignoring mount for partition: volumio_data Nov 30 18:02:48 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 30 18:02:48 wc volumio[819]: info: Loading plugin "volumio_command_line_client"... Nov 30 18:02:48 wc sudo[1023]: pam_unix(sudo:session): session closed for user root Nov 30 18:02:48 wc volumio[819]: info: Plugin upnp is not enabled Nov 30 18:02:48 wc volumio[819]: info: Loading plugin "my_music"... Nov 30 18:02:48 wc volumio[819]: info: Loading plugin "mpd"... Nov 30 18:02:49 wc kernel: Key type cifs.spnego registered Nov 30 18:02:49 wc kernel: Key type cifs.idmap registered Nov 30 18:02:49 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. Nov 30 18:02:49 wc kernel: CIFS: Attempting to mount //192.168.0.66/SAMBA Nov 30 18:02:49 wc sudo[1042]: pam_unix(sudo:session): session closed for user root Nov 30 18:02:50 wc volumio[819]: info: Plugin upnp_browser is not enabled Nov 30 18:02:50 wc volumio[819]: info: Loading plugin "alarm-clock"... Nov 30 18:02:52 wc systemd[1]: systemd-timedated.service: Succeeded. Nov 30 18:02:52 wc volumio[819]: info: Plugin airplay_emulation is not enabled Nov 30 18:02:52 wc volumio[819]: info: Loading plugin "last_100"... Nov 30 18:02:52 wc volumio[819]: info: Loading plugin "webradio"... Nov 30 18:02:53 wc volumio[819]: info: Loading plugin "i2s_dacs"... Nov 30 18:02:53 wc volumio[819]: info: Loading plugin "volumiodiscovery"... Nov 30 18:02:53 wc volumio[819]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 30 18:02:53 wc volumio[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 30 18:02:53 wc volumio[819]: *** WARNING *** For more information see Nov 30 18:02:53 wc volumio[819]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 30 18:02:53 wc volumio[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 30 18:02:53 wc volumio[819]: *** WARNING *** For more information see Nov 30 18:02:53 wc node[819]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 30 18:02:53 wc node[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 30 18:02:53 wc node[819]: *** WARNING *** For more information see Nov 30 18:02:53 wc node[819]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 30 18:02:53 wc node[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 30 18:02:53 wc node[819]: *** WARNING *** For more information see Nov 30 18:02:53 wc volumio[819]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 30 18:02:53 wc volumio[819]: info: Discovery: Started advertising with name: WC Nov 30 18:02:53 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 30 18:02:53 wc volumio[819]: info: Loading plugin "spop"... Nov 30 18:02:57 wc volumio-remote-updater[354]: [2024-11-30 18:02:57] [connect] Successful connection Nov 30 18:02:58 wc ntpd[563]: Soliciting pool server 159.69.245.253 Nov 30 18:02:59 wc ntpd[563]: Soliciting pool server 195.201.20.16 Nov 30 18:02:59 wc volumio[819]: info: Loading plugin "outputs"... Nov 30 18:02:59 wc volumio[819]: info: Loading plugin "albumart"... Nov 30 18:03:00 wc volumio[819]: info: Plugin example_plugin is not enabled Nov 30 18:03:00 wc volumio[819]: info: Loading plugin "inputs"... Nov 30 18:03:00 wc volumio[819]: info: Loading plugin "updater_comm"... Nov 30 18:03:00 wc ntpd[563]: Soliciting pool server 194.164.164.175 Nov 30 18:03:00 wc ntpd[563]: Soliciting pool server 194.50.19.117 Nov 30 18:03:01 wc ntpd[563]: Soliciting pool server 62.113.219.231 Nov 30 18:03:01 wc ntpd[563]: Soliciting pool server 131.234.220.232 Nov 30 18:03:01 wc ntpd[563]: Soliciting pool server 212.132.97.26 Nov 30 18:03:01 wc volumio[819]: info: Plugin mpdemulation is not enabled Nov 30 18:03:01 wc volumio[819]: info: Loading plugin "rest_api"... Nov 30 18:03:02 wc volumio[819]: info: Loading plugin "websocket"... Nov 30 18:03:02 wc volumio[819]: info: Starting Socket.io Server version 2.3.0 Nov 30 18:03:02 wc ntpd[563]: Soliciting pool server 49.13.14.46 Nov 30 18:03:02 wc ntpd[563]: Soliciting pool server 176.9.44.212 Nov 30 18:03:02 wc ntpd[563]: Soliciting pool server 91.205.175.192 Nov 30 18:03:02 wc volumio[819]: info: Loading i18n strings for locale de Nov 30 18:03:02 wc volumio[819]: Updating browse sources language Nov 30 18:03:02 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 18:03:03 wc ntpd[563]: Soliciting pool server 90.187.112.137 Nov 30 18:03:03 wc ntpd[563]: Soliciting pool server 81.3.27.46 Nov 30 18:03:03 wc volumio[819]: Forking 1 albumart workers Nov 30 18:03:04 wc ntpd[563]: Soliciting pool server 78.47.93.191 Nov 30 18:03:04 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 18:03:04 wc volumio[819]: info: CoreCommandRouter::initPlayerControls Nov 30 18:03:04 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 18:03:04 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 18:03:04 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 18:03:04 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 30 18:03:04 wc volumio[819]: Express server listening on port 3000 Nov 30 18:03:04 wc volumio[819]: [Metrics] WebUI: 31s 963.32ms Nov 30 18:03:05 wc volumio[819]: info: CoreStateMachine::resetVolumioState Nov 30 18:03:05 wc volumio[819]: info: CoreStateMachine::getcurrentVolume Nov 30 18:03:05 wc volumio[819]: info: CoreCommandRouter::volumioRetrievevolume Nov 30 18:03:05 wc ntpd[563]: Soliciting pool server 2001:678:8::123 Nov 30 18:03:05 wc volumio[819]: info: Volumio Network Manager: Network status updated: 2 Nov 30 18:03:07 wc volumio[819]: 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: 1 Nov 30 18:03:07 wc volumio[819]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.150 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 30 18:03:07 wc volumio[819]: 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: 3 Nov 30 18:03:07 wc volumio[819]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.150 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 30 18:03:07 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:07 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:07 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 18:03:07 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:07 wc volumio[819]: info: CoreStateMachine::updateTrackBlock Nov 30 18:03:07 wc volumio[819]: info: CorePlayQueue::getTrackBlock Nov 30 18:03:07 wc volumio[819]: info: CoreCommandRouter::volumioRetrievevolume Nov 30 18:03:10 wc ntpd[563]: receive: Unexpected origin timestamp 0xeaf5c3cb.7eb1e762 does not match aorg 0000000000.00000000 from server@131.234.220.232 xmt 0xeaf5c3ce.9e48af85 Nov 30 18:03:10 wc ntpd[563]: receive: Unexpected origin timestamp 0xeaf5c3cb.7ec1b151 does not match aorg 0000000000.00000000 from server@194.164.164.175 xmt 0xeaf5c3ce.a22f9498 Nov 30 18:03:10 wc volumio[819]: info: CoreCommandRouter::volumioGetState Nov 30 18:03:10 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:11 wc volumio[819]: info: CoreCommandRouter::volumioGetState Nov 30 18:03:11 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:11 wc volumio[819]: info: CoreCommandRouter::volumioGetState Nov 30 18:03:11 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:11 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 18:03:11 wc volumio[819]: info: Reloading queue from file Nov 30 18:03:11 wc volumio[819]: 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 Nov 30 18:03:11 wc volumio[819]: verbose: New Socket.io Connection to 192.168.0.80:3000 from 192.168.0.150 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:12 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::setRepeat null single undefined Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:12 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::setRandom true Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:12 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:12 wc volumio[819]: info: Setting Device type: Raspberry PI Nov 30 18:03:12 wc volumio[819]: info: Nov 30 18:03:12 wc volumio[819]: ---------------------------- Client requests Volume 50 Nov 30 18:03:12 wc volumio[819]: info: VolumeController::SetAlsaVolume50 Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:12 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:12 wc volumio[819]: info: Nov 30 18:03:12 wc volumio[819]: ---------------------------- Client requests Volume 50 Nov 30 18:03:12 wc volumio[819]: info: VolumeController::SetAlsaVolume50 Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:12 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:12 wc volumio[819]: info: Nov 30 18:03:12 wc volumio[819]: ---------------------------- Client requests Volume 50 Nov 30 18:03:12 wc volumio[819]: info: VolumeController::SetAlsaVolume50 Nov 30 18:03:12 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:12 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:12 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:13 wc volumio[819]: info: Completed loading Core Plugins Nov 30 18:03:13 wc volumio[819]: info: Preparing to generate the ALSA configuration file Nov 30 18:03:13 wc volumio[819]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 30 18:03:13 wc volumio[819]: info: Reading ALSA contributions from plugins. Nov 30 18:03:13 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 30 18:03:13 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 30 18:03:13 wc volumio[819]: info: Discovery: adding 4eafa67a-dc6e-4837-9947-5761bc470cb8 Nov 30 18:03:13 wc volumio[819]: info: Discovery: Found device WC Nov 30 18:03:13 wc volumio[819]: info: CoreCommandRouter::volumioGetState Nov 30 18:03:13 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:13 wc volumio[819]: info: Nov 30 18:03:13 wc volumio[819]: ---------------------------- Client requests Random true Nov 30 18:03:13 wc volumio[819]: info: CoreCommandRouter::volumioRandom Nov 30 18:03:13 wc volumio[819]: info: CoreCommandRouter::writePlayerControls Nov 30 18:03:13 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:13 wc volumio[819]: info: CoreStateMachine::setRandom true Nov 30 18:03:13 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:13 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:13 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:14 wc volumio[819]: info: Nov 30 18:03:14 wc volumio[819]: ---------------------------- Client requests Random true Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::volumioRandom Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::writePlayerControls Nov 30 18:03:14 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:14 wc volumio[819]: info: CoreStateMachine::setRandom true Nov 30 18:03:14 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:14 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:14 wc volumio[819]: info: Nov 30 18:03:14 wc volumio[819]: ---------------------------- Client requests Random true Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::volumioRandom Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::writePlayerControls Nov 30 18:03:14 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:14 wc volumio[819]: info: CoreStateMachine::setRandom true Nov 30 18:03:14 wc volumio[819]: info: CoreStateMachine::pushState Nov 30 18:03:14 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:14 wc volumio[819]: info: Discovery: adding 48b3b456-e27a-47de-9180-27d051f4ce1d Nov 30 18:03:14 wc volumio[819]: info: Discovery: Found device Bad Nov 30 18:03:14 wc volumio[819]: Starting albumart workers Nov 30 18:03:14 wc volumio[819]: info: Discovery: Connecting to remote: 192.168.0.150 Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::volumioGetState Nov 30 18:03:14 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:14 wc volumio[819]: info: CoreCommandRouter::volumioGetState Nov 30 18:03:14 wc volumio[819]: info: CorePlayQueue::getTrack 0 Nov 30 18:03:14 wc volumio[819]: info: Nov 30 18:03:14 wc volumio[819]: ---------------------------- Client requests Volumio Play Playlist Lullaby Nov 30 18:03:15 wc volumio[819]: info: Play playlist Lullaby Nov 30 18:03:15 wc volumio[819]: info: Nov 30 18:03:15 wc volumio[819]: ---------------------------- Client requests Volumio Play Playlist Lullaby Nov 30 18:03:15 wc volumio[819]: info: Play playlist Lullaby Nov 30 18:03:15 wc volumio[819]: info: Nov 30 18:03:15 wc volumio[819]: ---------------------------- Client requests Volumio Play Playlist Lullaby Nov 30 18:03:15 wc volumio[819]: info: Play playlist Lullaby Nov 30 18:03:15 wc volumio[819]: info: Discovery: adding 6a4f79cd-e46c-4295-a6ea-3358ca887812 Nov 30 18:03:15 wc volumio[819]: info: Discovery: Found device Schlafzimmer Nov 30 18:03:15 wc volumio[819]: info: Discovery: Connecting to remote: 192.168.0.102 Nov 30 18:03:15 wc volumio[819]: info: Discovery: Connected to remote: 192.168.0.150 Nov 30 18:03:15 wc volumio-remote-updater[354]: [2024-11-30 18:03:15] [connect] Successful connection Nov 30 18:03:16 wc volumio[819]: info: Discovery: Connected to remote: 192.168.0.102 Nov 30 18:03:16 wc volumio[819]: info: Asound.conf file unchanged, so no further update is needed Nov 30 18:03:16 wc volumio[819]: info: Output device has changed, restarting MPD Nov 30 18:03:16 wc volumio[819]: info: ___________ START PLUGINS ___________ Nov 30 18:03:16 wc volumio[819]: info: ControllerMpd::onStart: Initializing MPD Nov 30 18:03:16 wc volumio[819]: info: Creating MPD Configuration file Nov 30 18:03:16 wc sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 30 18:03:16 wc sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:03:16 wc sudo[1146]: pam_unix(sudo:session): session closed for user root Nov 30 18:03:16 wc sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 30 18:03:16 wc sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:03:16 wc volumio[819]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 30 18:03:16 wc volumio[819]: info: [1732986196712] CoreMusicLibrary::Adding element Last_100 Nov 30 18:03:16 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 18:03:16 wc systemd[1]: Stopping Music Player Daemon... Nov 30 18:03:17 wc volumio[819]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 30 18:03:17 wc volumio[819]: info: [1732986197008] CoreMusicLibrary::Adding element Webradio Nov 30 18:03:17 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 18:03:17 wc systemd[1]: mpd.service: Succeeded. Nov 30 18:03:17 wc systemd[1]: Stopped Music Player Daemon. Nov 30 18:03:17 wc systemd[1]: Starting Music Player Daemon... Nov 30 18:03:17 wc sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 30 18:03:17 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 30 18:03:17 wc sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:03:17 wc sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 30 18:03:17 wc sudo[1152]: pam_unix(sudo:session): session closed for user root Nov 30 18:03:17 wc volumio[819]: info: Initializing BBC Radios Nov 30 18:03:17 wc sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:03:17 wc systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 30 18:03:17 wc systemd[1]: mpd.service: Succeeded. Nov 30 18:03:17 wc systemd[1]: Stopped Music Player Daemon. Nov 30 18:03:17 wc volumio[819]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Nov 30 18:03:17 wc systemd[1]: Starting Music Player Daemon... Nov 30 18:03:17 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 18:03:18 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 30 18:03:18 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 30 18:03:18 wc sudo[1160]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 30 18:03:18 wc sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:03:18 wc sudo[1160]: pam_unix(sudo:session): session closed for user root Nov 30 18:03:18 wc volumio[819]: info: Creating Spotify config file Nov 30 18:03:18 wc volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 18:03:20 wc volumio[819]: info: Volumio Calling Home Nov 30 18:03:21 wc systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 30 18:03:21 wc systemd[1]: mpd.service: Failed with result 'protocol'. Nov 30 18:03:21 wc systemd[1]: Failed to start Music Player Daemon. Nov 30 18:03:21 wc sudo[1148]: pam_unix(sudo:session): session closed for user root Nov 30 18:03:21 wc sudo[1154]: pam_unix(sudo:session): session closed for user root Nov 30 18:03:21 wc systemd[1]: Starting Music Player Daemon... Nov 30 18:03:22 wc volumio[819]: info: CoreCommandRouter::volumioClearQueue Nov 30 18:03:22 wc volumio[819]: info: CoreStateMachine::ClearQueue Nov 30 18:03:22 wc volumio[819]: info: CoreStateMachine::stop Nov 30 18:03:22 wc sudo[1182]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 30 18:03:22 wc sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 18:03:22 wc volumio[819]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 30 18:03:22 wc volumio[819]: info: CorePlayQueue::clearPlayQueue Nov 30 18:03:22 wc sudo[1182]: pam_unix(sudo:session): session closed for user root Nov 30 18:03:22 wc volumio[819]: info: CorePlayQueue::saveQueue Nov 30 18:03:22 wc volumio[819]: info: CoreCommandRouter::volumioPushState Nov 30 18:03:22 wc volumio[819]: info: CoreCommandRouter::volumioPushQueue Nov 30 18:03:22 wc volumio[819]: info: CoreCommandRouter::volumioAddQueueItems Nov 30 18:03:22 wc volumio[819]: info: CoreStateMachine::addQueueItems Nov 30 18:03:22 wc volumio[819]: info: CorePlayQueue::addQueueItems Nov 30 18:03:22 wc volumio[819]: info: Preload queue cleared Nov 30 18:03:22 wc volumio[819]: info: Adding Item to queue: mnt/NAS/SAMBA/Lullaby/Hey Jude - Lullaby Renditions of The Beatles - Rockabye Baby!.mp3 Nov 30 18:03:22 wc volumio[819]: info: Exploding uri mnt/NAS/SAMBA/Lullaby/Hey Jude - Lullaby Renditions of The Beatles - Rockabye Baby!.mp3 in service mpd Nov 30 18:03:23 wc volumio[819]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 18:03:23 wc volumio[819]: TypeError: Cannot read property 'then' of undefined Nov 30 18:03:23 wc volumio[819]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19) Nov 30 18:03:23 wc volumio[819]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21) Nov 30 18:03:23 wc volumio[819]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1379:16) Nov 30 18:03:23 wc volumio[819]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Nov 30 18:03:23 wc volumio[819]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Nov 30 18:03:23 wc volumio[819]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Nov 30 18:03:23 wc volumio[819]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Nov 30 18:03:23 wc volumio[819]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:449:28) Nov 30 18:03:23 wc volumio[819]: at /volumio/app/playlistManager.js:726:30 Nov 30 18:03:23 wc volumio[819]: at /volumio/node_modules/jsonfile/index.js:46:5 Nov 30 18:03:23 wc volumio[819]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 18:03:28 wc sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-30 18:02 Nov 30 18:03:28 wc sudo[1212]: 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"