-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2024-05-01 17:19:11 CEST. -- May 01 17:18:21 volumio-mf ntpd[747]: receive: Unexpected origin timestamp 0xe9bd3145.b992888c does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xe9dcdbbd.dbac73de May 01 17:18:21 volumio-mf ntpd[747]: receive: Unexpected origin timestamp 0xe9bd3145.b98f93a7 does not match aorg 0000000000.00000000 from server@212.6.50.243 xmt 0xe9dcdbbd.dda8779b May 01 17:18:21 volumio-mf ntpd[747]: receive: Unexpected origin timestamp 0xe9bd3145.b98061a4 does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xe9dcdbbd.def2f4d3 May 01 17:18:21 volumio-mf dhcpcd[869]: wlan0: carrier acquired May 01 17:18:21 volumio-mf systemd[1]: Starting Daily apt download activities... May 01 17:18:21 volumio-mf dhcpcd[869]: wlan0: IAID eb:9c:0b:62 May 01 17:18:21 volumio-mf dhcpcd[869]: wlan0: probing address 192.168.178.33/24 May 01 17:18:22 volumio-mf wireless.js[528]: trying... May 01 17:18:22 volumio-mf sudo[942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 17:18:22 volumio-mf sudo[942]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:22 volumio-mf sudo[942]: pam_unix(sudo:session): session closed for user root May 01 17:18:22 volumio-mf dhcpcd[869]: wlan0: soliciting an IPv6 router May 01 17:18:23 volumio-mf systemd[1]: apt-daily.service: Succeeded. May 01 17:18:23 volumio-mf systemd[1]: Started Daily apt download activities. May 01 17:18:23 volumio-mf wireless.js[528]: trying... May 01 17:18:23 volumio-mf sudo[990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 17:18:23 volumio-mf sudo[990]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:23 volumio-mf systemd[1]: Starting Daily apt upgrade and clean activities... May 01 17:18:23 volumio-mf sudo[990]: pam_unix(sudo:session): session closed for user root May 01 17:18:24 volumio-mf wireless.js[528]: trying... May 01 17:18:24 volumio-mf sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 17:18:24 volumio-mf sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:24 volumio-mf sudo[1036]: pam_unix(sudo:session): session closed for user root May 01 17:18:24 volumio-mf systemd[1]: apt-daily-upgrade.service: Succeeded. May 01 17:18:24 volumio-mf systemd[1]: Started Daily apt upgrade and clean activities. May 01 17:18:25 volumio-mf wireless.js[528]: trying... May 01 17:18:25 volumio-mf sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 17:18:25 volumio-mf sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:25 volumio-mf sudo[1045]: pam_unix(sudo:session): session closed for user root May 01 17:18:26 volumio-mf wireless.js[528]: trying... May 01 17:18:26 volumio-mf sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 17:18:26 volumio-mf sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:26 volumio-mf sudo[1048]: pam_unix(sudo:session): session closed for user root May 01 17:18:26 volumio-mf dhcpcd[869]: wlan0: using static address 192.168.178.33/24 May 01 17:18:26 volumio-mf avahi-daemon[529]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.33. May 01 17:18:26 volumio-mf kernel: hwmon hwmon1: Voltage normalised May 01 17:18:26 volumio-mf avahi-daemon[529]: New relevant interface wlan0.IPv4 for mDNS. May 01 17:18:26 volumio-mf avahi-daemon[529]: Registering new address record for 192.168.178.33 on wlan0.IPv4. May 01 17:18:26 volumio-mf dhcpcd[869]: wlan0: adding route to 192.168.178.0/24 May 01 17:18:26 volumio-mf dhcpcd[869]: wlan0: adding default route via 192.168.1.1 May 01 17:18:26 volumio-mf dhcpcd[869]: if_route (ADD): Network is unreachable May 01 17:18:27 volumio-mf wireless.js[528]: trying... May 01 17:18:27 volumio-mf sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 17:18:27 volumio-mf sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:27 volumio-mf sudo[1078]: pam_unix(sudo:session): session closed for user root May 01 17:18:27 volumio-mf wireless.js[528]: Connected to: ----FRITZ!Box 4060 KA May 01 17:18:27 volumio-mf wireless.js[528]: ---- May 01 17:18:27 volumio-mf sudo[1081]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 17:18:27 volumio-mf sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:27 volumio-mf sudo[1081]: pam_unix(sudo:session): session closed for user root May 01 17:18:27 volumio-mf wireless.js[528]: ... joined AP, wlan0 IPv4 is 192.168.178.33, ipV6 is undefined May 01 17:18:27 volumio-mf wireless.js[528]: It's done! AP May 01 17:18:27 volumio-mf systemd[1]: Started Wireless Services. May 01 17:18:27 volumio-mf kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 01 17:18:27 volumio-mf systemd[1]: Started Volumio Backend Module. May 01 17:18:27 volumio-mf systemd[1]: Started Volumio Cpu Tweaker. May 01 17:18:27 volumio-mf systemd[1]: Reached target Multi-User System. May 01 17:18:27 volumio-mf systemd[1]: Reached target Graphical Interface. May 01 17:18:27 volumio-mf systemd[1]: Starting Update UTMP about System Runlevel Changes... May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: Setting RT Priority for mpd May 01 17:18:27 volumio-mf systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 01 17:18:27 volumio-mf systemd[1]: Started Update UTMP about System Runlevel Changes. May 01 17:18:27 volumio-mf systemd[1]: Startup finished in 10.193s (kernel) + 27.460s (userspace) = 37.654s. May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: pid 35's current scheduling policy: SCHED_OTHER May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: pid 35's current scheduling priority: 0 May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: Setting MPD Affinity May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: pid 3's current affinity mask: f May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 01 17:18:27 volumio-mf volumio-cpu-tweak[1087]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 01 17:18:27 volumio-mf systemd[1]: volumio_cpu_tweak.service: Succeeded. May 01 17:18:27 volumio-mf ntpd[747]: Listen normally on 4 wlan0 192.168.178.33:123 May 01 17:18:27 volumio-mf ntpd[747]: new interface(s) found: waking up resolver May 01 17:18:28 volumio-mf kernel: hwmon hwmon1: Undervoltage detected! May 01 17:18:31 volumio-mf volumio-remote-updater[523]: [2024-05-01 17:18:31] [connect] Successful connection May 01 17:18:32 volumio-mf volumio[1086]: info: ------------------------------------------- May 01 17:18:32 volumio-mf volumio[1086]: info: ----- Volumio3 ---- May 01 17:18:32 volumio-mf volumio[1086]: info: ------------------------------------------- May 01 17:18:32 volumio-mf volumio[1086]: info: ----- System startup ---- May 01 17:18:32 volumio-mf volumio[1086]: info: ------------------------------------------- May 01 17:18:34 volumio-mf volumio[1086]: info: MYVOLUMIO Environment detected May 01 17:18:34 volumio-mf volumio[1086]: info: Plugin folders cleanup May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning into folder /volumio/app/plugins/ May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning category audio_interface May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning category miscellanea May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning category music_service May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning category plugins.json May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning category system_controller May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning category user_interface May 01 17:18:34 volumio-mf volumio[1086]: info: Scanning into folder /data/plugins/ May 01 17:18:34 volumio-mf volumio[1086]: info: Plugin folders cleanup completed May 01 17:18:34 volumio-mf volumio[1086]: info: ------------------------------------------- May 01 17:18:34 volumio-mf volumio[1086]: info: ----- Core plugins startup ---- May 01 17:18:34 volumio-mf volumio[1086]: info: ------------------------------------------- May 01 17:18:34 volumio-mf volumio[1086]: info: Loading plugins from folder /volumio/app/plugins/ May 01 17:18:34 volumio-mf volumio[1086]: info: Adding plugin upnp to MyMusic Plugins May 01 17:18:34 volumio-mf volumio[1086]: info: Adding plugin airplay_emulation to MyMusic Plugins May 01 17:18:34 volumio-mf volumio[1086]: info: Adding plugin upnp_browser to MyMusic Plugins May 01 17:18:34 volumio-mf volumio[1086]: info: Loading plugins from folder /data/plugins/ May 01 17:18:34 volumio-mf volumio[1086]: info: Loading plugin "system"... May 01 17:18:34 volumio-mf volumio[1086]: info: Loading plugin "appearance"... May 01 17:18:36 volumio-mf systemd[1]: systemd-fsckd.service: Succeeded. May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "network"... May 01 17:18:37 volumio-mf volumio[1086]: info: Refreshing Cached IP Addresses May 01 17:18:37 volumio-mf sudo[1118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 17:18:37 volumio-mf sudo[1118]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "services"... May 01 17:18:37 volumio-mf sudo[1118]: pam_unix(sudo:session): session closed for user root May 01 17:18:37 volumio-mf sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 17:18:37 volumio-mf sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "alsa_controller"... May 01 17:18:37 volumio-mf sudo[1120]: pam_unix(sudo:session): session closed for user root May 01 17:18:37 volumio-mf sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 01 17:18:37 volumio-mf sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:37 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "wizard"... May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "networkfs"... May 01 17:18:37 volumio-mf volumio[1086]: info: Starting Udev Watcher for removable devices May 01 17:18:37 volumio-mf sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Admin,password=FLCmrc14,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.30/Musica /mnt/NAS/NAS_35-1C-70 May 01 17:18:37 volumio-mf sudo[1131]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:37 volumio-mf volumio[1086]: info: Ignoring mount for partition: boot May 01 17:18:37 volumio-mf volumio[1086]: info: Ignoring mount for partition: volumio May 01 17:18:37 volumio-mf volumio[1086]: info: Ignoring mount for partition: volumio_data May 01 17:18:37 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "volumio_command_line_client"... May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "upnp"... May 01 17:18:37 volumio-mf volumio[1086]: info: [1714576717755] Starting Upmpd Daemon May 01 17:18:37 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "my_music"... May 01 17:18:37 volumio-mf volumio[1086]: info: Loading plugin "mpd"... May 01 17:18:38 volumio-mf kernel: Key type cifs.spnego registered May 01 17:18:38 volumio-mf kernel: Key type cifs.idmap registered May 01 17:18:38 volumio-mf 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. May 01 17:18:38 volumio-mf kernel: CIFS: Attempting to mount \\192.168.178.30\Musica May 01 17:18:38 volumio-mf volumio[1086]: info: Loading plugin "upnp_browser"... May 01 17:18:38 volumio-mf sudo[1131]: pam_unix(sudo:session): session closed for user root May 01 17:18:39 volumio-mf volumio[1086]: info: Loading plugin "alarm-clock"... May 01 17:18:39 volumio-mf volumio[1086]: info: Loading plugin "airplay_emulation"... May 01 17:18:40 volumio-mf volumio[1086]: info: Starting Shairport Sync May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "last_100"... May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "webradio"... May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "i2s_dacs"... May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "volumiodiscovery"... May 01 17:18:40 volumio-mf sudo[1123]: pam_unix(sudo:session): session closed for user root May 01 17:18:40 volumio-mf volumio[1086]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 17:18:40 volumio-mf volumio[1086]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 17:18:40 volumio-mf volumio[1086]: *** WARNING *** For more information see May 01 17:18:40 volumio-mf node[1086]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 17:18:40 volumio-mf volumio[1086]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 17:18:40 volumio-mf volumio[1086]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 17:18:40 volumio-mf volumio[1086]: *** WARNING *** For more information see May 01 17:18:40 volumio-mf node[1086]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 17:18:40 volumio-mf node[1086]: *** WARNING *** For more information see May 01 17:18:40 volumio-mf node[1086]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 17:18:40 volumio-mf node[1086]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 17:18:40 volumio-mf node[1086]: *** WARNING *** For more information see May 01 17:18:40 volumio-mf volumio[1086]: info: Applying required configuration parameters for plugin volumiodiscovery May 01 17:18:40 volumio-mf volumio[1086]: info: Discovery: Started advertising with name: Volumio mf May 01 17:18:40 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "outputs"... May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "albumart"... May 01 17:18:40 volumio-mf volumio[1086]: info: Plugin example_plugin is not enabled May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "inputs"... May 01 17:18:40 volumio-mf volumio[1086]: info: Loading plugin "updater_comm"... May 01 17:18:40 volumio-mf systemd[1]: systemd-hostnamed.service: Succeeded. May 01 17:18:41 volumio-mf volumio[1086]: info: Plugin mpdemulation is not enabled May 01 17:18:41 volumio-mf volumio[1086]: info: Loading plugin "rest_api"... May 01 17:18:41 volumio-mf volumio[1086]: info: Loading plugin "websocket"... May 01 17:18:41 volumio-mf volumio[1086]: info: Loading i18n strings for locale it May 01 17:18:41 volumio-mf volumio[1086]: Updating browse sources language May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 17:18:41 volumio-mf volumio[1086]: Forking 3 albumart workers May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::initPlayerControls May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 17:18:41 volumio-mf volumio[1086]: Express server listening on port 3000 May 01 17:18:41 volumio-mf volumio[1086]: [Metrics] WebUI: 11s 192.44ms May 01 17:18:41 volumio-mf volumio[1086]: info: CoreStateMachine::resetVolumioState May 01 17:18:41 volumio-mf volumio[1086]: info: CoreStateMachine::getcurrentVolume May 01 17:18:41 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioRetrievevolume May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 17:18:42 volumio-mf volumio[1086]: info: Discovery: Getting this device information May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 17:18:42 volumio-mf volumio[1086]: info: Discovery: Getting this device information May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 17:18:42 volumio-mf volumio[1086]: info: Reloading queue from file May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 17:18:42 volumio-mf volumio[1086]: info: Setting Device type: Raspberry PI May 01 17:18:42 volumio-mf volumio[1086]: info: CoreStateMachine::setRepeat true single undefined May 01 17:18:42 volumio-mf volumio[1086]: info: CoreStateMachine::pushState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPushState May 01 17:18:42 volumio-mf volumio[1086]: info: CoreStateMachine::setRandom null May 01 17:18:42 volumio-mf volumio[1086]: info: CoreStateMachine::pushState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPushState May 01 17:18:42 volumio-mf volumio[1086]: verbose: New Socket.io Connection to 192.168.178.33 from 192.168.178.20 UA: okhttp/4.9.2 Total Clients: 1 May 01 17:18:42 volumio-mf volumio[1086]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.20 UA: okhttp/4.9.2 Total Clients: 2 May 01 17:18:42 volumio-mf volumio[1086]: info: VolumeController:: Volume=61 Mute =false May 01 17:18:42 volumio-mf volumio[1086]: info: CoreStateMachine::pushState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPushState May 01 17:18:42 volumio-mf volumio[1086]: info: CoreStateMachine::updateTrackBlock May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrackBlock May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioRetrievevolume May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:42 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 01 17:18:42 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 01 17:18:43 volumio-mf volumio[1086]: info: Discovery: adding 9e34190b-73ed-4e73-9d8d-245a166cc365 May 01 17:18:43 volumio-mf volumio[1086]: info: Discovery: Found device Volumio mf May 01 17:18:43 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:43 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:43 volumio-mf volumio[1086]: info: Discovery: this is already registered, 9e34190b-73ed-4e73-9d8d-245a166cc365 May 01 17:18:43 volumio-mf volumio[1086]: info: Discovery: Found device Volumio mf May 01 17:18:43 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:43 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:43 volumio-mf volumio[1086]: info: VolumeController:: Volume=61 Mute =false May 01 17:18:43 volumio-mf volumio[1086]: info: CoreStateMachine::pushState May 01 17:18:43 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:43 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPushState May 01 17:18:43 volumio-mf volumio[1086]: Starting albumart workers May 01 17:18:43 volumio-mf volumio[1086]: Starting albumart workers May 01 17:18:43 volumio-mf volumio[1086]: Starting albumart workers May 01 17:18:46 volumio-mf volumio-remote-updater[523]: [2024-05-01 17:18:46] [connect] Successful connection May 01 17:18:46 volumio-mf volumio-remote-updater[523]: [2024-05-01 17:18:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714576726 101 May 01 17:18:46 volumio-mf volumio[1086]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3 May 01 17:18:47 volumio-mf sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 17:18:47 volumio-mf sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:47 volumio-mf sudo[1227]: pam_unix(sudo:session): session closed for user root May 01 17:18:47 volumio-mf sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 17:18:47 volumio-mf sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:47 volumio-mf sudo[1229]: pam_unix(sudo:session): session closed for user root May 01 17:18:47 volumio-mf volumio[1086]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.20 UA: okhttp/4.9.2 Total Clients: 4 May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetVisibleSources May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:47 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 01 17:18:47 volumio-mf sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 17:18:47 volumio-mf sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:47 volumio-mf sudo[1233]: pam_unix(sudo:session): session closed for user root May 01 17:18:47 volumio-mf sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 17:18:47 volumio-mf sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:47 volumio-mf sudo[1235]: pam_unix(sudo:session): session closed for user root May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 17:18:47 volumio-mf volumio[1086]: info: Received Get System Info May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 17:18:47 volumio-mf volumio[1086]: info: Discovery: Getting this device information May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:47 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:47 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:47 volumio-mf volumio[1086]: info: Listing playlists May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 01 17:18:47 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 17:18:48 volumio-mf sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 01 17:18:48 volumio-mf sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 17:18:48 volumio-mf systemd[1]: Started UPnP Renderer front-end to MPD. May 01 17:18:48 volumio-mf sudo[1239]: pam_unix(sudo:session): session closed for user root May 01 17:18:48 volumio-mf volumio[1086]: info: Upmpdcli Daemon Started May 01 17:18:48 volumio-mf volumio[1086]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 17:18:49 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 17:18:49 volumio-mf volumio[1086]: info: Received Get System Info May 01 17:18:49 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 17:18:49 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 17:18:49 volumio-mf volumio[1086]: info: Discovery: Getting this device information May 01 17:18:49 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:49 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:49 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 17:18:50 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 17:18:50 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 01 17:18:50 volumio-mf volumio[1086]: info: Received Get System Info May 01 17:18:50 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 17:18:50 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 17:18:50 volumio-mf volumio[1086]: info: Discovery: Getting this device information May 01 17:18:50 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:18:50 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:50 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 17:18:51 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 01 17:18:52 volumio-mf volumio[1086]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 17:18:53 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPlay May 01 17:18:53 volumio-mf volumio[1086]: info: CoreStateMachine::play index undefined May 01 17:18:53 volumio-mf volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 17:18:53 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:53 volumio-mf volumio[1086]: info: CoreStateMachine::startPlaybackTimer May 01 17:18:53 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:53 volumio-mf volumio[1086]: info: [1714576733228] ControllerWebradio::clearAddPlayTrack May 01 17:18:53 volumio-mf kernel: hwmon hwmon1: Voltage normalised May 01 17:18:57 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPlay May 01 17:18:57 volumio-mf volumio[1086]: info: CoreStateMachine::play index undefined May 01 17:18:57 volumio-mf volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 17:18:57 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:57 volumio-mf volumio[1086]: info: CoreStateMachine::startPlaybackTimer May 01 17:18:57 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:18:57 volumio-mf volumio[1086]: info: [1714576737500] ControllerWebradio::clearAddPlayTrack May 01 17:18:58 volumio-mf volumio[1086]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 17:19:00 volumio-mf kernel: hwmon hwmon1: Undervoltage detected! May 01 17:19:04 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetQueue May 01 17:19:04 volumio-mf volumio[1086]: info: CoreStateMachine::getQueue May 01 17:19:04 volumio-mf volumio[1086]: info: CorePlayQueue::getQueue May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 01 17:19:05 volumio-mf volumio[1086]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 01 17:19:05 volumio-mf volumio[1086]: info: Received Get System Version May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 17:19:05 volumio-mf volumio[1086]: info: Received Get System Info May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 01 17:19:05 volumio-mf volumio[1086]: info: Discovery: Getting this device information May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioGetState May 01 17:19:05 volumio-mf volumio[1086]: info: CorePlayQueue::getTrack 0 May 01 17:19:05 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 01 17:19:08 volumio-mf volumiologrotate[512]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory May 01 17:19:08 volumio-mf volumiologrotate[512]: ls: cannot access 'MF': No such file or directory May 01 17:19:08 volumio-mf volumio[1086]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 17:19:08 volumio-mf kernel: hwmon hwmon1: Voltage normalised May 01 17:19:09 volumio-mf volumio[1086]: info: Preload queue cleared May 01 17:19:09 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioReplaceandPlayItems May 01 17:19:09 volumio-mf volumio[1086]: info: CoreStateMachine::ClearQueue May 01 17:19:09 volumio-mf volumio[1086]: info: CoreStateMachine::stop May 01 17:19:09 volumio-mf volumio[1086]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 17:19:09 volumio-mf volumio[1086]: info: CorePlayQueue::clearPlayQueue May 01 17:19:09 volumio-mf volumio[1086]: info: CorePlayQueue::saveQueue May 01 17:19:09 volumio-mf volumio[1086]: info: CoreCommandRouter::volumioPushQueue May 01 17:19:09 volumio-mf volumio[1086]: info: CoreStateMachine::addQueueItems May 01 17:19:09 volumio-mf volumio[1086]: info: CorePlayQueue::addQueueItems May 01 17:19:09 volumio-mf volumio[1086]: info: Preload queue cleared May 01 17:19:09 volumio-mf volumio[1086]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s304644 May 01 17:19:09 volumio-mf volumio[1086]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 01 17:19:09 volumio-mf volumio[1086]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 17:19:09 volumio-mf volumio[1086]: TypeError: Cannot read property 'tune_radio' of undefined May 01 17:19:09 volumio-mf volumio[1086]: at ControllerWebradio.explodeUri (/volumio/app/plugins/music_service/webradio/index.js:539:33) May 01 17:19:09 volumio-mf volumio[1086]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) May 01 17:19:09 volumio-mf volumio[1086]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:179:33) May 01 17:19:09 volumio-mf volumio[1086]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) May 01 17:19:09 volumio-mf volumio[1086]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) May 01 17:19:09 volumio-mf volumio[1086]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) May 01 17:19:09 volumio-mf volumio[1086]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) May 01 17:19:09 volumio-mf volumio[1086]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) May 01 17:19:09 volumio-mf volumio[1086]: at Socket.emit (events.js:315:20) May 01 17:19:09 volumio-mf volumio[1086]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 01 17:19:09 volumio-mf volumio[1086]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 01 17:19:09 volumio-mf volumio[1086]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 17:19:10 volumio-mf kernel: hwmon hwmon1: Undervoltage detected! May 01 17:19:11 volumio-mf sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 17:18 May 01 17:19:11 volumio-mf sudo[1292]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"