Apr 12 23:14:05 music volumio[1265]: [YOUTUBEJS][Player]: Failed to extract signature decipher function. Apr 12 23:14:05 music volumio[1265]: [YOUTUBEJS][Player]: Failed to extract n decipher function. Apr 12 23:14:05 music volumio[1265]: info: Initializing connection to go-librespot Websocket Apr 12 23:14:05 music volumio[1265]: info: Connection to go-librespot Websocket established Apr 12 23:14:05 music go-librespot[10744]: time="2026-04-12T23:14:05+07:00" level=debug msg="new websocket client" Apr 12 23:14:07 music volumio[1265]: info: [ytmusic] Obtained session PO token using visitorData (expires in 43199 seconds) Apr 12 23:14:12 music volumio[1265]: [YOUTUBEJS][Player]: Failed to extract signature decipher function. Apr 12 23:14:12 music volumio[1265]: [YOUTUBEJS][Player]: Failed to extract n decipher function. Apr 12 23:14:12 music volumio[1265]: info: [ytmusic] Going to refresh session PO token in 43099 seconds Apr 12 23:14:12 music volumio[1265]: info: Getting Spotify volume Apr 12 23:14:12 music volumio[1265]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Apr 12 23:14:12 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:14:12 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:37 music volumio[1265]: info: Received OAUTH Data Apr 12 23:15:37 music volumio[1265]: info: Executing Spotify Oauth Login Apr 12 23:15:37 music volumio[1265]: info: Saving Spotify Refresh Token Apr 12 23:15:37 music kernel: pcieport 0000:00:1c.0: AER: Multiple Correctable error message received from 0000:01:00.0 Apr 12 23:15:37 music kernel: iwlwifi 0000:01:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID) Apr 12 23:15:37 music kernel: iwlwifi 0000:01:00.0: device [8086:08b1] error status/mask=00000001/00002000 Apr 12 23:15:37 music kernel: iwlwifi 0000:01:00.0: [ 0] RxErr Apr 12 23:15:37 music volumio[1265]: info: New Spotify access tokenBQAovIC-BO... Apr 12 23:15:37 music volumio[1265]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 12 23:15:37 music sudo[11016]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 12 23:15:37 music sudo[11016]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 23:15:37 music sudo[11016]: pam_unix(sudo:session): session closed for user root Apr 12 23:15:37 music sudo[11018]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 12 23:15:37 music sudo[11018]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 23:15:37 music sudo[11018]: pam_unix(sudo:session): session closed for user root Apr 12 23:15:37 music volumio[1265]: SPOTIFY: User informations: {"country":"AR","display_name":"TIDAL Long","email":"longtidal1988@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31zua3ug3uxsvuqkacc2spxzuabm"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31zua3ug3uxsvuqkacc2spxzuabm","id":"31zua3ug3uxsvuqkacc2spxzuabm","images":[],"product":"free","type":"user","uri":"spotify:user:31zua3ug3uxsvuqkacc2spxzuabm"} Apr 12 23:15:37 music volumio[1265]: info: Creating Spotify config file Apr 12 23:15:37 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 23:15:37 music volumio[1265]: verbose: New Socket.io Connection to 192.168.50.91 from 192.168.50.48 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Apr 12 23:15:37 music volumio[1265]: info: Spotify config file written Apr 12 23:15:38 music sudo[11025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 12 23:15:38 music sudo[11025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 23:15:38 music systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Apr 12 23:15:38 music systemd[1]: go-librespot-daemon.service: Deactivated successfully. Apr 12 23:15:38 music systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 12 23:15:38 music volumio[1265]: info: Connection to go-librespot Websocket closed Apr 12 23:15:38 music systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 12 23:15:38 music go-librespot[11029]: go-librespot daemon starting... Apr 12 23:15:38 music sudo[11025]: pam_unix(sudo:session): session closed for user root Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=info msg="running go-librespot 0.7.1" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=debug msg="app state loaded" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=debug msg="stored credentials not found" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 12 23:15:38 music volumio[1265]: info: New Spotify access tokenBQCxuO0yHE... Apr 12 23:15:38 music volumio[1265]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=info msg="zeroconf server listening on port 43637" Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::volumioGetVisibleSources Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:15:38 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 12 23:15:38 music volumio[1265]: info: Received Get System Info Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 23:15:38 music volumio[1265]: info: Discovery: Getting this device information Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:15:38 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:15:38 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:38 music volumio[1265]: info: Listing playlists Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 12 23:15:38 music go-librespot[11032]: time="2026-04-12T23:15:38+07:00" level=debug msg="obtained new client token: AACUxc1DlAUbczlrrgcaiAoHvwBXxRbMfAbQ7v/CWWrHqTDiO2G+MO0Ub1oDAHozxxo5HAORsXeREZga2T3fIGuJIMWeu3tsGLG61jTljKyFi/iDnrX2iphb0LVplRaQDcXRqeFNvLm6gqolFMQuiofH5lxyHiD8DMl8hsNbY7UelLPBY7PEWnRvR5PKUNPdlkXW8NPqGj3UM8OKFf+1fpC0g57CUnJ16poEPmouBD2oy5qpblWZtya0" Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 12 23:15:38 music volumio[1265]: SPOTIFY: User informations: {"country":"AR","display_name":"TIDAL Long","email":"longtidal1988@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31zua3ug3uxsvuqkacc2spxzuabm"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31zua3ug3uxsvuqkacc2spxzuabm","id":"31zua3ug3uxsvuqkacc2spxzuabm","images":[],"product":"free","type":"user","uri":"spotify:user:31zua3ug3uxsvuqkacc2spxzuabm"} Apr 12 23:15:38 music volumio[1265]: info: Spotify Successfully logged in Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 12 23:15:38 music volumio[1265]: info: [1776010538778] CoreMusicLibrary::Adding element Spotify Apr 12 23:15:38 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 23:15:38 music volumio[1265]: Cannot find translation for source YouTube Music Apr 12 23:15:38 music volumio[1265]: Cannot find translation for source Spotify Apr 12 23:15:39 music go-librespot[11032]: time="2026-04-12T23:15:39+07:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 12 23:15:39 music go-librespot[11032]: time="2026-04-12T23:15:39+07:00" level=debug msg="completed keyexchange" Apr 12 23:15:39 music go-librespot[11032]: time="2026-04-12T23:15:39+07:00" level=debug msg="completed challenge" Apr 12 23:15:39 music go-librespot[11032]: time="2026-04-12T23:15:39+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:39 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 23:15:39 music volumio[1265]: info: Received Get System Info Apr 12 23:15:39 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 23:15:39 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 23:15:39 music volumio[1265]: info: Discovery: Getting this device information Apr 12 23:15:39 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:15:39 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:39 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 23:15:39 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 23:15:40 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 12 23:15:40 music go-librespot[11032]: time="2026-04-12T23:15:40+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Apr 12 23:15:40 music go-librespot[11032]: time="2026-04-12T23:15:40+07:00" level=debug msg="completed keyexchange" Apr 12 23:15:40 music go-librespot[11032]: time="2026-04-12T23:15:40+07:00" level=debug msg="completed challenge" Apr 12 23:15:40 music go-librespot[11032]: time="2026-04-12T23:15:40+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:41 music volumio[1265]: info: Initializing connection to go-librespot Websocket Apr 12 23:15:41 music go-librespot[11032]: time="2026-04-12T23:15:41+07:00" level=debug msg="new websocket client" Apr 12 23:15:41 music volumio[1265]: info: Connection to go-librespot Websocket established Apr 12 23:15:41 music volumio[1265]: info: go-librespot daemon successfully initialized Apr 12 23:15:41 music go-librespot[11032]: time="2026-04-12T23:15:41+07:00" level=debug msg="connected to ap-gae2.spotify.com:80" Apr 12 23:15:41 music go-librespot[11032]: time="2026-04-12T23:15:41+07:00" level=debug msg="completed keyexchange" Apr 12 23:15:41 music go-librespot[11032]: time="2026-04-12T23:15:41+07:00" level=debug msg="completed challenge" Apr 12 23:15:41 music go-librespot[11032]: time="2026-04-12T23:15:41+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:43 music go-librespot[11032]: time="2026-04-12T23:15:43+07:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Apr 12 23:15:43 music go-librespot[11032]: time="2026-04-12T23:15:43+07:00" level=debug msg="completed keyexchange" Apr 12 23:15:43 music go-librespot[11032]: time="2026-04-12T23:15:43+07:00" level=debug msg="completed challenge" Apr 12 23:15:43 music go-librespot[11032]: time="2026-04-12T23:15:43+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:44 music volumio[1265]: info: Getting Spotify volume Apr 12 23:15:44 music volumio[1265]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Apr 12 23:15:44 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:15:44 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:44 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 23:15:44 music volumio[1265]: info: Received Get System Info Apr 12 23:15:44 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 23:15:44 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 23:15:44 music volumio[1265]: info: Discovery: Getting this device information Apr 12 23:15:44 music volumio[1265]: info: CoreCommandRouter::volumioGetState Apr 12 23:15:44 music volumio[1265]: info: CorePlayQueue::getTrack 26 Apr 12 23:15:44 music volumio[1265]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 23:15:44 music volumio[1265]: info: Initializing connection to go-librespot Websocket Apr 12 23:15:44 music go-librespot[11032]: time="2026-04-12T23:15:44+07:00" level=debug msg="new websocket client" Apr 12 23:15:44 music volumio[1265]: info: Connection to go-librespot Websocket established Apr 12 23:15:44 music go-librespot[11032]: time="2026-04-12T23:15:44+07:00" level=debug msg="connected to ap-gew1.spotify.com:443" Apr 12 23:15:45 music go-librespot[11032]: time="2026-04-12T23:15:45+07:00" level=debug msg="completed keyexchange" Apr 12 23:15:45 music go-librespot[11032]: time="2026-04-12T23:15:45+07:00" level=debug msg="completed challenge" Apr 12 23:15:45 music go-librespot[11032]: time="2026-04-12T23:15:45+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:46 music go-librespot[11032]: time="2026-04-12T23:15:46+07:00" level=debug msg="connected to ap-gew4.spotify.com:80" Apr 12 23:15:46 music go-librespot[11032]: time="2026-04-12T23:15:46+07:00" level=debug msg="completed keyexchange" Apr 12 23:15:46 music go-librespot[11032]: time="2026-04-12T23:15:46+07:00" level=debug msg="completed challenge" Apr 12 23:15:47 music go-librespot[11032]: time="2026-04-12T23:15:47+07:00" level=warning msg="failed connecting to accesspoint, retrying" error="failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:47 music go-librespot[11032]: time="2026-04-12T23:15:47+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: TravelRestriction " Apr 12 23:15:47 music systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 12 23:15:47 music systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 12 23:15:47 music volumio[1265]: info: Connection to go-librespot Websocket closed Apr 12 23:15:47 music volumio[1265]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 23:15:47 music volumio[1265]: Error: socket hang up Apr 12 23:15:47 music volumio[1265]: at connResetException (node:internal/errors:720:14) Apr 12 23:15:47 music volumio[1265]: at Socket.socketOnEnd (node:_http_client:519:23) Apr 12 23:15:47 music volumio[1265]: at Socket.emit (node:events:526:35) Apr 12 23:15:47 music volumio[1265]: at endReadableNT (node:internal/streams/readable:1376:12) Apr 12 23:15:47 music volumio[1265]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Apr 12 23:15:47 music volumio[1265]: code: 'ECONNRESET', Apr 12 23:15:47 music volumio[1265]: response: undefined Apr 12 23:15:47 music volumio[1265]: } Apr 12 23:15:47 music volumio[1265]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 23:15:47 music sudo[11078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-12 23:14' Apr 12 23:15:47 music sudo[11078]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"