Feb 23 17:36:00 volumio volumio[2064]: info: Spotify volume: 100 Feb 23 17:36:00 volumio volumio[2064]: info: CoreCommandRouter::volumioGetState Feb 23 17:36:00 volumio volumio[2064]: info: CorePlayQueue::getTrack 0 Feb 23 17:36:02 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6 Feb 23 17:36:04 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 23 17:36:06 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 23 17:36:06 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Feb 23 17:36:06 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:06 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:06 volumio upmpdcli[2371]: Could not open config: /tmp/upmpdcli.conf Feb 23 17:36:06 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 17:36:06 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 17:36:08 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 23 17:36:09 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:13 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:17 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:19 volumio volumio[2064]: info: CoreCommandRouter::volumioGetState Feb 23 17:36:19 volumio volumio[2064]: info: CorePlayQueue::getTrack 0 Feb 23 17:36:20 volumio volumio[2064]: SPOTIFY: User informations: {"country":"ES","display_name":"stalkibus","email":"rodrigo@astelarra.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/stalkibus"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/stalkibus","id":"stalkibus","images":[],"product":"premium","type":"user","uri":"spotify:user:stalkibus"} Feb 23 17:36:20 volumio volumio[2064]: info: Spotify Successfully logged in Feb 23 17:36:20 volumio volumio[2064]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 17:36:20 volumio volumio[2064]: info: [1771864580943] CoreMusicLibrary::Adding element Spotify Feb 23 17:36:20 volumio volumio[2064]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 17:36:20 volumio volumio[2064]: Cannot find translation for source LastFM Feb 23 17:36:20 volumio volumio[2064]: Cannot find translation for source Spotify Feb 23 17:36:22 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8. Feb 23 17:36:22 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:22 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:22 volumio upmpdcli[2416]: Could not open config: /tmp/upmpdcli.conf Feb 23 17:36:22 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 17:36:22 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 17:36:22 volumio volumio[2064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Feb 23 17:36:22 volumio volumio[2064]: SPOTIFY: SPOTIFY VOLUME 100 Feb 23 17:36:22 volumio volumio[2064]: SPOTIFY: VOLUMIO VOLUME 79 Feb 23 17:36:22 volumio volumio[2064]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 23 17:36:22 volumio volumio[2064]: info: Setting Spotify Volume from Volumio: 79 Feb 23 17:36:22 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:23 volumio go-librespot[2237]: time="2026-02-23T17:36:23+01:00" level=trace msg="sent dealer ping" Feb 23 17:36:23 volumio go-librespot[2237]: time="2026-02-23T17:36:23+01:00" level=trace msg="received dealer pong" Feb 23 17:36:25 volumio volumio[2064]: SPOTIFY: SETTING SPOTIFY VOLUME 79 Feb 23 17:36:25 volumio volumio[2064]: info: Sending Spotify command with payload to local API: /player/volume Feb 23 17:36:26 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:26 volumio go-librespot[2237]: time="2026-02-23T17:36:26+01:00" level=debug msg="update volume requested to 51772/65535" Feb 23 17:36:27 volumio go-librespot[2237]: time="2026-02-23T17:36:27+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 23 17:36:27 volumio go-librespot[2237]: time="2026-02-23T17:36:27+01:00" level=trace msg="emitting websocket event: volume" Feb 23 17:36:30 volumio volumio[2064]: SPOTIFY: received: {"type":"volume","data":{"value":79,"max":100}} Feb 23 17:36:30 volumio volumio[2064]: SPOTIFY: RECEIVED SPOTIFY VOLUME 79 Feb 23 17:36:30 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:33 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:36 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:37 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 9. Feb 23 17:36:37 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:37 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:37 volumio upmpdcli[2446]: Could not open config: /tmp/upmpdcli.conf Feb 23 17:36:37 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 17:36:37 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 17:36:40 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:41 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 23 17:36:43 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 23 17:36:45 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 10 Feb 23 17:36:52 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:52 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10. Feb 23 17:36:52 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:52 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:36:52 volumio upmpdcli[2491]: Could not open config: /tmp/upmpdcli.conf Feb 23 17:36:52 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 17:36:52 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 17:36:53 volumio go-librespot[2237]: time="2026-02-23T17:36:53+01:00" level=trace msg="sent dealer ping" Feb 23 17:36:53 volumio go-librespot[2237]: time="2026-02-23T17:36:53+01:00" level=trace msg="received dealer pong" Feb 23 17:36:58 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:36:59 volumio volumio[2064]: info: CoreCommandRouter::volumioGetState Feb 23 17:36:59 volumio volumio[2064]: info: CorePlayQueue::getTrack 0 Feb 23 17:37:03 volumio volumio[2064]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Feb 23 17:37:03 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:37:07 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:37:07 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 11. Feb 23 17:37:07 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:37:07 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 17:37:07 volumio upmpdcli[2521]: Could not open config: /tmp/upmpdcli.conf Feb 23 17:37:07 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 17:37:07 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 17:37:11 volumio volumio[2064]: Cannot compose Albumart path Feb 23 17:37:12 volumio volumio[2064]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 23 17:37:12 volumio volumio[2064]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 17:37:12 volumio volumio[2064]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Feb 23 17:37:12 volumio volumio[2064]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Feb 23 17:37:12 volumio volumio[2064]: at new NodeError (node:internal/errors:405:5) Feb 23 17:37:12 volumio volumio[2064]: at assert (node:internal/assert:14:11) Feb 23 17:37:12 volumio volumio[2064]: at internalConnectMultiple (node:net:1118:3) Feb 23 17:37:12 volumio volumio[2064]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Feb 23 17:37:12 volumio volumio[2064]: at listOnTimeout (node:internal/timers:575:11) Feb 23 17:37:12 volumio volumio[2064]: at process.processTimers (node:internal/timers:514:7) { Feb 23 17:37:12 volumio volumio[2064]: code: 'ERR_INTERNAL_ASSERTION' Feb 23 17:37:12 volumio volumio[2064]: } Feb 23 17:37:12 volumio volumio[2064]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 17:37:12 volumio sudo[2554]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-23 17:36' Feb 23 17:37:12 volumio sudo[2554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"