-- Logs begin at Mon 2026-01-26 19:58:30 CET, end at Mon 2026-01-26 20:02:43 CET. -- Jan 26 20:01:02 volumio-digi2pro-rpi5 ntpd[964]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jan 26 20:01:04 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Fetching time from Volumio... Jan 26 20:01:12 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: adding 9d0707f6-0013-4351-a851-8995f578518a Jan 26 20:01:12 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Found device Volumio-Digi2Pro Jan 26 20:01:12 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Connecting to remote: 192.168.1.41 Jan 26 20:01:25 volumio-digi2pro-rpi5 go-librespot[1863]: time="2026-01-26T20:01:25+01:00" level=fatal msg="failed running zeroconf" 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 26 20:01:25 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 26 20:01:25 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 26 20:01:28 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 26 20:01:28 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Jan 26 20:01:28 volumio-digi2pro-rpi5 systemd[1]: Stopped go-librespot Daemon. Jan 26 20:01:28 volumio-digi2pro-rpi5 systemd[1]: Started go-librespot Daemon. Jan 26 20:01:28 volumio-digi2pro-rpi5 go-librespot[1920]: go-librespot daemon starting... Jan 26 20:01:28 volumio-digi2pro-rpi5 go-librespot[1920]: time="2026-01-26T20:01:28+01:00" level=info msg="running go-librespot 0.6.2" Jan 26 20:01:28 volumio-digi2pro-rpi5 go-librespot[1920]: time="2026-01-26T20:01:28+01:00" level=debug msg="app state loaded" Jan 26 20:01:28 volumio-digi2pro-rpi5 go-librespot[1920]: time="2026-01-26T20:01:28+01:00" level=debug msg="stored credentials not found" Jan 26 20:01:28 volumio-digi2pro-rpi5 go-librespot[1920]: time="2026-01-26T20:01:28+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 26 20:01:30 volumio-digi2pro-rpi5 ntpd[964]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jan 26 20:01:32 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Date not found in response Jan 26 20:01:32 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Retrying in 5 seconds... Jan 26 20:01:37 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Fetching time from Volumio... Jan 26 20:01:40 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: adding d6a3c472-de2e-4b05-aee9-0056d6824bee Jan 26 20:01:40 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Found device Volumio-Dac2Pro Jan 26 20:01:40 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Connecting to remote: 192.168.1.30 Jan 26 20:01:40 volumio-digi2pro-rpi5 go-librespot[1920]: time="2026-01-26T20:01:40+01:00" level=debug msg="new websocket client" Jan 26 20:01:40 volumio-digi2pro-rpi5 volumio[1199]: info: Connection to go-librespot Websocket established Jan 26 20:01:43 volumio-digi2pro-rpi5 volumio[1199]: info: Getting Spotify volume Jan 26 20:01:56 volumio-digi2pro-rpi5 go-librespot[1920]: time="2026-01-26T20:01:56+01:00" level=fatal msg="failed running zeroconf" 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 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: (node:1199) UnhandledPromiseRejectionWarning: Error: socket hang up Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: at connResetException (internal/errors.js:607:14) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: at Socket.socketOnEnd (_http_client.js:493:23) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: at Socket.emit (events.js:327:22) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: at endReadableNT (internal/streams/readable.js:1327:12) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: (Use `node --trace-warnings ...` to show where the warning was created) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: (node:1199) 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: 2) Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: (node:1199) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jan 26 20:01:56 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 26 20:01:56 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 26 20:01:56 volumio-digi2pro-rpi5 volumio[1199]: info: Connection to go-librespot Websocket closed Jan 26 20:01:58 volumio-digi2pro-rpi5 ntpd[964]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 26 20:01:59 volumio-digi2pro-rpi5 volumio[1199]: info: Initializing connection to go-librespot Websocket Jan 26 20:02:00 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 26 20:02:00 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Jan 26 20:02:00 volumio-digi2pro-rpi5 systemd[1]: Stopped go-librespot Daemon. Jan 26 20:02:00 volumio-digi2pro-rpi5 systemd[1]: Started go-librespot Daemon. Jan 26 20:02:00 volumio-digi2pro-rpi5 go-librespot[2022]: go-librespot daemon starting... Jan 26 20:02:00 volumio-digi2pro-rpi5 go-librespot[2022]: time="2026-01-26T20:02:00+01:00" level=info msg="running go-librespot 0.6.2" Jan 26 20:02:00 volumio-digi2pro-rpi5 go-librespot[2022]: time="2026-01-26T20:02:00+01:00" level=debug msg="app state loaded" Jan 26 20:02:00 volumio-digi2pro-rpi5 go-librespot[2022]: time="2026-01-26T20:02:00+01:00" level=debug msg="stored credentials not found" Jan 26 20:02:00 volumio-digi2pro-rpi5 go-librespot[2022]: time="2026-01-26T20:02:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 26 20:02:05 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Date not found in response Jan 26 20:02:05 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Retrying in 5 seconds... Jan 26 20:02:10 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Fetching time from Volumio... Jan 26 20:02:13 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Browse raised the following error Error: getaddrinfo -3008 Jan 26 20:02:26 volumio-digi2pro-rpi5 ntpd[964]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jan 26 20:02:28 volumio-digi2pro-rpi5 go-librespot[2022]: time="2026-01-26T20:02:28+01:00" level=fatal msg="failed running zeroconf" 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 26 20:02:28 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 26 20:02:28 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 26 20:02:31 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jan 26 20:02:31 volumio-digi2pro-rpi5 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Jan 26 20:02:31 volumio-digi2pro-rpi5 systemd[1]: Stopped go-librespot Daemon. Jan 26 20:02:31 volumio-digi2pro-rpi5 systemd[1]: Started go-librespot Daemon. Jan 26 20:02:31 volumio-digi2pro-rpi5 go-librespot[2094]: go-librespot daemon starting... Jan 26 20:02:31 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:31+01:00" level=info msg="running go-librespot 0.6.2" Jan 26 20:02:31 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:31+01:00" level=debug msg="app state loaded" Jan 26 20:02:31 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:31+01:00" level=debug msg="stored credentials not found" Jan 26 20:02:31 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:31+01:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 26 20:02:38 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Date not found in response Jan 26 20:02:38 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Retrying in 5 seconds... Jan 26 20:02:40 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 26 20:02:40 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.11 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 26 20:02:40 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:40+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Jan 26 20:02:40 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:40+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jan 26 20:02:40 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:40+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jan 26 20:02:40 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:40+01:00" level=info msg="zeroconf server listening on port 33157" Jan 26 20:02:40 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.178.58.245 Jan 26 20:02:40 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.178.58.245 Jan 26 20:02:40 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.250.114.105 Jan 26 20:02:40 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.178.58.245 Jan 26 20:02:40 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.178.58.245 Jan 26 20:02:40 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.178.58.245 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.41 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8 from 192.168.1.9 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Connected to remote: 192.168.1.30 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.33 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Discovery: Connected to remote: 192.168.1.33 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Jan 26 20:02:41 volumio-digi2pro-rpi5 go-librespot[2094]: time="2026-01-26T20:02:41+01:00" level=debug msg="new websocket client" Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Connection to go-librespot Websocket established Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: CoreCommandRouter::volumioGetState Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: CorePlayQueue::getTrack 0 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.11 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22 Jan 26 20:02:41 volumio-digi2pro-rpi5 ntpd[964]: Soliciting pool server 195.178.58.245 Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin bluetooth to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin multiroom to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin metavolumio to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin cd_controller to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 26 20:02:41 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: Starting MyVolumio Remote Streaming Endpoints Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: MyVolumio login type: Token Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: Starting Streaming Service Transparent Proxy Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: Streaming services startup Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: Starting Streaming Daemon Jan 26 20:02:42 volumio-digi2pro-rpi5 sudo[2167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 26 20:02:42 volumio-digi2pro-rpi5 sudo[2167]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 26 20:02:42 volumio-digi2pro-rpi5 sudo[2167]: pam_unix(sudo:session): session closed for user root Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: error: Cannot start Volumio Streaming Daemon Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.33 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23 Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.41 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: STREAMING PROXY: Starting server on port 3245 Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: Node JS runtime: 14 Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25 Jan 26 20:02:42 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.11 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 27 Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.11 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 28 Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MyVolumio token set successfully Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MYVOLUMIO: Adding device Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MYVOLUMIO: Evaluating Server Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Fetching time from Volumio... Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 29 Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: Setting system time to: 2026-01-26 20:02:43 Jan 26 20:02:43 volumio-digi2pro-rpi5 sudo[2181]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-01-26 20:02:43 Jan 26 20:02:43 volumio-digi2pro-rpi5 sudo[2181]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: verbose: New Socket.io Connection to 192.168.1.8:3000 from 192.168.1.41 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Jan 26 20:02:43 volumio-digi2pro-rpi5 dbus-daemon[812]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.17' (uid=0 pid=2182 comm="timedatectl set-time 2026-01-26 20:02:43 ") Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Starting Time & Date Service... Jan 26 20:02:43 volumio-digi2pro-rpi5 dbus-daemon[812]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Started Time & Date Service. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd-timedated[2184]: Changed local time to Mon Jan 26 20:02:43 2026 Jan 26 20:02:43 volumio-digi2pro-rpi5 sudo[2181]: pam_unix(sudo:session): session closed for user root Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio-time-update[809]: volumio-time-update-util: System time updated successfully. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Started Volumio Time Update Utility. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Reached target Multi-User System. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Reached target Graphical Interface. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MyVolumio Plan changed: premium Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: Removing browser output: myVolumio user plan is not superstar Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: Removing audio output: Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MYVOLUMIO: Adding device Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: info: MYVOLUMIO: Evaluating Server Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 26 20:02:43 volumio-digi2pro-rpi5 systemd[1]: Startup finished in 11.153s (kernel) + 4min 13.517s (userspace) = 4min 24.671s. Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: error: Failed to ping endpoint eu7.myvolumio.org : unknown error Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: Error: Unable to resolve or reject the same promise twice Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at Socket.emit (events.js:315:20) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at addChunk (internal/streams/readable.js:309:12) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at readableAddChunk (internal/streams/readable.js:284:9) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jan 26 20:02:43 volumio-digi2pro-rpi5 volumio[1199]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 20:02:43 volumio-digi2pro-rpi5 sudo[2213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 20:01 Jan 26 20:02:43 volumio-digi2pro-rpi5 sudo[2213]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"