-- Logs begin at Sun 2025-06-01 05:00:45 CDT, end at Sun 2025-06-01 18:33:52 CDT. -- Jun 01 18:32:00 officevolumio go-librespot[5463]: time="2025-06-01T18:32:00-05:00" level=error msg="did not receive last pong from dealer, 52s passed" Jun 01 18:32:02 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:02 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:02 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:32:05 officevolumio go-librespot[5463]: time="2025-06-01T18:32:05-05:00" level=error msg="failed receiving dealer message" error="failed to get reader: WebSocket closed: sent close frame: status = StatusServiceRestart and reason = \"\"" Jun 01 18:32:06 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:06 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:06 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:06 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.212 Jun 01 18:32:06 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.212 Jun 01 18:32:11 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:11 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:11 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:32:16 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:16 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:16 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:16 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.212 Jun 01 18:32:19 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:19 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:25 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:25 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:26 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:26 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:26 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:26 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.212 Jun 01 18:32:26 officevolumio go-librespot[5463]: time="2025-06-01T18:32:26-05:00" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": context deadline exceeded" Jun 01 18:32:26 officevolumio go-librespot[5463]: time="2025-06-01T18:32:26-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gue1.spotify.com: i/o timeout" Jun 01 18:32:30 officevolumio go-librespot[5463]: time="2025-06-01T18:32:30-05:00" level=error msg="did not receive last pong from dealer, 82s passed" Jun 01 18:32:30 officevolumio go-librespot[5463]: time="2025-06-01T18:32:30-05:00" level=error msg="did not receive last pong ack from accesspoint, 191s passed" Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:35 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:36 officevolumio volumio[984]: verbose: New Socket.io Connection to 192.168.1.200:3000 from 192.168.1.159 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 01 18:32:36 officevolumio go-librespot[5463]: time="2025-06-01T18:32:36-05:00" level=debug msg="dealer connection opened" Jun 01 18:32:36 officevolumio go-librespot[5463]: time="2025-06-01T18:32:36-05:00" level=debug msg="re-established dealer connection" Jun 01 18:32:36 officevolumio go-librespot[5463]: time="2025-06-01T18:32:36-05:00" level=debug msg="received connection id: OTdjY2VlNmUtZTA5ZC00ZGUwLTkzMTUtZWVhOGIwODI0YjRmK2RlYWxlcit0Y3A6Ly8wYWNiZjk5ZS5pcC5ndWUxLnNwb3RpZnkubmV0OjU3MDArMUNFRDYyQzMyQzZGN0JDQjAyRTQ4RjlCRTgyMzE5QzdBRjMxM0IzRDk3Nzg3MjFFODlBQTA1NzI0QjVENjhDQw==" Jun 01 18:32:37 officevolumio go-librespot[5463]: time="2025-06-01T18:32:37-05:00" level=debug msg="put connect state because NEW_DEVICE" Jun 01 18:32:37 officevolumio volumio[984]: verbose: New Socket.io Connection to 192.168.1.200:3000 from 192.168.1.159 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 01 18:32:41 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:41 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:41 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:45 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:45 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:45 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:32:48 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:48 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:48 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:48 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:48 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:48 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:55 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:32:56 officevolumio go-librespot[5463]: time="2025-06-01T18:32:56-05:00" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": context deadline exceeded" Jun 01 18:32:56 officevolumio go-librespot[5463]: time="2025-06-01T18:32:56-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gue1.spotify.com: i/o timeout" Jun 01 18:33:00 officevolumio go-librespot[5463]: time="2025-06-01T18:33:00-05:00" level=trace msg="sent dealer ping" Jun 01 18:33:04 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:04 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:04 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:05 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:05 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:05 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:05 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:05 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:33:05 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:33:11 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:11 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:11 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:15 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:15 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:15 officevolumio volumio[984]: info: Discovery: Remote connection timeout: 192.168.1.159 Jun 01 18:33:20 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:20 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:20 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:22 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:22 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:26 officevolumio go-librespot[5463]: time="2025-06-01T18:33:26-05:00" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": context deadline exceeded" Jun 01 18:33:26 officevolumio go-librespot[5463]: time="2025-06-01T18:33:26-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gue1.spotify.com: i/o timeout" Jun 01 18:33:28 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:28 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:28 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:29 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:29 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:30 officevolumio go-librespot[5463]: time="2025-06-01T18:33:30-05:00" level=error msg="did not receive last pong from dealer, 54s passed" Jun 01 18:33:34 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:34 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:34 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:35 officevolumio go-librespot[5463]: time="2025-06-01T18:33:35-05:00" level=error msg="failed receiving dealer message" error="failed to get reader: WebSocket closed: sent close frame: status = StatusServiceRestart and reason = \"\"" Jun 01 18:33:37 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:37 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:41 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:41 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:41 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:46 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:46 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:46 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.159 Jun 01 18:33:49 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:49 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:49 officevolumio volumio[984]: info: Discovery: Remote connection error: 192.168.1.212 Jun 01 18:33:50 officevolumio go-librespot[5463]: time="2025-06-01T18:33:50-05:00" level=debug msg="dealer connection opened" Jun 01 18:33:50 officevolumio go-librespot[5463]: time="2025-06-01T18:33:50-05:00" level=debug msg="re-established dealer connection" Jun 01 18:33:50 officevolumio go-librespot[5463]: time="2025-06-01T18:33:50-05:00" level=debug msg="received connection id: Mjk2YzkyZWItYTdmZC00NDlhLTkyZWQtNGZmMWU5ZjIxZGEyK2RlYWxlcit0Y3A6Ly8wYWM5NDg0Ny5pcC5nYWUyLnNwb3RpZnkubmV0OjU3MDArNzc3REU4RTcxMEZGM0M3QUY2Qzg4ODM5N0QyOTk3N0M1NTk3RUE3NUM2RjFGNDUyMjc0RjJGREVGOTVGN0FGQg==" Jun 01 18:33:51 officevolumio go-librespot[5463]: time="2025-06-01T18:33:51-05:00" level=debug msg="put connect state because NEW_DEVICE" Jun 01 18:33:51 officevolumio volumio[984]: verbose: New Socket.io Connection to 192.168.1.200:3000 from 192.168.1.159 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 01 18:33:51 officevolumio volumio[984]: info: MRS: Pushing audio output on request Jun 01 18:33:51 officevolumio volumio[984]: info: MRS: Pushing multiroomSync output Jun 01 18:33:51 officevolumio volumio[984]: info: Discovery: Connected to remote: 192.168.1.159 Jun 01 18:33:51 officevolumio volumio[984]: verbose: New Socket.io Connection to 192.168.1.200:3000 from 192.168.1.212 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 01 18:33:51 officevolumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 01 18:33:51 officevolumio volumio[984]: info: CoreCommandRouter::volumioGetState Jun 01 18:33:51 officevolumio volumio[984]: info: CorePlayQueue::getTrack 0 Jun 01 18:33:52 officevolumio volumio[984]: verbose: New Socket.io Connection to 192.168.1.200:3000 from 192.168.1.159 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 01 18:33:52 officevolumio volumio[984]: info: MRS: Adding multiroomSync output Jun 01 18:33:52 officevolumio volumio[984]: info: Adding audio output: Jun 01 18:33:52 officevolumio volumio[984]: info: MRS: Pushing multiroomSync output Jun 01 18:33:52 officevolumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 01 18:33:52 officevolumio volumio[984]: info: CoreCommandRouter::volumioGetState Jun 01 18:33:52 officevolumio volumio[984]: info: CorePlayQueue::getTrack 0 Jun 01 18:33:52 officevolumio volumio[984]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 18:33:52 officevolumio volumio[984]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Jun 01 18:33:52 officevolumio volumio[984]: code: 'auth/network-request-failed', Jun 01 18:33:52 officevolumio volumio[984]: a: null Jun 01 18:33:52 officevolumio volumio[984]: } Jun 01 18:33:52 officevolumio volumio[984]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 18:33:52 officevolumio sudo[32731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-01 18:32 Jun 01 18:33:52 officevolumio sudo[32731]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"