-- Logs begin at Fri 2025-01-10 01:12:17 CET, end at Fri 2025-01-10 22:31:51 CET. -- Jan 10 22:30:01 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:02 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:30:02 kueche go-librespot[6488]: time="2025-01-10T22:30:02+01:00" level=debug msg="new websocket client" Jan 10 22:30:02 kueche volumio[622]: info: Connection to go-librespot Websocket established Jan 10 22:30:03 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:05 kueche volumio[622]: info: Getting Spotify volume Jan 10 22:30:05 kueche volumio[622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Jan 10 22:30:05 kueche volumio[622]: info: CoreCommandRouter::volumioGetState Jan 10 22:30:05 kueche volumio[622]: info: CorePlayQueue::getTrack 0 Jan 10 22:30:05 kueche volumio[622]: SPOTIFY: RECEIVED VOLUMIO VOLUME 49 Jan 10 22:30:05 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:07 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:09 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:11 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:14 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:16 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:18 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:20 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:22 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:24 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:26 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:27 kueche go-librespot[6488]: time="2025-01-10T22:30:27+01: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: device or resource busy" Jan 10 22:30:27 kueche systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 10 22:30:27 kueche systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 10 22:30:27 kueche volumio[622]: (node:622) UnhandledPromiseRejectionWarning: Error: socket hang up Jan 10 22:30:27 kueche volumio[622]: at connResetException (internal/errors.js:607:14) Jan 10 22:30:27 kueche volumio[622]: at Socket.socketOnEnd (_http_client.js:493:23) Jan 10 22:30:27 kueche volumio[622]: at Socket.emit (events.js:327:22) Jan 10 22:30:27 kueche volumio[622]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 10 22:30:27 kueche volumio[622]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 10 22:30:27 kueche volumio[622]: (node:622) 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: 253) Jan 10 22:30:27 kueche volumio[622]: info: Connection to go-librespot Websocket closed Jan 10 22:30:28 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:30 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:30:30 kueche volumio[622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 10 22:30:30 kueche systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 10 22:30:30 kueche systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 218. Jan 10 22:30:30 kueche systemd[1]: Stopped go-librespot Daemon. Jan 10 22:30:30 kueche systemd[1]: Started go-librespot Daemon. Jan 10 22:30:30 kueche go-librespot[6498]: Librespot-go daemon starting... Jan 10 22:30:30 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:30 kueche go-librespot[6498]: time="2025-01-10T22:30:30+01:00" level=info msg="generated new device id: b415ccc83ee665cdea5054f2f9cc36da61e975b8" Jan 10 22:30:30 kueche go-librespot[6498]: time="2025-01-10T22:30:30+01:00" level=debug msg="stored credentials found for 31vvsazxpzqfqgh7fvpmjyagznyq" Jan 10 22:30:32 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:33 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:30:33 kueche go-librespot[6498]: time="2025-01-10T22:30:33+01:00" level=debug msg="new websocket client" Jan 10 22:30:33 kueche volumio[622]: info: Connection to go-librespot Websocket established Jan 10 22:30:34 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:36 kueche volumio[622]: info: Getting Spotify volume Jan 10 22:30:36 kueche volumio[622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Jan 10 22:30:36 kueche volumio[622]: info: CoreCommandRouter::volumioGetState Jan 10 22:30:36 kueche volumio[622]: info: CorePlayQueue::getTrack 0 Jan 10 22:30:36 kueche volumio[622]: SPOTIFY: RECEIVED VOLUMIO VOLUME 49 Jan 10 22:30:36 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:39 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:41 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:43 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:45 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:47 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:49 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:51 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:53 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:55 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:57 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:30:58 kueche go-librespot[6498]: time="2025-01-10T22:30:58+01: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: device or resource busy" Jan 10 22:30:58 kueche systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 10 22:30:58 kueche systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 10 22:30:58 kueche volumio[622]: (node:622) UnhandledPromiseRejectionWarning: Error: socket hang up Jan 10 22:30:58 kueche volumio[622]: at connResetException (internal/errors.js:607:14) Jan 10 22:30:58 kueche volumio[622]: at Socket.socketOnEnd (_http_client.js:493:23) Jan 10 22:30:58 kueche volumio[622]: at Socket.emit (events.js:327:22) Jan 10 22:30:58 kueche volumio[622]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 10 22:30:58 kueche volumio[622]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 10 22:30:58 kueche volumio[622]: (node:622) 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: 254) Jan 10 22:30:58 kueche volumio[622]: info: Connection to go-librespot Websocket closed Jan 10 22:30:59 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:01 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:31:01 kueche volumio[622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 10 22:31:01 kueche systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 10 22:31:01 kueche systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 219. Jan 10 22:31:01 kueche systemd[1]: Stopped go-librespot Daemon. Jan 10 22:31:01 kueche systemd[1]: Started go-librespot Daemon. Jan 10 22:31:01 kueche go-librespot[6508]: Librespot-go daemon starting... Jan 10 22:31:01 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:01 kueche go-librespot[6508]: time="2025-01-10T22:31:01+01:00" level=info msg="generated new device id: b68e22a4edcf150b515b5e40a3ce5e8a2a07a531" Jan 10 22:31:01 kueche go-librespot[6508]: time="2025-01-10T22:31:01+01:00" level=debug msg="stored credentials found for 31vvsazxpzqfqgh7fvpmjyagznyq" Jan 10 22:31:03 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:04 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:31:04 kueche go-librespot[6508]: time="2025-01-10T22:31:04+01:00" level=debug msg="new websocket client" Jan 10 22:31:04 kueche volumio[622]: info: Connection to go-librespot Websocket established Jan 10 22:31:06 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:07 kueche volumio[622]: info: Getting Spotify volume Jan 10 22:31:07 kueche volumio[622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Jan 10 22:31:07 kueche volumio[622]: info: CoreCommandRouter::volumioGetState Jan 10 22:31:07 kueche volumio[622]: info: CorePlayQueue::getTrack 0 Jan 10 22:31:07 kueche volumio[622]: SPOTIFY: RECEIVED VOLUMIO VOLUME 49 Jan 10 22:31:08 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:10 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:12 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:14 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:16 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:18 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:20 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:22 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:24 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:26 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:28 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:29 kueche go-librespot[6508]: time="2025-01-10T22:31:29+01: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: device or resource busy" Jan 10 22:31:29 kueche systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 10 22:31:29 kueche systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 10 22:31:29 kueche volumio[622]: (node:622) UnhandledPromiseRejectionWarning: Error: socket hang up Jan 10 22:31:29 kueche volumio[622]: at connResetException (internal/errors.js:607:14) Jan 10 22:31:29 kueche volumio[622]: at Socket.socketOnEnd (_http_client.js:493:23) Jan 10 22:31:29 kueche volumio[622]: at Socket.emit (events.js:327:22) Jan 10 22:31:29 kueche volumio[622]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 10 22:31:29 kueche volumio[622]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 10 22:31:29 kueche volumio[622]: (node:622) 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: 255) Jan 10 22:31:29 kueche volumio[622]: info: Connection to go-librespot Websocket closed Jan 10 22:31:31 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:32 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:31:33 kueche volumio[622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jan 10 22:31:33 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:33 kueche systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 10 22:31:33 kueche systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 220. Jan 10 22:31:33 kueche systemd[1]: Stopped go-librespot Daemon. Jan 10 22:31:33 kueche systemd[1]: Started go-librespot Daemon. Jan 10 22:31:33 kueche go-librespot[6517]: Librespot-go daemon starting... Jan 10 22:31:33 kueche go-librespot[6517]: time="2025-01-10T22:31:33+01:00" level=info msg="generated new device id: 8d5d76abc646b91ff1da1be0941bd7daa4b10bbf" Jan 10 22:31:33 kueche go-librespot[6517]: time="2025-01-10T22:31:33+01:00" level=debug msg="stored credentials found for 31vvsazxpzqfqgh7fvpmjyagznyq" Jan 10 22:31:35 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:36 kueche volumio[622]: info: Initializing connection to go-librespot Websocket Jan 10 22:31:36 kueche volumio[622]: info: Connection to go-librespot Websocket established Jan 10 22:31:36 kueche go-librespot[6517]: time="2025-01-10T22:31:36+01:00" level=debug msg="new websocket client" Jan 10 22:31:37 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:39 kueche volumio[622]: info: Getting Spotify volume Jan 10 22:31:39 kueche volumio[622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Jan 10 22:31:39 kueche volumio[622]: info: CoreCommandRouter::volumioGetState Jan 10 22:31:39 kueche volumio[622]: info: CorePlayQueue::getTrack 0 Jan 10 22:31:39 kueche volumio[622]: SPOTIFY: RECEIVED VOLUMIO VOLUME 49 Jan 10 22:31:39 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:41 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:43 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:45 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:47 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:49 kueche kernel: CIFS: VFS: \\192.192.11.20\Musik BAD_NETWORK_NAME: \\192.192.11.20\Musik Jan 10 22:31:50 kueche volumio[622]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 22:31:50 kueche volumio[622]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Jan 10 22:31:50 kueche volumio[622]: code: 'auth/network-request-failed', Jan 10 22:31:50 kueche volumio[622]: a: null Jan 10 22:31:50 kueche volumio[622]: } Jan 10 22:31:50 kueche volumio[622]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 22:31:51 kueche sudo[6535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-10 22:30 Jan 10 22:31:51 kueche sudo[6535]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"