-- Logs begin at Thu 2019-02-14 19:12:00 KST, end at Fri 2025-09-12 16:10:55 KST. -- Sep 12 16:09:42 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Sep 12 16:09:42 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Sep 12 16:09:42 volumio sudo[1718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:09:42 volumio sudo[1718]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:42 volumio sudo[1718]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:42 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Sep 12 16:09:42 volumio volumio[848]: info: Saving new wireless network Sep 12 16:09:42 volumio sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Sep 12 16:09:42 volumio sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:42 volumio sudo[1721]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:42 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Sep 12 16:09:42 volumio volumio[848]: info: Discovery: Restarting Advertising due to device name change Sep 12 16:09:42 volumio sudo[1724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Sep 12 16:09:42 volumio sudo[1724]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:42 volumio systemd[1]: Starting Wireless Services... Sep 12 16:09:43 volumio volumio[848]: info: Discovery: A device disappeared from network Sep 12 16:09:43 volumio volumio[848]: info: Discovery: Device volumio disappeared from network Sep 12 16:09:43 volumio volumio[848]: info: Discovery: A device disappeared from network Sep 12 16:09:43 volumio wireless.js[1739]: Cleaning previous... Sep 12 16:09:43 volumio systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Sep 12 16:09:44 volumio systemd[1]: hostapd.service: Succeeded. Sep 12 16:09:44 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Sep 12 16:09:44 volumio sudo[1754]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 12 16:09:44 volumio sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:44 volumio avahi-daemon[553]: Withdrawing address record for 192.168.211.1 on wlan0. Sep 12 16:09:44 volumio avahi-daemon[553]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Sep 12 16:09:44 volumio avahi-daemon[553]: Interface wlan0.IPv4 no longer relevant for mDNS. Sep 12 16:09:44 volumio sudo[1754]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:44 volumio sudo[1756]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 12 16:09:44 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:44 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:44 volumio wireless.js[1739]: Stopped aP Sep 12 16:09:44 volumio sudo[1763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 12 16:09:44 volumio sudo[1763]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:44 volumio kernel: rtl8192cu: MAC auto ON okay! Sep 12 16:09:44 volumio kernel: rtl8192cu: Tx queue select: 0x05 Sep 12 16:09:46 volumio sudo[1763]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:46 volumio ntpd[687]: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=225 secs Sep 12 16:09:46 volumio sudo[1765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Sep 12 16:09:46 volumio sudo[1765]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:46 volumio sudo[1765]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:46 volumio sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 12 16:09:46 volumio sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:46 volumio sudo[1772]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:46 volumio sudo[1774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Sep 12 16:09:46 volumio sudo[1774]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:47 volumio volumio[848]: info: Discovery: Started advertising with name: Volumio Sep 12 16:09:47 volumio sudo[1774]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:47 volumio wireless.js[1739]: SETTING APPROPRIATE REG DOMAIN: KR Sep 12 16:09:47 volumio sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 12 16:09:47 volumio sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:47 volumio sudo[1780]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:47 volumio sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set KR Sep 12 16:09:47 volumio sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:47 volumio sudo[1782]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:47 volumio wireless.js[1739]: SUCCESSFULLY SET NEW REGDOMAIN: KR Sep 12 16:09:47 volumio wireless.js[1739]: Start wireless flow Sep 12 16:09:47 volumio wireless.js[1739]: Stopped hotspot (if there).. Sep 12 16:09:47 volumio sudo[1787]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 12 16:09:47 volumio sudo[1787]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:47 volumio sudo[1787]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:47 volumio sudo[1789]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 12 16:09:47 volumio sudo[1789]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:47 volumio sudo[1789]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:48 volumio wireless.js[1739]: DHCP IP Sep 12 16:09:48 volumio wireless.js[1739]: Start ap Sep 12 16:09:48 volumio wpa_supplicant[1791]: Successfully initialized wpa_supplicant Sep 12 16:09:48 volumio sudo[1792]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Sep 12 16:09:48 volumio kernel: rtl8192cu: MAC auto ON okay! Sep 12 16:09:48 volumio sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:48 volumio dhcpcd[1793]: dev: loaded udev Sep 12 16:09:48 volumio kernel: rtl8192cu: Tx queue select: 0x05 Sep 12 16:09:48 volumio volumio[848]: info: Discovery: adding f3910629-b46a-4584-8d7a-7d57310ea29e Sep 12 16:09:48 volumio volumio[848]: info: Discovery: Found device Volumio Sep 12 16:09:48 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:09:48 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:09:49 volumio wireless.js[1739]: trying... Sep 12 16:09:49 volumio sudo[1830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:49 volumio sudo[1830]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:49 volumio sudo[1830]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:49 volumio dhcpcd-run-hooks[1844]: wlan0: starting wpa_supplicant Sep 12 16:09:50 volumio wireless.js[1739]: trying... Sep 12 16:09:50 volumio sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:50 volumio sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:50 volumio sudo[1848]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:50 volumio dhcpcd-run-hooks[1850]: wlan0: failed to start wpa_supplicant Sep 12 16:09:50 volumio dhcpcd-run-hooks[1851]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Sep 12 16:09:50 volumio dhcpcd[1793]: wlan0: connected to Access Point `' Sep 12 16:09:50 volumio dhcpcd[1793]: DUID 00:01:00:01:2f:f7:ff:dc:b8:27:eb:46:fd:28 Sep 12 16:09:50 volumio dhcpcd[1793]: eth0: IAID eb:46:fd:28 Sep 12 16:09:50 volumio dhcpcd[1793]: eth0: adding address fe80::fcc8:5eb4:461f:5e62 Sep 12 16:09:50 volumio dhcpcd[1793]: ipv6_addaddr1: Permission denied Sep 12 16:09:50 volumio dhcpcd[1793]: wlan0: waiting for carrier Sep 12 16:09:50 volumio dhcpcd[1793]: eth0: rebinding lease of 192.168.219.121 Sep 12 16:09:50 volumio dhcpcd[1793]: eth0: leased 192.168.219.121 for 21600 seconds Sep 12 16:09:50 volumio dhcpcd[1793]: eth0: adding route to 192.168.219.0/24 Sep 12 16:09:50 volumio dhcpcd[1793]: eth0: adding default route via 192.168.219.1 Sep 12 16:09:50 volumio dhcpcd[1793]: forked to background, child pid 1888 Sep 12 16:09:51 volumio sudo[1792]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:51 volumio wireless.js[1739]: trying... Sep 12 16:09:51 volumio sudo[1890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:51 volumio sudo[1890]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:51 volumio sudo[1890]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:51 volumio dhcpcd[1888]: eth0: soliciting an IPv6 router Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: SME: Trying to authenticate with 50:46:ae:63:a6:8c (SSID='U+NetA68D' freq=2412 MHz) Sep 12 16:09:51 volumio kernel: wlan0: authenticate with 50:46:ae:63:a6:8c Sep 12 16:09:51 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: Trying to associate with 50:46:ae:63:a6:8c (SSID='U+NetA68D' freq=2412 MHz) Sep 12 16:09:51 volumio kernel: wlan0: send auth to 50:46:ae:63:a6:8c (try 1/3) Sep 12 16:09:51 volumio kernel: wlan0: authenticated Sep 12 16:09:51 volumio kernel: wlan0: associate with 50:46:ae:63:a6:8c (try 1/3) Sep 12 16:09:51 volumio kernel: wlan0: RX AssocResp from 50:46:ae:63:a6:8c (capab=0x1411 status=0 aid=29) Sep 12 16:09:51 volumio kernel: wlan0: AP has invalid WMM params (AIFSN=1 for ACI 3), will use 2 Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: carrier acquired Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: Associated with 50:46:ae:63:a6:8c Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: connected to Access Point `U+NetA68D' Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=KR Sep 12 16:09:51 volumio kernel: wlan0: associated Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: IAID 66:44:cd:68 Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: adding address fe80::b4d1:1cde:8aa7:59d9 Sep 12 16:09:51 volumio dhcpcd[1888]: ipv6_addaddr1: Permission denied Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: carrier lost Sep 12 16:09:51 volumio kernel: wlan0: AP has invalid WMM params (AIFSN=1 for ACI 3), will use 2 Sep 12 16:09:51 volumio kernel: wlan0: Limiting TX power to 23 (23 - 0) dBm as advertised by 50:46:ae:63:a6:8c Sep 12 16:09:51 volumio kernel: cryptd: max_cpu_qlen set to 1000 Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: WPA: Key negotiation completed with 50:46:ae:63:a6:8c [PTK=CCMP GTK=CCMP] Sep 12 16:09:51 volumio wpa_supplicant[1846]: wlan0: CTRL-EVENT-CONNECTED - Connection to 50:46:ae:63:a6:8c completed [id=0 id_str=] Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: carrier acquired Sep 12 16:09:51 volumio dhcpcd[1888]: wlan0: IAID 66:44:cd:68 Sep 12 16:09:52 volumio wireless.js[1739]: trying... Sep 12 16:09:52 volumio dhcpcd[1888]: wlan0: soliciting a DHCP lease Sep 12 16:09:52 volumio sudo[1924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:52 volumio sudo[1924]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:52 volumio sudo[1924]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:52 volumio dhcpcd[1888]: wlan0: soliciting an IPv6 router Sep 12 16:09:52 volumio dhcpcd[1888]: wlan0: offered 192.168.219.111 from 192.168.219.1 Sep 12 16:09:52 volumio dhcpcd[1888]: wlan0: probing address 192.168.219.111/24 Sep 12 16:09:53 volumio wireless.js[1739]: trying... Sep 12 16:09:53 volumio sudo[1941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:53 volumio sudo[1941]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:53 volumio sudo[1941]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:54 volumio wireless.js[1739]: trying... Sep 12 16:09:54 volumio sudo[1944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:54 volumio sudo[1944]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:54 volumio sudo[1944]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:55 volumio wireless.js[1739]: trying... Sep 12 16:09:55 volumio sudo[1947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:55 volumio sudo[1947]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:55 volumio sudo[1947]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:56 volumio wireless.js[1739]: trying... Sep 12 16:09:56 volumio sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:56 volumio sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:56 volumio sudo[1950]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:57 volumio wireless.js[1739]: trying... Sep 12 16:09:57 volumio sudo[1953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:57 volumio sudo[1953]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:57 volumio sudo[1953]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:58 volumio wireless.js[1739]: trying... Sep 12 16:09:58 volumio sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:58 volumio sudo[1956]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:58 volumio sudo[1956]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:58 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:09:58 volumio volumio[848]: info: Retrieving Cloud Streaming UI Sep 12 16:09:58 volumio volumio[848]: info: Getting Tidal Cloud Configuration Sep 12 16:09:58 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:09:58 volumio volumio[848]: info: Getting Qobuz Cloud Configuration Sep 12 16:09:58 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:09:58 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:09:58 volumio volumio[848]: info: Getting Spotify Cloud Configuration Sep 12 16:09:58 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:09:58 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:09:58 volumio volumio[848]: info: Saving Spotify Acccount Sep 12 16:09:58 volumio volumio[848]: info: Got Tidal Cloud Configuration Sep 12 16:09:58 volumio volumio[848]: info: Got it Sep 12 16:09:58 volumio volumio[848]: info: Got it Sep 12 16:09:58 volumio volumio[848]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 12 16:09:58 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:09:58 volumio volumio[848]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 12 16:09:58 volumio dhcpcd[1888]: wlan0: leased 192.168.219.111 for 21600 seconds Sep 12 16:09:58 volumio dhcpcd[1888]: wlan0: adding route to 192.168.219.0/24 Sep 12 16:09:58 volumio avahi-daemon[553]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.219.111. Sep 12 16:09:58 volumio avahi-daemon[553]: New relevant interface wlan0.IPv4 for mDNS. Sep 12 16:09:58 volumio dhcpcd[1888]: wlan0: adding default route via 192.168.219.1 Sep 12 16:09:58 volumio avahi-daemon[553]: Registering new address record for 192.168.219.111 on wlan0.IPv4. Sep 12 16:09:58 volumio dnsmasq[843]: reading /etc/resolv.conf Sep 12 16:09:58 volumio dnsmasq[843]: using nameserver 61.41.153.2#53 Sep 12 16:09:58 volumio dnsmasq[843]: using nameserver 1.214.68.2#53 Sep 12 16:09:58 volumio dnsmasq[843]: using nameserver 208.67.222.222#53 Sep 12 16:09:58 volumio dnsmasq[843]: using nameserver 208.67.220.220#53 Sep 12 16:09:59 volumio wireless.js[1739]: trying... Sep 12 16:09:59 volumio sudo[1984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 12 16:09:59 volumio sudo[1984]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:59 volumio sudo[1984]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:59 volumio wireless.js[1739]: Connected to: ----U+NetA68D Sep 12 16:09:59 volumio wireless.js[1739]: ---- Sep 12 16:09:59 volumio sudo[1987]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:09:59 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:09:59 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:59 volumio wireless.js[1739]: ... joined AP, wlan0 IPv4 is 192.168.219.111, ipV6 is undefined Sep 12 16:09:59 volumio wireless.js[1739]: It's done! AP Sep 12 16:09:59 volumio iwconfig[1991]: Error for wireless request "Set Power Management" (8B2C) : Sep 12 16:09:59 volumio iwconfig[1991]: SET failed on device wlan0 ; Operation not supported. Sep 12 16:09:59 volumio systemd[1]: Started Wireless Services. Sep 12 16:09:59 volumio sudo[1724]: pam_unix(sudo:session): session closed for user root Sep 12 16:09:59 volumio volumio[848]: info: Discovery: this is already registered, f3910629-b46a-4584-8d7a-7d57310ea29e Sep 12 16:09:59 volumio volumio[848]: info: Discovery: Found device Volumio Sep 12 16:09:59 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:09:59 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:00 volumio ntpd[687]: Listen normally on 5 wlan0 192.168.219.111:123 Sep 12 16:10:00 volumio ntpd[687]: new interface(s) found: waking up resolver Sep 12 16:10:02 volumio volumio[848]: info: Volumio Network Manager: Network status updated: 3 Sep 12 16:10:03 volumio sudo[2007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:10:03 volumio sudo[2007]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:03 volumio sudo[2007]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:03 volumio sudo[2009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:03 volumio sudo[2009]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:03 volumio sudo[2009]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:03 volumio volumio[848]: verbose: New Socket.io Connection to 192.168.219.121 from 192.168.219.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 12 16:10:03 volumio volumio[848]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 16:10:03 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 16:10:03 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:03 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:03 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:03 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:03 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:03 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:03 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:04 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Sep 12 16:10:04 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Sep 12 16:10:04 volumio sudo[2013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:04 volumio sudo[2013]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:04 volumio sudo[2013]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:04 volumio sudo[2016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 12 16:10:04 volumio sudo[2016]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:04 volumio sudo[2016]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:07 volumio sudo[2021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:10:07 volumio sudo[2021]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:07 volumio sudo[2021]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:07 volumio sudo[2023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:07 volumio sudo[2023]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:07 volumio sudo[2023]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:07 volumio volumio[848]: verbose: New Socket.io Connection to 192.168.219.121 from 192.168.219.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Sep 12 16:10:07 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:07 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:07 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:07 volumio volumio-remote-updater[539]: No test mode Sep 12 16:10:07 volumio volumio-remote-updater[539]: No alpha test mode Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:07 volumio volumio[848]: info: Retrieving Cloud Streaming UI Sep 12 16:10:07 volumio volumio[848]: info: Getting Tidal Cloud Configuration Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:07 volumio volumio[848]: info: Getting Qobuz Cloud Configuration Sep 12 16:10:07 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:07 volumio volumio[848]: info: Getting Spotify Cloud Configuration Sep 12 16:10:07 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:07 volumio volumio[848]: info: Saving Spotify Acccount Sep 12 16:10:07 volumio volumio[848]: info: Got Tidal Cloud Configuration Sep 12 16:10:07 volumio volumio[848]: info: Got it Sep 12 16:10:07 volumio volumio[848]: info: Got it Sep 12 16:10:07 volumio volumio[848]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 12 16:10:07 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:07 volumio volumio[848]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 12 16:10:08 volumio volumio[848]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 12 16:10:08 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 12 16:10:08 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 12 16:10:08 volumio volumio[848]: info: Loading i18n strings for locale ko Sep 12 16:10:08 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 12 16:10:08 volumio volumio[848]: info: Setting timezone to Asia/Seoul Sep 12 16:10:08 volumio sudo[2031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 12 16:10:08 volumio sudo[2031]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:08 volumio sudo[2031]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:08 volumio sudo[2034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Seoul /etc/localtime Sep 12 16:10:08 volumio sudo[2034]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:08 volumio sudo[2034]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:08 volumio sudo[2037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 12 16:10:08 volumio sudo[2037]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:08 volumio sudo[2037]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:08 volumio sudo[2040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Seoul Sep 12 16:10:08 volumio sudo[2040]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:08 volumio dbus-daemon[530]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.21' (uid=0 pid=2041 comm="/usr/bin/timedatectl set-timezone Asia/Seoul ") Sep 12 16:10:09 volumio systemd[1]: Starting Time & Date Service... Sep 12 16:10:09 volumio dbus-daemon[530]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 12 16:10:09 volumio systemd[1]: Started Time & Date Service. Sep 12 16:10:09 volumio sudo[2040]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:09 volumio volumio[848]: info: Fetching Streaming Services browse cache Sep 12 16:10:09 volumio volumio[848]: Updating browse sources language Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Sep 12 16:10:09 volumio volumio[848]: info: Refreshing Cached IP Addresses Sep 12 16:10:09 volumio sudo[2044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Sep 12 16:10:09 volumio sudo[2044]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:09 volumio sudo[2044]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:09 volumio sudo[2046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:10:09 volumio sudo[2046]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:09 volumio sudo[2046]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:09 volumio volumio[848]: error: Upnp client error: Error: This socket has been ended by the other party Sep 12 16:10:09 volumio sudo[2049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:09 volumio sudo[2049]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:09 volumio sudo[2049]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:09 volumio volumio[848]: info: Retrieving Cloud Streaming UI Sep 12 16:10:09 volumio volumio[848]: info: Getting Tidal Cloud Configuration Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:09 volumio volumio[848]: info: Getting Qobuz Cloud Configuration Sep 12 16:10:09 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:09 volumio volumio[848]: info: Getting Spotify Cloud Configuration Sep 12 16:10:09 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:09 volumio volumio[848]: info: Saving Spotify Acccount Sep 12 16:10:09 volumio volumio[848]: info: Got Tidal Cloud Configuration Sep 12 16:10:09 volumio volumio[848]: info: Got it Sep 12 16:10:09 volumio volumio[848]: info: Got it Sep 12 16:10:09 volumio volumio[848]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 12 16:10:09 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:09 volumio volumio[848]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 12 16:10:10 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Sep 12 16:10:10 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 12 16:10:10 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:10 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:11 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 12 16:10:11 volumio volumio[848]: info: Preparing to save Alsa Options, stopping services first Sep 12 16:10:11 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:11 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:11 volumio volumio[848]: info: CoreCommandRouter::volumioPause Sep 12 16:10:11 volumio volumio[848]: info: CoreStateMachine::pause Sep 12 16:10:11 volumio volumio[848]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI Out"},"disallowPush":true} Sep 12 16:10:11 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:11 volumio volumio[848]: info: Enabling PI HDMI Output Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:12 volumio volumio[848]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 12 16:10:12 volumio volumio[848]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI Out Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 12 16:10:12 volumio volumio[848]: info: Disabling external Volume Control Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:12 volumio volumio[848]: info: Preparing to generate the ALSA configuration file Sep 12 16:10:12 volumio volumio[848]: info: Raspberry PI HDMI Output Enabled Sep 12 16:10:12 volumio sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store Sep 12 16:10:12 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:12 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 12 16:10:12 volumio volumio[848]: info: Asound.conf file unchanged, so no further update is needed Sep 12 16:10:12 volumio volumio[848]: info: Output device has changed, restarting MPD Sep 12 16:10:12 volumio volumio[848]: info: Output device has changed, restarting Shairport Sync Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:12 volumio sudo[2074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 16:10:12 volumio sudo[2074]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:12 volumio sudo[2074]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:12 volumio sudo[2076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 16:10:12 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:12 volumio systemd[1]: Stopping Music Player Daemon... Sep 12 16:10:12 volumio volumio[848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Sep 12 16:10:12 volumio volumio[848]: info: MPD Permissions set Sep 12 16:10:12 volumio volumio[848]: info: Alsa Settings successfully stored Sep 12 16:10:12 volumio volumio[848]: info: VolumeController:: Volume=86 Mute =false Sep 12 16:10:12 volumio volumio[848]: info: CoreStateMachine::pushState Sep 12 16:10:12 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::volumioPushState Sep 12 16:10:12 volumio systemd[1]: mpd.service: Succeeded. Sep 12 16:10:12 volumio systemd[1]: Stopped Music Player Daemon. Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:12 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:13 volumio systemd[1]: Starting Music Player Daemon... Sep 12 16:10:13 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:13 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:13 volumio volumio[848]: info: Starting Shairport Sync Sep 12 16:10:13 volumio sudo[2102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 16:10:13 volumio sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 12 16:10:13 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 12 16:10:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 12 16:10:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 12 16:10:13 volumio sudo[2102]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:13 volumio volumio[848]: info: Shairport-Sync Started Sep 12 16:10:13 volumio sudo[2094]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 12 16:10:13 volumio sudo[2094]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:13 volumio sudo[2094]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:13 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 12 16:10:13 volumio volumio[848]: info: Loading i18n strings for locale ko Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 12 16:10:14 volumio volumio[848]: info: Setting timezone to Asia/Seoul Sep 12 16:10:14 volumio sudo[2110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 12 16:10:14 volumio sudo[2110]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:14 volumio sudo[2110]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:14 volumio sudo[2113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Seoul /etc/localtime Sep 12 16:10:14 volumio sudo[2113]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:14 volumio sudo[2113]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:14 volumio sudo[2116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 12 16:10:14 volumio sudo[2116]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:14 volumio sudo[2116]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:14 volumio sudo[2119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Seoul Sep 12 16:10:14 volumio sudo[2119]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:14 volumio sudo[2119]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Sep 12 16:10:14 volumio sudo[2122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 12 16:10:14 volumio sudo[2122]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:14 volumio volumio[848]: info: Fetching Streaming Services browse cache Sep 12 16:10:14 volumio volumio[848]: Updating browse sources language Sep 12 16:10:14 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 16:10:16 volumio mpd[2106]: Sep 12 16:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 12 16:10:16 volumio systemd[1]: Started Music Player Daemon. Sep 12 16:10:16 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:16 volumio volumio[848]: error: updateQueue error: null Sep 12 16:10:16 volumio volumio[848]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 12 16:10:16 volumio volumio[848]: info: CoreStateMachine::getcurrentVolume Sep 12 16:10:16 volumio volumio[848]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 16:10:16 volumio volumio[848]: info: VolumeController:: Volume=86 Mute =false Sep 12 16:10:16 volumio volumio[848]: info: CoreStateMachine::pushState Sep 12 16:10:16 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:16 volumio volumio[848]: info: CoreCommandRouter::volumioPushState Sep 12 16:10:16 volumio volumio[848]: info: CoreStateMachine::updateTrackBlock Sep 12 16:10:16 volumio volumio[848]: info: CorePlayQueue::getTrackBlock Sep 12 16:10:16 volumio volumio[848]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 16:10:16 volumio volumio[848]: info: VolumeController:: Volume=86 Mute =false Sep 12 16:10:16 volumio volumio[848]: info: CoreStateMachine::pushState Sep 12 16:10:16 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:16 volumio volumio[848]: info: CoreCommandRouter::volumioPushState Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 12 16:10:17 volumio volumio[848]: info: Preparing to save Alsa Options, stopping services first Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:17 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::volumioPause Sep 12 16:10:17 volumio volumio[848]: info: CoreStateMachine::pause Sep 12 16:10:17 volumio volumio[848]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI Out"},"disallowPush":true} Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:17 volumio volumio[848]: info: Enabling PI HDMI Output Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:17 volumio volumio[848]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 12 16:10:17 volumio volumio[848]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI Out Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 12 16:10:17 volumio volumio[848]: info: Disabling external Volume Control Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:17 volumio volumio[848]: info: Preparing to generate the ALSA configuration file Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:17 volumio volumio[848]: info: Retrieving Cloud Streaming UI Sep 12 16:10:17 volumio volumio[848]: info: Raspberry PI HDMI Output Enabled Sep 12 16:10:17 volumio sudo[2142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store Sep 12 16:10:17 volumio sudo[2142]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:17 volumio sudo[2142]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 12 16:10:17 volumio volumio[848]: info: Asound.conf file unchanged, so no further update is needed Sep 12 16:10:17 volumio volumio[848]: info: Output device has changed, restarting MPD Sep 12 16:10:17 volumio volumio[848]: info: Output device has changed, restarting Shairport Sync Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:17 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:17 volumio sudo[2152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 16:10:17 volumio sudo[2152]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:18 volumio sudo[2152]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:18 volumio sudo[2154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 16:10:18 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:18 volumio systemd[1]: Stopping Music Player Daemon... Sep 12 16:10:18 volumio volumio[848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 16:10:18 volumio volumio[848]: info: Getting Tidal Cloud Configuration Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:18 volumio systemd[1]: mpd.service: Succeeded. Sep 12 16:10:18 volumio volumio[848]: info: Getting Qobuz Cloud Configuration Sep 12 16:10:18 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:18 volumio systemd[1]: Stopped Music Player Daemon. Sep 12 16:10:18 volumio volumio[848]: info: Getting Spotify Cloud Configuration Sep 12 16:10:18 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:18 volumio volumio[848]: info: Saving Spotify Acccount Sep 12 16:10:18 volumio volumio[848]: info: Got Tidal Cloud Configuration Sep 12 16:10:18 volumio volumio[848]: info: Got it Sep 12 16:10:18 volumio volumio[848]: info: Got it Sep 12 16:10:18 volumio volumio[848]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 12 16:10:18 volumio volumio[848]: info: MPD Permissions set Sep 12 16:10:18 volumio volumio[848]: info: Alsa Settings successfully stored Sep 12 16:10:18 volumio volumio[848]: info: VolumeController:: Volume=86 Mute =false Sep 12 16:10:18 volumio volumio[848]: info: CoreStateMachine::pushState Sep 12 16:10:18 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::volumioPushState Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio systemd[1]: Starting Music Player Daemon... Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:18 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:18 volumio volumio[848]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 12 16:10:18 volumio volumio[848]: info: Starting Shairport Sync Sep 12 16:10:18 volumio sudo[2166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 16:10:18 volumio sudo[2166]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 12 16:10:18 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 12 16:10:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 12 16:10:18 volumio sudo[2160]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 12 16:10:18 volumio sudo[2160]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:18 volumio sudo[2160]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 12 16:10:18 volumio sudo[2122]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:18 volumio sudo[2166]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:18 volumio volumio[848]: info: Shairport-Sync Started Sep 12 16:10:18 volumio nmbd[646]: [2025/09/12 16:10:18.914992, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 12 16:10:18 volumio nmbd[646]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.219.121 for name WORKGROUP<1d>. Sep 12 16:10:18 volumio nmbd[646]: This response was from IP 192.168.219.10, reporting an IP address of 192.168.219.10. Sep 12 16:10:19 volumio sudo[2177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:10:19 volumio sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:19 volumio sudo[2177]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:19 volumio sudo[2179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:19 volumio sudo[2179]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:19 volumio sudo[2179]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:19 volumio sudo[2182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 12 16:10:19 volumio sudo[2182]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:19 volumio sudo[2182]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:19 volumio volumio[848]: info: Upmpdcli Daemon Started Sep 12 16:10:20 volumio mpd[2172]: Sep 12 16:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 12 16:10:20 volumio systemd[1]: Started Music Player Daemon. Sep 12 16:10:20 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:21 volumio volumio[848]: error: updateQueue error: null Sep 12 16:10:21 volumio volumio[848]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 12 16:10:21 volumio volumio[848]: info: CoreStateMachine::getcurrentVolume Sep 12 16:10:21 volumio volumio[848]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 16:10:21 volumio volumio[848]: info: VolumeController:: Volume=86 Mute =false Sep 12 16:10:21 volumio volumio[848]: info: CoreStateMachine::pushState Sep 12 16:10:21 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:21 volumio volumio[848]: info: CoreCommandRouter::volumioPushState Sep 12 16:10:21 volumio volumio[848]: info: CoreStateMachine::updateTrackBlock Sep 12 16:10:21 volumio volumio[848]: info: CorePlayQueue::getTrackBlock Sep 12 16:10:21 volumio volumio[848]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 16:10:21 volumio volumio[848]: info: VolumeController:: Volume=86 Mute =false Sep 12 16:10:21 volumio volumio[848]: info: CoreStateMachine::pushState Sep 12 16:10:21 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:21 volumio volumio[848]: info: CoreCommandRouter::volumioPushState Sep 12 16:10:23 volumio nmbd[646]: [2025/09/12 16:10:23.930609, 0] ../source3/libsmb/nmblib.c:917(send_udp) Sep 12 16:10:23 volumio nmbd[646]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Sep 12 16:10:24 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Sep 12 16:10:24 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Sep 12 16:10:24 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Sep 12 16:10:24 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Sep 12 16:10:24 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::Reload Ui Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Sep 12 16:10:28 volumio volumio[848]: info: Wizard terminated Successfully Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::volumiosetStartupVolume Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 16:10:28 volumio sudo[2213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:10:28 volumio sudo[2213]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:28 volumio sudo[2213]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:28 volumio sudo[2215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:28 volumio sudo[2215]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:28 volumio sudo[2215]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:28 volumio volumio[848]: verbose: New Socket.io Connection to 192.168.219.121 from 192.168.219.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:28 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 12 16:10:28 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:28 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:28 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:28 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:28 volumio volumio[848]: info: Listing playlists Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 12 16:10:28 volumio sudo[2219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 16:10:28 volumio sudo[2219]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:28 volumio sudo[2219]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:28 volumio sudo[2221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 16:10:28 volumio sudo[2221]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 16:10:28 volumio sudo[2221]: pam_unix(sudo:session): session closed for user root Sep 12 16:10:28 volumio volumio[848]: verbose: New Socket.io Connection to 192.168.219.121 from 192.168.219.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 12 16:10:28 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:29 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 12 16:10:29 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:29 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:29 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:29 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:29 volumio volumio[848]: info: Listing playlists Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 12 16:10:29 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:29 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:30 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 12 16:10:30 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 12 16:10:30 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:30 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:30 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:30 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:30 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:30 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:30 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:32 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 12 16:10:32 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:32 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:32 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:32 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:32 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:32 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:32 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:33 volumio dnsmasq-dhcp[843]: no address range available for DHCP request via wlan0 Sep 12 16:10:38 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 12 16:10:39 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 12 16:10:39 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 12 16:10:39 volumio volumio-remote-updater[539]: No test mode Sep 12 16:10:39 volumio volumio-remote-updater[539]: No alpha test mode Sep 12 16:10:39 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 12 16:10:40 volumio volumio[848]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 12 16:10:40 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 12 16:10:42 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Sep 12 16:10:43 volumio nmbd[646]: [2025/09/12 16:10:43.947852, 0] ../source3/libsmb/nmblib.c:917(send_udp) Sep 12 16:10:43 volumio nmbd[646]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Sep 12 16:10:44 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 12 16:10:44 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 12 16:10:44 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 12 16:10:44 volumio volumio-remote-updater[539]: No test mode Sep 12 16:10:44 volumio volumio-remote-updater[539]: No alpha test mode Sep 12 16:10:44 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 12 16:10:45 volumio volumio[848]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 12 16:10:45 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 12 16:10:47 volumio volumio[848]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 12 16:10:47 volumio volumio[848]: info: Received Get System Version Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 16:10:47 volumio volumio[848]: info: Received Get System Info Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 16:10:47 volumio volumio[848]: info: Discovery: Getting this device information Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::volumioGetState Sep 12 16:10:47 volumio volumio[848]: info: CorePlayQueue::getTrack 0 Sep 12 16:10:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:50 volumio volumio[848]: info: Retrieving Cloud Streaming UI Sep 12 16:10:50 volumio volumio[848]: info: Getting Tidal Cloud Configuration Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:50 volumio volumio[848]: info: Getting Qobuz Cloud Configuration Sep 12 16:10:50 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:50 volumio volumio[848]: info: Getting Spotify Cloud Configuration Sep 12 16:10:50 volumio volumio[848]: info: Asking plugin for UI Config Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:50 volumio volumio[848]: info: Saving Spotify Acccount Sep 12 16:10:50 volumio volumio[848]: info: Got Tidal Cloud Configuration Sep 12 16:10:50 volumio volumio[848]: info: Got it Sep 12 16:10:50 volumio volumio[848]: info: Got it Sep 12 16:10:50 volumio volumio[848]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 16:10:50 volumio volumio[848]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 12 16:10:50 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 12 16:10:54 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 12 16:10:54 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 12 16:10:54 volumio volumio[848]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 16:10:54 volumio volumio[848]: Error: getaddrinfo -3007 Sep 12 16:10:54 volumio volumio[848]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Sep 12 16:10:54 volumio volumio[848]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Sep 12 16:10:54 volumio volumio[848]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Sep 12 16:10:54 volumio volumio[848]: code: -3007, Sep 12 16:10:54 volumio volumio[848]: errno: -3007, Sep 12 16:10:54 volumio volumio[848]: syscall: 'getaddrinfo' Sep 12 16:10:54 volumio volumio[848]: } Sep 12 16:10:54 volumio volumio[848]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 16:10:55 volumio sudo[2326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 16:09 Sep 12 16:10:55 volumio sudo[2326]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"