-- Logs begin at Sun 2025-10-26 06:26:37 EDT, end at Wed 2025-10-29 11:12:51 EDT. -- Oct 29 11:11:07 home-radio go-librespot[15300]: time="2025-10-29T11:11:07-04:00" level=trace msg="sent dealer ping" Oct 29 11:11:12 home-radio ntpd[1022]: Soliciting pool server 23.186.168.125 Oct 29 11:11:21 home-radio ntpd[1022]: Soliciting pool server 172.104.28.175 Oct 29 11:11:22 home-radio ntpd[1022]: Soliciting pool server 45.63.54.13 Oct 29 11:11:23 home-radio ntpd[1022]: Soliciting pool server 23.186.168.127 Oct 29 11:11:24 home-radio ntpd[1022]: Soliciting pool server 23.141.40.124 Oct 29 11:11:25 home-radio ntpd[1022]: Soliciting pool server 209.205.228.50 Oct 29 11:11:26 home-radio ntpd[1022]: Soliciting pool server 170.187.147.56 Oct 29 11:11:27 home-radio ntpd[1022]: Soliciting pool server 23.186.168.129 Oct 29 11:11:28 home-radio ntpd[1022]: Soliciting pool server 50.117.3.95 Oct 29 11:11:29 home-radio ntpd[1022]: Soliciting pool server 67.217.246.204 Oct 29 11:11:30 home-radio ntpd[1022]: Soliciting pool server 216.31.17.12 Oct 29 11:11:30 home-radio volumiologrotate[734]: ls: cannot access '/var/log/samba/log.wb-HOME': No such file or directory Oct 29 11:11:30 home-radio volumiologrotate[734]: ls: cannot access 'RADIO': No such file or directory Oct 29 11:11:37 home-radio go-librespot[15300]: time="2025-10-29T11:11:37-04:00" level=error msg="did not receive last pong from dealer, 55s passed" Oct 29 11:11:52 home-radio volumio[1182]: info: CoreCommandRouter::volumioGetState Oct 29 11:11:52 home-radio volumio[1182]: info: CorePlayQueue::getTrack 115 Oct 29 11:12:07 home-radio go-librespot[15300]: time="2025-10-29T11:12:07-04:00" level=error msg="did not receive last pong from dealer, 85s passed" Oct 29 11:12:24 home-radio volumio[1182]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 29 11:12:24 home-radio volumio[1182]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 29 11:12:24 home-radio volumio[1182]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 29 11:12:24 home-radio volumio[1182]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 29 11:12:24 home-radio volumio[1182]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Oct 29 11:12:24 home-radio volumio[1182]: info: Received Get System Version Oct 29 11:12:24 home-radio volumio[1182]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 11:12:30 home-radio volumiologrotate[734]: ls: cannot access '/var/log/samba/log.wb-HOME': No such file or directory Oct 29 11:12:30 home-radio volumiologrotate[734]: ls: cannot access 'RADIO': No such file or directory Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.0.244:36064->34.158.255.62:443: read: connection timed out" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=debug msg="connected to ap-gue1.spotify.com:80" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=debug msg="completed keyexchange" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=debug msg="completed challenge" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=info msg="authenticated AP as shauncrump" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=debug msg="re-established accesspoint connection" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=trace msg="received accesspoint ping" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 29 11:12:34 home-radio go-librespot[15300]: time="2025-10-29T11:12:34-04:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 29 11:12:37 home-radio go-librespot[15300]: time="2025-10-29T11:12:37-04:00" level=error msg="did not receive last pong ack from accesspoint, 154s passed" Oct 29 11:12:37 home-radio go-librespot[15300]: time="2025-10-29T11:12:37-04:00" level=error msg="did not receive last pong from dealer, 115s passed" Oct 29 11:12:49 home-radio volumio[1182]: info: CoreCommandRouter::volumioGetState Oct 29 11:12:49 home-radio volumio[1182]: info: CorePlayQueue::getTrack 115 Oct 29 11:12:51 home-radio volumio[1182]: info: CorePlayQueue::getTrack 115 Oct 29 11:12:51 home-radio volumio[1182]: info: CorePlayQueue::getTrack 26 Oct 29 11:12:51 home-radio volumio[1182]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 11:12:51 home-radio volumio[1182]: TypeError: Cannot read property 'service' of undefined Oct 29 11:12:51 home-radio volumio[1182]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:456:107) Oct 29 11:12:51 home-radio volumio[1182]: at listOnTimeout (internal/timers.js:554:17) Oct 29 11:12:51 home-radio volumio[1182]: at processTimers (internal/timers.js:497:7) Oct 29 11:12:51 home-radio volumio[1182]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 11:12:51 home-radio sudo[26332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-29 11:11 Oct 29 11:12:51 home-radio sudo[26332]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"