Aug 25 08:10:20 porch volumio[1226]: info: Received Get System Info Aug 25 08:10:20 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 08:10:20 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 08:10:20 porch volumio[1226]: info: Discovery: Getting this device information Aug 25 08:10:20 porch volumio[1226]: info: CoreCommandRouter::volumioGetState Aug 25 08:10:20 porch volumio[1226]: info: CorePlayQueue::getTrack 1 Aug 25 08:10:20 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 08:10:20 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 25 08:10:20 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 25 08:10:21 porch volumio5-onboarding[1873]: time=2026-08-25T08:10:21.004-05:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 25 08:11:33 porch wpa_supplicant[1135]: wlan0: WNM: Preferred List Available Aug 25 08:11:33 porch wpa_supplicant[1135]: wlan0: SME: Trying to authenticate with 5c:35:fc:7e:14:09 (SSID='TIPTIO' freq=2412 MHz) Aug 25 08:11:34 porch volumio[1226]: info: Received Get System Info Aug 25 08:11:34 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 08:11:34 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 08:11:34 porch volumio[1226]: info: Discovery: Getting this device information Aug 25 08:11:34 porch volumio[1226]: info: CoreCommandRouter::volumioGetState Aug 25 08:11:34 porch volumio[1226]: info: CorePlayQueue::getTrack 1 Aug 25 08:11:34 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 08:11:34 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 25 08:11:34 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 25 08:11:34 porch dhcpcd[1205]: wlan0: carrier lost Aug 25 08:11:34 porch kernel: wlan0: disconnect from AP 5c:35:fc:7e:14:11 for new auth to 5c:35:fc:7e:14:09 Aug 25 08:11:35 porch kernel: wlan0: authenticate with 5c:35:fc:7e:14:09 (local address=b4:4b:d6:21:21:71) Aug 25 08:11:35 porch kernel: wlan0: send auth to 5c:35:fc:7e:14:09 (try 1/3) Aug 25 08:11:35 porch avahi-daemon[1411]: Withdrawing address record for 192.168.1.181 on wlan0. Aug 25 08:11:35 porch avahi-daemon[1411]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.181. Aug 25 08:11:35 porch avahi-daemon[1411]: Interface wlan0.IPv4 no longer relevant for mDNS. Aug 25 08:11:35 porch dhcpcd[1205]: wlan0: deleting route to 192.168.1.0/24 Aug 25 08:11:35 porch kernel: wlan0: authenticated Aug 25 08:11:35 porch dhcpcd[1205]: wlan0: deleting default route via 192.168.1.1 Aug 25 08:11:35 porch volumio[1226]: info: Discovery: A device disappeared from network Aug 25 08:11:35 porch wpa_supplicant[1135]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Aug 25 08:11:35 porch wpa_supplicant[1135]: wlan0: Trying to associate with 5c:35:fc:7e:14:09 (SSID='TIPTIO' freq=2412 MHz) Aug 25 08:11:35 porch kernel: wlan0: associate with 5c:35:fc:7e:14:09 (try 1/3) Aug 25 08:11:35 porch volumio[1226]: info: Discovery: A device disappeared from network Aug 25 08:11:35 porch volumio[1226]: info: Discovery: Device dj disappeared from network Aug 25 08:11:35 porch volumio[1226]: info: Discovery: Disconnected from remote: 192.168.1.202 Aug 25 08:11:35 porch kernel: wlan0: RX ReassocResp from 5c:35:fc:7e:14:09 (capab=0x1431 status=0 aid=21) Aug 25 08:11:35 porch wpa_supplicant[1135]: wlan0: Associated with 5c:35:fc:7e:14:09 Aug 25 08:11:35 porch kernel: wlan0: associated Aug 25 08:11:35 porch volumio[1226]: info: Received Get System Info Aug 25 08:11:35 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 08:11:35 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 08:11:35 porch volumio[1226]: info: Discovery: Getting this device information Aug 25 08:11:35 porch volumio[1226]: info: CoreCommandRouter::volumioGetState Aug 25 08:11:35 porch volumio[1226]: info: CorePlayQueue::getTrack 1 Aug 25 08:11:35 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 08:11:35 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 25 08:11:35 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 25 08:11:35 porch wpa_supplicant[1135]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 25 08:11:35 porch kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 5c:35:fc:7e:14:09 Aug 25 08:11:35 porch systemd[1]: Stopped target ip-changed@wlan2.target - IP Address changed on wlan2. Aug 25 08:11:35 porch systemd[1]: Stopping ip-changed@wlan2.target - IP Address changed on wlan2... Aug 25 08:11:35 porch systemd[1]: Reached target ip-changed@wlan2.target - IP Address changed on wlan2. Aug 25 08:11:35 porch wpa_supplicant[1135]: wlan0: WPA: Key negotiation completed with 5c:35:fc:7e:14:09 [PTK=CCMP GTK=CCMP] Aug 25 08:11:35 porch wpa_supplicant[1135]: wlan0: CTRL-EVENT-CONNECTED - Connection to 5c:35:fc:7e:14:09 completed [id=0 id_str=] Aug 25 08:11:35 porch dhcpcd[1205]: wlan0: carrier acquired Aug 25 08:11:35 porch dhcpcd[1205]: wlan0: IAID d6:21:21:71 Aug 25 08:11:36 porch volumio[1226]: info: Received Get System Info Aug 25 08:11:36 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 08:11:36 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 08:11:36 porch volumio[1226]: info: Discovery: Getting this device information Aug 25 08:11:36 porch volumio[1226]: info: CoreCommandRouter::volumioGetState Aug 25 08:11:36 porch volumio[1226]: info: CorePlayQueue::getTrack 1 Aug 25 08:11:36 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 08:11:36 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 25 08:11:36 porch volumio[1226]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 25 08:11:36 porch dhcpcd[1205]: wlan0: soliciting an IPv6 router Aug 25 08:11:37 porch dhcpcd[1205]: wlan0: rebinding lease of 192.168.1.181 Aug 25 08:11:37 porch dhcpcd[1205]: wlan0: probing address 192.168.1.181/24 Aug 25 08:11:37 porch ntpd[874]: IO: Deleting interface #16 wlan0, 192.168.1.181#123, interface stats: received=162, sent=162, dropped=0, active_time=24323 secs Aug 25 08:11:37 porch ntpd[874]: PROTO: 163.123.153.14 unlink local addr 192.168.1.181 -> Aug 25 08:11:37 porch ntpd[874]: PROTO: 23.143.196.200 unlink local addr 192.168.1.181 -> Aug 25 08:11:37 porch ntpd[874]: PROTO: 23.150.41.122 unlink local addr 192.168.1.181 -> Aug 25 08:11:37 porch ntpd[874]: PROTO: 208.113.130.146 unlink local addr 192.168.1.181 -> Aug 25 08:11:37 porch ntpd[874]: PROTO: 172.238.164.57 unlink local addr 192.168.1.181 -> Aug 25 08:11:37 porch ntpd[874]: PROTO: 66.85.78.80 unlink local addr 192.168.1.181 -> Aug 25 08:11:37 porch ntpd[874]: PROTO: 173.249.203.227 unlink local addr 192.168.1.181 -> Aug 25 08:11:38 porch volumio5-onboarding[1873]: time=2026-08-25T08:11:38.684-05:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 25 08:11:42 porch dhcpcd[1205]: wlan0: leased 192.168.1.181 for 86400 seconds Aug 25 08:11:42 porch dhcpcd[1205]: wlan0: adding route to 192.168.1.0/24 Aug 25 08:11:42 porch avahi-daemon[1411]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.181. Aug 25 08:11:42 porch avahi-daemon[1411]: New relevant interface wlan0.IPv4 for mDNS. Aug 25 08:11:42 porch dhcpcd[1205]: wlan0: adding default route via 192.168.1.1 Aug 25 08:11:42 porch avahi-daemon[1411]: Registering new address record for 192.168.1.181 on wlan0.IPv4. Aug 25 08:11:42 porch systemd[1]: Stopped target ip-changed@wlan2.target - IP Address changed on wlan2. Aug 25 08:11:42 porch systemd[1]: Stopping ip-changed@wlan2.target - IP Address changed on wlan2... Aug 25 08:11:42 porch systemd[1]: Reached target ip-changed@wlan2.target - IP Address changed on wlan2. Aug 25 08:11:42 porch volumio[1226]: compat.c: read() failed: Resource temporarily unavailable Aug 25 08:11:42 porch volumio[1226]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:11:42 porch volumio[1226]: Error: dns service error: unknown Aug 25 08:11:42 porch volumio[1226]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Aug 25 08:11:42 porch volumio[1226]: errorCode: -65537 Aug 25 08:11:42 porch volumio[1226]: } Aug 25 08:11:42 porch volumio[1226]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 08:11:43 porch ntpd[874]: IO: Listen normally on 17 wlan0 192.168.1.181:123 Aug 25 08:11:43 porch ntpd[874]: IO: new interface(s) found: waking up resolver Aug 25 08:11:46 porch sudo[16159]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 08:10' Aug 25 08:11:46 porch sudo[16159]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"