Oct 13 12:46:41 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:46:41 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:46:46 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 13 12:46:46 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 13 12:46:57 volumio go-librespot[1816]: time="2026-10-13T12:46:57+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Oct 13 12:46:57 volumio volumio[1110]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Oct 13 12:46:57 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:46:57 volumio volumio[1110]: info: Disabling plugin spop Oct 13 12:46:57 volumio volumio[1110]: info: Done. Oct 13 12:46:57 volumio sudo[2638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop go-librespot-daemon.service Oct 13 12:46:57 volumio sudo[2638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:46:57 volumio volumio[1110]: info: Connection to go-librespot Websocket closed Oct 13 12:46:57 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Oct 13 12:46:57 volumio systemd[1]: go-librespot-daemon.service: Killing process 1821 (go-librespot) with signal SIGKILL. Oct 13 12:46:57 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Oct 13 12:46:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 13 12:46:57 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:46:57 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:46:57 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:46:57 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:46:57 volumio sudo[2638]: pam_unix(sudo:session): session closed for user root Oct 13 12:46:58 volumio volumio[1110]: info: Enabling plugin spop Oct 13 12:46:58 volumio volumio[1110]: info: Loading plugin "spop"... Oct 13 12:46:58 volumio volumio[1110]: info: PLUGIN START: spop Oct 13 12:46:58 volumio volumio[1110]: info: Creating Spotify config file Oct 13 12:46:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 12:46:58 volumio volumio[1110]: info: Done. Oct 13 12:46:58 volumio volumio[1110]: info: Spotify config file written Oct 13 12:46:58 volumio volumio[1110]: info: No need to fix Spotify hosts Oct 13 12:46:58 volumio sudo[2657]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 13 12:46:58 volumio sudo[2657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:46:58 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:46:58 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:46:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 13 12:46:58 volumio sudo[2657]: pam_unix(sudo:session): session closed for user root Oct 13 12:46:58 volumio go-librespot[2659]: go-librespot daemon starting... Oct 13 12:46:58 volumio go-librespot[2660]: time="2026-10-13T12:46:58+02:00" level=info msg="running go-librespot 0.9.1" Oct 13 12:46:58 volumio go-librespot[2660]: time="2026-10-13T12:46:58+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 13 12:46:58 volumio go-librespot[2660]: time="2026-10-13T12:46:58+02:00" level=debug msg="app state loaded" Oct 13 12:46:58 volumio volumio[1110]: info: New Spotify access tokenBQDpD0qh_6... Oct 13 12:46:58 volumio volumio[1110]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 13 12:46:59 volumio volumio[1110]: SPOTIFY: User informations: {"account_id":"zbUqG2M0K6","country":"IT","display_name":"Alessio Zardoni","email":"alessiozardoni@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31dditmar4osk4t7wtd6rahsjxpq"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31dditmar4osk4t7wtd6rahsjxpq","id":"31dditmar4osk4t7wtd6rahsjxpq","images":[],"product":"premium","type":"user","uri":"spotify:user:31dditmar4osk4t7wtd6rahsjxpq"} Oct 13 12:46:59 volumio volumio[1110]: info: Spotify Successfully logged in Oct 13 12:46:59 volumio volumio[1110]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 12:46:59 volumio volumio[1110]: info: [1791888419089] CoreMusicLibrary::Adding element Spotify Oct 13 12:46:59 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=info msg="zeroconf server listening on port 39743" Oct 13 12:46:59 volumio volumio[1110]: Cannot find translation for source Spotify Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=info msg="loading previously persisted zeroconf credentials" username="31************************pq" Oct 13 12:46:59 volumio volumio[1110]: info: pi_screen_setup: Stopping plugin Oct 13 12:46:59 volumio volumio[1110]: info: pi_screen_setup: Management server stopped Oct 13 12:46:59 volumio volumio[1110]: info: Disabling plugin pi_screen_setup Oct 13 12:46:59 volumio volumio[1110]: info: Done. Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=debug msg="obtained new client token: AAG8BEy/VnH+E/HCrGvuWRGtAaCDZUmpjHdMFIs5vqEjdsKvur2JwZL6O3Zj+Q/zWNJuGJGqenDqK1Z1DdQntx/UpjD7JYmaApZocifN9zKwQhiEpbparyNG4qYa6kdbQIfoMVb8Y/3rgGARDs0SUQb6iizg4h5Q5iB4qdICQDX00PDsfXeWrrT8Cd0z3UwWsZRPHNpHT1MzxMqiqZ09e03PU/jMMPxjSvQpxWsHY5aF8t31VhxN8NgG" Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=debug msg="avahi service \"Volumio\" established" Oct 13 12:46:59 volumio go-librespot[2660]: time="2026-10-13T12:46:59+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="completed keyexchange" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="completed challenge" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=info msg="authenticated AP" username="31************************pq" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=info msg="authenticated Login5" username="31************************pq" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="initializing zeroconf session" username="31************************pq" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="connected to gew4-dealer.spotify.com:443" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=trace msg="starting accesspoint recv loop" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=trace msg="starting dealer recv loop" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 13 12:47:00 volumio go-librespot[2660]: time="2026-10-13T12:47:00+02:00" level=debug msg="received connection id: ZmU5NjBmN2EtYzVi...NzA5QzMzNzk5QQ==" Oct 13 12:47:01 volumio volumio[1110]: info: OLED: Plugin stopped Oct 13 12:47:01 volumio volumio[1110]: info: Disabling plugin oled_display_ssd1309 Oct 13 12:47:01 volumio volumio[1110]: info: Done. Oct 13 12:47:01 volumio volumio[1110]: info: go-librespot daemon successfully initialized Oct 13 12:47:01 volumio go-librespot[2660]: time="2026-10-13T12:47:01+02:00" level=debug msg="put connect state because NEW_DEVICE" Oct 13 12:47:01 volumio go-librespot[2660]: time="2026-10-13T12:47:01+02:00" level=trace msg="emitting websocket event: playback_ready" Oct 13 12:47:01 volumio go-librespot[2660]: time="2026-10-13T12:47:01+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 13 12:47:01 volumio go-librespot[2660]: time="2026-10-13T12:47:01+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 13 12:47:01 volumio go-librespot[2660]: time="2026-10-13T12:47:01+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Oct 13 12:47:02 volumio sudo[2675]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 13 12:47:02 volumio sudo[2675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:47:02 volumio sudo[2677]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Oct 13 12:47:02 volumio sudo[2677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:47:02 volumio sudo[2679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Oct 13 12:47:02 volumio sudo[2675]: pam_unix(sudo:session): session closed for user root Oct 13 12:47:02 volumio sudo[2679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:47:02 volumio volumio[1110]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Oct 13 12:47:02 volumio sudo[2682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Oct 13 12:47:02 volumio volumio[1110]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:47:02 volumio sudo[2682]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:47:02 volumio volumio[1110]: TypeError: Cannot read properties of undefined (reading 'split') Oct 13 12:47:02 volumio volumio[1110]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Oct 13 12:47:02 volumio volumio[1110]: at ChildProcess.exithandler (node:child_process:413:7) Oct 13 12:47:02 volumio volumio[1110]: at ChildProcess.emit (node:events:514:28) Oct 13 12:47:02 volumio volumio[1110]: at maybeClose (node:internal/child_process:1105:16) Oct 13 12:47:02 volumio volumio[1110]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Oct 13 12:47:02 volumio volumio[1110]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 12:47:02 volumio systemd[1]: Reloading. Oct 13 12:47:04 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:47:04 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 13 12:47:04 volumio sudo[2720]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-13 12:46' Oct 13 12:47:04 volumio sudo[2720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 13 12:47:04 volumio sudo[2679]: pam_unix(sudo:session): session closed for user root Oct 13 12:47:04 volumio systemd[1]: Created slice system-getty.slice - Slice /system/getty. PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"