-- Logs begin at Wed 2024-11-06 00:09:39 CET, end at Sun 2024-11-24 09:27:28 CET. -- Nov 24 09:26:00 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Nov 24 09:26:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 584. Nov 24 09:26:00 volumio systemd[1]: Stopped go-librespot Daemon. Nov 24 09:26:00 volumio systemd[1]: Started go-librespot Daemon. Nov 24 09:26:00 volumio go-librespot[1160]: Librespot-go daemon starting... Nov 24 09:26:00 volumio go-librespot[1160]: time="2024-11-24T09:26:00+01:00" level=info msg="generated new device id: fb9e5ce8dcc9a3da3c5dc7f11484b10decc9c3de" Nov 24 09:26:00 volumio go-librespot[1160]: time="2024-11-24T09:26:00+01:00" level=debug msg="stored credentials found for 31i5ww2a7yit3xjpy44sbds6hnm4" Nov 24 09:26:02 volumio volumio[964]: info: Initializing connection to go-librespot Websocket Nov 24 09:26:02 volumio go-librespot[1160]: time="2024-11-24T09:26:02+01:00" level=debug msg="new websocket client" Nov 24 09:26:02 volumio volumio[964]: info: Connection to go-librespot Websocket established Nov 24 09:26:05 volumio volumio[964]: info: Getting Spotify volume Nov 24 09:26:05 volumio volumio[964]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 24 09:26:05 volumio volumio[964]: info: CoreCommandRouter::volumioGetState Nov 24 09:26:05 volumio volumio[964]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Nov 24 09:26:23 volumio volumio[964]: error: error Nov 24 09:26:30 volumio go-librespot[1160]: time="2024-11-24T09:26:30+01:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: i/o timeout" Nov 24 09:26:30 volumio volumio[964]: (node:964) UnhandledPromiseRejectionWarning: Error: socket hang up Nov 24 09:26:30 volumio volumio[964]: at connResetException (internal/errors.js:607:14) Nov 24 09:26:30 volumio volumio[964]: at Socket.socketOnEnd (_http_client.js:493:23) Nov 24 09:26:30 volumio volumio[964]: at Socket.emit (events.js:327:22) Nov 24 09:26:30 volumio volumio[964]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 24 09:26:30 volumio volumio[964]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 24 09:26:30 volumio volumio[964]: (node:964) 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: 633) Nov 24 09:26:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 24 09:26:30 volumio volumio[964]: info: Connection to go-librespot Websocket closed Nov 24 09:26:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 24 09:26:33 volumio volumio[964]: info: Initializing connection to go-librespot Websocket Nov 24 09:26:33 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Nov 24 09:26:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 585. Nov 24 09:26:33 volumio systemd[1]: Stopped go-librespot Daemon. Nov 24 09:26:33 volumio systemd[1]: Started go-librespot Daemon. Nov 24 09:26:33 volumio go-librespot[1248]: Librespot-go daemon starting... Nov 24 09:26:33 volumio go-librespot[1248]: time="2024-11-24T09:26:33+01:00" level=info msg="generated new device id: b3ae02a70b08874867d2e0d87286739cd27ec05d" Nov 24 09:26:33 volumio go-librespot[1248]: time="2024-11-24T09:26:33+01:00" level=debug msg="stored credentials found for 31i5ww2a7yit3xjpy44sbds6hnm4" Nov 24 09:26:38 volumio volumio[964]: info: Connection to go-librespot Websocket established Nov 24 09:26:38 volumio go-librespot[1248]: time="2024-11-24T09:26:38+01:00" level=debug msg="new websocket client" Nov 24 09:26:41 volumio volumio[964]: info: Getting Spotify volume Nov 24 09:26:41 volumio volumio[964]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 24 09:26:41 volumio volumio[964]: info: CoreCommandRouter::volumioGetState Nov 24 09:26:42 volumio volumio[964]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Nov 24 09:26:57 volumio go-librespot[1248]: time="2024-11-24T09:26:57+01:00" level=debug msg="obtained new client token: AADXajcbcLRiWGUZfnKpmeqWk5ZyXjrmcz6TDmXoWVrdP0lXJBJFDHlQlSPmm35PgHw1wYPeZ5M7rs7w8C4U0XU1qUsT+Q1Y3OPYRatOizfVhkhvQv0WmF7o8h8msPHqxftjbbqZoAjl9HmYTiJddyzmU3CkmXCWNk2QfqexFl0RbuWhcPI5Jh6dC6gZ10/A/62aWV/Xg5PH6qH5S9Hu8jQMCrS8zkni1fpXs+j/evqbXS54D0LOJnuxt3Ic8S8=" Nov 24 09:27:27 volumio volumio[964]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 09:27:27 volumio volumio[964]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Nov 24 09:27:27 volumio volumio[964]: code: 'auth/network-request-failed', Nov 24 09:27:27 volumio volumio[964]: a: null Nov 24 09:27:27 volumio volumio[964]: } Nov 24 09:27:27 volumio volumio[964]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 09:27:28 volumio sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-24 09:26 Nov 24 09:27:28 volumio sudo[1332]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"