Dec 07 15:09:01 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 15:09:05 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 15:09:08 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Dec 07 15:09:08 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:09:11 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:09:11 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 07 15:09:12 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 07 15:09:12 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 07 15:09:12 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 07 15:09:12 volumio volumio[1255]: info: Received Get System Version Dec 07 15:09:12 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 07 15:09:20 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Dec 07 15:09:20 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:09:22 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:09:23 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 07 15:09:23 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 07 15:09:23 volumio sudo[1859]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 07 15:09:23 volumio sudo[1859]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio sudo[1864]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 07 15:09:23 volumio sudo[1864]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Dec 07 15:09:23 volumio sudo[1866]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 07 15:09:23 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Dec 07 15:09:23 volumio sudo[1866]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio sudo[1864]: pam_unix(sudo:session): session closed for user root Dec 07 15:09:23 volumio sudo[1874]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 07 15:09:23 volumio sudo[1874]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio sudo[1880]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 07 15:09:23 volumio sudo[1880]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio sudo[1859]: pam_unix(sudo:session): session closed for user root Dec 07 15:09:23 volumio sudo[1866]: pam_unix(sudo:session): session closed for user root Dec 07 15:09:23 volumio sudo[1880]: pam_unix(sudo:session): session closed for user root Dec 07 15:09:23 volumio sudo[1874]: pam_unix(sudo:session): session closed for user root Dec 07 15:09:23 volumio sudo[1887]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 07 15:09:23 volumio sudo[1887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio sudo[1882]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 07 15:09:23 volumio sudo[1882]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:09:23 volumio sudo[1882]: pam_unix(sudo:session): session closed for user root Dec 07 15:09:24 volumio sudo[1887]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:03 volumio volumio[1255]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object] Dec 07 15:10:03 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Dec 07 15:10:04 volumio sudo[1958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Dec 07 15:10:04 volumio sudo[1958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:04 volumio sudo[1958]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:04 volumio volumio[1255]: info: Permissions for /etc/hostapd/hostapd.conf Dec 07 15:10:04 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Dec 07 15:10:04 volumio volumio[1255]: info: Discovery: Restarting Advertising due to device name change Dec 07 15:10:04 volumio sudo[1961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Dec 07 15:10:04 volumio sudo[1961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:05 volumio systemd[1]: Stopping wireless.service - Wireless Services... Dec 07 15:10:05 volumio systemd[1]: wireless.service: Killing process 1104 (wpa_supplicant) with signal SIGKILL. Dec 07 15:10:05 volumio systemd[1]: wireless.service: Deactivated successfully. Dec 07 15:10:05 volumio systemd[1]: Stopped wireless.service - Wireless Services. Dec 07 15:10:05 volumio systemd[1]: wireless.service: Consumed 6min 49.319s CPU time. Dec 07 15:10:05 volumio systemd[1]: Starting wireless.service - Wireless Services... Dec 07 15:10:05 volumio volumio[1255]: info: Discovery: A device disappeared from network Dec 07 15:10:05 volumio volumio[1255]: info: Discovery: Device volumio disappeared from network Dec 07 15:10:05 volumio volumio[1255]: info: Discovery: A device disappeared from network Dec 07 15:10:06 volumio wireless.js[1965]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Dec 07 15:10:06 volumio wireless.js[1965]: WIRELESS.JS: Wireless.js initializing wireless flow Dec 07 15:10:06 volumio wireless.js[1965]: WIRELESS.JS: Cleaning previous... Dec 07 15:10:07 volumio sudo[1984]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 07 15:10:07 volumio sudo[1984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 15:10:07 volumio avahi-daemon[1245]: Withdrawing address record for 192.168.4.30 on wlan0. Dec 07 15:10:07 volumio avahi-daemon[1245]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.30. Dec 07 15:10:07 volumio dhcpcd[752]: wlan0: pid 1985 deleted IP address 192.168.4.30/22 Dec 07 15:10:07 volumio dhcpcd[752]: wlan0: deleting route to 192.168.4.0/22 Dec 07 15:10:07 volumio sudo[1984]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:07 volumio avahi-daemon[1245]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 07 15:10:07 volumio dhcpcd[752]: wlan0: deleting default route via 192.168.4.1 Dec 07 15:10:07 volumio sudo[1987]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 07 15:10:07 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 15:10:07 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 07 15:10:07 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 07 15:10:07 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 07 15:10:07 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 07 15:10:07 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 07 15:10:07 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 07 15:10:07 volumio dhcpcd[752]: wlan0: rebinding lease of 192.168.4.30 Dec 07 15:10:07 volumio dhcpcd[752]: wlan0: carrier lost Dec 07 15:10:07 volumio welcome[2001]: Resolved ip:[0] Dec 07 15:10:07 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:07 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 07 15:10:07 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 07 15:10:08 volumio wireless.js[1965]: WIRELESS.JS: Stopped aP Dec 07 15:10:08 volumio sudo[2027]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 07 15:10:08 volumio sudo[2027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:08 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 07 15:10:08 volumio sudo[2027]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:08 volumio sudo[2029]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 07 15:10:08 volumio sudo[2029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:08 volumio sudo[2029]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:08 volumio sudo[2037]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 07 15:10:08 volumio sudo[2037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:08 volumio sudo[2037]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:08 volumio sudo[2039]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 07 15:10:08 volumio sudo[2039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:08 volumio sudo[2039]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:08 volumio wireless.js[1965]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: US Dec 07 15:10:09 volumio sudo[2045]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 07 15:10:09 volumio sudo[2045]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:09 volumio sudo[2045]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:09 volumio sudo[2047]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US Dec 07 15:10:09 volumio sudo[2047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:09 volumio sudo[2047]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:09 volumio wireless.js[1965]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: US Dec 07 15:10:09 volumio wireless.js[1965]: WIRELESS.JS: Start wireless flow Dec 07 15:10:09 volumio wireless.js[1965]: WIRELESS.JS: Stopped hotspot (if there).. Dec 07 15:10:09 volumio sudo[2055]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Dec 07 15:10:09 volumio sudo[2055]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 15:10:09 volumio sudo[2055]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:09 volumio sudo[2057]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Dec 07 15:10:09 volumio sudo[2057]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 15:10:09 volumio volumio[1255]: info: Discovery: Started advertising with name: Volumio Dec 07 15:10:09 volumio sudo[2057]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:09 volumio wireless.js[1965]: WIRELESS.JS: DHCP IP fallback Dec 07 15:10:09 volumio wireless.js[1965]: WIRELESS.JS: Start ap Dec 07 15:10:09 volumio wpa_supplicant[2063]: Successfully initialized wpa_supplicant Dec 07 15:10:10 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 07 15:10:10 volumio sudo[2064]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Dec 07 15:10:10 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 15:10:10 volumio dhcpcd[752]: ps_ctl_dispatch: cannot handle another client Dec 07 15:10:10 volumio dhcpcd[752]: control_free: No such file or directory Dec 07 15:10:10 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:10 volumio volumio[1255]: info: Discovery: adding 52ebd6ae-9b3c-4504-9a96-ddf0b8cd452b Dec 07 15:10:10 volumio volumio[1255]: info: Discovery: Found device Volumio Dec 07 15:10:10 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Dec 07 15:10:10 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:10 volumio wpa_supplicant[2068]: wlan0: Trying to associate with d0:68:27:e4:1c:c6 (SSID='ThompsonFam' freq=2462 MHz) Dec 07 15:10:10 volumio wpa_supplicant[2068]: wlan0: Associated with d0:68:27:e4:1c:c6 Dec 07 15:10:10 volumio wpa_supplicant[2068]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 07 15:10:10 volumio wpa_supplicant[2068]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Dec 07 15:10:10 volumio wpa_supplicant[2068]: wlan0: WPA: Key negotiation completed with d0:68:27:e4:1c:c6 [PTK=CCMP GTK=CCMP] Dec 07 15:10:10 volumio wpa_supplicant[2068]: wlan0: CTRL-EVENT-CONNECTED - Connection to d0:68:27:e4:1c:c6 completed [id=0 id_str=] Dec 07 15:10:10 volumio dhcpcd[752]: wlan0: carrier acquired Dec 07 15:10:10 volumio dhcpcd[752]: wlan0: IAID eb:30:51:94 Dec 07 15:10:10 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:11 volumio sudo[2073]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:11 volumio dhcpcd[752]: wlan0: soliciting an IPv6 router Dec 07 15:10:11 volumio sudo[2073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:11 volumio sudo[2073]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:11 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:12 volumio sudo[2077]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:12 volumio sudo[2077]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:12 volumio sudo[2077]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:12 volumio ntpd[1021]: IO: Deleting interface #3 wlan0, 192.168.4.30#123, interface stats: received=167, sent=172, dropped=0, active_time=205 secs Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 171.66.97.126 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 155.248.196.28 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 108.61.215.221 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 23.186.168.133 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 23.150.41.122 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 97.107.136.23 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 142.202.190.19 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 198.137.202.56 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 52.21.95.127 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 23.186.168.129 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 162.159.200.1 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 192.155.94.72 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 23.186.168.132 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 45.33.53.84 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 51.81.226.229 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio ntpd[1021]: PROTO: 96.231.54.40 unlink local addr 192.168.4.30 -> Dec 07 15:10:12 volumio dhcpcd[752]: wlan0: rebinding lease of 192.168.4.30 Dec 07 15:10:12 volumio dhcpcd[752]: wlan0: probing address 192.168.4.30/22 Dec 07 15:10:12 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:13 volumio sudo[2083]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:13 volumio sudo[2083]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:13 volumio sudo[2083]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:13 volumio volumio[1255]: info: Volumio Network Manager: Network status updated: 0 Dec 07 15:10:13 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:14 volumio sudo[2101]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:14 volumio sudo[2101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:14 volumio sudo[2101]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:14 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:15 volumio sudo[2105]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:15 volumio sudo[2105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:15 volumio sudo[2105]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:15 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:16 volumio sudo[2109]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:16 volumio sudo[2109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:16 volumio sudo[2109]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:16 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:17 volumio sudo[2113]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:17 volumio sudo[2113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:17 volumio sudo[2113]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:17 volumio dhcpcd[752]: wlan0: leased 192.168.4.30 for 14188 seconds Dec 07 15:10:17 volumio avahi-daemon[1245]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.30. Dec 07 15:10:17 volumio avahi-daemon[1245]: New relevant interface wlan0.IPv4 for mDNS. Dec 07 15:10:17 volumio avahi-daemon[1245]: Registering new address record for 192.168.4.30 on wlan0.IPv4. Dec 07 15:10:17 volumio dhcpcd[752]: wlan0: adding route to 192.168.4.0/22 Dec 07 15:10:17 volumio dhcpcd[752]: wlan0: adding default route via 192.168.4.1 Dec 07 15:10:17 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 07 15:10:17 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Dec 07 15:10:17 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 07 15:10:17 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 07 15:10:17 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 07 15:10:17 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 07 15:10:17 volumio welcome[2125]: Resolved ip:[1] 192.168.4.30 Dec 07 15:10:17 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 07 15:10:17 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 07 15:10:17 volumio wireless.js[1965]: WIRELESS.JS: trying... Dec 07 15:10:18 volumio sudo[2147]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 07 15:10:18 volumio sudo[2147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:18 volumio sudo[2147]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:18 volumio wireless.js[1965]: WIRELESS.JS: Connected to: ----ThompsonFam---- Dec 07 15:10:18 volumio volumio[1255]: info: Discovery: this is already registered, 52ebd6ae-9b3c-4504-9a96-ddf0b8cd452b Dec 07 15:10:18 volumio volumio[1255]: info: Discovery: Found device Volumio Dec 07 15:10:18 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Dec 07 15:10:18 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:18 volumio sudo[2150]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 07 15:10:18 volumio sudo[2150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 15:10:18 volumio sudo[2150]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:18 volumio wireless.js[1965]: WIRELESS.JS: ... joined AP, wlan0 IPv4 is 192.168.4.30, ipV6 is undefined Dec 07 15:10:18 volumio wireless.js[1965]: WIRELESS.JS: It's done! AP Dec 07 15:10:18 volumio wireless.js[1965]: WIRELESS.JS: Restarting avahi-daemon... Dec 07 15:10:18 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 07 15:10:18 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 07 15:10:18 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 07 15:10:18 volumio systemd[1]: shairport-sync.service: Consumed 2.174s CPU time. Dec 07 15:10:18 volumio avahi-daemon[1245]: Got SIGTERM, quitting. Dec 07 15:10:18 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 07 15:10:18 volumio avahi-daemon[1245]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.30. Dec 07 15:10:18 volumio avahi-daemon[1245]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 07 15:10:18 volumio avahi-daemon[1245]: avahi-daemon 0.8 exiting. Dec 07 15:10:18 volumio dbus-daemon[651]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.22' (uid=0 pid=1287 comm="/usr/sbin/smbd --foreground --no-process-group") Dec 07 15:10:18 volumio systemd[1]: avahi-daemon.service: Deactivated successfully. Dec 07 15:10:18 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 07 15:10:18 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 07 15:10:18 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 07 15:10:18 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 07 15:10:18 volumio avahi-daemon[2158]: Process 1245 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Dec 07 15:10:18 volumio wireless.js[1965]: WIRELESS.JS: Notified systemd about wireless ready Dec 07 15:10:18 volumio avahi-daemon[2158]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Dec 07 15:10:18 volumio avahi-daemon[2158]: Successfully dropped root privileges. Dec 07 15:10:18 volumio avahi-daemon[2158]: avahi-daemon 0.8 starting up. Dec 07 15:10:18 volumio sudo[1961]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:18 volumio dbus-daemon[651]: [system] Successfully activated service 'org.freedesktop.Avahi' Dec 07 15:10:18 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 07 15:10:18 volumio avahi-daemon[2158]: Successfully called chroot(). Dec 07 15:10:18 volumio avahi-daemon[2158]: Successfully dropped remaining capabilities. Dec 07 15:10:18 volumio avahi-daemon[2158]: No service file found in /etc/avahi/services. Dec 07 15:10:18 volumio avahi-daemon[2158]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.30. Dec 07 15:10:18 volumio avahi-daemon[2158]: New relevant interface wlan0.IPv4 for mDNS. Dec 07 15:10:18 volumio avahi-daemon[2158]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 07 15:10:18 volumio avahi-daemon[2158]: New relevant interface lo.IPv4 for mDNS. Dec 07 15:10:18 volumio avahi-daemon[2158]: Network interface enumeration completed. Dec 07 15:10:18 volumio avahi-daemon[2158]: Registering new address record for 192.168.4.30 on wlan0.IPv4. Dec 07 15:10:18 volumio avahi-daemon[2158]: Registering new address record for 127.0.0.1 on lo.IPv4. Dec 07 15:10:18 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 07 15:10:18 volumio volumio[1255]: info: Discovery: mDNS browse temporarily unavailable during network transition Dec 07 15:10:18 volumio volumio[1255]: error: Discovery: Advertisement error: Error: dns service error: unknown Dec 07 15:10:18 volumio volumio[1255]: info: Discovery: mDNS temporarily unavailable during network transition Dec 07 15:10:18 volumio ntpd[1021]: IO: Listen normally on 4 wlan0 192.168.4.30:123 Dec 07 15:10:18 volumio ntpd[1021]: IO: new interface(s) found: waking up resolver Dec 07 15:10:19 volumio avahi-daemon[2158]: Server startup complete. Host name is volumio.local. Local service cookie is 3780264272. Dec 07 15:10:19 volumio volumio[1255]: info: CoreCommandRouter::volumioGetState Dec 07 15:10:19 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:23 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Dec 07 15:10:23 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Dec 07 15:10:23 volumio volumio[1255]: info: Volumio Network Manager: Network status updated: 2 Dec 07 15:10:23 volumio sudo[2194]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 07 15:10:23 volumio sudo[2194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:23 volumio sudo[2194]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:23 volumio sudo[2199]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 07 15:10:23 volumio sudo[2199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:23 volumio sudo[2199]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:10:25 volumio volumio[1255]: info: Retrieving Cloud Streaming UI Dec 07 15:10:25 volumio volumio[1255]: info: Getting Tidal Cloud Configuration Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:10:25 volumio volumio[1255]: info: Getting Qobuz Cloud Configuration Dec 07 15:10:25 volumio volumio[1255]: info: Asking plugin for UI Config Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:10:25 volumio volumio[1255]: info: Getting Spotify Cloud Configuration Dec 07 15:10:25 volumio volumio[1255]: info: Asking plugin for UI Config Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:10:25 volumio volumio[1255]: info: Saving Spotify Acccount Dec 07 15:10:25 volumio volumio[1255]: info: Got Tidal Cloud Configuration Dec 07 15:10:25 volumio volumio[1255]: info: Got it Dec 07 15:10:25 volumio volumio[1255]: info: Got it Dec 07 15:10:25 volumio volumio[1255]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 15:10:25 volumio volumio[1255]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::volumioGetBrowseSources Dec 07 15:10:25 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 15:10:26 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 07 15:10:28 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Dec 07 15:10:28 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Dec 07 15:10:28 volumio volumio[1255]: info: Refreshing Cached IP Addresses Dec 07 15:10:28 volumio volumio[1255]: info: Discovery: Started advertising with name: Volumio Dec 07 15:10:28 volumio sudo[2206]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Dec 07 15:10:28 volumio sudo[2206]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:28 volumio sudo[2209]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 07 15:10:28 volumio sudo[2209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:28 volumio sudo[2210]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 07 15:10:28 volumio sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 07 15:10:28 volumio sudo[2209]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:28 volumio sudo[2206]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:28 volumio sudo[2210]: pam_unix(sudo:session): session closed for user root Dec 07 15:10:29 volumio upmpdcli[1490]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Dec 07 15:10:29 volumio upmpdcli[1490]: :2:../src/ohmetacache.cxx:94::dmcacheSaveWorker: can't get task from queue Dec 07 15:10:29 volumio systemd[1]: upmpdcli.service: Deactivated successfully. Dec 07 15:10:29 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand update Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: info: Dec 07 15:10:30 volumio volumio[1255]: ---------------------------- MPD announces state update: update Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand update took 29 milliseconds Dec 07 15:10:30 volumio volumio[1255]: info: ControllerMpd::getState Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand status took 27 milliseconds Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand status took 17 milliseconds Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:30 volumio volumio[1255]: info: Command Router : Notfying DB Updatetrue Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:30 volumio volumio[1255]: info: ControllerMpd::pushState Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Dec 07 15:10:30 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:30 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:30 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:30 volumio volumio[1255]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 07 15:10:30 volumio volumio[1255]: verbose: CURRENT POSITION 0 Dec 07 15:10:30 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Dec 07 15:10:30 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:10:30 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:30 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:30 volumio volumio[1255]: info: No code Dec 07 15:10:30 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:30 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:30 volumio volumio[1255]: info: ------------------------------ 449ms Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: info: Dec 07 15:10:30 volumio volumio[1255]: ---------------------------- MPD announces state update: update Dec 07 15:10:30 volumio volumio[1255]: info: ControllerMpd::getState Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: info: Dec 07 15:10:30 volumio volumio[1255]: ---------------------------- MPD announces state update: update Dec 07 15:10:30 volumio volumio[1255]: info: ControllerMpd::getState Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: info: Dec 07 15:10:30 volumio volumio[1255]: ---------------------------- MPD announces state update: update Dec 07 15:10:30 volumio volumio[1255]: info: ControllerMpd::getState Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand status took 64 milliseconds Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand status took 50 milliseconds Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand status took 47 milliseconds Dec 07 15:10:30 volumio volumio[1255]: info: sendMpdCommand status took 37 milliseconds Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:30 volumio volumio[1255]: info: Command Router : Notfying DB Updatefalse Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::Close All Modals sent Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:30 volumio volumio[1255]: info: Command Router : Notfying DB Updatefalse Dec 07 15:10:30 volumio volumio[1255]: info: CoreCommandRouter::Close All Modals sent Dec 07 15:10:30 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:31 volumio volumio[1255]: info: ControllerMpd::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 07 15:10:31 volumio volumio[1255]: verbose: CURRENT POSITION 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:31 volumio volumio[1255]: info: No code Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:31 volumio volumio[1255]: info: ControllerMpd::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 07 15:10:31 volumio volumio[1255]: verbose: CURRENT POSITION 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:31 volumio volumio[1255]: info: No code Dec 07 15:10:31 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:31 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:31 volumio volumio[1255]: info: ------------------------------ 688ms Dec 07 15:10:31 volumio volumio[1255]: info: ------------------------------ 665ms Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:31 volumio volumio[1255]: info: Dec 07 15:10:31 volumio volumio[1255]: ---------------------------- MPD announces state update: update Dec 07 15:10:31 volumio volumio[1255]: info: ControllerMpd::getState Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:31 volumio volumio[1255]: info: Dec 07 15:10:31 volumio volumio[1255]: ---------------------------- MPD announces state update: update Dec 07 15:10:31 volumio volumio[1255]: info: ControllerMpd::getState Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::sendMpdCommand status Dec 07 15:10:31 volumio volumio[1255]: info: sendMpdCommand status took 844 milliseconds Dec 07 15:10:31 volumio volumio[1255]: info: sendMpdCommand status took 828 milliseconds Dec 07 15:10:31 volumio volumio[1255]: info: sendMpdCommand status took 198 milliseconds Dec 07 15:10:31 volumio volumio[1255]: info: sendMpdCommand status took 197 milliseconds Dec 07 15:10:31 volumio volumio[1255]: info: sendMpdCommand status took 225 milliseconds Dec 07 15:10:31 volumio volumio[1255]: info: sendMpdCommand status took 216 milliseconds Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:31 volumio volumio[1255]: info: Command Router : Notfying DB Updatefalse Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::Close All Modals sent Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:31 volumio volumio[1255]: info: Command Router : Notfying DB Updatefalse Dec 07 15:10:31 volumio volumio[1255]: info: CoreCommandRouter::Close All Modals sent Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:31 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:32 volumio volumio[1255]: info: Command Router : Notfying DB Updatefalse Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::Close All Modals sent Dec 07 15:10:32 volumio volumio[1255]: verbose: ControllerMpd::parseState Dec 07 15:10:32 volumio volumio[1255]: info: ControllerMpd::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 07 15:10:32 volumio volumio[1255]: verbose: CURRENT POSITION 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: No code Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: ControllerMpd::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 07 15:10:32 volumio volumio[1255]: verbose: CURRENT POSITION 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: No code Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: ControllerMpd::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::servicePushState Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 07 15:10:32 volumio volumio[1255]: verbose: CURRENT POSITION 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::syncState stateService stop Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::syncState currentStatus stop Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: No code Dec 07 15:10:32 volumio volumio[1255]: info: CoreStateMachine::pushState Dec 07 15:10:32 volumio volumio[1255]: info: CorePlayQueue::getTrack 0 Dec 07 15:10:32 volumio volumio[1255]: info: CoreCommandRouter::volumioPushState Dec 07 15:10:32 volumio volumio[1255]: info: ------------------------------ 2193ms Dec 07 15:10:32 volumio volumio[1255]: info: ------------------------------ 1550ms Dec 07 15:10:32 volumio volumio[1255]: info: ------------------------------ 1541ms Dec 07 15:10:34 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 15:10:36 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 07 15:10:36 volumio volumio[1255]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 07 15:10:37 volumio volumio[1255]: compat.c: read() failed: Resource temporarily unavailable Dec 07 15:10:37 volumio volumio[1255]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 15:10:37 volumio volumio[1255]: Error: dns service error: unknown Dec 07 15:10:37 volumio volumio[1255]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 07 15:10:37 volumio volumio[1255]: errorCode: -65537 Dec 07 15:10:37 volumio volumio[1255]: } Dec 07 15:10:37 volumio volumio[1255]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 15:10:42 volumio sudo[2270]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-07 15:09' Dec 07 15:10:42 volumio sudo[2270]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"