-- Logs begin at Sun 2025-01-19 14:39:41 MST, end at Mon 2025-01-20 04:57:14 MST. -- Jan 20 04:56:02 den volumio[1092]: verbose: New Socket.io Connection to 192.168.100.100:3000 from 192.168.100.143 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 20 04:56:09 den go-librespot[17619]: time="2025-01-20T04:56:09-07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 35.186.224.24:443: i/o timeout" Jan 20 04:56:09 den systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 20 04:56:09 den systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 20 04:56:09 den volumio[1092]: (node:1092) UnhandledPromiseRejectionWarning: Error: socket hang up Jan 20 04:56:09 den volumio[1092]: at connResetException (internal/errors.js:607:14) Jan 20 04:56:09 den volumio[1092]: at Socket.socketOnEnd (_http_client.js:493:23) Jan 20 04:56:09 den volumio[1092]: at Socket.emit (events.js:327:22) Jan 20 04:56:09 den volumio[1092]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 20 04:56:09 den volumio[1092]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 20 04:56:09 den volumio[1092]: (node:1092) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 7810) Jan 20 04:56:09 den volumio[1092]: info: Connection to go-librespot Websocket closed Jan 20 04:56:12 den volumio[1092]: info: Initializing connection to go-librespot Websocket Jan 20 04:56:13 den systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 20 04:56:13 den systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7201. Jan 20 04:56:13 den systemd[1]: Stopped go-librespot Daemon. Jan 20 04:56:13 den systemd[1]: Started go-librespot Daemon. Jan 20 04:56:13 den go-librespot[17732]: Librespot-go daemon starting... Jan 20 04:56:13 den go-librespot[17732]: time="2025-01-20T04:56:13-07:00" level=info msg="generated new device id: fa85fd0b120aaad33db919a08961cdaa9f8b9446" Jan 20 04:56:13 den go-librespot[17732]: time="2025-01-20T04:56:13-07:00" level=debug msg="stored credentials found for millerg2" Jan 20 04:56:21 den volumio[1092]: verbose: New Socket.io Connection to 192.168.100.100:3000 from 192.168.100.143 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 20 04:56:23 den go-librespot[17732]: time="2025-01-20T04:56:23-07:00" level=debug msg="new websocket client" Jan 20 04:56:23 den volumio[1092]: info: Connection to go-librespot Websocket established Jan 20 04:56:25 den volumio[1092]: verbose: New Socket.io Connection to 192.168.100.100:3000 from 192.168.100.143 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 20 04:56:26 den volumio[1092]: info: Getting Spotify volume Jan 20 04:56:26 den volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jan 20 04:56:26 den volumio[1092]: info: CoreCommandRouter::volumioGetState Jan 20 04:56:26 den volumio[1092]: info: CorePlayQueue::getTrack 0 Jan 20 04:56:43 den go-librespot[17732]: time="2025-01-20T04:56:43-07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: i/o timeout" Jan 20 04:56:43 den systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 20 04:56:43 den systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 20 04:56:43 den volumio[1092]: (node:1092) UnhandledPromiseRejectionWarning: Error: socket hang up Jan 20 04:56:43 den volumio[1092]: at connResetException (internal/errors.js:607:14) Jan 20 04:56:43 den volumio[1092]: at Socket.socketOnEnd (_http_client.js:493:23) Jan 20 04:56:43 den volumio[1092]: at Socket.emit (events.js:327:22) Jan 20 04:56:43 den volumio[1092]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 20 04:56:43 den volumio[1092]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 20 04:56:43 den volumio[1092]: (node:1092) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 7811) Jan 20 04:56:43 den volumio[1092]: info: Connection to go-librespot Websocket closed Jan 20 04:56:46 den volumio[1092]: info: Initializing connection to go-librespot Websocket Jan 20 04:56:46 den volumio[1092]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 20 04:56:46 den systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 20 04:56:46 den systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7202. Jan 20 04:56:46 den systemd[1]: Stopped go-librespot Daemon. Jan 20 04:56:46 den systemd[1]: Started go-librespot Daemon. Jan 20 04:56:46 den go-librespot[17793]: Librespot-go daemon starting... Jan 20 04:56:46 den go-librespot[17793]: time="2025-01-20T04:56:46-07:00" level=info msg="generated new device id: 3578c32b6d08be975bae587f96d1a97e21d02849" Jan 20 04:56:46 den go-librespot[17793]: time="2025-01-20T04:56:46-07:00" level=debug msg="stored credentials found for millerg2" Jan 20 04:56:49 den volumio[1092]: info: Initializing connection to go-librespot Websocket Jan 20 04:56:49 den go-librespot[17793]: time="2025-01-20T04:56:49-07:00" level=debug msg="new websocket client" Jan 20 04:56:49 den volumio[1092]: info: Connection to go-librespot Websocket established Jan 20 04:56:52 den volumio[1092]: info: Getting Spotify volume Jan 20 04:56:52 den volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 20 04:56:52 den volumio[1092]: info: CoreCommandRouter::volumioGetState Jan 20 04:56:52 den volumio[1092]: info: CorePlayQueue::getTrack 0 Jan 20 04:56:59 den volumio[1092]: verbose: New Socket.io Connection to 192.168.100.100:3000 from 192.168.100.143 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jan 20 04:57:10 den volumio[1092]: error: error Jan 20 04:57:13 den volumio[1092]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 04:57:13 den volumio[1092]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Jan 20 04:57:13 den volumio[1092]: code: 'auth/network-request-failed', Jan 20 04:57:13 den volumio[1092]: a: null Jan 20 04:57:13 den volumio[1092]: } Jan 20 04:57:13 den volumio[1092]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 04:57:14 den sudo[17901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 04:56 Jan 20 04:57:14 den sudo[17901]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"