-- Logs begin at Mon 2025-07-07 10:17:51 EDT, end at Mon 2025-07-07 19:17:29 EDT. -- Jul 07 19:16:09 volumio-2 wpa_supplicant[746]: wlan0: SME: Trying to authenticate with 62:96:71:94:d2:73 (SSID='CrookedHouse-IoT' freq=2437 MHz) Jul 07 19:16:09 volumio-2 kernel: wlan0: authenticate with 62:96:71:94:d2:73 Jul 07 19:16:09 volumio-2 kernel: wlan0: 80 MHz not supported, disabling VHT Jul 07 19:16:10 volumio-2 kernel: wlan0: send auth to 62:96:71:94:d2:73 (try 1/3) Jul 07 19:16:10 volumio-2 wpa_supplicant[746]: wlan0: Trying to associate with 62:96:71:94:d2:73 (SSID='CrookedHouse-IoT' freq=2437 MHz) Jul 07 19:16:10 volumio-2 kernel: wlan0: authenticated Jul 07 19:16:10 volumio-2 kernel: wlan0: associate with 62:96:71:94:d2:73 (try 1/3) Jul 07 19:16:10 volumio-2 kernel: wlan0: RX AssocResp from 62:96:71:94:d2:73 (capab=0x1411 status=0 aid=9) Jul 07 19:16:10 volumio-2 kernel: wlan0: associated Jul 07 19:16:10 volumio-2 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 62:96:71:94:d2:73 Jul 07 19:16:10 volumio-2 kernel: ath: EEPROM regdomain: 0x8348 Jul 07 19:16:10 volumio-2 kernel: ath: EEPROM indicates we should expect a country code Jul 07 19:16:10 volumio-2 kernel: ath: doing EEPROM country->regdmn map search Jul 07 19:16:10 volumio-2 kernel: ath: country maps to regdmn code: 0x3a Jul 07 19:16:10 volumio-2 kernel: ath: Country alpha2 being used: US Jul 07 19:16:10 volumio-2 kernel: ath: Regpair used: 0x3a Jul 07 19:16:10 volumio-2 kernel: ath: regdomain 0x8348 dynamically updated by country element Jul 07 19:16:10 volumio-2 wpa_supplicant[746]: wlan0: Associated with 62:96:71:94:d2:73 Jul 07 19:16:10 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jul 07 19:16:10 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jul 07 19:16:10 volumio-2 wpa_supplicant[746]: wlan0: WPA: Key negotiation completed with 62:96:71:94:d2:73 [PTK=CCMP GTK=CCMP] Jul 07 19:16:10 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-CONNECTED - Connection to 62:96:71:94:d2:73 completed [id=0 id_str=] Jul 07 19:16:10 volumio-2 dhcpcd[769]: wlan0: carrier acquired Jul 07 19:16:10 volumio-2 dhcpcd[769]: wlan0: IAID 5d:6d:64:a3 Jul 07 19:16:11 volumio-2 dhcpcd[769]: wlan0: soliciting an IPv6 router Jul 07 19:16:11 volumio-2 dhcpcd[769]: wlan0: rebinding lease of 192.168.1.186 Jul 07 19:16:11 volumio-2 dhcpcd[769]: wlan0: probing address 192.168.1.186/24 Jul 07 19:16:16 volumio-2 dhcpcd[769]: wlan0: leased 192.168.1.186 for 86400 seconds Jul 07 19:16:16 volumio-2 avahi-daemon[408]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.186. Jul 07 19:16:16 volumio-2 avahi-daemon[408]: New relevant interface wlan0.IPv4 for mDNS. Jul 07 19:16:16 volumio-2 avahi-daemon[408]: Registering new address record for 192.168.1.186 on wlan0.IPv4. Jul 07 19:16:16 volumio-2 dhcpcd[769]: wlan0: adding route to 192.168.1.0/24 Jul 07 19:16:16 volumio-2 dhcpcd[769]: wlan0: adding default route via 192.168.1.1 Jul 07 19:16:18 volumio-2 ntpd[552]: Listen normally on 4 wlan0 192.168.1.186:123 Jul 07 19:16:18 volumio-2 ntpd[552]: new interface(s) found: waking up resolver Jul 07 19:16:21 volumio-2 ntpd[552]: Soliciting pool server 64.142.54.12 Jul 07 19:16:25 volumio-2 volumio[2278]: info: Volumio Network Manager: Network status updated: 2 Jul 07 19:16:30 volumio-2 ntpd[552]: Soliciting pool server 99.28.14.242 Jul 07 19:16:46 volumio-2 volumio[2278]: info: CoreCommandRouter::volumioGetState Jul 07 19:16:46 volumio-2 volumio[2278]: info: CorePlayQueue::getTrack 0 Jul 07 19:16:46 volumio-2 volumio[2278]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jul 07 19:16:46 volumio-2 volumio[2278]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 07 19:16:46 volumio-2 volumio[2278]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jul 07 19:16:46 volumio-2 volumio[2278]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jul 07 19:16:46 volumio-2 volumio[2278]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 07 19:16:46 volumio-2 volumio[2278]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 07 19:16:46 volumio-2 volumio[2278]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 07 19:16:46 volumio-2 volumio[2278]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 07 19:16:46 volumio-2 volumio[2278]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 07 19:16:46 volumio-2 volumio[2278]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 07 19:16:46 volumio-2 volumio[2278]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 07 19:16:46 volumio-2 volumio[2278]: info: Listing playlists Jul 07 19:16:46 volumio-2 volumio[2278]: info: Listing playlists Jul 07 19:16:52 volumio-2 kernel: wlan0: deauthenticated from 62:96:71:94:d2:73 (Reason: 3=DEAUTH_LEAVING) Jul 07 19:16:52 volumio-2 dhcpcd[769]: wlan0: carrier lost Jul 07 19:16:53 volumio-2 avahi-daemon[408]: Withdrawing address record for 192.168.1.186 on wlan0. Jul 07 19:16:53 volumio-2 avahi-daemon[408]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.186. Jul 07 19:16:53 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-DISCONNECTED bssid=62:96:71:94:d2:73 reason=3 Jul 07 19:16:53 volumio-2 avahi-daemon[408]: Interface wlan0.IPv4 no longer relevant for mDNS. Jul 07 19:16:53 volumio-2 dhcpcd[769]: wlan0: deleting route to 192.168.1.0/24 Jul 07 19:16:53 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jul 07 19:16:53 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Jul 07 19:16:53 volumio-2 dhcpcd[769]: wlan0: deleting default route via 192.168.1.1 Jul 07 19:16:53 volumio-2 volumio[2278]: info: Discovery: A device disappeared from network Jul 07 19:16:53 volumio-2 volumio[2278]: info: Discovery: A device disappeared from network Jul 07 19:16:54 volumio-2 ntpd[552]: Deleting interface #4 wlan0, 192.168.1.186#123, interface stats: received=0, sent=8, dropped=0, active_time=36 secs Jul 07 19:16:54 volumio-2 ntpd[552]: 137.190.2.4 local addr 192.168.1.186 -> Jul 07 19:16:54 volumio-2 ntpd[552]: 23.150.41.122 local addr 192.168.1.186 -> Jul 07 19:16:54 volumio-2 ntpd[552]: 45.63.54.13 local addr 192.168.1.186 -> Jul 07 19:16:54 volumio-2 ntpd[552]: 23.111.186.186 local addr 192.168.1.186 -> Jul 07 19:16:54 volumio-2 ntpd[552]: 104.234.61.117 local addr 192.168.1.186 -> Jul 07 19:16:54 volumio-2 ntpd[552]: 96.60.160.227 local addr 192.168.1.186 -> Jul 07 19:16:56 volumio-2 ntpd[552]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jul 07 19:16:56 volumio-2 ntpd[552]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jul 07 19:16:57 volumio-2 wpa_supplicant[746]: wlan0: SME: Trying to authenticate with 62:96:71:94:d2:73 (SSID='CrookedHouse-IoT' freq=2437 MHz) Jul 07 19:16:57 volumio-2 kernel: wlan0: authenticate with 62:96:71:94:d2:73 Jul 07 19:16:57 volumio-2 kernel: wlan0: 80 MHz not supported, disabling VHT Jul 07 19:16:57 volumio-2 volumio[2278]: info: Volumio Network Manager: Network status updated: 0 Jul 07 19:16:57 volumio-2 kernel: wlan0: send auth to 62:96:71:94:d2:73 (try 1/3) Jul 07 19:16:57 volumio-2 wpa_supplicant[746]: wlan0: Trying to associate with 62:96:71:94:d2:73 (SSID='CrookedHouse-IoT' freq=2437 MHz) Jul 07 19:16:57 volumio-2 kernel: wlan0: authenticated Jul 07 19:16:57 volumio-2 kernel: wlan0: associate with 62:96:71:94:d2:73 (try 1/3) Jul 07 19:16:57 volumio-2 kernel: wlan0: RX AssocResp from 62:96:71:94:d2:73 (capab=0x1411 status=0 aid=9) Jul 07 19:16:57 volumio-2 kernel: wlan0: associated Jul 07 19:16:57 volumio-2 kernel: ath: EEPROM regdomain: 0x8348 Jul 07 19:16:57 volumio-2 kernel: ath: EEPROM indicates we should expect a country code Jul 07 19:16:57 volumio-2 kernel: ath: doing EEPROM country->regdmn map search Jul 07 19:16:57 volumio-2 kernel: ath: country maps to regdmn code: 0x3a Jul 07 19:16:57 volumio-2 kernel: ath: Country alpha2 being used: US Jul 07 19:16:57 volumio-2 kernel: ath: Regpair used: 0x3a Jul 07 19:16:58 volumio-2 kernel: ath: regdomain 0x8348 dynamically updated by country element Jul 07 19:16:57 volumio-2 wpa_supplicant[746]: wlan0: Associated with 62:96:71:94:d2:73 Jul 07 19:16:57 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jul 07 19:16:57 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jul 07 19:16:58 volumio-2 kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 62:96:71:94:d2:73 Jul 07 19:16:58 volumio-2 wpa_supplicant[746]: wlan0: WPA: Key negotiation completed with 62:96:71:94:d2:73 [PTK=CCMP GTK=CCMP] Jul 07 19:16:58 volumio-2 wpa_supplicant[746]: wlan0: CTRL-EVENT-CONNECTED - Connection to 62:96:71:94:d2:73 completed [id=0 id_str=] Jul 07 19:16:58 volumio-2 dhcpcd[769]: wlan0: carrier acquired Jul 07 19:16:58 volumio-2 dhcpcd[769]: wlan0: IAID 5d:6d:64:a3 Jul 07 19:16:58 volumio-2 dhcpcd[769]: wlan0: rebinding lease of 192.168.1.186 Jul 07 19:16:58 volumio-2 dhcpcd[769]: wlan0: probing address 192.168.1.186/24 Jul 07 19:16:58 volumio-2 volumio[2278]: info: Discovery: Browse raised the following error Error: getaddrinfo -3008 Jul 07 19:16:58 volumio-2 dhcpcd[769]: wlan0: soliciting an IPv6 router Jul 07 19:16:58 volumio-2 volumio[2278]: info: Discovery: Browse raised the following error Error: getaddrinfo -3008 Jul 07 19:17:03 volumio-2 dhcpcd[769]: wlan0: leased 192.168.1.186 for 86354 seconds Jul 07 19:17:03 volumio-2 avahi-daemon[408]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.186. Jul 07 19:17:03 volumio-2 avahi-daemon[408]: New relevant interface wlan0.IPv4 for mDNS. Jul 07 19:17:03 volumio-2 dhcpcd[769]: wlan0: adding route to 192.168.1.0/24 Jul 07 19:17:03 volumio-2 avahi-daemon[408]: Registering new address record for 192.168.1.186 on wlan0.IPv4. Jul 07 19:17:03 volumio-2 dhcpcd[769]: wlan0: adding default route via 192.168.1.1 Jul 07 19:17:05 volumio-2 ntpd[552]: Listen normally on 5 wlan0 192.168.1.186:123 Jul 07 19:17:05 volumio-2 ntpd[552]: new interface(s) found: waking up resolver Jul 07 19:17:06 volumio-2 volumio[2278]: info: CoreCommandRouter::volumioGetState Jul 07 19:17:06 volumio-2 volumio[2278]: info: CorePlayQueue::getTrack 0 Jul 07 19:17:06 volumio-2 volumio[2278]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jul 07 19:17:06 volumio-2 volumio[2278]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 07 19:17:06 volumio-2 volumio[2278]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jul 07 19:17:06 volumio-2 volumio[2278]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jul 07 19:17:06 volumio-2 volumio[2278]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 07 19:17:06 volumio-2 volumio[2278]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 07 19:17:06 volumio-2 volumio[2278]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 07 19:17:06 volumio-2 volumio[2278]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 07 19:17:06 volumio-2 volumio[2278]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 07 19:17:06 volumio-2 volumio[2278]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 07 19:17:06 volumio-2 volumio[2278]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 07 19:17:06 volumio-2 volumio[2278]: info: Listing playlists Jul 07 19:17:06 volumio-2 volumio[2278]: info: Listing playlists Jul 07 19:17:07 volumio-2 volumio[2278]: info: Volumio Network Manager: Network status updated: 2 Jul 07 19:17:15 volumio-2 volumio[2278]: info: CoreCommandRouter::volumioGetState Jul 07 19:17:15 volumio-2 volumio[2278]: info: CorePlayQueue::getTrack 0 Jul 07 19:17:15 volumio-2 volumio[2278]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'name' of undefined Jul 07 19:17:15 volumio-2 volumio[2278]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 07 19:17:15 volumio-2 volumio[2278]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jul 07 19:17:15 volumio-2 volumio[2278]: at RESTApiPlayback.playbackGetState (/volumio/app/plugins/user_interface/rest_api/playback.js:262:37) Jul 07 19:17:15 volumio-2 volumio[2278]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 07 19:17:15 volumio-2 volumio[2278]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Jul 07 19:17:15 volumio-2 volumio[2278]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Jul 07 19:17:15 volumio-2 volumio[2278]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Jul 07 19:17:15 volumio-2 volumio[2278]: at /volumio/node_modules/express/lib/router/index.js:281:22 Jul 07 19:17:15 volumio-2 volumio[2278]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Jul 07 19:17:15 volumio-2 volumio[2278]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Jul 07 19:17:22 volumio-2 volumio[2278]: info: Discovery: adding d83b9c5e-848f-4d1f-9f76-e3fad2527237 Jul 07 19:17:22 volumio-2 volumio[2278]: info: Discovery: Found device Volumio-2 Jul 07 19:17:22 volumio-2 volumio[2278]: info: CoreCommandRouter::volumioGetState Jul 07 19:17:22 volumio-2 volumio[2278]: info: CorePlayQueue::getTrack 0 Jul 07 19:17:22 volumio-2 volumio[2278]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 19:17:22 volumio-2 volumio[2278]: TypeError: Cannot read property 'name' of undefined Jul 07 19:17:22 volumio-2 volumio[2278]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Jul 07 19:17:22 volumio-2 volumio[2278]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:109:28) Jul 07 19:17:22 volumio-2 volumio[2278]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:272:40) Jul 07 19:17:22 volumio-2 volumio[2278]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Jul 07 19:17:22 volumio-2 volumio[2278]: at Browser.emit (events.js:315:20) Jul 07 19:17:22 volumio-2 volumio[2278]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jul 07 19:17:22 volumio-2 volumio[2278]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jul 07 19:17:22 volumio-2 volumio[2278]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Jul 07 19:17:22 volumio-2 volumio[2278]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Jul 07 19:17:22 volumio-2 volumio[2278]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jul 07 19:17:22 volumio-2 volumio[2278]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 19:17:27 volumio-2 ntpd[552]: Soliciting pool server 66.118.229.14 Jul 07 19:17:28 volumio-2 ntpd[552]: Soliciting pool server 141.11.89.193 Jul 07 19:17:29 volumio-2 sudo[22391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-07 19:16 Jul 07 19:17:29 volumio-2 sudo[22391]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 19:17:29 volumio-2 ntpd[552]: Soliciting pool server 96.231.54.40 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"