-- Logs begin at Thu 2019-02-14 13:12:02 MSK, end at Sun 2024-07-07 23:15:59 MSK. -- Jul 07 23:14:00 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Jul 07 23:14:00 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Jul 07 23:14:00 volumio sudo[2076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:00 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:00 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:00 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Jul 07 23:14:00 volumio volumio[843]: info: Saving new wireless network Jul 07 23:14:00 volumio sudo[2079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Jul 07 23:14:00 volumio sudo[2079]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:00 volumio sudo[2079]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:00 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jul 07 23:14:00 volumio volumio[843]: info: Discovery: Restarting Advertising due to device name change Jul 07 23:14:00 volumio sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jul 07 23:14:00 volumio sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:00 volumio systemd[1]: Starting Wireless Services... Jul 07 23:14:00 volumio systemd[1]: hostapd.service: Service RestartSec=2s expired, scheduling restart. Jul 07 23:14:00 volumio systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 69. Jul 07 23:14:00 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 07 23:14:00 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 07 23:14:00 volumio hostapd[2091]: Configuration file: /etc/hostapd/hostapd.conf Jul 07 23:14:00 volumio avahi-daemon[581]: Interface wlan0.IPv4 no longer relevant for mDNS. Jul 07 23:14:00 volumio avahi-daemon[581]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jul 07 23:14:01 volumio avahi-daemon[581]: Withdrawing address record for 192.168.211.1 on wlan0. Jul 07 23:14:01 volumio volumio[843]: info: Discovery: A device disappeared from network Jul 07 23:14:01 volumio avahi-daemon[581]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jul 07 23:14:01 volumio hostapd[2091]: nl80211: Could not configure driver mode Jul 07 23:14:01 volumio avahi-daemon[581]: New relevant interface wlan0.IPv4 for mDNS. Jul 07 23:14:01 volumio avahi-daemon[581]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Jul 07 23:14:01 volumio hostapd[2091]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 07 23:14:01 volumio hostapd[2091]: nl80211 driver initialization failed. Jul 07 23:14:01 volumio hostapd[2091]: wlan0: interface state UNINITIALIZED->DISABLED Jul 07 23:14:01 volumio hostapd[2091]: wlan0: AP-DISABLED Jul 07 23:14:01 volumio hostapd[2091]: wlan0: CTRL-EVENT-TERMINATING Jul 07 23:14:01 volumio hostapd[2091]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 07 23:14:01 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 07 23:14:01 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 07 23:14:01 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 07 23:14:01 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 07 23:14:01 volumio volumio[843]: info: Discovery: A device disappeared from network Jul 07 23:14:01 volumio volumio[843]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jul 07 23:14:01 volumio wireless.js[2084]: Cleaning previous... Jul 07 23:14:02 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 07 23:14:02 volumio sudo[2100]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 07 23:14:02 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:02 volumio avahi-daemon[581]: Withdrawing address record for 192.168.211.1 on wlan0. Jul 07 23:14:02 volumio avahi-daemon[581]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jul 07 23:14:02 volumio avahi-daemon[581]: Interface wlan0.IPv4 no longer relevant for mDNS. Jul 07 23:14:02 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:02 volumio sudo[2102]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 07 23:14:02 volumio sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:02 volumio sudo[2102]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:02 volumio wireless.js[2084]: Stopped aP Jul 07 23:14:02 volumio sudo[2109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 07 23:14:02 volumio sudo[2109]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:02 volumio sudo[2109]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:02 volumio sudo[2111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jul 07 23:14:02 volumio sudo[2111]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:02 volumio sudo[2111]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:02 volumio sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 07 23:14:02 volumio sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:02 volumio sudo[2118]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:02 volumio sudo[2120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jul 07 23:14:02 volumio sudo[2120]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:03 volumio volumio[843]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jul 07 23:14:04 volumio sudo[2120]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:04 volumio wireless.js[2084]: Start wireless flow Jul 07 23:14:04 volumio wireless.js[2084]: Stopped hotspot (if there).. Jul 07 23:14:04 volumio sudo[2125]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 07 23:14:04 volumio sudo[2125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:04 volumio sudo[2125]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:04 volumio sudo[2127]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 07 23:14:04 volumio sudo[2127]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:04 volumio sudo[2127]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:04 volumio wireless.js[2084]: DHCP IP Jul 07 23:14:04 volumio wireless.js[2084]: Start ap Jul 07 23:14:04 volumio wpa_supplicant[2129]: Successfully initialized wpa_supplicant Jul 07 23:14:04 volumio sudo[2130]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jul 07 23:14:04 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:04 volumio dhcpcd[2131]: dev: loaded udev Jul 07 23:14:04 volumio dhcpcd-run-hooks[2140]: wlan0: starting wpa_supplicant Jul 07 23:14:05 volumio dhcpcd-run-hooks[2143]: wlan0: failed to start wpa_supplicant Jul 07 23:14:05 volumio dhcpcd-run-hooks[2144]: 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 Jul 07 23:14:05 volumio dhcpcd[2131]: wlan0: connected to Access Point `' Jul 07 23:14:05 volumio dhcpcd[2131]: DUID 00:01:00:01:2d:f2:1d:9e:b8:27:eb:6d:c1:63 Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: IAID eb:6d:c1:63 Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: adding address fe80::4ca8:410d:44fc:e03 Jul 07 23:14:05 volumio dhcpcd[2131]: ipv6_addaddr1: Permission denied Jul 07 23:14:05 volumio dhcpcd[2131]: wlan0: waiting for carrier Jul 07 23:14:05 volumio volumio[843]: info: Discovery: Started advertising with name: Volumio Jul 07 23:14:05 volumio wireless.js[2084]: trying... Jul 07 23:14:05 volumio sudo[2163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:05 volumio sudo[2163]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: soliciting a DHCP lease Jul 07 23:14:05 volumio sudo[2163]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: soliciting an IPv6 router Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: offered 192.168.31.111 from 192.168.31.1 Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: leased 192.168.31.111 for 43200 seconds Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: adding route to 192.168.31.0/24 Jul 07 23:14:05 volumio dhcpcd[2131]: eth0: adding default route via 192.168.31.1 Jul 07 23:14:05 volumio dhcpcd[2131]: forked to background, child pid 2185 Jul 07 23:14:06 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: SME: Trying to authenticate with 28:d1:27:d2:c1:a6 (SSID='Avrora' freq=2412 MHz) Jul 07 23:14:06 volumio kernel: wlan0: authenticate with 28:d1:27:d2:c1:a6 Jul 07 23:14:06 volumio kernel: wlan0: 80 MHz not supported, disabling VHT Jul 07 23:14:06 volumio kernel: wlan0: send auth to 28:d1:27:d2:c1:a6 (try 1/3) Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: Trying to associate with 28:d1:27:d2:c1:a6 (SSID='Avrora' freq=2412 MHz) Jul 07 23:14:06 volumio kernel: wlan0: authenticated Jul 07 23:14:06 volumio kernel: wlan0: associate with 28:d1:27:d2:c1:a6 (try 1/3) Jul 07 23:14:06 volumio volumio[843]: info: Discovery: adding undefined Jul 07 23:14:06 volumio volumio[843]: info: Discovery: Found device Volumio Jul 07 23:14:06 volumio kernel: wlan0: RX AssocResp from 28:d1:27:d2:c1:a6 (capab=0xc11 status=0 aid=6) Jul 07 23:14:06 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:06 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: carrier acquired Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: connected to Access Point `Avrora' Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: Associated with 28:d1:27:d2:c1:a6 Jul 07 23:14:06 volumio kernel: wlan0: associated Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=RU Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: IAID 02:0e:4d:ef Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: adding address fe80::66d3:c802:33d8:c833 Jul 07 23:14:06 volumio dhcpcd[2185]: ipv6_addaddr1: Permission denied Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: carrier lost Jul 07 23:14:06 volumio wireless.js[2084]: trying... Jul 07 23:14:06 volumio sudo[2207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:06 volumio sudo[2207]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:06 volumio sudo[2207]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:06 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: WPA: Key negotiation completed with 28:d1:27:d2:c1:a6 [PTK=CCMP GTK=CCMP] Jul 07 23:14:06 volumio wpa_supplicant[2141]: wlan0: CTRL-EVENT-CONNECTED - Connection to 28:d1:27:d2:c1:a6 completed [id=0 id_str=] Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: carrier acquired Jul 07 23:14:06 volumio dhcpcd[2185]: wlan0: IAID 02:0e:4d:ef Jul 07 23:14:07 volumio dhcpcd[2185]: wlan0: soliciting an IPv6 router Jul 07 23:14:07 volumio wireless.js[2084]: trying... Jul 07 23:14:07 volumio sudo[2236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:07 volumio sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:07 volumio sudo[2236]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:07 volumio dhcpcd[2185]: wlan0: soliciting a DHCP lease Jul 07 23:14:07 volumio dhcpcd[2185]: wlan0: offered 192.168.31.65 from 192.168.31.1 Jul 07 23:14:07 volumio dhcpcd[2185]: wlan0: probing address 192.168.31.65/24 Jul 07 23:14:08 volumio wireless.js[2084]: trying... Jul 07 23:14:08 volumio sudo[2239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:08 volumio sudo[2239]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:08 volumio sudo[2239]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:09 volumio wireless.js[2084]: trying... Jul 07 23:14:09 volumio sudo[2242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:09 volumio sudo[2242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:09 volumio sudo[2242]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:10 volumio wireless.js[2084]: trying... Jul 07 23:14:10 volumio sudo[2245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:10 volumio sudo[2245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:10 volumio sudo[2245]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:11 volumio wireless.js[2084]: trying... Jul 07 23:14:11 volumio sudo[2248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:11 volumio sudo[2248]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:11 volumio sudo[2248]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:11 volumio kernel: hwmon hwmon1: Voltage normalised Jul 07 23:14:12 volumio wireless.js[2084]: trying... Jul 07 23:14:12 volumio sudo[2252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:12 volumio sudo[2252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:12 volumio sudo[2252]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:13 volumio dhcpcd[2185]: wlan0: leased 192.168.31.65 for 43200 seconds Jul 07 23:14:13 volumio dhcpcd[2185]: wlan0: adding route to 192.168.31.0/24 Jul 07 23:14:13 volumio avahi-daemon[581]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.31.65. Jul 07 23:14:13 volumio dhcpcd[2185]: wlan0: adding default route via 192.168.31.1 Jul 07 23:14:13 volumio avahi-daemon[581]: New relevant interface wlan0.IPv4 for mDNS. Jul 07 23:14:13 volumio avahi-daemon[581]: Registering new address record for 192.168.31.65 on wlan0.IPv4. Jul 07 23:14:13 volumio dnsmasq[837]: reading /etc/resolv.conf Jul 07 23:14:13 volumio dnsmasq[837]: using nameserver 192.168.31.1#53 Jul 07 23:14:13 volumio dnsmasq[837]: using nameserver 208.67.222.222#53 Jul 07 23:14:13 volumio dnsmasq[837]: using nameserver 208.67.220.220#53 Jul 07 23:14:13 volumio wireless.js[2084]: trying... Jul 07 23:14:13 volumio sudo[2276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jul 07 23:14:13 volumio sudo[2276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:13 volumio sudo[2276]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:13 volumio wireless.js[2084]: Connected to: ----Avrora Jul 07 23:14:13 volumio wireless.js[2084]: ---- Jul 07 23:14:13 volumio sudo[2279]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:13 volumio sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:13 volumio sudo[2279]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:13 volumio wireless.js[2084]: ... joined AP, wlan0 IPv4 is 192.168.31.65, ipV6 is undefined Jul 07 23:14:13 volumio wireless.js[2084]: It's done! AP Jul 07 23:14:13 volumio iwconfig[2283]: Error for wireless request "Set Power Management" (8B2C) : Jul 07 23:14:13 volumio iwconfig[2283]: SET failed on device wlan0 ; Operation not supported. Jul 07 23:14:13 volumio systemd[1]: Started Wireless Services. Jul 07 23:14:13 volumio sudo[2082]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:13 volumio volumio[843]: info: Discovery: this is already registered, undefined Jul 07 23:14:13 volumio volumio[843]: info: Discovery: Found device Volumio Jul 07 23:14:13 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:13 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:14 volumio ntpd[684]: Listen normally on 4 wlan0 192.168.31.65:123 Jul 07 23:14:14 volumio ntpd[684]: new interface(s) found: waking up resolver Jul 07 23:14:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jul 07 23:14:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jul 07 23:14:18 volumio sudo[2285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:18 volumio sudo[2285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:18 volumio sudo[2285]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:19 volumio sudo[2288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 07 23:14:19 volumio sudo[2288]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:19 volumio sudo[2288]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:23 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:23 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:23 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:23 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:23 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:23 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:23 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:23 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:23 volumio volumio[843]: info: Got it Jul 07 23:14:23 volumio volumio[843]: info: Got it Jul 07 23:14:23 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:23 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jul 07 23:14:23 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jul 07 23:14:23 volumio volumio[843]: info: Refreshing Cached IP Addresses Jul 07 23:14:23 volumio sudo[2293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jul 07 23:14:23 volumio sudo[2293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:23 volumio sudo[2295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:23 volumio sudo[2295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:23 volumio sudo[2293]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:23 volumio volumio[843]: error: Upnp client error: Error: This socket has been ended by the other party Jul 07 23:14:23 volumio sudo[2295]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:24 volumio sudo[2298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:24 volumio sudo[2298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:24 volumio sudo[2298]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:26 volumio sudo[2303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:26 volumio sudo[2303]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:26 volumio sudo[2303]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:26 volumio sudo[2305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:26 volumio sudo[2305]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:26 volumio sudo[2305]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:26 volumio volumio[843]: verbose: New Socket.io Connection to 192.168.31.111 from 192.168.31.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 07 23:14:26 volumio volumio[843]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 23:14:26 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 23:14:26 volumio volumio[843]: info: Received Get System Info Jul 07 23:14:26 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 23:14:26 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 23:14:26 volumio volumio[843]: info: Discovery: Getting this device information Jul 07 23:14:26 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:26 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:26 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 23:14:34 volumio sudo[2350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:34 volumio sudo[2350]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:34 volumio sudo[2350]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:34 volumio sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:34 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:34 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:34 volumio sudo[2355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 07 23:14:34 volumio sudo[2355]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:34 volumio sudo[2355]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:34 volumio volumio[843]: info: Upmpdcli Daemon Started Jul 07 23:14:35 volumio sudo[2359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:35 volumio sudo[2359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:35 volumio sudo[2359]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:35 volumio sudo[2361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:35 volumio sudo[2361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:35 volumio sudo[2361]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:35 volumio volumio[843]: verbose: New Socket.io Connection to 192.168.31.111 from 192.168.31.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 07 23:14:35 volumio volumio[843]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 23:14:35 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 23:14:35 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jul 07 23:14:35 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jul 07 23:14:36 volumio volumio[843]: info: Received Get System Info Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 23:14:36 volumio volumio[843]: info: Discovery: Getting this device information Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:36 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 23:14:36 volumio volumio-remote-updater[574]: No test mode Jul 07 23:14:36 volumio volumio-remote-updater[574]: No alpha test mode Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:36 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:36 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:36 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:36 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:36 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:36 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:36 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:36 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:36 volumio volumio[843]: info: Got it Jul 07 23:14:36 volumio volumio[843]: info: Got it Jul 07 23:14:36 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:36 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:36 volumio volumio[843]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 07 23:14:36 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 07 23:14:37 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jul 07 23:14:37 volumio volumio[843]: info: Loading i18n strings for locale ru Jul 07 23:14:37 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jul 07 23:14:37 volumio volumio[843]: info: Setting timezone to Europe/Moscow Jul 07 23:14:37 volumio sudo[2369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jul 07 23:14:37 volumio sudo[2369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:37 volumio sudo[2369]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:37 volumio sudo[2372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Moscow /etc/localtime Jul 07 23:14:37 volumio sudo[2372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:37 volumio sudo[2372]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:37 volumio sudo[2375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jul 07 23:14:37 volumio sudo[2375]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:37 volumio sudo[2375]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:37 volumio sudo[2378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Moscow Jul 07 23:14:37 volumio sudo[2378]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:37 volumio dbus-daemon[567]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.100' (uid=0 pid=2379 comm="/usr/bin/timedatectl set-timezone Europe/Moscow ") Jul 07 23:14:37 volumio systemd[1]: Starting Time & Date Service... Jul 07 23:14:37 volumio dbus-daemon[567]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 07 23:14:37 volumio systemd[1]: Started Time & Date Service. Jul 07 23:14:37 volumio sudo[2378]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:37 volumio volumio[843]: info: Fetching Streaming Services browse cache Jul 07 23:14:37 volumio volumio[843]: Updating browse sources language Jul 07 23:14:37 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 23:14:39 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Jul 07 23:14:39 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Jul 07 23:14:39 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 07 23:14:39 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:39 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 07 23:14:42 volumio volumio[843]: info: Preparing to save Alsa Options, stopping services first Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:42 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::volumioPause Jul 07 23:14:42 volumio volumio[843]: info: CoreStateMachine::pause Jul 07 23:14:42 volumio volumio[843]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"HiFiBerry Digi"},"output_device":{"value":1,"label":"HiFiBerry Digi"},"disallowPush":true} Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 07 23:14:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:42 volumio volumio[843]: info: Device 2 does not have any Mixer Control Available Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 07 23:14:43 volumio volumio[843]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry Digi Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 07 23:14:43 volumio volumio[843]: info: Disabling external Volume Control Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:43 volumio volumio[843]: info: CoreStateMachine::pushState Jul 07 23:14:43 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::volumioPushState Jul 07 23:14:43 volumio volumio[843]: info: Preparing to generate the ALSA configuration file Jul 07 23:14:43 volumio volumio[843]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:43 volumio volumio[843]: info: Getting Alsa Cards List without I2S DAC Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 07 23:14:43 volumio volumio[843]: info: Asound.conf file unchanged, so no further update is needed Jul 07 23:14:43 volumio volumio[843]: info: Output device has changed, restarting MPD Jul 07 23:14:43 volumio volumio[843]: info: Output device has changed, restarting Shairport Sync Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:43 volumio sudo[2401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 23:14:43 volumio sudo[2401]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:43 volumio sudo[2401]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:43 volumio sudo[2403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 23:14:43 volumio sudo[2403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:43 volumio systemd[1]: Stopping Music Player Daemon... Jul 07 23:14:43 volumio volumio[843]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:43 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:43 volumio systemd[1]: mpd.service: Succeeded. Jul 07 23:14:43 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 23:14:43 volumio volumio[843]: info: MPD Permissions set Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:43 volumio systemd[1]: Starting Music Player Daemon... Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:43 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:43 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:43 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:43 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:43 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:43 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:43 volumio volumio[843]: info: Got it Jul 07 23:14:43 volumio volumio[843]: info: Got it Jul 07 23:14:43 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:43 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:43 volumio volumio[843]: info: Starting Shairport Sync Jul 07 23:14:44 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:44 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:44 volumio sudo[2417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 23:14:44 volumio sudo[2417]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:44 volumio sudo[2409]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 07 23:14:44 volumio sudo[2409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:44 volumio sudo[2409]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 23:14:44 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 23:14:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 23:14:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 23:14:44 volumio sudo[2417]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:44 volumio volumio[843]: info: Shairport-Sync Started Jul 07 23:14:44 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:44 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:44 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:44 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:44 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:44 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:44 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:44 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:44 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:44 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:44 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:44 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:44 volumio volumio[843]: info: Got it Jul 07 23:14:44 volumio volumio[843]: info: Got it Jul 07 23:14:44 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:44 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:44 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:45 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 07 23:14:45 volumio volumio[843]: info: Preparing to save Alsa Options, stopping services first Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:45 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::volumioPause Jul 07 23:14:45 volumio volumio[843]: info: CoreStateMachine::pause Jul 07 23:14:45 volumio volumio[843]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"HiFiBerry Digi"},"output_device":{"value":1,"label":"HiFiBerry Digi"},"disallowPush":true} Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 07 23:14:45 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:46 volumio volumio[843]: info: Device 2 does not have any Mixer Control Available Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 07 23:14:46 volumio volumio[843]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry Digi Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 07 23:14:46 volumio volumio[843]: info: Disabling external Volume Control Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:46 volumio volumio[843]: info: CoreStateMachine::pushState Jul 07 23:14:46 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::volumioPushState Jul 07 23:14:46 volumio volumio[843]: info: Preparing to generate the ALSA configuration file Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:46 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 07 23:14:46 volumio volumio[843]: info: Getting Alsa Cards List without I2S DAC Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 07 23:14:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 07 23:14:47 volumio volumio[843]: info: Asound.conf file unchanged, so no further update is needed Jul 07 23:14:47 volumio volumio[843]: info: Output device has changed, restarting MPD Jul 07 23:14:47 volumio volumio[843]: info: Output device has changed, restarting Shairport Sync Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:47 volumio sudo[2442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 23:14:47 volumio sudo[2442]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:47 volumio sudo[2442]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:47 volumio sudo[2444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 23:14:47 volumio sudo[2444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:47 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 07 23:14:47 volumio systemd[1]: mpd.service: Succeeded. Jul 07 23:14:47 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 23:14:47 volumio volumio[843]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 07 23:14:47 volumio volumio[843]: info: CoreStateMachine::getcurrentVolume Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 23:14:47 volumio volumio[843]: info: CoreStateMachine::pushState Jul 07 23:14:47 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::volumioPushState Jul 07 23:14:47 volumio volumio[843]: info: MPD Permissions set Jul 07 23:14:47 volumio systemd[1]: Starting Music Player Daemon... Jul 07 23:14:47 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:47 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: Got it Jul 07 23:14:47 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:47 volumio volumio[843]: info: Starting Shairport Sync Jul 07 23:14:47 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:47 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:47 volumio volumio[843]: info: Got it Jul 07 23:14:47 volumio volumio[843]: info: Got it Jul 07 23:14:47 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:47 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:47 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:47 volumio sudo[2456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 07 23:14:47 volumio sudo[2456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 07 23:14:47 volumio sudo[2450]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 07 23:14:47 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 07 23:14:47 volumio sudo[2450]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 07 23:14:47 volumio sudo[2450]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 07 23:14:47 volumio sudo[2456]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:47 volumio volumio[843]: info: Shairport-Sync Started Jul 07 23:14:48 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:48 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:48 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:48 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:48 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:48 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:48 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:48 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:48 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:48 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:48 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:48 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:48 volumio volumio[843]: info: Got it Jul 07 23:14:48 volumio volumio[843]: info: Got it Jul 07 23:14:48 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:48 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:48 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:50 volumio mpd[2460]: Jul 07 23:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 07 23:14:50 volumio systemd[1]: Started Music Player Daemon. Jul 07 23:14:50 volumio sudo[2444]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:50 volumio sudo[2403]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:50 volumio volumio[843]: error: MPD error: The expression evaluated to a falsy value: Jul 07 23:14:50 volumio volumio[843]: assert.ok(self.idling) Jul 07 23:14:50 volumio volumio[843]: error: The expression evaluated to a falsy value: Jul 07 23:14:50 volumio volumio[843]: assert.ok(self.idling) Jul 07 23:14:50 volumio volumio[843]: error: updateQueue error: null Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 07 23:14:50 volumio volumio[843]: info: CoreStateMachine::getcurrentVolume Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::volumioRetrievevolume Jul 07 23:14:50 volumio volumio[843]: info: CoreStateMachine::pushState Jul 07 23:14:50 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::volumioPushState Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:50 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:50 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:50 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:50 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:50 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:50 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:50 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:50 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:50 volumio volumio[843]: info: Got it Jul 07 23:14:50 volumio volumio[843]: info: Got it Jul 07 23:14:50 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:50 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:50 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:51 volumio kernel: hwmon hwmon1: Voltage normalised Jul 07 23:14:52 volumio volumio[843]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jul 07 23:14:52 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jul 07 23:14:52 volumio volumio[843]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined Jul 07 23:14:52 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:52 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:14:52 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:14:52 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:52 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:14:52 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:52 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:52 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:14:52 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:14:52 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:52 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:14:52 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:14:52 volumio volumio[843]: info: Got it Jul 07 23:14:52 volumio volumio[843]: info: Got it Jul 07 23:14:52 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:14:52 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:14:52 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:14:53 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jul 07 23:14:53 volumio volumio[843]: info: CoreCommandRouter::Reload Ui Jul 07 23:14:53 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Jul 07 23:14:53 volumio volumio[843]: info: Wizard terminated Successfully Jul 07 23:14:53 volumio volumio[843]: info: CoreCommandRouter::volumiosetStartupVolume Jul 07 23:14:53 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 23:14:53 volumio volumio[843]: info: Player Reboot required after I2S DAC has been enabled in wizard Jul 07 23:14:55 volumio sudo[2478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:55 volumio sudo[2478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:55 volumio sudo[2478]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:55 volumio sudo[2480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:55 volumio sudo[2480]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:55 volumio sudo[2480]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:55 volumio volumio[843]: verbose: New Socket.io Connection to 192.168.31.111 from 192.168.31.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 07 23:14:55 volumio sudo[2484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 07 23:14:55 volumio sudo[2484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:55 volumio sudo[2486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 07 23:14:55 volumio sudo[2486]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 23:14:55 volumio sudo[2484]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:55 volumio sudo[2486]: pam_unix(sudo:session): session closed for user root Jul 07 23:14:55 volumio volumio[843]: verbose: New Socket.io Connection to 192.168.31.111 from 192.168.31.32 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 23:14:55 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::volumioGetVisibleSources Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:55 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 07 23:14:55 volumio volumio[843]: info: Received Get System Info Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 23:14:55 volumio volumio[843]: info: Discovery: Getting this device information Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:55 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:55 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:55 volumio volumio[843]: info: Listing playlists Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 07 23:14:55 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 07 23:14:56 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:56 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:57 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 07 23:14:57 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 07 23:14:57 volumio volumio[843]: info: Received Get System Info Jul 07 23:14:57 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 23:14:57 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 23:14:57 volumio volumio[843]: info: Discovery: Getting this device information Jul 07 23:14:57 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:57 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:57 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 23:14:58 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 07 23:14:58 volumio volumio[843]: info: Received Get System Info Jul 07 23:14:58 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 23:14:58 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 23:14:58 volumio volumio[843]: info: Discovery: Getting this device information Jul 07 23:14:58 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:14:58 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:14:58 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 23:14:59 volumio kernel: hwmon hwmon1: Voltage normalised Jul 07 23:15:00 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jul 07 23:15:01 volumio volumio[843]: info: CoreCommandRouter::volumioPlay Jul 07 23:15:01 volumio volumio[843]: info: CoreStateMachine::play index undefined Jul 07 23:15:01 volumio volumio[843]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 23:15:01 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:15:05 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 07 23:15:07 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 07 23:15:07 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 07 23:15:07 volumio systemd[1]: systemd-timedated.service: Succeeded. Jul 07 23:15:08 volumio volumio-remote-updater[574]: No test mode Jul 07 23:15:08 volumio volumio-remote-updater[574]: No alpha test mode Jul 07 23:15:08 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 07 23:15:08 volumio volumio[843]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 07 23:15:08 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 07 23:15:08 volumio volumio[843]: info: CoreCommandRouter::Close All Modals sent Jul 07 23:15:08 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 07 23:15:13 volumio volumio[843]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 07 23:15:13 volumio volumio[843]: info: Received Get System Version Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 23:15:13 volumio volumio[843]: info: Received Get System Info Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 23:15:13 volumio volumio[843]: info: Discovery: Getting this device information Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::volumioGetState Jul 07 23:15:13 volumio volumio[843]: info: CorePlayQueue::getTrack 0 Jul 07 23:15:13 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 23:15:17 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:15:17 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:15:17 volumio volumio[843]: info: Retrieving Cloud Streaming UI Jul 07 23:15:17 volumio volumio[843]: info: Getting Tidal Cloud Configuration Jul 07 23:15:17 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:15:17 volumio volumio[843]: info: Getting Qobuz Cloud Configuration Jul 07 23:15:17 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:15:17 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:15:17 volumio volumio[843]: info: Getting Spotify Cloud Configuration Jul 07 23:15:17 volumio volumio[843]: info: Asking plugin for UI Config Jul 07 23:15:17 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:15:17 volumio volumio[843]: info: Saving Spotify Acccount Jul 07 23:15:17 volumio volumio[843]: info: Got Tidal Cloud Configuration Jul 07 23:15:17 volumio volumio[843]: info: Got it Jul 07 23:15:17 volumio volumio[843]: info: Got it Jul 07 23:15:17 volumio volumio[843]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 07 23:15:17 volumio volumio[843]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 07 23:15:17 volumio volumio[843]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::volumioGetBrowseSources Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:18 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 07 23:15:22 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:26 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:27 volumio volumio[843]: info: Enabling MyMusic plugin bluetooth Jul 07 23:15:27 volumio volumio[843]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth Jul 07 23:15:27 volumio volumio[843]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling Jul 07 23:15:27 volumio volumio[843]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling Jul 07 23:15:27 volumio volumio[843]: error: Could not Enable MyMusic Plugin: Error Jul 07 23:15:30 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:33 volumio volumio[843]: info: Enabling MyMusic plugin bluetooth Jul 07 23:15:33 volumio volumio[843]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth Jul 07 23:15:33 volumio volumio[843]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling Jul 07 23:15:33 volumio volumio[843]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling Jul 07 23:15:33 volumio volumio[843]: error: Could not Enable MyMusic Plugin: Error Jul 07 23:15:34 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:38 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:42 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:45 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 07 23:15:46 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:50 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:51 volumio kernel: hwmon hwmon1: Voltage normalised Jul 07 23:15:53 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jul 07 23:15:53 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jul 07 23:15:54 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:58 volumio volumio[843]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 07 23:15:58 volumio volumio[843]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 23:15:58 volumio volumio[843]: Error: dns service error: unknown Jul 07 23:15:58 volumio volumio[843]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Jul 07 23:15:58 volumio volumio[843]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Jul 07 23:15:58 volumio volumio[843]: errorCode: -65537 Jul 07 23:15:58 volumio volumio[843]: } Jul 07 23:15:58 volumio volumio[843]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 23:15:59 volumio sudo[2555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-07 23:14 Jul 07 23:15:59 volumio sudo[2555]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"