-- Logs begin at Tue 2026-04-14 15:37:03 CEST, end at Tue 2026-04-14 15:41:06 CEST. -- Apr 14 15:40:05 volumioalrum volumio[1045]: error: [yt-cast-receiver] (YouTube Music) Error occurred in SendMessageTask: Apr 14 15:40:05 volumioalrum volumio[1045]: LoungeScreenDisconnected { Apr 14 15:40:05 volumioalrum volumio[1045]: AID: null, Apr 14 15:40:05 volumioalrum volumio[1045]: name: 'loungeScreenDisconnected', Apr 14 15:40:05 volumioalrum volumio[1045]: payload: {} Apr 14 15:40:05 volumioalrum volumio[1045]: } Apr 14 15:40:05 volumioalrum volumio[1045]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Apr 14 15:40:05 volumioalrum volumio[1045]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Apr 14 15:40:05 volumioalrum volumio[1045]: Stack trace: Apr 14 15:40:05 volumioalrum volumio[1045]: IncompleteAPIDataError: Missing data required to construct query string from bind params Apr 14 15:40:05 volumioalrum volumio[1045]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Apr 14 15:40:05 volumioalrum volumio[1045]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Apr 14 15:40:05 volumioalrum volumio[1045]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Apr 14 15:40:05 volumioalrum volumio[1045]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Apr 14 15:40:05 volumioalrum volumio[1045]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Apr 14 15:40:05 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:40:05 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:40:05 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Apr 14 15:40:05 volumioalrum volumio[1045]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Apr 14 15:40:05 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:40:05 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:40:05 volumioalrum volumio[1045]: (node:1045) 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: 714) Apr 14 15:40:05 volumioalrum volumio[1045]: error: [yt-cast-receiver] (YouTube) Error occurred in SendMessageTask: Apr 14 15:40:05 volumioalrum volumio[1045]: LoungeScreenDisconnected { Apr 14 15:40:05 volumioalrum volumio[1045]: AID: null, Apr 14 15:40:05 volumioalrum volumio[1045]: name: 'loungeScreenDisconnected', Apr 14 15:40:05 volumioalrum volumio[1045]: payload: {} Apr 14 15:40:05 volumioalrum volumio[1045]: } Apr 14 15:40:05 volumioalrum volumio[1045]: (IncompleteAPIDataError) Missing data required to construct query string from bind params Apr 14 15:40:05 volumioalrum volumio[1045]: Error info: { missing: [ 'loungeIdToken', 'SID', 'gsessionid' ] } Apr 14 15:40:05 volumioalrum volumio[1045]: Stack trace: Apr 14 15:40:05 volumioalrum volumio[1045]: IncompleteAPIDataError: Missing data required to construct query string from bind params Apr 14 15:40:05 volumioalrum volumio[1045]: at BindParams.toQueryString (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/BindParams.js:120:19) Apr 14 15:40:05 volumioalrum volumio[1045]: at Session._Session_doSendMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:492:103) Apr 14 15:40:05 volumioalrum volumio[1045]: at SendMessageTask.run (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:552:71) Apr 14 15:40:05 volumioalrum volumio[1045]: at AsyncTaskQueue.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/utils/AsyncTaskQueue.js:51:36) Apr 14 15:40:05 volumioalrum volumio[1045]: at Session.end (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:237:71) Apr 14 15:40:05 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:40:05 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:40:05 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Apr 14 15:40:05 volumioalrum volumio[1045]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Apr 14 15:40:05 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:40:05 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:40:05 volumioalrum volumio[1045]: (node:1045) 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: 716) Apr 14 15:40:11 volumioalrum volumio-time-update[767]: volumio-time-update-util: Date not found in response Apr 14 15:40:11 volumioalrum volumio-time-update[767]: volumio-time-update-util: Retrying in 5 seconds... Apr 14 15:40:11 volumioalrum go-librespot[2620]: time="2026-04-14T15:40:11+02: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" Apr 14 15:40:11 volumioalrum systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 14 15:40:11 volumioalrum systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 14 15:40:15 volumioalrum systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 14 15:40:15 volumioalrum systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Apr 14 15:40:15 volumioalrum systemd[1]: Stopped go-librespot Daemon. Apr 14 15:40:15 volumioalrum systemd[1]: Started go-librespot Daemon. Apr 14 15:40:15 volumioalrum go-librespot[2715]: go-librespot daemon starting... Apr 14 15:40:15 volumioalrum go-librespot[2715]: time="2026-04-14T15:40:15+02:00" level=info msg="running go-librespot 0.4.0" Apr 14 15:40:15 volumioalrum go-librespot[2715]: time="2026-04-14T15:40:15+02:00" level=debug msg="app state loaded" Apr 14 15:40:15 volumioalrum go-librespot[2715]: time="2026-04-14T15:40:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 14 15:40:16 volumioalrum volumio-time-update[767]: volumio-time-update-util: Fetching time from Volumio... Apr 14 15:40:25 volumioalrum go-librespot[2715]: time="2026-04-14T15:40:25+02:00" level=debug msg="new websocket client" Apr 14 15:40:25 volumioalrum volumio[1045]: info: Connection to go-librespot Websocket established Apr 14 15:40:28 volumioalrum volumio[1045]: info: Getting Spotify volume Apr 14 15:40:35 volumioalrum go-librespot[2715]: time="2026-04-14T15:40:35+02: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" Apr 14 15:40:35 volumioalrum systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 14 15:40:35 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: Error: socket hang up Apr 14 15:40:35 volumioalrum volumio[1045]: at connResetException (internal/errors.js:639:14) Apr 14 15:40:35 volumioalrum volumio[1045]: at Socket.socketOnEnd (_http_client.js:499:23) Apr 14 15:40:35 volumioalrum volumio[1045]: at Socket.emit (events.js:412:35) Apr 14 15:40:35 volumioalrum volumio[1045]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 14 15:40:35 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 14 15:40:35 volumioalrum volumio[1045]: (node:1045) 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: 717) Apr 14 15:40:35 volumioalrum systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 14 15:40:35 volumioalrum volumio[1045]: info: Connection to go-librespot Websocket closed Apr 14 15:40:36 volumioalrum volumio-time-update[767]: volumio-time-update-util: Date not found in response Apr 14 15:40:36 volumioalrum volumio-time-update[767]: volumio-time-update-util: Retrying in 5 seconds... Apr 14 15:40:38 volumioalrum volumio[1045]: info: Initializing connection to go-librespot Websocket Apr 14 15:40:38 volumioalrum systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 14 15:40:38 volumioalrum systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Apr 14 15:40:38 volumioalrum systemd[1]: Stopped go-librespot Daemon. Apr 14 15:40:38 volumioalrum systemd[1]: Started go-librespot Daemon. Apr 14 15:40:38 volumioalrum go-librespot[2759]: go-librespot daemon starting... Apr 14 15:40:38 volumioalrum go-librespot[2759]: time="2026-04-14T15:40:38+02:00" level=info msg="running go-librespot 0.4.0" Apr 14 15:40:38 volumioalrum go-librespot[2759]: time="2026-04-14T15:40:38+02:00" level=debug msg="app state loaded" Apr 14 15:40:38 volumioalrum go-librespot[2759]: time="2026-04-14T15:40:38+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 14 15:40:39 volumioalrum ntpd[2484]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 14 15:40:41 volumioalrum volumio-time-update[767]: volumio-time-update-util: Fetching time from Volumio... Apr 14 15:40:44 volumioalrum dhcpcd[2565]: eth0: offered 192.168.1.101 from 192.168.1.1 Apr 14 15:40:44 volumioalrum dhcpcd[1541]: eth0: offered 192.168.1.101 from 192.168.1.1 Apr 14 15:40:44 volumioalrum dhcpcd[2565]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:44 volumioalrum dhcpcd[1541]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:44 volumioalrum dhcpcd[2565]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:44 volumioalrum dhcpcd[1541]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:45 volumioalrum dhcpcd[2565]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:45 volumioalrum volumio[1045]: info: Discovery: adding d016a4a5-e68e-44ec-998d-33514b24f501 Apr 14 15:40:45 volumioalrum volumio[1045]: info: Discovery: Found device VolumioAlrum Apr 14 15:40:45 volumioalrum volumio[1045]: info: CoreCommandRouter::volumioGetState Apr 14 15:40:45 volumioalrum volumio[1045]: info: CorePlayQueue::getTrack 0 Apr 14 15:40:46 volumioalrum dhcpcd[1541]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:51 volumioalrum dhcpcd[2565]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:51 volumioalrum dhcpcd[1541]: eth0: ignoring offer of 192.168.1.101 from 192.168.1.1 Apr 14 15:40:51 volumioalrum dhcpcd[2565]: eth0: probing address 192.168.1.101/24 Apr 14 15:40:51 volumioalrum dhcpcd[1541]: eth0: probing address 192.168.1.101/24 Apr 14 15:40:56 volumioalrum dhcpcd[2565]: eth0: leased 192.168.1.101 for 86400 seconds Apr 14 15:40:56 volumioalrum dhcpcd[2565]: eth0: adding route to 192.168.1.0/24 Apr 14 15:40:56 volumioalrum dhcpcd[2565]: eth0: changing default route via 192.168.1.1 Apr 14 15:40:56 volumioalrum dhcpcd[1541]: eth0: deleted default route Apr 14 15:40:56 volumioalrum avahi-daemon[814]: Registering new address record for 192.168.1.101 on eth0.IPv4. Apr 14 15:40:57 volumioalrum ntpd[2484]: ntpd exiting on signal 15 (Terminated) Apr 14 15:40:57 volumioalrum systemd[1]: Stopping Network Time Service... Apr 14 15:40:57 volumioalrum systemd[1]: ntp.service: Succeeded. Apr 14 15:40:57 volumioalrum systemd[1]: Stopped Network Time Service. Apr 14 15:40:57 volumioalrum systemd[1]: Starting Network Time Service... Apr 14 15:40:57 volumioalrum ntpd[2833]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 14 15:40:57 volumioalrum ntpd[2833]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 14 15:40:57 volumioalrum systemd[1]: Started Network Time Service. Apr 14 15:40:57 volumioalrum ntpd[2839]: proto: precision = 0.200 usec (-22) Apr 14 15:40:57 volumioalrum ntpd[2839]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 14 15:40:57 volumioalrum avahi-daemon[814]: Withdrawing address record for 169.254.251.118 on eth0. Apr 14 15:40:57 volumioalrum avahi-daemon[814]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.251.118. Apr 14 15:40:57 volumioalrum avahi-daemon[814]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.101. Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: deleted route to 169.254.0.0/16 Apr 14 15:40:57 volumioalrum ntpd[2839]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 14 15:40:57 volumioalrum dhcpcd[2565]: eth0: deleting route to 169.254.0.0/16 Apr 14 15:40:57 volumioalrum ntpd[2839]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1204 days ago Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: adding route to 169.254.0.0/16 Apr 14 15:40:57 volumioalrum dhcpcd[1541]: if_route (ADD): Invalid argument Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: adding default route Apr 14 15:40:57 volumioalrum dhcpcd[1541]: if_route (ADD): Invalid argument Apr 14 15:40:57 volumioalrum ntpd[2839]: Listen and drop on 0 v6wildcard [::]:123 Apr 14 15:40:57 volumioalrum ntpd[2839]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 14 15:40:57 volumioalrum ntpd[2839]: Listen normally on 2 lo 127.0.0.1:123 Apr 14 15:40:57 volumioalrum ntpd[2839]: Listen normally on 3 eth0 192.168.1.101:123 Apr 14 15:40:57 volumioalrum ntpd[2839]: Listening on routing socket on fd #20 for interface updates Apr 14 15:40:57 volumioalrum ntpd[2839]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 14 15:40:57 volumioalrum ntpd[2839]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: leased 192.168.1.101 for 86400 seconds Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: adding route to 192.168.1.0/24 Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: adding default route via 192.168.1.1 Apr 14 15:40:57 volumioalrum dhcpcd[1541]: eth0: adding route to 169.254.0.0/16 Apr 14 15:40:57 volumioalrum dhcpcd[1541]: if_route (ADD): Invalid argument Apr 14 15:40:57 volumioalrum ntpd[2839]: ntpd exiting on signal 15 (Terminated) Apr 14 15:40:57 volumioalrum systemd[1]: Stopping Network Time Service... Apr 14 15:40:57 volumioalrum systemd[1]: ntp.service: Succeeded. Apr 14 15:40:57 volumioalrum systemd[1]: Stopped Network Time Service. Apr 14 15:40:57 volumioalrum systemd[1]: Starting Network Time Service... Apr 14 15:40:57 volumioalrum ntpd[2887]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 14 15:40:57 volumioalrum ntpd[2887]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 14 15:40:57 volumioalrum systemd[1]: Started Network Time Service. Apr 14 15:40:57 volumioalrum ntpd[2893]: proto: precision = 0.188 usec (-22) Apr 14 15:40:57 volumioalrum ntpd[2893]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 14 15:40:57 volumioalrum ntpd[2893]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 14 15:40:57 volumioalrum ntpd[2893]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1204 days ago Apr 14 15:40:57 volumioalrum ntpd[2893]: Listen and drop on 0 v6wildcard [::]:123 Apr 14 15:40:57 volumioalrum ntpd[2893]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 14 15:40:57 volumioalrum ntpd[2893]: Listen normally on 2 lo 127.0.0.1:123 Apr 14 15:40:57 volumioalrum ntpd[2893]: Listen normally on 3 eth0 192.168.1.101:123 Apr 14 15:40:57 volumioalrum ntpd[2893]: Listening on routing socket on fd #20 for interface updates Apr 14 15:40:57 volumioalrum ntpd[2893]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 14 15:40:57 volumioalrum ntpd[2893]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 14 15:40:58 volumioalrum go-librespot[2759]: time="2026-04-14T15:40:58+02: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" Apr 14 15:40:58 volumioalrum systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 14 15:40:58 volumioalrum systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 14 15:40:58 volumioalrum ntpd[2893]: Soliciting pool server 77.37.97.124 Apr 14 15:40:59 volumioalrum ntpd[2893]: Soliciting pool server 195.72.61.39 Apr 14 15:40:59 volumioalrum ntpd[2893]: Soliciting pool server 217.198.219.102 Apr 14 15:41:00 volumioalrum ntpd[2893]: Soliciting pool server 87.63.200.138 Apr 14 15:41:00 volumioalrum ntpd[2893]: Soliciting pool server 193.200.91.90 Apr 14 15:41:00 volumioalrum ntpd[2893]: Soliciting pool server 162.159.200.123 Apr 14 15:41:00 volumioalrum volumio[1045]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 14 15:41:00 volumioalrum volumio[1045]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 14 15:41:00 volumioalrum volumio[1045]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 14 15:41:00 volumioalrum volumio[1045]: info: CoreCommandRouter::volumioGetState Apr 14 15:41:00 volumioalrum volumio[1045]: info: CorePlayQueue::getTrack 0 Apr 14 15:41:01 volumioalrum volumio-time-update[767]: volumio-time-update-util: Date not found in response Apr 14 15:41:01 volumioalrum volumio-time-update[767]: volumio-time-update-util: Retrying in 5 seconds... Apr 14 15:41:01 volumioalrum systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 14 15:41:01 volumioalrum systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Apr 14 15:41:01 volumioalrum systemd[1]: Stopped go-librespot Daemon. Apr 14 15:41:01 volumioalrum systemd[1]: Started go-librespot Daemon. Apr 14 15:41:01 volumioalrum go-librespot[2912]: go-librespot daemon starting... Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=info msg="running go-librespot 0.4.0" Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=debug msg="app state loaded" Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 14 15:41:01 volumioalrum ntpd[2893]: Soliciting pool server 162.159.200.1 Apr 14 15:41:01 volumioalrum ntpd[2893]: Soliciting pool server 77.33.21.8 Apr 14 15:41:01 volumioalrum ntpd[2893]: Soliciting pool server 80.209.68.118 Apr 14 15:41:01 volumioalrum ntpd[2893]: Soliciting pool server 95.154.26.34 Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Apr 14 15:41:01 volumioalrum volumio[1045]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Apr 14 15:41:01 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:41:01 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) 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: 718) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Apr 14 15:41:01 volumioalrum volumio[1045]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Apr 14 15:41:01 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:41:01 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) 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: 719) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Apr 14 15:41:01 volumioalrum volumio[1045]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Apr 14 15:41:01 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:41:01 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) 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: 720) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'removeAllListeners' of undefined Apr 14 15:41:01 volumioalrum volumio[1045]: at Session._Session_refreshLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:372:16) Apr 14 15:41:01 volumioalrum volumio[1045]: at runMicrotasks () Apr 14 15:41:01 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Apr 14 15:41:01 volumioalrum volumio[1045]: (node:1045) 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: 721) Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 14 15:41:01 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:01+02:00" level=info msg="zeroconf server listening on port 33097" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="obtained new client token: AADBugIaKeJ99blrp4ym+hlls/XD5YXt07sCfan+uPfM2lC+VE9C24UW2BF5ultc+Ha4c6DfVc4MNZoq7Oy3r1yBYwFQn2nmfRrZJJnRJBHs1bja0d78QQpnqMvLWkZqkhSSODdd3LTWw8MCPShBGXQfXy9GJiuF7pXb4JXnu/auKuZM9PuC88IGMi8KZS9yqMEzoJ523y7T2sMGRXF2PQeJ/t6+agSZFx6hHVcblsxw7RIUpQ4MBI+ONA==" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="completed keyexchange" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="completed challenge" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=info msg="authenticated AP" username="th*****99" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=info msg="authenticated Login5" username="th*****99" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="initializing zeroconf session" username="th*****99" Apr 14 15:41:02 volumioalrum ntpd[2893]: Soliciting pool server 5.186.56.205 Apr 14 15:41:02 volumioalrum ntpd[2893]: Soliciting pool server 212.99.225.86 Apr 14 15:41:02 volumioalrum ntpd[2893]: Soliciting pool server 87.52.105.26 Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="dealer connection opened" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=trace msg="starting accesspoint recv loop" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=trace msg="starting dealer recv loop" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=trace msg="received accesspoint ping" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="received connection id: MGZmNzQ5MWYtNmU4...OTRCMjBFMTM4Mw==" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 14 15:41:02 volumioalrum volumio[1045]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 14 15:41:02 volumioalrum volumio[1045]: info: Received Get System Info Apr 14 15:41:02 volumioalrum volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 15:41:02 volumioalrum volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 15:41:02 volumioalrum volumio[1045]: info: Discovery: Getting this device information Apr 14 15:41:02 volumioalrum volumio[1045]: info: CoreCommandRouter::volumioGetState Apr 14 15:41:02 volumioalrum volumio[1045]: info: CorePlayQueue::getTrack 0 Apr 14 15:41:02 volumioalrum volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="update volume requested to 65535/65535" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 14 15:41:02 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:02+02:00" level=trace msg="received accesspoint pong ack" Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin bluetooth to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin multiroom to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin metavolumio to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin cd_controller to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin qobuzconnect to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 14 15:41:03 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:03+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Apr 14 15:41:03 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:03+02:00" level=trace msg="emitting websocket event: volume" Apr 14 15:41:03 volumioalrum ntpd[2893]: Soliciting pool server 2a09:5e41:d10:93f0:da3a:ddff:fe17:5175 Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 14 15:41:03 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 14 15:41:03 volumioalrum volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 15:41:03 volumioalrum volumio[1045]: info: Starting MyVolumio Remote Streaming Endpoints Apr 14 15:41:04 volumioalrum volumio[1045]: info: MyVolumio login type: Token Apr 14 15:41:04 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 14 15:41:04 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 14 15:41:05 volumioalrum volumio[1045]: info: Starting Streaming Service Transparent Proxy Apr 14 15:41:05 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 14 15:41:05 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 14 15:41:05 volumioalrum volumio[1045]: info: Streaming services startup Apr 14 15:41:05 volumioalrum volumio[1045]: info: Starting Streaming Daemon Apr 14 15:41:05 volumioalrum sudo[2942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 14 15:41:05 volumioalrum sudo[2942]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 15:41:05 volumioalrum sudo[2942]: pam_unix(sudo:session): session closed for user root Apr 14 15:41:05 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 14 15:41:05 volumioalrum volumio[1045]: info: Initializing connection to go-librespot Websocket Apr 14 15:41:05 volumioalrum volumio[1045]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 14 15:41:05 volumioalrum volumio[1045]: info: MyVolumio login type: Token Apr 14 15:41:05 volumioalrum volumio[1045]: error: Cannot start Volumio Streaming Daemon Apr 14 15:41:05 volumioalrum volumio[1045]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 14 15:41:05 volumioalrum volumio[1045]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 14 15:41:05 volumioalrum go-librespot[2912]: time="2026-04-14T15:41:05+02:00" level=debug msg="new websocket client" Apr 14 15:41:05 volumioalrum volumio[1045]: info: Connection to go-librespot Websocket established Apr 14 15:41:05 volumioalrum volumio[1045]: error: MyVolumio Custom Token format not valid, refreshing it Apr 14 15:41:05 volumioalrum volumio[1045]: STREAMING PROXY: Starting server on port 3245 Apr 14 15:41:05 volumioalrum volumio[1045]: Node JS runtime: 14 Apr 14 15:41:05 volumioalrum volumio[1045]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 14 15:41:05 volumioalrum volumio[1045]: info: MyVolumio login type: Token Apr 14 15:41:05 volumioalrum volumio[1045]: info: MyVolumio token set successfully Apr 14 15:41:05 volumioalrum volumio[1045]: info: MYVOLUMIO: Adding device Apr 14 15:41:05 volumioalrum volumio[1045]: info: MYVOLUMIO: Evaluating Server Apr 14 15:41:06 volumioalrum volumio-time-update[767]: volumio-time-update-util: Fetching time from Volumio... Apr 14 15:41:06 volumioalrum volumio-time-update[767]: volumio-time-update-util: Setting system time to: 2026-04-14 15:41:06 Apr 14 15:41:06 volumioalrum sudo[3010]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-04-14 15:41:06 Apr 14 15:41:06 volumioalrum sudo[3010]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 15:41:06 volumioalrum dbus-daemon[792]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.26' (uid=0 pid=3012 comm="timedatectl set-time 2026-04-14 15:41:06 ") Apr 14 15:41:06 volumioalrum systemd[1]: Starting Time & Date Service... Apr 14 15:41:06 volumioalrum dbus-daemon[792]: [system] Successfully activated service 'org.freedesktop.timedate1' Apr 14 15:41:06 volumioalrum systemd[1]: Started Time & Date Service. Apr 14 15:41:06 volumioalrum volumio[1045]: info: MyVolumio Plan changed: premium Apr 14 15:41:06 volumioalrum volumio[1045]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 14 15:41:06 volumioalrum volumio[1045]: info: Removing browser output: myVolumio user plan is not superstar Apr 14 15:41:06 volumioalrum systemd-timedated[3015]: Changed local time to Tue Apr 14 15:41:06 2026 Apr 14 15:41:06 volumioalrum volumio[1045]: info: Removing audio output: Apr 14 15:41:06 volumioalrum volumio[1045]: info: MYVOLUMIO: Adding device Apr 14 15:41:06 volumioalrum volumio[1045]: info: MYVOLUMIO: Evaluating Server Apr 14 15:41:06 volumioalrum sudo[3010]: pam_unix(sudo:session): session closed for user root Apr 14 15:41:06 volumioalrum volumio-time-update[767]: volumio-time-update-util: System time updated successfully. Apr 14 15:41:06 volumioalrum systemd[1]: Started Volumio Time Update Utility. Apr 14 15:41:06 volumioalrum systemd[1]: Reached target Multi-User System. Apr 14 15:41:06 volumioalrum systemd[1]: Reached target Graphical Interface. Apr 14 15:41:06 volumioalrum volumio[1045]: error: Failed to ping endpoint us3.myvolumio.org : unknown error Apr 14 15:41:06 volumioalrum systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 14 15:41:06 volumioalrum volumio[1045]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 15:41:06 volumioalrum volumio[1045]: Error: Unable to resolve or reject the same promise twice Apr 14 15:41:06 volumioalrum volumio[1045]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 14 15:41:06 volumioalrum volumio[1045]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Apr 14 15:41:06 volumioalrum volumio[1045]: at Socket.emit (events.js:412:35) Apr 14 15:41:06 volumioalrum volumio[1045]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 14 15:41:06 volumioalrum volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 14 15:41:06 volumioalrum volumio[1045]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 15:41:06 volumioalrum systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 14 15:41:06 volumioalrum systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 14 15:41:06 volumioalrum systemd[1]: Startup finished in 10.002s (firmware) + 2.892s (loader) + 10.379s (kernel) + 4min 4.338s (userspace) = 4min 27.612s. Apr 14 15:41:06 volumioalrum sudo[3033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-14 15:40 Apr 14 15:41:06 volumioalrum sudo[3033]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 09:58:18 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="54b3518c7dd8feba4753e0ad124ce801"