Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:25:00 volumio volumio[1340]: info: Received Get System Info Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:00 volumio volumio[1340]: info: Discovery: Getting this device information Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:00 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:25:00 volumio volumio[1340]: info: Received Get System Info Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:00 volumio volumio[1340]: info: Discovery: Getting this device information Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:00 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:00 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:25:04 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Dec 16 16:25:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Dec 16 16:25:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:25:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:25:06 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:25:07 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:25:08 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 16:25:08 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 16:25:10 volumio volumio[1340]: info: CoreCommandRouter::Close All Modals sent Dec 16 16:25:10 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Dec 16 16:26:00 volumio hostapd[2188]: wlan0: STA a0:b3:39:4c:6b:a7 IEEE 802.11: authenticated Dec 16 16:26:00 volumio hostapd[2188]: wlan0: STA a0:b3:39:4c:6b:a7 IEEE 802.11: associated (aid 1) Dec 16 16:26:00 volumio hostapd[2188]: wlan0: STA a0:b3:39:4c:6b:a7 RADIUS: starting accounting session F350263459F731C8 Dec 16 16:26:00 volumio dnsmasq-dhcp[2193]: DHCPREQUEST(wlan0) 192.168.211.185 a0:b3:39:4c:6b:a7 Dec 16 16:26:00 volumio dnsmasq-dhcp[2193]: DHCPACK(wlan0) 192.168.211.185 a0:b3:39:4c:6b:a7 nemo Dec 16 16:26:02 volumio sudo[3574]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:02 volumio sudo[3574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:02 volumio sudo[3572]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:26:02 volumio sudo[3572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:02 volumio sudo[3574]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:02 volumio sudo[3572]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:02 volumio volumio[1340]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.185 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 5 Dec 16 16:26:03 volumio sudo[3581]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:26:03 volumio sudo[3581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:03 volumio sudo[3581]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:03 volumio sudo[3583]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:03 volumio sudo[3583]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:03 volumio sudo[3583]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:03 volumio volumio[1340]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.185 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 5 Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:03 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:26:03 volumio volumio[1340]: info: Received Get System Info Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:26:03 volumio volumio[1340]: info: Discovery: Getting this device information Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:03 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:03 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:03 volumio volumio[1340]: info: Listing playlists Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:26:03 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:26:04 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:04 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:04 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:26:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:26:05 volumio volumio[1340]: info: Received Get System Info Dec 16 16:26:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:26:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:26:05 volumio volumio[1340]: info: Discovery: Getting this device information Dec 16 16:26:05 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:05 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:05 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:26:12 volumio volumio[1340]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:26:12 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 16 16:26:12 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 16 16:26:12 volumio sudo[3621]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 16 16:26:12 volumio sudo[3621]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio sudo[3626]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 16:26:12 volumio sudo[3626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio sudo[3632]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 16:26:12 volumio sudo[3632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio sudo[3632]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:12 volumio sudo[3626]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:12 volumio sudo[3636]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 16:26:12 volumio sudo[3636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio sudo[3636]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:12 volumio sudo[3644]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:26:12 volumio sudo[3644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 16 16:26:12 volumio sudo[3644]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:12 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 16 16:26:12 volumio sudo[3649]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:12 volumio sudo[3649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio sudo[3651]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 16 16:26:12 volumio sudo[3651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:12 volumio sudo[3621]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:12 volumio sudo[3649]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:13 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 16:26:19 volumio sudo[3651]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:27 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Dec 16 16:26:27 volumio volumio[1340]: info: Saving new wireless network Dec 16 16:26:28 volumio sudo[3686]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Dec 16 16:26:28 volumio sudo[3686]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:28 volumio sudo[3686]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:28 volumio volumio[1340]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 16 16:26:28 volumio volumio[1340]: info: Discovery: Restarting Advertising due to device name change Dec 16 16:26:28 volumio sudo[3690]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 16 16:26:28 volumio sudo[3690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:28 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 16 16:26:28 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 16 16:26:28 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 16 16:26:28 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 16 16:26:28 volumio wireless.js[3692]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 16 16:26:28 volumio wireless.js[3692]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 16 16:26:28 volumio wireless.js[3692]: WIRELESS.JS: Cleaning previous... Dec 16 16:26:28 volumio systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Dec 16 16:26:28 volumio dnsmasq[2193]: exiting on receipt of SIGTERM Dec 16 16:26:28 volumio systemd[1]: dnsmasq.service: Deactivated successfully. Dec 16 16:26:28 volumio systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Dec 16 16:26:28 volumio systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Dec 16 16:26:28 volumio dhcpcd[1026]: wlan0: carrier lost Dec 16 16:26:28 volumio avahi-daemon[946]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 16 16:26:28 volumio avahi-daemon[946]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 16 16:26:28 volumio avahi-daemon[946]: Withdrawing address record for 192.168.211.1 on wlan0. Dec 16 16:26:28 volumio volumio[1340]: info: Discovery: A device disappeared from network Dec 16 16:26:28 volumio volumio[1340]: info: Discovery: Device volumio disappeared from network Dec 16 16:26:28 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 16 16:26:28 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 16 16:26:28 volumio kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring Dec 16 16:26:28 volumio avahi-daemon[946]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 16 16:26:28 volumio avahi-daemon[946]: New relevant interface wlan0.IPv4 for mDNS. Dec 16 16:26:28 volumio avahi-daemon[946]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Dec 16 16:26:28 volumio systemd[1]: hostapd.service: Deactivated successfully. Dec 16 16:26:28 volumio systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Dec 16 16:26:28 volumio sudo[3726]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 16 16:26:28 volumio sudo[3726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:28 volumio avahi-daemon[946]: Withdrawing address record for 192.168.211.1 on wlan0. Dec 16 16:26:28 volumio avahi-daemon[946]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Dec 16 16:26:28 volumio avahi-daemon[946]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 16 16:26:28 volumio sudo[3726]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:28 volumio sudo[3729]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 16 16:26:28 volumio sudo[3729]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:28 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 16 16:26:28 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 16 16:26:28 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 16 16:26:28 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 16 16:26:28 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 16 16:26:28 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 16 16:26:28 volumio sudo[3729]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:28 volumio welcome[3731]: Resolved ip:[0] Dec 16 16:26:28 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 16 16:26:28 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 16 16:26:28 volumio wireless.js[3692]: WIRELESS.JS: Stopped aP Dec 16 16:26:28 volumio sudo[3742]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 16 16:26:28 volumio sudo[3742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:28 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 16 16:26:28 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 16 16:26:28 volumio kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring Dec 16 16:26:28 volumio sudo[3742]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:28 volumio sudo[3744]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 16 16:26:28 volumio sudo[3744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:28 volumio sudo[3744]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:28 volumio sudo[3752]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 16 16:26:28 volumio sudo[3752]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:28 volumio sudo[3752]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:28 volumio sudo[3754]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 16 16:26:28 volumio sudo[3754]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:29 volumio volumio[1340]: info: Discovery: A device disappeared from network Dec 16 16:26:29 volumio sudo[3760]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:29 volumio sudo[3760]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:29 volumio sudo[3760]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:29 volumio ntpd[1167]: IO: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=281 secs Dec 16 16:26:30 volumio sudo[3781]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:30 volumio sudo[3781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:30 volumio sudo[3781]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:31 volumio sudo[3786]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:31 volumio sudo[3786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:31 volumio sudo[3786]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio sudo[3790]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:32 volumio sudo[3790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:32 volumio sudo[3790]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio sudo[3754]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio wireless.js[3692]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: FR Dec 16 16:26:32 volumio sudo[3795]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 16 16:26:32 volumio sudo[3795]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:32 volumio sudo[3795]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio sudo[3797]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set FR Dec 16 16:26:32 volumio sudo[3797]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:32 volumio sudo[3797]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio wireless.js[3692]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: FR Dec 16 16:26:32 volumio wireless.js[3692]: WIRELESS.JS: Start wireless flow Dec 16 16:26:32 volumio wireless.js[3692]: WIRELESS.JS: Stopped hotspot (if there).. Dec 16 16:26:32 volumio sudo[3805]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 16 16:26:32 volumio sudo[3805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:32 volumio sudo[3805]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio sudo[3807]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 16 16:26:32 volumio sudo[3807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:32 volumio sudo[3807]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio wireless.js[3692]: WIRELESS.JS: DHCP IP fallback Dec 16 16:26:32 volumio wireless.js[3692]: WIRELESS.JS: Start ap Dec 16 16:26:32 volumio wpa_supplicant[3812]: Successfully initialized wpa_supplicant Dec 16 16:26:32 volumio sudo[3813]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 16 16:26:32 volumio sudo[3813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:32 volumio dhcpcd[1026]: control command: /sbin/dhcpcd Dec 16 16:26:32 volumio sudo[3813]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:32 volumio dhcpcd[1026]: control_free: No such file or directory Dec 16 16:26:32 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 16 16:26:32 volumio kernel: iwlwifi 0000:02:00.0: Applying debug destination EXTERNAL_DRAM Dec 16 16:26:32 volumio kernel: iwlwifi 0000:02:00.0: FW already configured (0) - re-configuring Dec 16 16:26:32 volumio dhcpcd[1026]: lo: IAID 00:00:00:00 Dec 16 16:26:32 volumio dhcpcd[1026]: lo: adding address fe80::e4de:83c4:3874:e0b4 Dec 16 16:26:32 volumio dhcpcd[1026]: ipv6_addaddr1: Permission denied Dec 16 16:26:32 volumio dhcpcd[1026]: lo: using static address 127.0.0.1/8 Dec 16 16:26:32 volumio dhcpcd[1026]: lo: adding route to 127.0.0.0/8 Dec 16 16:26:32 volumio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Dec 16 16:26:32 volumio wpa_supplicant[3843]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=WORLD Dec 16 16:26:33 volumio volumio[1340]: info: Discovery: Started advertising with name: Volumio Dec 16 16:26:33 volumio sudo[3846]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:33 volumio sudo[3846]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:33 volumio sudo[3846]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:33 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:33 volumio sudo[3851]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:33 volumio sudo[3851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:33 volumio sudo[3851]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:34 volumio volumio[1340]: info: Discovery: adding e2dba1bf-2de6-4d2f-ac76-16712d6dd2e3 Dec 16 16:26:34 volumio volumio[1340]: info: Discovery: Found device Volumio Dec 16 16:26:34 volumio volumio[1340]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:34 volumio volumio[1340]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:34 volumio sudo[3856]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:34 volumio sudo[3856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:34 volumio sudo[3856]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:34 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:34 volumio sudo[3860]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:34 volumio sudo[3860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:34 volumio sudo[3860]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:35 volumio sudo[3864]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:35 volumio sudo[3864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:35 volumio sudo[3864]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:35 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:35 volumio sudo[3868]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:35 volumio sudo[3868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:35 volumio sudo[3868]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:36 volumio sudo[3872]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:36 volumio sudo[3872]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:36 volumio sudo[3872]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:36 volumio wpa_supplicant[3843]: wlan0: SME: Trying to authenticate with 56:bb:9e:fe:dd:ae (SSID='DIRECT-TF-1' freq=5745 MHz) Dec 16 16:26:36 volumio kernel: wlan0: authenticate with 56:bb:9e:fe:dd:ae (local address=00:21:5c:bf:41:bd) Dec 16 16:26:36 volumio kernel: wlan0: send auth to 56:bb:9e:fe:dd:ae (try 1/3) Dec 16 16:26:36 volumio wpa_supplicant[3843]: wlan0: Trying to associate with 56:bb:9e:fe:dd:ae (SSID='DIRECT-TF-1' freq=5745 MHz) Dec 16 16:26:36 volumio kernel: wlan0: authenticated Dec 16 16:26:36 volumio kernel: wlan0: associate with 56:bb:9e:fe:dd:ae (try 1/3) Dec 16 16:26:36 volumio wpa_supplicant[3843]: wlan0: Associated with 56:bb:9e:fe:dd:ae Dec 16 16:26:36 volumio wpa_supplicant[3843]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 16 16:26:36 volumio kernel: wlan0: RX AssocResp from 56:bb:9e:fe:dd:ae (capab=0x1431 status=0 aid=8) Dec 16 16:26:36 volumio kernel: wlan0: associated Dec 16 16:26:36 volumio wpa_supplicant[3843]: wlan0: WPA: Key negotiation completed with 56:bb:9e:fe:dd:ae [PTK=CCMP GTK=CCMP] Dec 16 16:26:36 volumio wpa_supplicant[3843]: wlan0: CTRL-EVENT-CONNECTED - Connection to 56:bb:9e:fe:dd:ae completed [id=0 id_str=] Dec 16 16:26:36 volumio dhcpcd[1026]: wlan0: carrier acquired Dec 16 16:26:36 volumio dhcpcd[1026]: wlan0: connected to Access Point: DIRECT-TF-1 Dec 16 16:26:36 volumio kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 56:bb:9e:fe:dd:ae Dec 16 16:26:36 volumio dhcpcd[1026]: wlan0: IAID 5c:bf:41:bd Dec 16 16:26:36 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:36 volumio sudo[3877]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:36 volumio sudo[3877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:36 volumio sudo[3877]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:36 volumio dhcpcd[1026]: wlan0: soliciting an IPv6 router Dec 16 16:26:37 volumio sudo[3880]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:37 volumio sudo[3880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:37 volumio sudo[3880]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:37 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:37 volumio sudo[3885]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:37 volumio sudo[3885]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:37 volumio sudo[3885]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:37 volumio dhcpcd[1026]: wlan0: soliciting a DHCP lease Dec 16 16:26:37 volumio dhcpcd[1026]: wlan0: offered 192.168.54.58 from 192.168.54.91 Dec 16 16:26:37 volumio dhcpcd[1026]: wlan0: probing address 192.168.54.58/24 Dec 16 16:26:38 volumio sudo[3890]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:38 volumio sudo[3890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:38 volumio sudo[3890]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:38 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:38 volumio sudo[3895]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:38 volumio sudo[3895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:38 volumio sudo[3895]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:39 volumio sudo[3898]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:39 volumio sudo[3898]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:39 volumio sudo[3898]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:39 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:39 volumio sudo[3903]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:39 volumio sudo[3903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:39 volumio sudo[3903]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:40 volumio sudo[3920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:40 volumio sudo[3920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:40 volumio sudo[3920]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:40 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:40 volumio sudo[3925]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:40 volumio sudo[3925]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:40 volumio sudo[3925]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:41 volumio sudo[3928]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:41 volumio sudo[3928]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:41 volumio sudo[3928]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:41 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:41 volumio sudo[3933]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:41 volumio sudo[3933]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:41 volumio sudo[3933]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:42 volumio dhcpcd[1026]: wlan0: leased 192.168.54.58 for 3599 seconds Dec 16 16:26:42 volumio avahi-daemon[946]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.54.58. Dec 16 16:26:42 volumio avahi-daemon[946]: New relevant interface wlan0.IPv4 for mDNS. Dec 16 16:26:42 volumio avahi-daemon[946]: Registering new address record for 192.168.54.58 on wlan0.IPv4. Dec 16 16:26:42 volumio dhcpcd[1026]: wlan0: adding route to 192.168.54.0/24 Dec 16 16:26:42 volumio dhcpcd[1026]: wlan0: adding default route via 192.168.54.91 Dec 16 16:26:42 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 16 16:26:42 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 16 16:26:42 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 16 16:26:42 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 16 16:26:42 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 16 16:26:42 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 16 16:26:42 volumio welcome[3949]: Resolved ip:[1] 192.168.54.58 Dec 16 16:26:42 volumio sudo[3956]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:42 volumio sudo[3956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:42 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 16 16:26:42 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 16 16:26:42 volumio sudo[3956]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:42 volumio sudo[3965]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 16 16:26:42 volumio sudo[3965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:42 volumio sudo[3965]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:42 volumio wireless.js[3692]: WIRELESS.JS: trying... Dec 16 16:26:42 volumio sudo[3974]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 16:26:42 volumio sudo[3974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:42 volumio sudo[3974]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:42 volumio wireless.js[3692]: WIRELESS.JS: Connected to: ----DIRECT-TF-1---- Dec 16 16:26:42 volumio sudo[3977]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:42 volumio sudo[3977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:42 volumio sudo[3977]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:42 volumio wireless.js[3692]: WIRELESS.JS: ... joined AP, wlan0 IPv4 is 192.168.54.58, ipV6 is undefined Dec 16 16:26:42 volumio wireless.js[3692]: WIRELESS.JS: It's done! AP Dec 16 16:26:42 volumio wireless.js[3692]: WIRELESS.JS: Restarting avahi-daemon... Dec 16 16:26:42 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 16 16:26:42 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 16 16:26:42 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:26:42 volumio systemd[1]: shairport-sync.service: Consumed 2.005s CPU time. Dec 16 16:26:42 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 16 16:26:42 volumio wireless.js[3692]: WIRELESS.JS: Notified systemd about wireless ready Dec 16 16:26:42 volumio sudo[3690]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:42 volumio avahi-daemon[946]: Got SIGTERM, quitting. Dec 16 16:26:42 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 16 16:26:42 volumio avahi-daemon[946]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 16 16:26:42 volumio avahi-daemon[946]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.54.58. Dec 16 16:26:42 volumio dbus-daemon[948]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.37' (uid=0 pid=1489 comm="/usr/sbin/smbd --foreground --no-process-group") Dec 16 16:26:42 volumio volumio-remote-updater[2972]: [2025-12-16 15:26:42] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 16 16:26:42 volumio volumio-remote-updater[2972]: [2025-12-16 15:26:42] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 16 16:26:42 volumio avahi-daemon[946]: avahi-daemon 0.8 exiting. Dec 16 16:26:42 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Dec 16 16:26:42 volumio systemd[1]: avahi-daemon.service: Deactivated successfully. Dec 16 16:26:42 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 16 16:26:42 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 16 16:26:42 volumio avahi-daemon[3991]: Process 946 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Dec 16 16:26:42 volumio avahi-daemon[3991]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Dec 16 16:26:42 volumio systemd[1]: volumio.service: Failed with result 'signal'. Dec 16 16:26:42 volumio avahi-daemon[3991]: Successfully dropped root privileges. Dec 16 16:26:42 volumio avahi-daemon[3991]: avahi-daemon 0.8 starting up. Dec 16 16:26:42 volumio systemd[1]: volumio.service: Consumed 5min 15.870s CPU time. Dec 16 16:26:42 volumio dbus-daemon[948]: [system] Successfully activated service 'org.freedesktop.Avahi' Dec 16 16:26:42 volumio avahi-daemon[3991]: Successfully called chroot(). Dec 16 16:26:42 volumio avahi-daemon[3991]: Successfully dropped remaining capabilities. Dec 16 16:26:42 volumio avahi-daemon[3991]: No service file found in /etc/avahi/services. Dec 16 16:26:42 volumio avahi-daemon[3991]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.54.58. Dec 16 16:26:42 volumio avahi-daemon[3991]: New relevant interface wlan0.IPv4 for mDNS. Dec 16 16:26:42 volumio avahi-daemon[3991]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 16 16:26:42 volumio avahi-daemon[3991]: New relevant interface lo.IPv4 for mDNS. Dec 16 16:26:42 volumio avahi-daemon[3991]: Network interface enumeration completed. Dec 16 16:26:42 volumio avahi-daemon[3991]: Registering new address record for 192.168.54.58 on wlan0.IPv4. Dec 16 16:26:42 volumio avahi-daemon[3991]: Registering new address record for 127.0.0.1 on lo.IPv4. Dec 16 16:26:42 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Dec 16 16:26:42 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 16 16:26:42 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:26:42 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Dec 16 16:26:42 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Dec 16 16:26:42 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Dec 16 16:26:42 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Dec 16 16:26:42 volumio systemd[1]: volumio.service: Consumed 5min 15.870s CPU time. Dec 16 16:26:42 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Dec 16 16:26:42 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Dec 16 16:26:43 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:43 volumio volumio[4026]: info: ----- Volumio3 ---- Dec 16 16:26:43 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:43 volumio volumio[4026]: info: ----- System startup ---- Dec 16 16:26:43 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:43 volumio volumio[4026]: info: MYVOLUMIO Environment detected Dec 16 16:26:43 volumio volumio[4026]: info: Plugin folders cleanup Dec 16 16:26:43 volumio volumio[4026]: info: Scanning into folder /volumio/app/plugins/ Dec 16 16:26:43 volumio volumio[4026]: info: Scanning category audio_interface Dec 16 16:26:43 volumio volumio[4026]: info: Scanning category miscellanea Dec 16 16:26:43 volumio volumio[4026]: info: Scanning category music_service Dec 16 16:26:43 volumio volumio[4026]: info: Scanning category plugins.json Dec 16 16:26:43 volumio volumio[4026]: info: Scanning category system_controller Dec 16 16:26:43 volumio volumio[4026]: info: Scanning category user_interface Dec 16 16:26:43 volumio volumio[4026]: info: Scanning into folder /data/plugins/ Dec 16 16:26:43 volumio volumio[4026]: info: Plugin folders cleanup completed Dec 16 16:26:43 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:43 volumio volumio[4026]: info: ----- Core plugins startup ---- Dec 16 16:26:43 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugins from folder /volumio/app/plugins/ Dec 16 16:26:43 volumio volumio[4026]: info: Adding plugin upnp to MyMusic Plugins Dec 16 16:26:43 volumio volumio[4026]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 16 16:26:43 volumio volumio[4026]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugins from folder /data/plugins/ Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "system"... Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "appearance"... Dec 16 16:26:43 volumio avahi-daemon[3991]: Server startup complete. Host name is volumio.local. Local service cookie is 1920497080. Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "network"... Dec 16 16:26:43 volumio volumio[4026]: info: Refreshing Cached IP Addresses Dec 16 16:26:43 volumio sudo[4073]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:26:43 volumio sudo[4073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:43 volumio sudo[4075]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:26:43 volumio sudo[4075]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:43 volumio sudo[4073]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "services"... Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "alsa_controller"... Dec 16 16:26:43 volumio sudo[4075]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:43 volumio sudo[4084]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 16 16:26:43 volumio sudo[4084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:43 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "wizard"... Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "networkfs"... Dec 16 16:26:43 volumio volumio[4026]: info: Starting Udev Watcher for removable devices Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: boot Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: volumio Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: volumio_data Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: MYMUSIC Dec 16 16:26:43 volumio ntpd[1167]: IO: Listen normally on 5 wlan0 192.168.54.58:123 Dec 16 16:26:43 volumio ntpd[1167]: IO: new interface(s) found: waking up resolver Dec 16 16:26:43 volumio ntpd[1167]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: 5721-3C67 Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: fbcec3ff-c508-49d8-a4d4-3a263c287ae6 Dec 16 16:26:43 volumio volumio[4026]: info: Ignoring mount for partition: 6c3f8501-0510-41fb-8119-2563da5b5ffa Dec 16 16:26:43 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "volumio_command_line_client"... Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "upnp"... Dec 16 16:26:43 volumio volumio[4026]: info: [1765898803905] Starting Upmpd Daemon Dec 16 16:26:43 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "my_music"... Dec 16 16:26:43 volumio volumio[4026]: info: Loading plugin "mpd"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "upnp_browser"... Dec 16 16:26:44 volumio ntpd[1167]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 16 16:26:44 volumio ntpd[1167]: DNS: Pool taking: 54.36.61.42 Dec 16 16:26:44 volumio ntpd[1167]: DNS: Pool taking: 172.234.184.36 Dec 16 16:26:44 volumio ntpd[1167]: DNS: Pool taking: 109.190.177.203 Dec 16 16:26:44 volumio ntpd[1167]: DNS: Pool taking: 82.64.42.185 Dec 16 16:26:44 volumio ntpd[1167]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 16 16:26:44 volumio volumio[4026]: info: Starting UPNP Browser Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "alarm-clock"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "airplay_emulation"... Dec 16 16:26:44 volumio volumio[4026]: info: Starting Shairport Sync Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "last_100"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "webradio"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "i2s_dacs"... Dec 16 16:26:44 volumio volumio[4026]: info: I2S DAC not set, start Auto-detection Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "volumiodiscovery"... Dec 16 16:26:44 volumio volumio[4026]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 16 16:26:44 volumio volumio[4026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:26:44 volumio volumio[4026]: *** WARNING *** For more information see Dec 16 16:26:44 volumio volumio[4026]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 16 16:26:44 volumio volumio[4026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:26:44 volumio volumio[4026]: *** WARNING *** For more information see Dec 16 16:26:44 volumio node[4026]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 16 16:26:44 volumio node[4026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:26:44 volumio node[4026]: *** WARNING *** For more information see Dec 16 16:26:44 volumio node[4026]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 16 16:26:44 volumio node[4026]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:26:44 volumio node[4026]: *** WARNING *** For more information see Dec 16 16:26:44 volumio volumio[4026]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 16 16:26:44 volumio volumio[4026]: info: Discovery: Started advertising with name: Volumio Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "outputs"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "albumart"... Dec 16 16:26:44 volumio volumio[4026]: info: Plugin example_plugin is not enabled Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "inputs"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "updater_comm"... Dec 16 16:26:44 volumio volumio[4026]: info: Plugin mpdemulation is not enabled Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "rest_api"... Dec 16 16:26:44 volumio volumio[4026]: info: Loading plugin "websocket"... Dec 16 16:26:44 volumio volumio[4026]: info: Starting Socket.io Server version 1.7.4 Dec 16 16:26:44 volumio volumio[4026]: info: Loading i18n strings for locale fr Dec 16 16:26:44 volumio volumio[4026]: Updating browse sources language Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:26:44 volumio volumio[4126]: Forking 3 albumart workers Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::initPlayerControls Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: Express server listening on port 3000 Dec 16 16:26:44 volumio volumio[4026]: [Metrics] WebUI: 1s 517.93ms Dec 16 16:26:44 volumio volumio[4026]: info: Setting Device type: x86 Dec 16 16:26:44 volumio volumio[4026]: info: CoreStateMachine::resetVolumioState Dec 16 16:26:44 volumio volumio[4026]: info: CoreStateMachine::getcurrentVolume Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::volumioRetrievevolume Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 16 16:26:44 volumio volumio[4026]: info: Completed loading Core Plugins Dec 16 16:26:44 volumio volumio[4026]: info: Preparing to generate the ALSA configuration file Dec 16 16:26:44 volumio volumio[4026]: info: Cannot read play queue from file Dec 16 16:26:44 volumio volumio[4026]: info: Volumio Network Manager: Network status updated: 2 Dec 16 16:26:44 volumio volumio[4026]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 16 16:26:44 volumio volumio[4026]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 16 16:26:44 volumio volumio[4026]: info: VolumeController:: Volume=100 Mute =false Dec 16 16:26:44 volumio volumio[4026]: info: CoreStateMachine::pushState Dec 16 16:26:44 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::volumioPushState Dec 16 16:26:44 volumio volumio[4026]: info: CoreStateMachine::updateTrackBlock Dec 16 16:26:44 volumio volumio[4026]: info: CorePlayQueue::getTrackBlock Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::volumioRetrievevolume Dec 16 16:26:44 volumio volumio[4026]: info: Asound.conf file unchanged, so no further update is needed Dec 16 16:26:44 volumio volumio[4026]: info: Output device has changed, restarting MPD Dec 16 16:26:44 volumio volumio[4026]: info: Output device has changed, restarting Shairport Sync Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:44 volumio ntpd[1167]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 16:26:44 volumio sudo[4179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 16 16:26:44 volumio sudo[4179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:44 volumio sudo[4177]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 16 16:26:44 volumio sudo[4177]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:44 volumio volumio[4136]: Starting albumart workers Dec 16 16:26:44 volumio volumio[4026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 16:26:44 volumio sudo[4177]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:44 volumio volumio[4026]: info: ___________ START PLUGINS ___________ Dec 16 16:26:44 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 16 16:26:44 volumio volumio[4026]: info: ControllerMpd::onStart: Initializing MPD Dec 16 16:26:44 volumio volumio[4026]: info: Creating MPD Configuration file Dec 16 16:26:44 volumio volumio[4137]: Starting albumart workers Dec 16 16:26:44 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 16 16:26:44 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 16 16:26:44 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:26:44 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 16 16:26:44 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 16:26:44 volumio volumio[4026]: info: [1765898804915] CoreMusicLibrary::Adding element Serveurs Média Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:26:44 volumio volumio[4138]: Starting albumart workers Dec 16 16:26:44 volumio sudo[4188]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 16 16:26:44 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:44 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:44 volumio volumio[4026]: info: UPNP Browser: Client initialized successfully Dec 16 16:26:44 volumio sudo[4189]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 16 16:26:44 volumio sudo[4189]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:44 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 16 16:26:44 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 16 16:26:44 volumio volumio[4026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:44 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 16 16:26:44 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 16 16:26:44 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 16 16:26:44 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 16 16:26:44 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 16 16:26:44 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 16 16:26:44 volumio volumio[4026]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 16:26:44 volumio volumio[4026]: info: [1765898804979] CoreMusicLibrary::Adding element Last_100 Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 16:26:44 volumio volumio[4026]: info: [1765898804981] CoreMusicLibrary::Adding element Webradio Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:26:44 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 16 16:26:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:26:44 volumio volumio[4026]: info: Initializing BBC Radios Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: Volumio Calling Home Dec 16 16:26:45 volumio sudo[4204]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 16 16:26:45 volumio sudo[4204]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:26:45 volumio sudo[4204]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio ntpd[1167]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 79.143.250.33 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 38.143.19.16 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 37.59.63.125 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 45.90.162.253 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 2a12:bec4:1821:25c:1246:1246:1246:1246 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 2001:41d0:a:6d54:: Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 2a01:cb00:129e:a803::104 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 2a01:e0a:fc:9551::3:9 Dec 16 16:26:45 volumio ntpd[1167]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 16 16:26:45 volumio volumio[4026]: info: CoreStateMachine::setRepeat null single undefined Dec 16 16:26:45 volumio volumio[4026]: info: CoreStateMachine::pushState Dec 16 16:26:45 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::volumioPushState Dec 16 16:26:45 volumio volumio[4026]: info: CoreStateMachine::setRandom null Dec 16 16:26:45 volumio volumio[4026]: info: CoreStateMachine::pushState Dec 16 16:26:45 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::volumioPushState Dec 16 16:26:45 volumio volumio[4026]: info: MPD Permissions set Dec 16 16:26:45 volumio volumio[4026]: info: MPD Permissions set Dec 16 16:26:45 volumio volumio[4026]: error: Upnp client error: Error: This socket has been ended by the other party Dec 16 16:26:45 volumio volumio[4026]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:26:45 volumio volumio[4026]: info: VolumeController:: Volume=100 Mute =false Dec 16 16:26:45 volumio volumio[4026]: info: CoreStateMachine::pushState Dec 16 16:26:45 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::volumioPushState Dec 16 16:26:45 volumio volumio[4026]: info: Starting Shairport Sync Dec 16 16:26:45 volumio volumio[4026]: info: Starting Shairport Sync Dec 16 16:26:45 volumio volumio[4026]: info: Starting Shairport Sync Dec 16 16:26:45 volumio sudo[4262]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 16:26:45 volumio sudo[4262]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:45 volumio sudo[4267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 16:26:45 volumio sudo[4267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:45 volumio sudo[4265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 16:26:45 volumio sudo[4265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:45 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 16 16:26:45 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 16 16:26:45 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:26:45 volumio systemd[1]: shairport-sync.service: Consumed 1.543s CPU time. Dec 16 16:26:45 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:45 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:45 volumio sudo[4262]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio volumio[4026]: info: Shairport-Sync Started Dec 16 16:26:45 volumio volumio[4026]: Error adding Membership: Error: addMembership EINVAL Dec 16 16:26:45 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 16 16:26:45 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 16 16:26:45 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:26:45 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:26:45 volumio sudo[4267]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio sudo[4265]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio volumio[4026]: info: Shairport-Sync Started Dec 16 16:26:45 volumio volumio[4026]: info: Shairport-Sync Started Dec 16 16:26:45 volumio volumio[4026]: info: Volumio called home Dec 16 16:26:45 volumio mpd[4222]: 2025-12-16T16:26:45 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 16 16:26:45 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 16 16:26:45 volumio sudo[4189]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio sudo[4179]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio volumio[4026]: info: Completed starting Core Plugins Dec 16 16:26:45 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:45 volumio volumio[4026]: info: ----- MyVolumio plugins startup ---- Dec 16 16:26:45 volumio volumio[4026]: info: ------------------------------------------- Dec 16 16:26:45 volumio volumio[4026]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 16 16:26:45 volumio volumio[4026]: error: MPD error: The expression evaluated to a falsy value: Dec 16 16:26:45 volumio volumio[4026]: assert.ok(self.idling) Dec 16 16:26:45 volumio volumio[4026]: error: The expression evaluated to a falsy value: Dec 16 16:26:45 volumio volumio[4026]: assert.ok(self.idling) Dec 16 16:26:45 volumio volumio[4026]: info: MPD running with PID4222 Dec 16 16:26:45 volumio volumio[4026]: ,establishing connection Dec 16 16:26:45 volumio volumio[4026]: error: updateQueue error: null Dec 16 16:26:45 volumio volumio[4026]: error: updateQueue error: null Dec 16 16:26:45 volumio volumio[4026]: info: Discovery: adding e2dba1bf-2de6-4d2f-ac76-16712d6dd2e3 Dec 16 16:26:45 volumio volumio[4026]: info: Discovery: Found device Volumio Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:45 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:45 volumio volumio[4026]: info: Discovery: this is already registered, e2dba1bf-2de6-4d2f-ac76-16712d6dd2e3 Dec 16 16:26:45 volumio volumio[4026]: info: Discovery: Found device Volumio Dec 16 16:26:45 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:45 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:45 volumio sudo[4084]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:45 volumio ntpd[1167]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 16:26:45 volumio ntpd[1167]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 129.151.225.244 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 172.232.63.219 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool taking: 82.65.248.56 Dec 16 16:26:45 volumio ntpd[1167]: DNS: Pool skipping: 172.234.184.36 Dec 16 16:26:45 volumio ntpd[1167]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 16 16:26:46 volumio volumio[4026]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:46 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:46 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:26:46 volumio volumio[4026]: info: Received Get System Info Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:26:46 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:46 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:26:46 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:26:46 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:26:46 volumio volumio[4026]: info: Listing playlists Dec 16 16:26:46 volumio ntpd[1167]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 16:26:47 volumio ntpd[1167]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 16 16:26:47 volumio ntpd[1167]: DNS: Pool taking: 82.64.81.218 Dec 16 16:26:47 volumio ntpd[1167]: DNS: Pool taking: 176.137.36.37 Dec 16 16:26:47 volumio ntpd[1167]: DNS: Pool taking: 195.35.29.178 Dec 16 16:26:47 volumio ntpd[1167]: DNS: Pool taking: 163.172.179.38 Dec 16 16:26:47 volumio ntpd[1167]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 16 16:26:47 volumio volumio-remote-updater[2972]: [2025-12-16 15:26:47] [connect] Successful connection Dec 16 16:26:47 volumio volumio-remote-updater[2972]: [2025-12-16 15:26:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1765898807 101 Dec 16 16:26:47 volumio volumio[4026]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 4 Dec 16 16:26:48 volumio sudo[4297]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 16 16:26:48 volumio sudo[4297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:48 volumio sudo[4299]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 16 16:26:48 volumio sudo[4299]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:26:48 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 16 16:26:48 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 16 16:26:48 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 16 16:26:48 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 16 16:26:48 volumio sudo[4297]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:48 volumio mpd_monitor.sh[4302]: MPD Monitor Service: Starting MPD Monitor Service Dec 16 16:26:48 volumio volumio[4026]: info: Successfully started MPD Monitor Dec 16 16:26:48 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 16 16:26:48 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 16 16:26:48 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 16 16:26:48 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 16 16:26:48 volumio sudo[4299]: pam_unix(sudo:session): session closed for user root Dec 16 16:26:48 volumio mpd_monitor.sh[4305]: MPD Monitor Service: Starting MPD Monitor Service Dec 16 16:26:48 volumio volumio[4026]: info: Successfully started MPD Monitor Dec 16 16:25:03 volumio volumio[4026]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Dec 16 16:25:03 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Dec 16 16:25:03 volumio volumio[4026]: info: Setting active UI to: {"uiPrettyName":"Contemporary","uiName":"contemporary","uiPath":"/volumio/http/www3"} Dec 16 16:25:04 volumio volumio[4026]: info: CoreCommandRouter::Reload Ui Dec 16 16:25:05 volumio volumio[4026]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 16 16:25:05 volumio sudo[5536]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:25:05 volumio sudo[5536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:05 volumio sudo[5536]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:05 volumio sudo[5538]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:25:05 volumio sudo[5538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:05 volumio sudo[5538]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:05 volumio volumio[4026]: verbose: New Socket.io Connection to 192.168.54.58 from 192.168.54.234 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 8 Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:05 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:05 volumio volumio[4026]: info: Listing playlists Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:05 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:06 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:25:06 volumio volumio[4026]: info: Received Get System Version Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:06 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:25:08 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:08 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:08 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:25:08 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:08 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:08 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:08 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:13 volumio volumio[4026]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Dec 16 16:25:13 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Dec 16 16:25:13 volumio volumio[4026]: info: Setting active UI to: {"uiPrettyName":"Manifest","uiName":"manifest","uiPath":"/volumio/http/www4"} Dec 16 16:25:13 volumio sudo[5577]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/active_volumio_ui Dec 16 16:25:13 volumio sudo[5577]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:13 volumio sudo[5577]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:14 volumio volumio[4026]: info: CoreCommandRouter::Reload Ui Dec 16 16:25:15 volumio volumio[4026]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:15 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:25:15 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:15 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:15 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:15 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:15 volumio volumio[4026]: info: Listing playlists Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:25:15 volumio sudo[5584]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:25:15 volumio sudo[5584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:15 volumio sudo[5586]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:25:15 volumio sudo[5586]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:15 volumio sudo[5584]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:15 volumio sudo[5586]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:15 volumio volumio[4026]: verbose: New Socket.io Connection to 192.168.54.58 from 192.168.54.234 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 8 Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:15 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:25:15 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:15 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:15 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:15 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:15 volumio volumio[4026]: info: Listing playlists Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 16 16:25:15 volumio volumio[4026]: info: Received Get System Version Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:15 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 16 16:25:16 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:16 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:16 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:25:16 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:16 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:16 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:16 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:16 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:16 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:16 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 16:25:17 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:17 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:17 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:17 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:23 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:23 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:23 volumio volumio[4026]: info: CoreCommandRouter::volumioGetQueue Dec 16 16:25:23 volumio volumio[4026]: info: CoreStateMachine::getQueue Dec 16 16:25:23 volumio volumio[4026]: info: CorePlayQueue::getQueue Dec 16 16:25:25 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 16:25:25 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 16:25:26 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 16 16:25:26 volumio volumio[4026]: info: CURURI: music-library Dec 16 16:25:26 volumio volumio[4026]: error: Failed LSINFO: null Dec 16 16:25:26 volumio volumio[4026]: info: Preload queue cleared Dec 16 16:25:32 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:32 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:25:33 volumio volumio[4026]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 16 16:25:33 volumio volumio[4026]: info: Received Get System Version Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:33 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:33 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:33 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:33 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 16:25:34 volumio volumio[4026]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 16 16:25:34 volumio volumio[4026]: info: Received Get System Version Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:34 volumio volumio[4026]: info: Received Get System Info Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:34 volumio volumio[4026]: info: Discovery: Getting this device information Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:34 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 16 16:25:34 volumio volumio[4026]: info: Received Get System Version Dec 16 16:25:34 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:40 volumio volumio[4026]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:40 volumio volumio[4026]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:41 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:41 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:41 volumio volumio[4026]: info: Retrieving Cloud Streaming UI Dec 16 16:25:41 volumio volumio[4026]: info: Getting Tidal Cloud Configuration Dec 16 16:25:41 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:41 volumio volumio[4026]: info: Getting Qobuz Cloud Configuration Dec 16 16:25:41 volumio volumio[4026]: info: Asking plugin for UI Config Dec 16 16:25:41 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:41 volumio volumio[4026]: info: Getting Spotify Cloud Configuration Dec 16 16:25:41 volumio volumio[4026]: info: Asking plugin for UI Config Dec 16 16:25:41 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:41 volumio volumio[4026]: info: Saving Spotify Acccount Dec 16 16:25:41 volumio volumio[4026]: info: Got Tidal Cloud Configuration Dec 16 16:25:41 volumio volumio[4026]: info: Got it Dec 16 16:25:41 volumio volumio[4026]: info: Got it Dec 16 16:25:41 volumio volumio[4026]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 16 16:25:41 volumio volumio[4026]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 16 16:25:42 volumio volumio[4026]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::volumioGetBrowseSources Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::volumioGetBrowseSources Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::volumioGetBrowseSources Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 16 16:25:42 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 16 16:25:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 16 16:25:44 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 16 16:25:46 volumio volumio[4026]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 16 16:25:49 volumio volumio[4026]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 16:25:49 volumio volumio[4026]: Error: dns service error: unknown Dec 16 16:25:49 volumio volumio[4026]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Dec 16 16:25:49 volumio volumio[4026]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 16 16:25:49 volumio volumio[4026]: errorCode: -65537 Dec 16 16:25:49 volumio volumio[4026]: } Dec 16 16:25:49 volumio volumio[4026]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 16:25:49 volumio sudo[5712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 16:24' Dec 16 16:25:49 volumio sudo[5712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:49 volumio sudo[5712]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:54 volumio volumio-remote-updater[2972]: [2025-12-16 15:25:54] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 16 16:25:54 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 16 16:25:54 volumio volumio-remote-updater[2972]: [2025-12-16 15:25:54] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 16 16:25:54 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 16 16:25:54 volumio systemd[1]: volumio.service: Consumed 15.697s CPU time. Dec 16 16:25:54 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Dec 16 16:25:54 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Dec 16 16:25:55 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Dec 16 16:25:55 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Dec 16 16:25:55 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Dec 16 16:25:55 volumio systemd[1]: volumio.service: Consumed 15.697s CPU time. Dec 16 16:25:55 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Dec 16 16:25:55 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Dec 16 16:25:55 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:55 volumio volumio[5763]: info: ----- Volumio3 ---- Dec 16 16:25:55 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:55 volumio volumio[5763]: info: ----- System startup ---- Dec 16 16:25:55 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:55 volumio volumio[5763]: info: MYVOLUMIO Environment detected Dec 16 16:25:55 volumio volumio[5763]: info: Plugin folders cleanup Dec 16 16:25:55 volumio volumio[5763]: info: Scanning into folder /volumio/app/plugins/ Dec 16 16:25:55 volumio volumio[5763]: info: Scanning category audio_interface Dec 16 16:25:55 volumio volumio[5763]: info: Scanning category miscellanea Dec 16 16:25:55 volumio volumio[5763]: info: Scanning category music_service Dec 16 16:25:55 volumio volumio[5763]: info: Scanning category plugins.json Dec 16 16:25:55 volumio volumio[5763]: info: Scanning category system_controller Dec 16 16:25:55 volumio volumio[5763]: info: Scanning category user_interface Dec 16 16:25:55 volumio volumio[5763]: info: Scanning into folder /data/plugins/ Dec 16 16:25:55 volumio volumio[5763]: info: Plugin folders cleanup completed Dec 16 16:25:55 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:55 volumio volumio[5763]: info: ----- Core plugins startup ---- Dec 16 16:25:55 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugins from folder /volumio/app/plugins/ Dec 16 16:25:55 volumio volumio[5763]: info: Adding plugin upnp to MyMusic Plugins Dec 16 16:25:55 volumio volumio[5763]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 16 16:25:55 volumio volumio[5763]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugins from folder /data/plugins/ Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "system"... Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "appearance"... Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "network"... Dec 16 16:25:55 volumio volumio[5763]: info: Refreshing Cached IP Addresses Dec 16 16:25:55 volumio sudo[5792]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 16:25:55 volumio sudo[5792]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:55 volumio sudo[5794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 16:25:55 volumio sudo[5794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:55 volumio sudo[5792]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:55 volumio sudo[5794]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "services"... Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "alsa_controller"... Dec 16 16:25:55 volumio sudo[5803]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 16 16:25:55 volumio sudo[5803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:55 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "wizard"... Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "networkfs"... Dec 16 16:25:55 volumio volumio[5763]: info: Starting Udev Watcher for removable devices Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: boot Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: volumio Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: volumio_data Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: MYMUSIC Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: 5721-3C67 Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: fbcec3ff-c508-49d8-a4d4-3a263c287ae6 Dec 16 16:25:55 volumio volumio[5763]: info: Ignoring mount for partition: 6c3f8501-0510-41fb-8119-2563da5b5ffa Dec 16 16:25:55 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "volumio_command_line_client"... Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "upnp"... Dec 16 16:25:55 volumio volumio[5763]: info: [1765898755933] Starting Upmpd Daemon Dec 16 16:25:55 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "my_music"... Dec 16 16:25:55 volumio volumio[5763]: info: Loading plugin "mpd"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "upnp_browser"... Dec 16 16:25:56 volumio volumio[5763]: info: Starting UPNP Browser Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "alarm-clock"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "airplay_emulation"... Dec 16 16:25:56 volumio volumio[5763]: info: Starting Shairport Sync Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "last_100"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "webradio"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "i2s_dacs"... Dec 16 16:25:56 volumio volumio[5763]: info: I2S DAC not set, start Auto-detection Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "volumiodiscovery"... Dec 16 16:25:56 volumio volumio[5763]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 16 16:25:56 volumio volumio[5763]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:25:56 volumio volumio[5763]: *** WARNING *** For more information see Dec 16 16:25:56 volumio volumio[5763]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 16 16:25:56 volumio volumio[5763]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:25:56 volumio volumio[5763]: *** WARNING *** For more information see Dec 16 16:25:56 volumio node[5763]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 16 16:25:56 volumio node[5763]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:25:56 volumio node[5763]: *** WARNING *** For more information see Dec 16 16:25:56 volumio node[5763]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 16 16:25:56 volumio node[5763]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 16:25:56 volumio node[5763]: *** WARNING *** For more information see Dec 16 16:25:56 volumio volumio[5763]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 16 16:25:56 volumio volumio[5763]: info: Discovery: Started advertising with name: Volumio Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "outputs"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "albumart"... Dec 16 16:25:56 volumio volumio[5763]: info: Plugin example_plugin is not enabled Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "inputs"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "updater_comm"... Dec 16 16:25:56 volumio volumio[5763]: info: Plugin mpdemulation is not enabled Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "rest_api"... Dec 16 16:25:56 volumio volumio[5763]: info: Loading plugin "websocket"... Dec 16 16:25:56 volumio volumio[5763]: info: Starting Socket.io Server version 1.7.4 Dec 16 16:25:56 volumio volumio[5763]: info: Loading i18n strings for locale fr Dec 16 16:25:56 volumio volumio[5763]: Updating browse sources language Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:56 volumio volumio[5843]: Forking 3 albumart workers Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::initPlayerControls Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: Express server listening on port 3000 Dec 16 16:25:56 volumio volumio[5763]: [Metrics] WebUI: 1s 317.80ms Dec 16 16:25:56 volumio volumio[5763]: info: Setting Device type: x86 Dec 16 16:25:56 volumio volumio[5763]: info: CoreStateMachine::resetVolumioState Dec 16 16:25:56 volumio volumio[5763]: info: CoreStateMachine::getcurrentVolume Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::volumioRetrievevolume Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 16 16:25:56 volumio volumio[5763]: info: Completed loading Core Plugins Dec 16 16:25:56 volumio volumio[5763]: info: Preparing to generate the ALSA configuration file Dec 16 16:25:56 volumio volumio[5763]: info: Cannot read play queue from file Dec 16 16:25:56 volumio volumio[5763]: info: Volumio Network Manager: Network status updated: 2 Dec 16 16:25:56 volumio volumio[5763]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 16 16:25:56 volumio volumio[5763]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 16 16:25:56 volumio volumio[5763]: verbose: New Socket.io Connection to 192.168.54.58 from 192.168.54.234 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 2 Dec 16 16:25:56 volumio volumio[5763]: info: VolumeController:: Volume=100 Mute =false Dec 16 16:25:56 volumio volumio[5763]: info: CoreStateMachine::pushState Dec 16 16:25:56 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::volumioPushState Dec 16 16:25:56 volumio volumio[5763]: info: CoreStateMachine::updateTrackBlock Dec 16 16:25:56 volumio volumio[5763]: info: CorePlayQueue::getTrackBlock Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::volumioRetrievevolume Dec 16 16:25:56 volumio volumio[5763]: info: Asound.conf file unchanged, so no further update is needed Dec 16 16:25:56 volumio volumio[5763]: info: Output device has changed, restarting MPD Dec 16 16:25:56 volumio volumio[5763]: info: Output device has changed, restarting Shairport Sync Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:56 volumio sudo[5892]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 16 16:25:56 volumio sudo[5892]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:56 volumio volumio[5763]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 16:25:56 volumio volumio[5763]: info: ___________ START PLUGINS ___________ Dec 16 16:25:56 volumio sudo[5892]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:56 volumio volumio[5763]: info: ControllerMpd::onStart: Initializing MPD Dec 16 16:25:56 volumio volumio[5763]: info: Creating MPD Configuration file Dec 16 16:25:56 volumio sudo[5894]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 16 16:25:56 volumio sudo[5894]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:56 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 16:25:56 volumio volumio[5763]: info: [1765898756830] CoreMusicLibrary::Adding element Serveurs Média Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:56 volumio sudo[5903]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 16 16:25:56 volumio volumio[5763]: info: UPNP Browser: Client initialized successfully Dec 16 16:25:56 volumio sudo[5904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 16 16:25:56 volumio sudo[5904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:56 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 16 16:25:56 volumio volumio[5853]: Starting albumart workers Dec 16 16:25:56 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 16 16:25:56 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 16 16:25:56 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 16 16:25:56 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 16 16:25:56 volumio sudo[5903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:56 volumio volumio[5855]: Starting albumart workers Dec 16 16:25:56 volumio volumio[5763]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 16:25:56 volumio sudo[5903]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:56 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 16 16:25:56 volumio volumio[5763]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 16:25:56 volumio volumio[5763]: info: [1765898756891] CoreMusicLibrary::Adding element Last_100 Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 16:25:56 volumio volumio[5763]: info: [1765898756893] CoreMusicLibrary::Adding element Webradio Dec 16 16:25:56 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:56 volumio volumio[5763]: info: Initializing BBC Radios Dec 16 16:25:56 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 16 16:25:56 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 16 16:25:56 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 16 16:25:56 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 16 16:25:56 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 16 16:25:56 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 16 16:25:56 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 16 16:25:56 volumio volumio[5854]: Starting albumart workers Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 16:25:56 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:56 volumio volumio[5763]: info: Volumio Calling Home Dec 16 16:25:56 volumio sudo[5921]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 16 16:25:56 volumio sudo[5921]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 16:25:57 volumio sudo[5921]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:57 volumio volumio[5763]: info: CoreStateMachine::setRepeat null single undefined Dec 16 16:25:57 volumio volumio[5763]: info: CoreStateMachine::pushState Dec 16 16:25:57 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::volumioPushState Dec 16 16:25:57 volumio volumio[5763]: info: CoreStateMachine::setRandom null Dec 16 16:25:57 volumio volumio[5763]: info: CoreStateMachine::pushState Dec 16 16:25:57 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::volumioPushState Dec 16 16:25:57 volumio volumio[5763]: info: MPD Permissions set Dec 16 16:25:57 volumio volumio[5763]: info: MPD Permissions set Dec 16 16:25:57 volumio volumio[5763]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 16:25:57 volumio volumio[5763]: info: VolumeController:: Volume=100 Mute =false Dec 16 16:25:57 volumio volumio[5763]: info: CoreStateMachine::pushState Dec 16 16:25:57 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::volumioPushState Dec 16 16:25:57 volumio volumio[5763]: info: Starting Shairport Sync Dec 16 16:25:57 volumio volumio[5763]: info: Starting Shairport Sync Dec 16 16:25:57 volumio volumio[5763]: info: Starting Shairport Sync Dec 16 16:25:57 volumio sudo[5973]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 16:25:57 volumio sudo[5973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:57 volumio sudo[5975]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 16:25:57 volumio sudo[5975]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:57 volumio sudo[5977]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 16:25:57 volumio sudo[5977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:57 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:57 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 16 16:25:57 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 16 16:25:57 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:25:57 volumio systemd[1]: shairport-sync.service: Consumed 2.085s CPU time. Dec 16 16:25:57 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 16:25:57 volumio sudo[5977]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:57 volumio sudo[5973]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:57 volumio sudo[5975]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:57 volumio volumio[5763]: info: Volumio called home Dec 16 16:25:57 volumio volumio[5763]: info: Shairport-Sync Started Dec 16 16:25:57 volumio volumio[5763]: Error adding Membership: Error: addMembership EINVAL Dec 16 16:25:57 volumio volumio[5763]: info: Shairport-Sync Started Dec 16 16:25:57 volumio volumio[5763]: info: Shairport-Sync Started Dec 16 16:25:57 volumio mpd[5935]: 2025-12-16T16:25:57 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 16 16:25:57 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 16 16:25:57 volumio volumio[5763]: info: Discovery: adding e2dba1bf-2de6-4d2f-ac76-16712d6dd2e3 Dec 16 16:25:57 volumio volumio[5763]: info: Discovery: Found device Volumio Dec 16 16:25:57 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:57 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:57 volumio sudo[5894]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:57 volumio sudo[5904]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:57 volumio volumio[5763]: info: Completed starting Core Plugins Dec 16 16:25:57 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:57 volumio volumio[5763]: info: ----- MyVolumio plugins startup ---- Dec 16 16:25:57 volumio volumio[5763]: info: ------------------------------------------- Dec 16 16:25:57 volumio volumio[5763]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 16 16:25:57 volumio volumio[5763]: error: MPD error: The expression evaluated to a falsy value: Dec 16 16:25:57 volumio volumio[5763]: assert.ok(self.idling) Dec 16 16:25:57 volumio volumio[5763]: error: The expression evaluated to a falsy value: Dec 16 16:25:57 volumio volumio[5763]: assert.ok(self.idling) Dec 16 16:25:57 volumio volumio[5763]: info: MPD running with PID5935 Dec 16 16:25:57 volumio volumio[5763]: ,establishing connection Dec 16 16:25:57 volumio volumio[5763]: error: updateQueue error: null Dec 16 16:25:57 volumio volumio[5763]: error: updateQueue error: null Dec 16 16:25:57 volumio sudo[5803]: pam_unix(sudo:session): session closed for user root Dec 16 16:25:58 volumio volumio[5763]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:58 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:58 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:25:58 volumio volumio[5763]: info: Received Get System Info Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:58 volumio volumio[5763]: info: Discovery: Getting this device information Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:58 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:58 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:58 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:58 volumio volumio[5763]: info: Listing playlists Dec 16 16:25:59 volumio volumio[5763]: verbose: New Socket.io Connection to 192.168.54.58 from 192.168.54.234 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 5 Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:59 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:59 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 16:25:59 volumio volumio[5763]: info: Received Get System Info Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 16:25:59 volumio volumio[5763]: info: Discovery: Getting this device information Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:59 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::volumioGetState Dec 16 16:25:59 volumio volumio[5763]: info: CorePlayQueue::getTrack 0 Dec 16 16:25:59 volumio volumio[5763]: info: Listing playlists Dec 16 16:25:59 volumio volumio[5763]: info: CoreCommandRouter::volumioGetQueue Dec 16 16:25:59 volumio volumio[5763]: info: CoreStateMachine::getQueue Dec 16 16:25:59 volumio volumio[5763]: info: CorePlayQueue::getQueue Dec 16 16:25:59 volumio volumio-remote-updater[2972]: [2025-12-16 15:25:59] [connect] Successful connection Dec 16 16:25:59 volumio volumio-remote-updater[2972]: [2025-12-16 15:25:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1765898759 101 Dec 16 16:25:59 volumio volumio[5763]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 6 Dec 16 16:26:00 volumio volumio[5763]: info: Enabling MyMusic plugin cd_controller Dec 16 16:26:00 volumio volumio[5763]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service cd_controller Dec 16 16:26:00 volumio volumio[5763]: info: [MyVolumio PluginManager] Plugin music_service cd_controller not in user plan, not enabling Dec 16 16:26:00 volumio volumio[5763]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 16:26:00 volumio volumio[5763]: TypeError: Cannot read properties of undefined (reading 'toUpperCase') Dec 16 16:26:00 volumio volumio[5763]: at MyVolumioPluginManager.pushMyVolumioRequiredAccountModal (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:19516) Dec 16 16:26:00 volumio volumio[5763]: at MyVolumioPluginManager.enablePlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:18418) Dec 16 16:26:00 volumio volumio[5763]: at MyVolumioPluginManager.enableAndStartPlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:17039) Dec 16 16:26:00 volumio volumio[5763]: at PluginManager.enableDisableMyMusicPlugin (/volumio/app/pluginmanager.js:2024:48) Dec 16 16:26:00 volumio volumio[5763]: at CoreCommandRouter.enableDisableMyMusicPlugin (/volumio/app/index.js:2107:29) Dec 16 16:26:00 volumio volumio[5763]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1957:59) Dec 16 16:26:00 volumio volumio[5763]: at Socket.emit (node:events:514:28) Dec 16 16:26:00 volumio volumio[5763]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 16 16:26:00 volumio volumio[5763]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 16 16:26:00 volumio volumio[5763]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 16:26:00 volumio sudo[6025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 16:25' Dec 16 16:26:00 volumio sudo[6025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"