-- Logs begin at Mon 2025-12-29 20:03:52 CST, end at Mon 2025-12-29 22:35:24 CST. -- Dec 29 22:34:00 volumio go-librespot[27944]: time="2025-12-29T22:34:00+08:00" level=debug msg="obtained new client token: AAB5ETE4N46QPJtn2bGR2pCwwMQpNqwDEIvl1f5JsbhTdpZslVhxEsOdCvJ+SgKJqR8QH56Ru2d/SOBOCgFxDH2ZULHiNAWyA/apF864fA9cOXzFlay9hZRWP32EdPK8QG/2Icy8YI4gIQ8mmBCOhEFddc8bezeUAyCWkzAuc6ieRU6zFCcX7iDUWvxny9VVg7fR5slT6q/Z4Umqe7DPc+DxtRCHrBh94fH7jhu+M5tHuKQSYZxz8r47scM=" Dec 29 22:34:00 volumio kernel: hwmon hwmon1: Voltage normalised Dec 29 22:34:00 volumio go-librespot[27944]: time="2025-12-29T22:34:00+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:00 volumio go-librespot[27944]: time="2025-12-29T22:34:00+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:00 volumio go-librespot[27944]: time="2025-12-29T22:34:00+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed solving challenge: failed login: BadCredentials" Dec 29 22:34:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:01 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:01 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:03 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2191. Dec 29 22:34:03 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:03 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:03 volumio go-librespot[27953]: Librespot-go daemon starting... Dec 29 22:34:03 volumio go-librespot[27953]: time="2025-12-29T22:34:03+08:00" level=info msg="generated new device id: 596aeac8a6b038ee355cec4f5e9305699aeee382" Dec 29 22:34:03 volumio go-librespot[27953]: time="2025-12-29T22:34:03+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:04 volumio kernel: hwmon hwmon1: Undervoltage detected! Dec 29 22:34:04 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:04 volumio go-librespot[27953]: time="2025-12-29T22:34:04+08:00" level=debug msg="new websocket client" Dec 29 22:34:04 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:04 volumio go-librespot[27953]: time="2025-12-29T22:34:04+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:04 volumio go-librespot[27953]: time="2025-12-29T22:34:04+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:04 volumio go-librespot[27953]: time="2025-12-29T22:34:04+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:04 volumio go-librespot[27953]: time="2025-12-29T22:34:04+08:00" level=debug msg="zeroconf server listening on port 34007" Dec 29 22:34:05 volumio go-librespot[27953]: time="2025-12-29T22:34:05+08:00" level=debug msg="obtained new client token: AAA6Jf5otF33XcD8QIPCl1w+Kof/dpHqJyUmCn3D+kRnyF8Rpf6DDDG7IkjUg6UGpN+1vKPrda31cnjHakFI2Uz2uFdVBr9YfpM8OIhhsVgRTbRqKIkHfcwW+dZeu6ehprJJG7ZkO+hL5YyXyilaz41htyQaJsemEF8HM/rt8+W3LvoQzfoKCMXyosgNLwdn6DKfuffKH56LvcvQ2Ee/0VyuoMDLjvk8MjL1t978+SsLM5wr218v3z5Wcq0=" Dec 29 22:34:05 volumio go-librespot[27953]: time="2025-12-29T22:34:05+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:06 volumio go-librespot[27953]: time="2025-12-29T22:34:06+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:06 volumio go-librespot[27953]: time="2025-12-29T22:34:06+08:00" level=debug msg="completed challenge" Dec 29 22:34:06 volumio go-librespot[27953]: time="2025-12-29T22:34:06+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:06 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:07 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:07 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:07 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:07 volumio volumio[959]: (node:959) 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: 2097) Dec 29 22:34:07 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:07 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:07 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:07 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:09 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:09 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2192. Dec 29 22:34:10 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:10 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:10 volumio go-librespot[27981]: Librespot-go daemon starting... Dec 29 22:34:10 volumio go-librespot[27981]: time="2025-12-29T22:34:10+08:00" level=info msg="generated new device id: 475914e18be90114e39c4a4aa23b3d4ded380cdd" Dec 29 22:34:10 volumio go-librespot[27981]: time="2025-12-29T22:34:10+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:10 volumio go-librespot[27981]: time="2025-12-29T22:34:10+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:10 volumio go-librespot[27981]: time="2025-12-29T22:34:10+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:10 volumio go-librespot[27981]: time="2025-12-29T22:34:10+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:10 volumio go-librespot[27981]: time="2025-12-29T22:34:10+08:00" level=debug msg="zeroconf server listening on port 37471" Dec 29 22:34:11 volumio go-librespot[27981]: time="2025-12-29T22:34:11+08:00" level=debug msg="obtained new client token: AABVo4+PB7rffbe5tQNaclE9Q96nteOcVWSwLDv7pURtst/l0EU+kshd0GmQQSF9M6c8TijhLzRPJ9/A6SQIPjVA6/O2v11mq+ijosoUbFi830n+bKfII/401Q21enJr60ec04EzN55vQYy1Db54Xg1wi6fJlvgiAW7aM5CSNMLZk2sZA3xZMWHa4ui4bpLLED1C1e0AuH8W7lgWijdZLUmfxUcCjXc4fB4gcdn6mODIbQSzMa8uk5H1dXA=" Dec 29 22:34:11 volumio go-librespot[27981]: time="2025-12-29T22:34:11+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:12 volumio go-librespot[27981]: time="2025-12-29T22:34:12+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:12 volumio go-librespot[27981]: time="2025-12-29T22:34:12+08:00" level=debug msg="completed challenge" Dec 29 22:34:12 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:12 volumio go-librespot[27981]: time="2025-12-29T22:34:12+08:00" level=debug msg="new websocket client" Dec 29 22:34:12 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:13 volumio go-librespot[27981]: time="2025-12-29T22:34:13+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:13 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:15 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:15 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:15 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:15 volumio volumio[959]: (node:959) 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: 2098) Dec 29 22:34:15 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:15 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:15 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:15 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:16 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:16 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:16 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2193. Dec 29 22:34:16 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:16 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:16 volumio go-librespot[28003]: Librespot-go daemon starting... Dec 29 22:34:16 volumio go-librespot[28003]: time="2025-12-29T22:34:16+08:00" level=info msg="generated new device id: cd2d9b64ce6b0d9e3d9858f84e5d9b60d3701b34" Dec 29 22:34:16 volumio go-librespot[28003]: time="2025-12-29T22:34:16+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:17 volumio go-librespot[28003]: time="2025-12-29T22:34:17+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:17 volumio go-librespot[28003]: time="2025-12-29T22:34:17+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:17 volumio go-librespot[28003]: time="2025-12-29T22:34:17+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:17 volumio go-librespot[28003]: time="2025-12-29T22:34:17+08:00" level=debug msg="zeroconf server listening on port 40109" Dec 29 22:34:17 volumio go-librespot[28003]: time="2025-12-29T22:34:17+08:00" level=debug msg="obtained new client token: AAAEpJQqDqUbFFQw4KnFBROaO1hOggbJRk3da3oVilGTVTBDBuZUh8PJJE+u79eo8zKDHos9NnZkpKeNjWbpPB5pyA8zBs5+WLnM407KyJAp4j7hxZhCz6trWQQEb/0dtTgJlfeY2tmabug8zI9NQwXOJJo6Noz9rPbdZyre2Nk0mJ8BvEBdkVfzddWNB7Ml1xaO3KzONeqi2NXKkSWbpzCz7rIj7zjfsRnRlFozlxi7lEkt+ltfIv0mBRM=" Dec 29 22:34:18 volumio go-librespot[28003]: time="2025-12-29T22:34:18+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:18 volumio go-librespot[28003]: time="2025-12-29T22:34:18+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:18 volumio go-librespot[28003]: time="2025-12-29T22:34:18+08:00" level=debug msg="completed challenge" Dec 29 22:34:19 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:19 volumio go-librespot[28003]: time="2025-12-29T22:34:19+08:00" level=debug msg="new websocket client" Dec 29 22:34:19 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:19 volumio go-librespot[28003]: time="2025-12-29T22:34:19+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:19 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:22 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:22 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:22 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:22 volumio volumio[959]: (node:959) 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: 2099) Dec 29 22:34:22 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:22 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:22 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:22 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:22 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:22 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:22 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2194. Dec 29 22:34:22 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:22 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:22 volumio go-librespot[28011]: Librespot-go daemon starting... Dec 29 22:34:22 volumio go-librespot[28011]: time="2025-12-29T22:34:22+08:00" level=info msg="generated new device id: f713b7007f74d6767645098998cfc7618ac5ac91" Dec 29 22:34:22 volumio go-librespot[28011]: time="2025-12-29T22:34:22+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:23 volumio go-librespot[28011]: time="2025-12-29T22:34:23+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 29 22:34:23 volumio go-librespot[28011]: time="2025-12-29T22:34:23+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 29 22:34:23 volumio go-librespot[28011]: time="2025-12-29T22:34:23+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Dec 29 22:34:23 volumio go-librespot[28011]: time="2025-12-29T22:34:23+08:00" level=debug msg="zeroconf server listening on port 42823" Dec 29 22:34:24 volumio go-librespot[28011]: time="2025-12-29T22:34:24+08:00" level=debug msg="obtained new client token: AAA29uOquJUQTBN2Rg8bsaI6rHY3j6LIPSxGBVZkH5rKfpCjQd9WpM5mOLrBTLXClpY4IrXnfmRagRYPZQ8829HZWF9536jsjtnByWvj3m10OYeMcURl++cN3ATQikP5AQL/WbVz2Gv+K6O6hFIB6Lh07CERzwtJGoZkfLbtZ8R7W2UJrug6NjTwoFZEPTr4+I8KPR1Ymnv1y/KeT+dVlsHQJJ0M6aIF6SqqRk/ayougn3aMYGDgznxY" Dec 29 22:34:24 volumio go-librespot[28011]: time="2025-12-29T22:34:24+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:24 volumio go-librespot[28011]: time="2025-12-29T22:34:24+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:24 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 22:34:25 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:25 volumio go-librespot[28011]: time="2025-12-29T22:34:25+08:00" level=debug msg="new websocket client" Dec 29 22:34:25 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:25 volumio go-librespot[28011]: time="2025-12-29T22:34:25+08:00" level=debug msg="completed challenge" Dec 29 22:34:25 volumio go-librespot[28011]: time="2025-12-29T22:34:25+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:25 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:28 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:28 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:28 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:28 volumio volumio[959]: (node:959) 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: 2100) Dec 29 22:34:28 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:28 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:28 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:28 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:28 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:28 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2195. Dec 29 22:34:28 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:28 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:28 volumio go-librespot[28036]: Librespot-go daemon starting... Dec 29 22:34:28 volumio go-librespot[28036]: time="2025-12-29T22:34:28+08:00" level=info msg="generated new device id: bb6160efd598787ca1db70c0e505e72e96b60995" Dec 29 22:34:28 volumio go-librespot[28036]: time="2025-12-29T22:34:28+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:29 volumio go-librespot[28036]: time="2025-12-29T22:34:29+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:29 volumio go-librespot[28036]: time="2025-12-29T22:34:29+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:29 volumio go-librespot[28036]: time="2025-12-29T22:34:29+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:29 volumio go-librespot[28036]: time="2025-12-29T22:34:29+08:00" level=debug msg="zeroconf server listening on port 36421" Dec 29 22:34:30 volumio go-librespot[28036]: time="2025-12-29T22:34:30+08:00" level=debug msg="obtained new client token: AADeq3ssqqOWd+xT15PXKUoTVXvs7jlnh5jRfQT1fkDvZUBLJ33Oo41ju4DBNuFWtoo54HovRisFjPTxu2D+6RU3npnMTsYDpdEq936si1oqzDPED5xCssm/Ey2H9VyYlmYJNAzaVdyAPEnfblozSawlQOtErxBsREasBG3pzpB9b5AcZ1DyllFLY9h6SqIs5wvdl6g56t8sNAs3q3l3vkPqMTLL6h8vdTBN4fBrx9CiKUjOUAMlSg8th44=" Dec 29 22:34:30 volumio go-librespot[28036]: time="2025-12-29T22:34:30+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:30 volumio go-librespot[28036]: time="2025-12-29T22:34:30+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:31 volumio go-librespot[28036]: time="2025-12-29T22:34:31+08:00" level=debug msg="completed challenge" Dec 29 22:34:31 volumio go-librespot[28036]: time="2025-12-29T22:34:31+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:31 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:31 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:33 volumio kernel: hwmon hwmon1: Voltage normalised Dec 29 22:34:34 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2196. Dec 29 22:34:34 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:34 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:34 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:34 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:34 volumio go-librespot[28045]: Librespot-go daemon starting... Dec 29 22:34:34 volumio go-librespot[28045]: time="2025-12-29T22:34:34+08:00" level=info msg="generated new device id: b8d8a7ec9b84dc1f7302af8161de3abe07016122" Dec 29 22:34:34 volumio go-librespot[28045]: time="2025-12-29T22:34:34+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:35 volumio kernel: hwmon hwmon1: Undervoltage detected! Dec 29 22:34:35 volumio go-librespot[28045]: time="2025-12-29T22:34:35+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:35 volumio go-librespot[28045]: time="2025-12-29T22:34:35+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:35 volumio go-librespot[28045]: time="2025-12-29T22:34:35+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:35 volumio go-librespot[28045]: time="2025-12-29T22:34:35+08:00" level=debug msg="zeroconf server listening on port 46005" Dec 29 22:34:36 volumio go-librespot[28045]: time="2025-12-29T22:34:36+08:00" level=debug msg="obtained new client token: AADPcIikDRwI8um2VgEVhLnlA+U4Q/K+1Oqf/j4vNnNEAhWiTCCnXZ1vsr+EtFnkFh2+JrlJm7M5YwAGzFfQKPpl7maw0vu/h22CVfYT6UBPjE+/XyHTCVBFlYBgUqvgP4+ffReOpkAHAQliZITg1Njmgt9O6VZyjv3jIOQJSIZAo+KwmfOx0T5jyEe42YuBHhp96Il+r86By8vwmSkg9i6tSHLVzTNAQoZF47PDr4zULZ+WnMuVxG4I" Dec 29 22:34:36 volumio go-librespot[28045]: time="2025-12-29T22:34:36+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:36 volumio go-librespot[28045]: time="2025-12-29T22:34:36+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:37 volumio go-librespot[28045]: time="2025-12-29T22:34:37+08:00" level=debug msg="completed challenge" Dec 29 22:34:37 volumio go-librespot[28045]: time="2025-12-29T22:34:37+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:37 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:37 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:40 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2197. Dec 29 22:34:40 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:40 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:40 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:40 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:40 volumio go-librespot[28068]: Librespot-go daemon starting... Dec 29 22:34:40 volumio go-librespot[28068]: time="2025-12-29T22:34:40+08:00" level=info msg="generated new device id: df80407c91f335cfbeef97e2648cda4f5655b973" Dec 29 22:34:40 volumio go-librespot[28068]: time="2025-12-29T22:34:40+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:41 volumio go-librespot[28068]: time="2025-12-29T22:34:41+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:41 volumio go-librespot[28068]: time="2025-12-29T22:34:41+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:41 volumio go-librespot[28068]: time="2025-12-29T22:34:41+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:41 volumio go-librespot[28068]: time="2025-12-29T22:34:41+08:00" level=debug msg="zeroconf server listening on port 36821" Dec 29 22:34:42 volumio go-librespot[28068]: time="2025-12-29T22:34:42+08:00" level=debug msg="obtained new client token: AACTOGnEVkFpcuQSElpRgxsg6EUt2h1mnQ98HnUlQjpN1OSbXkyx5ZI1XDkdqYNh4kV3IfUZfvH9Dub8TzBkaZT9upKvO+sq+l30RTTiF5N9JbS9t7NlKhbjJFnhNdenR99FFlqZ3KTA7QIzyxU3lNxed70XzV7/t+GF6rXyoKo6ARHOGjgK+u+0PhCIN807yrmGrHtgk+xX4be/PylEA0Na587oYuVfmjTswe2nvY4SYPtmqaRLNa5j" Dec 29 22:34:42 volumio go-librespot[28068]: time="2025-12-29T22:34:42+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:42 volumio go-librespot[28068]: time="2025-12-29T22:34:42+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:43 volumio go-librespot[28068]: time="2025-12-29T22:34:43+08:00" level=debug msg="completed challenge" Dec 29 22:34:43 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:43 volumio go-librespot[28068]: time="2025-12-29T22:34:43+08:00" level=debug msg="new websocket client" Dec 29 22:34:43 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:43 volumio go-librespot[28068]: time="2025-12-29T22:34:43+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:43 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:46 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:46 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:46 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:46 volumio volumio[959]: (node:959) 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: 2101) Dec 29 22:34:46 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:46 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:46 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:46 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:46 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:46 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:47 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2198. Dec 29 22:34:47 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:47 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:47 volumio go-librespot[28093]: Librespot-go daemon starting... Dec 29 22:34:47 volumio go-librespot[28093]: time="2025-12-29T22:34:47+08:00" level=info msg="generated new device id: 25d0ad328baa48ee6753d862c5985a598fbd4aa3" Dec 29 22:34:47 volumio go-librespot[28093]: time="2025-12-29T22:34:47+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:48 volumio go-librespot[28093]: time="2025-12-29T22:34:48+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:48 volumio go-librespot[28093]: time="2025-12-29T22:34:48+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:48 volumio go-librespot[28093]: time="2025-12-29T22:34:48+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:48 volumio go-librespot[28093]: time="2025-12-29T22:34:48+08:00" level=debug msg="zeroconf server listening on port 41781" Dec 29 22:34:48 volumio go-librespot[28093]: time="2025-12-29T22:34:48+08:00" level=debug msg="obtained new client token: AACi73sR1HXer6rzQjfgoTg5vQbnTHH3MA9z0OutA9W6YL7OHEugwoSDFjWo3Cnr4fengzubKmtFv3Si5vG492GID2lM6UQ2zLLMhmTzQviKu2n+uXSNWtuKYqA6U6g2ODrxsWHlCDmEHOrYtrw6kbJh8+DEvs8OQvh8PE9JOleZVbWLqqacm0ckS/Du9CRIVvdC6jHnxUs+AYqKhrIbIiTOtlAaoOehPGEWiU95CUwEU9CCLcjUkLBZPo0=" Dec 29 22:34:48 volumio volumio[959]: verbose: New Socket.io Connection to 192.168.100.162 from 192.168.100.246 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Dec 29 22:34:48 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:48 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:48 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 29 22:34:48 volumio volumio[959]: info: Listing playlists Dec 29 22:34:49 volumio go-librespot[28093]: time="2025-12-29T22:34:49+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:34:49 volumio go-librespot[28093]: time="2025-12-29T22:34:49+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:49 volumio go-librespot[28093]: time="2025-12-29T22:34:49+08:00" level=debug msg="completed challenge" Dec 29 22:34:49 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:49 volumio go-librespot[28093]: time="2025-12-29T22:34:49+08:00" level=debug msg="new websocket client" Dec 29 22:34:49 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:50 volumio go-librespot[28093]: time="2025-12-29T22:34:50+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:50 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:52 volumio kernel: hwmon hwmon1: Voltage normalised Dec 29 22:34:52 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:52 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:52 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:52 volumio volumio[959]: (node:959) 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: 2102) Dec 29 22:34:52 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:52 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:52 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:52 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:53 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:53 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:53 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2199. Dec 29 22:34:53 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:53 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:53 volumio go-librespot[28103]: Librespot-go daemon starting... Dec 29 22:34:53 volumio go-librespot[28103]: time="2025-12-29T22:34:53+08:00" level=info msg="generated new device id: f8bb6d4807f70ecd5e11b7d583d6b3a4fb2747d0" Dec 29 22:34:53 volumio go-librespot[28103]: time="2025-12-29T22:34:53+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:34:54 volumio kernel: hwmon hwmon1: Undervoltage detected! Dec 29 22:34:54 volumio go-librespot[28103]: time="2025-12-29T22:34:54+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:34:54 volumio go-librespot[28103]: time="2025-12-29T22:34:54+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:34:54 volumio go-librespot[28103]: time="2025-12-29T22:34:54+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:34:54 volumio go-librespot[28103]: time="2025-12-29T22:34:54+08:00" level=debug msg="zeroconf server listening on port 35059" Dec 29 22:34:55 volumio go-librespot[28103]: time="2025-12-29T22:34:55+08:00" level=debug msg="obtained new client token: AABlYgP2IODNpuoGGJY0/F13HJSlLZ7toHFfDW0MJXeU8a+U1omkVYyKErXeqv9ULrIPwUZi3x4Gc1e4vVQCcFOu0rQJvJg5ySkfgOteLKCHocQabBvpR4PRfULtUvgixZPiZPTXG9XdCNKiXLrWIX/w1xtm29bp11JYe0T1JseYABp1zqO29oy2Y5nCea815ukubB7MOjHQkLmg3Qh3tad02Ip034bGgQMzlJ1adr3O8gWp1MYIuoa4xJM=" Dec 29 22:34:55 volumio go-librespot[28103]: time="2025-12-29T22:34:55+08:00" level=warning msg="failed to connect to AP ap-guc3.spotify.com:4070 (error: dial tcp 104.154.127.247:4070: connect: connection refused), retrying with a different AP" Dec 29 22:34:55 volumio go-librespot[28103]: time="2025-12-29T22:34:55+08:00" level=info msg="connected to ap-guc3.spotify.com:443" Dec 29 22:34:55 volumio go-librespot[28103]: time="2025-12-29T22:34:55+08:00" level=debug msg="completed keyexchange" Dec 29 22:34:56 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:56 volumio go-librespot[28103]: time="2025-12-29T22:34:56+08:00" level=debug msg="new websocket client" Dec 29 22:34:56 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:34:56 volumio go-librespot[28103]: time="2025-12-29T22:34:56+08:00" level=debug msg="completed challenge" Dec 29 22:34:56 volumio go-librespot[28103]: time="2025-12-29T22:34:56+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:34:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:34:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:34:56 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:34:59 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:34:59 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:59 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:34:59 volumio volumio[959]: (node:959) 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: 2103) Dec 29 22:34:59 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:34:59 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:34:59 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:34:59 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:34:59 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:34:59 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:34:59 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:34:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2200. Dec 29 22:34:59 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:34:59 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:34:59 volumio go-librespot[28163]: Librespot-go daemon starting... Dec 29 22:34:59 volumio go-librespot[28163]: time="2025-12-29T22:34:59+08:00" level=info msg="generated new device id: f32daeeb47887bd0a283307f4bfb671afce235f6" Dec 29 22:34:59 volumio go-librespot[28163]: time="2025-12-29T22:34:59+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:35:00 volumio go-librespot[28163]: time="2025-12-29T22:35:00+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:35:00 volumio go-librespot[28163]: time="2025-12-29T22:35:00+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:35:00 volumio go-librespot[28163]: time="2025-12-29T22:35:00+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:35:00 volumio go-librespot[28163]: time="2025-12-29T22:35:00+08:00" level=debug msg="zeroconf server listening on port 41465" Dec 29 22:35:00 volumio go-librespot[28163]: time="2025-12-29T22:35:00+08:00" level=debug msg="obtained new client token: AABaCrofmswvlMYckqetquBYok0dHJ2NcahY2fS62XWqjPNVXsCB1sgI7ceRRY3uN37zqWCUBExnhYsXzTjCFUV2nuFCX4p/hctmHenbDzQBL0Abe6+KKf6YwkFu1V/kogqErdv6Uow9HGsOLOd6M0WrGjWr3zLBTK7R/qENzGpqDsOZCmNfxrSdegSirCmCE0TCk5uso1eODUpu3DWOlJ9Y4uDB0uQ+On9pJDq8xLRhzBV5Qkiy61o4pM8=" Dec 29 22:35:01 volumio go-librespot[28163]: time="2025-12-29T22:35:01+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:35:01 volumio go-librespot[28163]: time="2025-12-29T22:35:01+08:00" level=debug msg="completed keyexchange" Dec 29 22:35:02 volumio go-librespot[28163]: time="2025-12-29T22:35:02+08:00" level=debug msg="completed challenge" Dec 29 22:35:02 volumio go-librespot[28163]: time="2025-12-29T22:35:02+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:35:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:35:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:35:02 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:02 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:05 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:05 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:05 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:35:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2201. Dec 29 22:35:05 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:35:05 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:35:05 volumio go-librespot[28175]: Librespot-go daemon starting... Dec 29 22:35:05 volumio go-librespot[28175]: time="2025-12-29T22:35:05+08:00" level=info msg="generated new device id: 705d5aa1db222d57eb812e900149b046c008149a" Dec 29 22:35:05 volumio go-librespot[28175]: time="2025-12-29T22:35:05+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:35:06 volumio go-librespot[28175]: time="2025-12-29T22:35:06+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:35:06 volumio go-librespot[28175]: time="2025-12-29T22:35:06+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:35:06 volumio go-librespot[28175]: time="2025-12-29T22:35:06+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:35:06 volumio go-librespot[28175]: time="2025-12-29T22:35:06+08:00" level=debug msg="zeroconf server listening on port 41955" Dec 29 22:35:07 volumio go-librespot[28175]: time="2025-12-29T22:35:07+08:00" level=debug msg="obtained new client token: AACrat/y5jb/eNqgpeQxCBGQUIvr+g7InHbHwbUXnJ3CUtxhv/Tdu+ihNjf3QfT+/Axx0/8T+gL7t036utZfoCKH2ojXTu82TLvt5ALczvTHKogtnFLsZKzXmHY8CSurRMce7KtXTK7aJu5kxeiFspxx8rRTZeb4iGVGPI508GY5JrnlC0iwLM3ms8jBsyeIiNrefs5W+Eh4cRxDDg6A0r0cdIFv5V+WLX7eBAiQinU0lTvg9CF39JCwASs=" Dec 29 22:35:07 volumio go-librespot[28175]: time="2025-12-29T22:35:07+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:35:07 volumio go-librespot[28175]: time="2025-12-29T22:35:07+08:00" level=debug msg="completed keyexchange" Dec 29 22:35:08 volumio go-librespot[28175]: time="2025-12-29T22:35:08+08:00" level=debug msg="completed challenge" Dec 29 22:35:08 volumio go-librespot[28175]: time="2025-12-29T22:35:08+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:35:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:35:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:35:08 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:08 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:11 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:35:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2202. Dec 29 22:35:11 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:35:11 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:35:11 volumio go-librespot[28197]: Librespot-go daemon starting... Dec 29 22:35:11 volumio go-librespot[28197]: time="2025-12-29T22:35:11+08:00" level=info msg="generated new device id: df16967371751fa76a9cbe3df82c12b2dbbe008f" Dec 29 22:35:11 volumio go-librespot[28197]: time="2025-12-29T22:35:11+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:35:11 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:11 volumio go-librespot[28197]: time="2025-12-29T22:35:11+08:00" level=debug msg="new websocket client" Dec 29 22:35:11 volumio volumio[959]: info: Connection to go-librespot Websocket established Dec 29 22:35:12 volumio go-librespot[28197]: time="2025-12-29T22:35:12+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Dec 29 22:35:12 volumio go-librespot[28197]: time="2025-12-29T22:35:12+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Dec 29 22:35:12 volumio go-librespot[28197]: time="2025-12-29T22:35:12+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Dec 29 22:35:12 volumio go-librespot[28197]: time="2025-12-29T22:35:12+08:00" level=debug msg="zeroconf server listening on port 37745" Dec 29 22:35:12 volumio go-librespot[28197]: time="2025-12-29T22:35:12+08:00" level=debug msg="obtained new client token: AAD40gspiHJ91BJicbRCPdFYvtERkMEriqygG3U1sn5KJ/KFDwcoDcSdxTQI7PiRAUjWrp1e1ZP4Sh4XXNqWshiyVfzJX0qcbAlH5n/aSILQNKFhKMdgFLE9Mm5xM9okgu5AMUXrANdW7c032vUTGPPqKSzw7KrkLNU/wbIv2nq6hnnPftZdbAlL7y7hMSCro6jBzhAoBq3KZy0EJkZhHnXH792ePgacWIIZeGoJygypMASPhMbPeK7Z6qA=" Dec 29 22:35:12 volumio go-librespot[28197]: time="2025-12-29T22:35:12+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:35:13 volumio go-librespot[28197]: time="2025-12-29T22:35:13+08:00" level=debug msg="completed keyexchange" Dec 29 22:35:13 volumio go-librespot[28197]: time="2025-12-29T22:35:13+08:00" level=debug msg="completed challenge" Dec 29 22:35:13 volumio go-librespot[28197]: time="2025-12-29T22:35:13+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:35:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:35:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:35:13 volumio volumio[959]: info: Connection to go-librespot Websocket closed Dec 29 22:35:14 volumio volumio[959]: info: Getting Spotify volume Dec 29 22:35:14 volumio volumio[959]: (node:959) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:14 volumio volumio[959]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Dec 29 22:35:14 volumio volumio[959]: (node:959) 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: 2104) Dec 29 22:35:14 volumio volumio[959]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 29 22:35:14 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Dec 29 22:35:14 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Dec 29 22:35:14 volumio volumio[959]: SPOTIFY: RECEIVED VOLUMIO VOLUME 64 Dec 29 22:35:15 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 22:35:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 22:35:16 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:16 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:17 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:35:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2203. Dec 29 22:35:17 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:35:17 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:35:17 volumio go-librespot[28219]: Librespot-go daemon starting... Dec 29 22:35:17 volumio go-librespot[28219]: time="2025-12-29T22:35:17+08:00" level=info msg="generated new device id: 637c378e3a6fd058c6298b5ba77cac08fc4607e6" Dec 29 22:35:17 volumio go-librespot[28219]: time="2025-12-29T22:35:17+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:35:18 volumio go-librespot[28219]: time="2025-12-29T22:35:18+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:35:18 volumio go-librespot[28219]: time="2025-12-29T22:35:18+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:35:18 volumio go-librespot[28219]: time="2025-12-29T22:35:18+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:35:18 volumio go-librespot[28219]: time="2025-12-29T22:35:18+08:00" level=debug msg="zeroconf server listening on port 45069" Dec 29 22:35:18 volumio go-librespot[28219]: time="2025-12-29T22:35:18+08:00" level=debug msg="obtained new client token: AAAqZz5A97GP7N8HQ5Wv0dupQHycB/y3fdLBuAc+0mBDwj5gjYr1SH3E7SmPJZQcOeSqrjkSGvMnjrGbslClLjlMk4kJ6jSaZOx7Ax3Ab51v+D9ODfUB8tS2s7zUTk+YCS7E5nJUXXFcHWlvJ35giCdPZZaI6crkVvZj1FglihISHcYxEvA440Yad5xhJqJ8Xe/XyqUeIXNHlRs8VoWf23OOEQYnrt20j7MGmiTO1497HJLgTTFrT6xHpFc=" Dec 29 22:35:18 volumio go-librespot[28219]: time="2025-12-29T22:35:18+08:00" level=info msg="connected to ap-guc3.spotify.com:4070" Dec 29 22:35:19 volumio go-librespot[28219]: time="2025-12-29T22:35:19+08:00" level=debug msg="completed keyexchange" Dec 29 22:35:19 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 29 22:35:19 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 29 22:35:19 volumio go-librespot[28219]: time="2025-12-29T22:35:19+08:00" level=debug msg="completed challenge" Dec 29 22:35:19 volumio go-librespot[28219]: time="2025-12-29T22:35:19+08:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Dec 29 22:35:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 29 22:35:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 22:35:19 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:19 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:20 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 22:35:20 volumio volumio[959]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fnOS.local. -m SMB3_11 Dec 29 22:35:20 volumio volumio[959]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fnOS.local. -m SMB3_11 Dec 29 22:35:20 volumio volumio[959]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L iStoreOS.local. -m SMB3_11 Dec 29 22:35:22 volumio volumio[959]: info: Initializing connection to go-librespot Websocket Dec 29 22:35:22 volumio volumio[959]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 22:35:23 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Dec 29 22:35:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2204. Dec 29 22:35:23 volumio systemd[1]: Stopped go-librespot Daemon. Dec 29 22:35:23 volumio systemd[1]: Started go-librespot Daemon. Dec 29 22:35:23 volumio go-librespot[28245]: Librespot-go daemon starting... Dec 29 22:35:23 volumio go-librespot[28245]: time="2025-12-29T22:35:23+08:00" level=info msg="generated new device id: 576e61ce2d98826cd983509052986747388b6337" Dec 29 22:35:23 volumio go-librespot[28245]: time="2025-12-29T22:35:23+08:00" level=debug msg="stored credentials found for 313o52zbdpq4duqp63nmr62ikxiu" Dec 29 22:35:23 volumio go-librespot[28245]: time="2025-12-29T22:35:23+08:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 29 22:35:23 volumio go-librespot[28245]: time="2025-12-29T22:35:23+08:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 29 22:35:23 volumio go-librespot[28245]: time="2025-12-29T22:35:23+08:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 29 22:35:24 volumio go-librespot[28245]: time="2025-12-29T22:35:24+08:00" level=debug msg="zeroconf server listening on port 32943" Dec 29 22:35:24 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 29 22:35:24 volumio volumio[959]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 22:35:24 volumio volumio[959]: Error: dns service error: unknown Dec 29 22:35:24 volumio volumio[959]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Dec 29 22:35:24 volumio volumio[959]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 29 22:35:24 volumio volumio[959]: errorCode: -65537 Dec 29 22:35:24 volumio volumio[959]: } Dec 29 22:35:24 volumio volumio[959]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 22:35:24 volumio sudo[28265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-29 22:34 Dec 29 22:35:24 volumio sudo[28265]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"