Oct 31 01:16:02 perivolumio volumio[1158]: info: Checking if install.sh is present Oct 31 01:16:02 perivolumio volumio[1158]: info: Executing install.sh Oct 31 01:16:02 perivolumio sudo[4664]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/youtube2/install.sh Oct 31 01:16:02 perivolumio sudo[4664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 31 01:16:02 perivolumio sudo[4664]: pam_unix(sudo:session): session closed for user root Oct 31 01:16:02 perivolumio volumio[1158]: info: Install script completed Oct 31 01:16:02 perivolumio volumio[1158]: info: Adding reference to registry Oct 31 01:16:02 perivolumio volumio[1158]: info: Done installing plugin. Oct 31 01:16:02 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:16:02 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:16:02 perivolumio volumio[1158]: info: YouTube2 plugin installed Oct 31 01:16:02 perivolumio volumio[1158]: Plugin install end detected on script Oct 31 01:16:02 perivolumio volumio[1158]: info: Folder /tmp/plugins removed Oct 31 01:16:02 perivolumio volumio[1158]: info: Folder /tmp/downloaded_plugin.zip removed Oct 31 01:16:02 perivolumio volumio[1158]: info: Folder /data/temp removed Oct 31 01:16:04 perivolumio volumio[1158]: info: Enabling plugin youtube2 Oct 31 01:16:04 perivolumio volumio[1158]: info: Loading plugin "youtube2"... Oct 31 01:16:05 perivolumio volumio[1158]: info: PLUGIN START: youtube2 Oct 31 01:16:05 perivolumio volumio[1158]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 31 01:16:05 perivolumio volumio[1158]: info: [1761887765933] CoreMusicLibrary::Adding element YouTube2 Oct 31 01:16:05 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 01:16:05 perivolumio volumio[1158]: Cannot find translation for source YouTube Music Oct 31 01:16:05 perivolumio volumio[1158]: Cannot find translation for source YouTube2 Oct 31 01:16:05 perivolumio volumio[1158]: info: Done. Oct 31 01:16:08 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:08 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:09 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:16:09 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:16:12 perivolumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 01:16:13 perivolumio volumio[1158]: info: CALLMETHOD: user_interface Systeminfo getsysteminfo undefined Oct 31 01:16:13 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , getsysteminfo Oct 31 01:16:13 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 31 01:16:13 perivolumio dbus-daemon[654]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.41' (uid=1000 pid=4718 comm="hostnamectl --json short") Oct 31 01:16:13 perivolumio systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Oct 31 01:16:14 perivolumio dbus-daemon[654]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 31 01:16:14 perivolumio systemd[1]: Started systemd-hostnamed.service - Hostname Service. Oct 31 01:16:14 perivolumio dbus-daemon[654]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.42' (uid=0 pid=4720 comm="/lib/systemd/systemd-hostnamed") Oct 31 01:16:14 perivolumio systemd[1]: Starting polkit.service - Authorization Manager... Oct 31 01:16:14 perivolumio polkitd[4722]: Started polkitd version 122 Oct 31 01:16:14 perivolumio polkitd[4722]: Loading rules from directory /etc/polkit-1/rules.d Oct 31 01:16:14 perivolumio polkitd[4722]: Loading rules from directory /usr/share/polkit-1/rules.d Oct 31 01:16:14 perivolumio polkitd[4722]: Finished loading, compiling and executing 2 rules Oct 31 01:16:14 perivolumio dbus-daemon[654]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Oct 31 01:16:14 perivolumio systemd[1]: Started polkit.service - Authorization Manager. Oct 31 01:16:14 perivolumio polkitd[4722]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Oct 31 01:16:14 perivolumio dbus-daemon[654]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.42" (uid=0 pid=4720 comm="/lib/systemd/systemd-hostnamed") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.InteractiveAuthorizationRequired" requested_reply="0" destination=":1.41" (uid=1000 pid=4718 comm="hostnamectl --json short") Oct 31 01:16:15 perivolumio sudo[4922]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/vcgencmd bootloader_version Oct 31 01:16:15 perivolumio sudo[4922]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 31 01:16:15 perivolumio sudo[4922]: pam_unix(sudo:session): session closed for user root Oct 31 01:16:18 perivolumio sudo[5403]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 31 01:16:18 perivolumio sudo[5403]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 31 01:16:18 perivolumio sudo[5403]: pam_unix(sudo:session): session closed for user root Oct 31 01:16:23 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:16:23 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:16:27 perivolumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 01:16:32 perivolumio volumio[1158]: info: Received OAUTH Data Oct 31 01:16:32 perivolumio volumio[1158]: info: Executing Spotify Oauth Login Oct 31 01:16:32 perivolumio volumio[1158]: info: Saving Spotify Refresh Token Oct 31 01:16:32 perivolumio sudo[5442]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 31 01:16:32 perivolumio sudo[5442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 31 01:16:32 perivolumio sudo[5442]: pam_unix(sudo:session): session closed for user root Oct 31 01:16:32 perivolumio sudo[5444]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 31 01:16:32 perivolumio sudo[5444]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 31 01:16:32 perivolumio sudo[5444]: pam_unix(sudo:session): session closed for user root Oct 31 01:16:32 perivolumio volumio[1158]: verbose: New Socket.io Connection to 192.168.21.50 from 192.168.21.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 31 01:16:32 perivolumio volumio[1158]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 31 01:16:32 perivolumio volumio[1158]: SPOTIFY: BQBrnmIlzsvG_OKMHqR0_XINfgepGVmMdcjT-KjXC9fsCAUhLshs7PXA2Cuj5049febM_rPDI98L_sHOjXK5H05OtXglGaSAneSo7Kj-N3YKvhuZIY2h1wJbjVj-5r0ITMIGTs5O0gJkNgqyU_Eo5ZHJpFVKakxZlIJgRo2P4WlNHkVnrcYxuCKb5dkSBw1PDpKBa4vjUkk_yuGcMRR1-Gut7ROBsXCNNhpNkFIik6cPkr1GUcJ99I8m1lrHEXTAyEHinchOI7WTVBEVqjEf-rKsQ-15XutFEy_3ocJdtCHwIqWY5g0 Oct 31 01:16:32 perivolumio volumio[1158]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 31 01:16:32 perivolumio volumio[1158]: info: New Spotify access token = BQBrnmIlzsvG_OKMHqR0_XINfgepGVmMdcjT-KjXC9fsCAUhLshs7PXA2Cuj5049febM_rPDI98L_sHOjXK5H05OtXglGaSAneSo7Kj-N3YKvhuZIY2h1wJbjVj-5r0ITMIGTs5O0gJkNgqyU_Eo5ZHJpFVKakxZlIJgRo2P4WlNHkVnrcYxuCKb5dkSBw1PDpKBa4vjUkk_yuGcMRR1-Gut7ROBsXCNNhpNkFIik6cPkr1GUcJ99I8m1lrHEXTAyEHinchOI7WTVBEVqjEf-rKsQ-15XutFEy_3ocJdtCHwIqWY5g0 Oct 31 01:16:32 perivolumio volumio[1158]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetVisibleSources Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:32 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 31 01:16:32 perivolumio volumio[1158]: info: Received Get System Info Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 01:16:32 perivolumio volumio[1158]: info: Discovery: Getting this device information Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:32 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:32 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:32 perivolumio volumio[1158]: info: Listing playlists Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 31 01:16:32 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 31 01:16:33 perivolumio volumio[1158]: SPOTIFY: User informations: {"country":"GR","display_name":"gp","email":"gpericleous89@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31bhh6qi5eul3xth3vtjfznaxns4"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31bhh6qi5eul3xth3vtjfznaxns4","id":"31bhh6qi5eul3xth3vtjfznaxns4","images":[],"product":"free","type":"user","uri":"spotify:user:31bhh6qi5eul3xth3vtjfznaxns4"} Oct 31 01:16:33 perivolumio volumio[1158]: info: Creating Spotify config file Oct 31 01:16:33 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 01:16:33 perivolumio volumio[1158]: info: Spotify config file written Oct 31 01:16:33 perivolumio sudo[5449]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 31 01:16:33 perivolumio sudo[5449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 31 01:16:33 perivolumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Oct 31 01:16:33 perivolumio systemd[1]: go-librespot-daemon.service: Killing process 4469 (go-librespot) with signal SIGKILL. Oct 31 01:16:33 perivolumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Oct 31 01:16:33 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:33 perivolumio volumio[1158]: info: Connection to go-librespot Websocket closed Oct 31 01:16:33 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:33 perivolumio sudo[5449]: pam_unix(sudo:session): session closed for user root Oct 31 01:16:33 perivolumio go-librespot[5451]: go-librespot daemon starting... Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="app state loaded" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:33 perivolumio volumio[1158]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 31 01:16:33 perivolumio volumio[1158]: SPOTIFY: BQB21g1cp0DINaR4kougL-dDa1Ms4lE1fTlQquPm5JYhDyOAlditDtjBOJWCgvVnVIBF2wjF26QSjwxG2azcx9Nc5mAtwVvFX9s2Xb5cnhlkp7fsU6I9rmnAa_O1Z2RZKL80lHisMY2zgZ5_kgtdlCobrdZJfZmZ1P47ZkX2CirR0KDymmAmOT4WWLY3cGLPdPjbj4LnEW_gapbl_9Cd9bP_gRUs1LXtHhPgMPOqEigWSbG80pjozOrAPFwghyeOWlsxtXKc1eIavla7_EtZN4cFc3nwRHZz_Lgk36HM05OIievszu8 Oct 31 01:16:33 perivolumio volumio[1158]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 31 01:16:33 perivolumio volumio[1158]: info: New Spotify access token = BQB21g1cp0DINaR4kougL-dDa1Ms4lE1fTlQquPm5JYhDyOAlditDtjBOJWCgvVnVIBF2wjF26QSjwxG2azcx9Nc5mAtwVvFX9s2Xb5cnhlkp7fsU6I9rmnAa_O1Z2RZKL80lHisMY2zgZ5_kgtdlCobrdZJfZmZ1P47ZkX2CirR0KDymmAmOT4WWLY3cGLPdPjbj4LnEW_gapbl_9Cd9bP_gRUs1LXtHhPgMPOqEigWSbG80pjozOrAPFwghyeOWlsxtXKc1eIavla7_EtZN4cFc3nwRHZz_Lgk36HM05OIievszu8 Oct 31 01:16:33 perivolumio volumio[1158]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=info msg="zeroconf server listening on port 36875" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="obtained new client token: AAABZGWIySJMLsV4YLR3kQzNJ+pVL0hppNs6IMn5b1gCXDIdt5x4a2NIisMberM9aJ1SlOyZjcfThgAyvCjKJBdqhKD6LQsnimCbjBhi2hMQ6VzEsDQ79HfQFK4Xv8+mt3IMbnKjATssUCMYJvfVYg7SRGkvzK2MKE7KvK2qxJeKZbhOKgIvac32oaYuSCtjzVjBYPMVdKjibDrfz051WQpDT4egaeI5GDLio6uE71QgoO62U3CWQH9zuQ==" Oct 31 01:16:33 perivolumio volumio[1158]: SPOTIFY: User informations: {"country":"GR","display_name":"gp","email":"gpericleous89@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31bhh6qi5eul3xth3vtjfznaxns4"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31bhh6qi5eul3xth3vtjfznaxns4","id":"31bhh6qi5eul3xth3vtjfznaxns4","images":[],"product":"free","type":"user","uri":"spotify:user:31bhh6qi5eul3xth3vtjfznaxns4"} Oct 31 01:16:33 perivolumio volumio[1158]: info: Spotify Successfully logged in Oct 31 01:16:33 perivolumio volumio[1158]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 31 01:16:33 perivolumio volumio[1158]: info: [1761887793534] CoreMusicLibrary::Adding element Spotify Oct 31 01:16:33 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 01:16:33 perivolumio volumio[1158]: Cannot find translation for source YouTube Music Oct 31 01:16:33 perivolumio volumio[1158]: Cannot find translation for source YouTube2 Oct 31 01:16:33 perivolumio volumio[1158]: Cannot find translation for source Spotify Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04:00" level=debug msg="completed challenge" Oct 31 01:16:33 perivolumio go-librespot[5452]: time="2025-10-31T01:16:33-04: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 " Oct 31 01:16:33 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:33 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:34 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 31 01:16:34 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:16:34 perivolumio volumio[1158]: info: Received Get System Info Oct 31 01:16:34 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 01:16:34 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 01:16:34 perivolumio volumio[1158]: info: Discovery: Getting this device information Oct 31 01:16:34 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:34 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:34 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 01:16:35 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:16:35 perivolumio volumio[1158]: info: Received Get System Info Oct 31 01:16:35 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 01:16:35 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 01:16:35 perivolumio volumio[1158]: info: Discovery: Getting this device information Oct 31 01:16:35 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:35 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:35 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 01:16:36 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:36 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:36 perivolumio volumio[1158]: info: go-librespot daemon successfully initialized Oct 31 01:16:36 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:36 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:36 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Oct 31 01:16:36 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:36 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:36 perivolumio go-librespot[5460]: go-librespot daemon starting... Oct 31 01:16:36 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetQueue Oct 31 01:16:36 perivolumio volumio[1158]: info: CoreStateMachine::getQueue Oct 31 01:16:36 perivolumio volumio[1158]: info: CorePlayQueue::getQueue Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=debug msg="app state loaded" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:36 perivolumio go-librespot[5461]: time="2025-10-31T01:16:36-04:00" level=info msg="zeroconf server listening on port 36547" Oct 31 01:16:37 perivolumio go-librespot[5461]: time="2025-10-31T01:16:37-04:00" level=debug msg="obtained new client token: AAAlRmaDwX++EjDyBHEFasO8rzUgFDfoIcPjADR57m7UOhw7CH6Zrjj65dWcPEU4tWLjuX5TWMaUa/yfO3R6dwdGTm7tJdyBU3UpMUbnFJKXleSmMR0akDn+Ub/5KOZMekwQrnopzi0osYUmsP9/G77v5JsJzUbmhmvQTqEPishxE4pYd3prmQzpRUeTFZ50pRxu3UQC73/Ais8XroCfGQUTrs/kwnLgTNrCpYA1hHfeDazJgOVH/p8=" Oct 31 01:16:37 perivolumio go-librespot[5461]: time="2025-10-31T01:16:37-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:37 perivolumio go-librespot[5461]: time="2025-10-31T01:16:37-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:37 perivolumio go-librespot[5461]: time="2025-10-31T01:16:37-04:00" level=debug msg="completed challenge" Oct 31 01:16:37 perivolumio go-librespot[5461]: time="2025-10-31T01:16:37-04: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 " Oct 31 01:16:37 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:37 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:38 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:38 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify Oct 31 01:16:38 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:38 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:38 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:38 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:39 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:39 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:39 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:39 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:40 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Oct 31 01:16:40 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:40 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:40 perivolumio go-librespot[5468]: go-librespot daemon starting... Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="app state loaded" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=info msg="zeroconf server listening on port 33723" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="obtained new client token: AADhz2gxfIK8lH9htyR1bEx3ulUqlcD/dj5XffMZ1tGI33c2XN+kd6ONi8L+zuJh+vu+XODDMeJ6Sjv005rNd8oHAhMYMwcOuwrUj4b2eqLsu7UWfig3K8W8pBME/PMZs/aHYy8mNc1Aa02Azoq5MbNbe1Z3CJr0pQfMJvDaZxftQx+W5NrsNQPRj24oGtF8M8EDZ8U6cHVr+97wh3L1ECRmNIoKHR5goXvDdKkhBqazWGFX0WVAebfjLQ==" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04:00" level=debug msg="completed challenge" Oct 31 01:16:40 perivolumio go-librespot[5469]: time="2025-10-31T01:16:40-04: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 " Oct 31 01:16:40 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:40 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:40 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:40 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify/mytracks Oct 31 01:16:40 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:42 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:42 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:42 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 31 01:16:43 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Oct 31 01:16:43 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:43 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:43 perivolumio go-librespot[5490]: go-librespot daemon starting... Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=debug msg="app state loaded" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:43 perivolumio go-librespot[5491]: time="2025-10-31T01:16:43-04:00" level=info msg="zeroconf server listening on port 43683" Oct 31 01:16:44 perivolumio go-librespot[5491]: time="2025-10-31T01:16:44-04:00" level=debug msg="obtained new client token: AAByhgqdnOLLA2BtQKgfRjyqsFbp0eOzlKnBSB4rHzQKdS4VRFnbjh8uawKY3CzhrM58H04GfXQzWGn3Ql/cIsdzVHji4VsDB6aEwhDs3djQxg43jLwtANRvPfnUizSZUqPBM2KmHpxbXyJXrSuM/fb9PUfNrynLyaT9h7pTce19TvxbHfbi43z5fLSLpGQJcZ4SysucjagyToLGAbRmRTKM7VEnvVQ672rbxJZ2G4CyccDfQUm5WhQ=" Oct 31 01:16:44 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:44 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify Oct 31 01:16:44 perivolumio go-librespot[5491]: time="2025-10-31T01:16:44-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:44 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:44 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:44 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:44 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:44 perivolumio go-librespot[5491]: time="2025-10-31T01:16:44-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:44 perivolumio go-librespot[5491]: time="2025-10-31T01:16:44-04:00" level=debug msg="completed challenge" Oct 31 01:16:44 perivolumio go-librespot[5491]: time="2025-10-31T01:16:44-04: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 " Oct 31 01:16:44 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:44 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:44 perivolumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 31 01:16:45 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:45 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:45 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:45 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify/mytracks Oct 31 01:16:45 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:45 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify/mytracks Oct 31 01:16:45 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:45 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:47 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Oct 31 01:16:47 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:47 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:47 perivolumio go-librespot[5501]: go-librespot daemon starting... Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="app state loaded" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=info msg="zeroconf server listening on port 44587" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="obtained new client token: AAD5ZPjtxBX9DkIuQAU26GonAMAqa62bxQun1kArI5NAKh9g455K0rA+TZqKREfPA8ixGY5hcgNoIWvw7zpbgt6MTtd+nvUzg8eKCHrPIj+uQ0QjQTXNoKsyD73WqyN+MWEvGTagG1cX9VPusWsqiP9sHSrf9r5XogRXMPJfLks4VtEuTfMlPD44c3kriGrpkhvbntbyRoex6s21Mc/h0MWaKvO/jE+rakHeiJQOvVn5SL8oms+FHC4t+w==" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04:00" level=debug msg="completed challenge" Oct 31 01:16:47 perivolumio go-librespot[5502]: time="2025-10-31T01:16:47-04: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 " Oct 31 01:16:47 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:47 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:48 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:48 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:49 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:49 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify Oct 31 01:16:49 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:49 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:49 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:49 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:50 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Oct 31 01:16:50 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:50 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:50 perivolumio go-librespot[5512]: go-librespot daemon starting... Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=debug msg="app state loaded" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Oct 31 01:16:50 perivolumio go-librespot[5513]: time="2025-10-31T01:16:50-04:00" level=info msg="zeroconf server listening on port 38229" Oct 31 01:16:51 perivolumio go-librespot[5513]: time="2025-10-31T01:16:51-04:00" level=debug msg="obtained new client token: AACAWCIYNDhIVZ7jjZSGtoZXX7eDY2kKd3F5kWxbz1ywzdIWfRYoglob/V5zDse2U5eOZCgd6rLEiFRDL2bK0O1UvPLLR771lLRcbRXm5aowYq74pEB9GbvLPz091F0bfMKR0Pzl4dh0HdvclfVJq+u4zwU1erI8zCw6tVcWJMH2KhUiAi3Pfg5U1lcvePob+i7k9nqI6Wppi3Shvw2XLiqBZcUM0k8DFLZ1FYoG69SV6tp2KnK08Do=" Oct 31 01:16:51 perivolumio go-librespot[5513]: time="2025-10-31T01:16:51-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:51 perivolumio go-librespot[5513]: time="2025-10-31T01:16:51-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:51 perivolumio go-librespot[5513]: time="2025-10-31T01:16:51-04:00" level=debug msg="completed challenge" Oct 31 01:16:51 perivolumio go-librespot[5513]: time="2025-10-31T01:16:51-04: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 " Oct 31 01:16:51 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:51 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 31 01:16:51 perivolumio volumio[1158]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 31 01:16:51 perivolumio volumio[1158]: info: Received Get System Version Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 31 01:16:51 perivolumio volumio[1158]: info: Received Get System Info Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 01:16:51 perivolumio volumio[1158]: info: Discovery: Getting this device information Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:16:51 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:16:51 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 01:16:51 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:51 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:54 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:54 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:54 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Oct 31 01:16:54 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:54 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:54 perivolumio go-librespot[5534]: go-librespot daemon starting... Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="app state loaded" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=info msg="zeroconf server listening on port 41139" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="obtained new client token: AADsFRj/vqYdEezCTIVOlfWSHZ7jO54ncVgkIbJu+zD6blTyIqCCAXPdQ5gqxDiiiHeIUjMW1kmhxelWGRwcftlCGi09aifk/8946hC1Giwh5CFxzWyBn9SS88zWCk5tr8CnuxIe+PJG8t1u8GXfstGN4lmNdHyAT0ZGPXsNmnJQzmVW+ppsG8fc+JJ0QAoNCRdu9Upt5melVz9sjsb5bFH+wG3OQu8nhon2cXZpWD/Y2tWokM0t/bMB/w==" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04:00" level=debug msg="completed challenge" Oct 31 01:16:54 perivolumio go-librespot[5535]: time="2025-10-31T01:16:54-04: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 " Oct 31 01:16:54 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:54 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:55 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:16:55 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify/myrecentlyplayedtracks Oct 31 01:16:55 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:6oZcg0MvysakiUd9K8Cfj7 Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:73KkjSWIXYCweCjnjHIGBl Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:7mVrOVStUbqrMVgfxHHyJ2 Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:77xmo79YlwVpuYZG7VZVhF Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:4ElkN0o2UP9K6ye2lAtSCd Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:5R5eEbO2oGSJ5BMqbqv7UZ Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:0KO2WxfCGp3Y41eMRr2e3f Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:3So0JoEUAUcWewZcZG2wcE Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:4pkKgY83MvNJLoWQFWOivp Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:0Q74tSUPiSTsu5njXulf0Y Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:2liSrnVctSNPOZfAtTtf2S Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:02gxn9kf40BQVpzooLRD5x Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:3OLsdfHZr1nNrIutlTNVEi Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:2LXYK0n0RQdSDkLy2db6sZ Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:2ALuT61frInq5wiOnjT8eS Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:1lgWEISNFOv8rTT9Usgzy5 Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:4guM5YkGo6Um7IySW2kSuo Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:519o4naClxo01L1PGu1DkZ Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:7hoUyw1aWIGHYVHCpKbm30 Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:3W58ZF3UECASzJRVUiH4eg Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:7mUaWsAkse2ctDjLJJZfPQ Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:6cvpSnBBkZCom6aSLQAeLt Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:7gJ8DmBCsOa98Q1xx2Akkb Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:5ZrlxLjcAN5u2b4DqIaSfQ Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:5bPiMLYazN46k4qEjRwzgY Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:4nbUUb3RG34Gd00KEMIAXN Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:3XPF6Dfeh5LTswnY9EIsUT Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:1272L5p2rlEuzzeiTpRqO0 Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:5BLqEfkX4LnyGadqzjh9ta Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:3I6kly2arBTCKFWcc1xmNp Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:6yX0hZ8nK7xc47hoT6yd4C Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:6hM19xXImAAjTJOiY4gg5O Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:61upcoWDQU5dndMvw4h4dq Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:5XjSXcPs4PuKlvr8WJePhP Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:7mEpb54mVcqg5rfceUTbCW Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:0TrdLXizsHDZBga13eB0nR Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:0TrdLXizsHDZBga13eB0nR Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:55W3uRbddGCIMKnLhyj6MU Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:4pvv31V54EtdqqV1liVDRF Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:5W5u3sSROl3tur2lVBWEVm Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:1Sdgqp34EFQqXyhQ90T9T0 Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:3e8dGS9EJMnsJu35h55Dxq Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:7jSiq9wgWfQ1Ow5KL6RuZS Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:4yeLrBWSXcFvRqhErm1UVr Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:2rBVlQd7e72PTIYnCGH6no Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:6qyjzj0mzdY8QEyRElCpjx Oct 31 01:16:55 perivolumio volumio[1158]: info: Preloading song: spotify:track:290zUPJlAxWRbvXrQyMIx6 Oct 31 01:16:55 perivolumio volumio[1158]: info: Exploding uri spotify:track:6oZcg0MvysakiUd9K8Cfj7 in service spop Oct 31 01:16:55 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:6oZcg0MvysakiUd9K8Cfj7 Oct 31 01:16:55 perivolumio volumio[1158]: info: Exploding uri spotify:track:73KkjSWIXYCweCjnjHIGBl in service spop Oct 31 01:16:55 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:73KkjSWIXYCweCjnjHIGBl Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:7mVrOVStUbqrMVgfxHHyJ2 in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:7mVrOVStUbqrMVgfxHHyJ2 Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6oZcg0MvysakiUd9K8Cfj7","service":"spop","name":"Dialogos - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":127,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:77xmo79YlwVpuYZG7VZVhF in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:77xmo79YlwVpuYZG7VZVhF Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:73KkjSWIXYCweCjnjHIGBl","service":"spop","name":"Leipsa Mou Xamogelases - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":207,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:4ElkN0o2UP9K6ye2lAtSCd in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:4ElkN0o2UP9K6ye2lAtSCd Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7mVrOVStUbqrMVgfxHHyJ2","service":"spop","name":"Nato Pali - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":111,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:5R5eEbO2oGSJ5BMqbqv7UZ in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:5R5eEbO2oGSJ5BMqbqv7UZ Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:77xmo79YlwVpuYZG7VZVhF","service":"spop","name":"Kyriaki Stin Eparchia - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":132,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:0KO2WxfCGp3Y41eMRr2e3f in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:0KO2WxfCGp3Y41eMRr2e3f Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:3So0JoEUAUcWewZcZG2wcE in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:3So0JoEUAUcWewZcZG2wcE Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:4pkKgY83MvNJLoWQFWOivp in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:4pkKgY83MvNJLoWQFWOivp Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5R5eEbO2oGSJ5BMqbqv7UZ","service":"spop","name":"Tora Pou Pantreuesai - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":136,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4ElkN0o2UP9K6ye2lAtSCd","service":"spop","name":"O Dromos - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":222,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0KO2WxfCGp3Y41eMRr2e3f","service":"spop","name":"To Pollaplo Sou Eidolo - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":215,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:0Q74tSUPiSTsu5njXulf0Y in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:0Q74tSUPiSTsu5njXulf0Y Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:2liSrnVctSNPOZfAtTtf2S in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:2liSrnVctSNPOZfAtTtf2S Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3So0JoEUAUcWewZcZG2wcE","service":"spop","name":"Heimerinoi Kolymvites - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":130,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4pkKgY83MvNJLoWQFWOivp","service":"spop","name":"Se Mia Ekklisia - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":137,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:02gxn9kf40BQVpzooLRD5x in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:02gxn9kf40BQVpzooLRD5x Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0Q74tSUPiSTsu5njXulf0Y","service":"spop","name":"Prosfygia - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":175,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:3OLsdfHZr1nNrIutlTNVEi in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:3OLsdfHZr1nNrIutlTNVEi Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2liSrnVctSNPOZfAtTtf2S","service":"spop","name":"Arzentina - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":85,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:2LXYK0n0RQdSDkLy2db6sZ in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:2LXYK0n0RQdSDkLy2db6sZ Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:02gxn9kf40BQVpzooLRD5x","service":"spop","name":"To Idio Kanei - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":89,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:2ALuT61frInq5wiOnjT8eS in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:2ALuT61frInq5wiOnjT8eS Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3OLsdfHZr1nNrIutlTNVEi","service":"spop","name":"Sto Pazari - Live","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":132,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:1lgWEISNFOv8rTT9Usgzy5 in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:1lgWEISNFOv8rTT9Usgzy5 Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:4guM5YkGo6Um7IySW2kSuo in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:4guM5YkGo6Um7IySW2kSuo Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2LXYK0n0RQdSDkLy2db6sZ","service":"spop","name":"O Dromos","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":198,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2ALuT61frInq5wiOnjT8eS","service":"spop","name":"To Pollaplo Sou Eidolo","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":199,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:519o4naClxo01L1PGu1DkZ in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:519o4naClxo01L1PGu1DkZ Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:7hoUyw1aWIGHYVHCpKbm30 in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:7hoUyw1aWIGHYVHCpKbm30 Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4guM5YkGo6Um7IySW2kSuo","service":"spop","name":"Sa Svoura","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":160,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:3W58ZF3UECASzJRVUiH4eg in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:3W58ZF3UECASzJRVUiH4eg Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:519o4naClxo01L1PGu1DkZ","service":"spop","name":"Kyriaki Stin Eparchia","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":168,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1lgWEISNFOv8rTT9Usgzy5","service":"spop","name":"Ston Eptalofo","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":131,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:7mUaWsAkse2ctDjLJJZfPQ in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:7mUaWsAkse2ctDjLJJZfPQ Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7hoUyw1aWIGHYVHCpKbm30","service":"spop","name":"Nato Pali","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":129,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:56 perivolumio volumio[1158]: info: Exploding uri spotify:track:6cvpSnBBkZCom6aSLQAeLt in service spop Oct 31 01:16:56 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:6cvpSnBBkZCom6aSLQAeLt Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3W58ZF3UECASzJRVUiH4eg","service":"spop","name":"Se Mia Ekklisia","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":139,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:7gJ8DmBCsOa98Q1xx2Akkb in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:7gJ8DmBCsOa98Q1xx2Akkb Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:5ZrlxLjcAN5u2b4DqIaSfQ in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:5ZrlxLjcAN5u2b4DqIaSfQ Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6cvpSnBBkZCom6aSLQAeLt","service":"spop","name":"Ekdromi","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":158,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7mUaWsAkse2ctDjLJJZfPQ","service":"spop","name":"Heimerinoi Kolymvites","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":151,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:5bPiMLYazN46k4qEjRwzgY in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:5bPiMLYazN46k4qEjRwzgY Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7gJ8DmBCsOa98Q1xx2Akkb","service":"spop","name":"Pseires","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":310,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:4nbUUb3RG34Gd00KEMIAXN in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:4nbUUb3RG34Gd00KEMIAXN Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5ZrlxLjcAN5u2b4DqIaSfQ","service":"spop","name":"Tora Pou Pantreuesai","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":139,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:3XPF6Dfeh5LTswnY9EIsUT in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:3XPF6Dfeh5LTswnY9EIsUT Oct 31 01:16:57 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:16:57 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5bPiMLYazN46k4qEjRwzgY","service":"spop","name":"Ston Pagasitiko","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":139,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:1272L5p2rlEuzzeiTpRqO0 in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:1272L5p2rlEuzzeiTpRqO0 Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4nbUUb3RG34Gd00KEMIAXN","service":"spop","name":"Arzentina","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":82,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:5BLqEfkX4LnyGadqzjh9ta in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:5BLqEfkX4LnyGadqzjh9ta Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:3I6kly2arBTCKFWcc1xmNp in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:3I6kly2arBTCKFWcc1xmNp Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3XPF6Dfeh5LTswnY9EIsUT","service":"spop","name":"Romylia","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":231,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1272L5p2rlEuzzeiTpRqO0","service":"spop","name":"Prosfygia","artist":"Heimerinoi Kolymvites","album":"Heimerinoi Kolymvites","type":"song","duration":183,"albumart":"https://i.scdn.co/image/ab67616d0000b273e95c45a8bc137f454b2bcb83","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:6yX0hZ8nK7xc47hoT6yd4C in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:6yX0hZ8nK7xc47hoT6yd4C Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5BLqEfkX4LnyGadqzjh9ta","service":"spop","name":"Analipsi Ton 7 Kai I Mpanta Sti Florina","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":148,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:6hM19xXImAAjTJOiY4gg5O in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:6hM19xXImAAjTJOiY4gg5O Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3I6kly2arBTCKFWcc1xmNp","service":"spop","name":"Leipsa Mou Xamogelases","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":219,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:61upcoWDQU5dndMvw4h4dq in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:61upcoWDQU5dndMvw4h4dq Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6yX0hZ8nK7xc47hoT6yd4C","service":"spop","name":"Roula","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":130,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:5XjSXcPs4PuKlvr8WJePhP in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:5XjSXcPs4PuKlvr8WJePhP Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:7mEpb54mVcqg5rfceUTbCW in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:7mEpb54mVcqg5rfceUTbCW Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:61upcoWDQU5dndMvw4h4dq","service":"spop","name":"Hara","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":136,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6hM19xXImAAjTJOiY4gg5O","service":"spop","name":"Sto Pazari","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":108,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:0TrdLXizsHDZBga13eB0nR in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:0TrdLXizsHDZBga13eB0nR Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5XjSXcPs4PuKlvr8WJePhP","service":"spop","name":"O Thanatos Mou","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":179,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:0TrdLXizsHDZBga13eB0nR in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:0TrdLXizsHDZBga13eB0nR Oct 31 01:16:57 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Oct 31 01:16:57 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7mEpb54mVcqg5rfceUTbCW","service":"spop","name":"Polypatho Pouli","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":122,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:55W3uRbddGCIMKnLhyj6MU in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:55W3uRbddGCIMKnLhyj6MU Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0TrdLXizsHDZBga13eB0nR","service":"spop","name":"Oi 4 Epohes","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":93,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:4pvv31V54EtdqqV1liVDRF in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:4pvv31V54EtdqqV1liVDRF Oct 31 01:16:57 perivolumio go-librespot[5544]: go-librespot daemon starting... Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0TrdLXizsHDZBga13eB0nR","service":"spop","name":"Oi 4 Epohes","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":93,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=debug msg="app state loaded" Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=debug msg="stored credentials not found" Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:5W5u3sSROl3tur2lVBWEVm in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:5W5u3sSROl3tur2lVBWEVm Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:55W3uRbddGCIMKnLhyj6MU","service":"spop","name":"To Idio Kanei","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":107,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:1Sdgqp34EFQqXyhQ90T9T0 in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:1Sdgqp34EFQqXyhQ90T9T0 Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4pvv31V54EtdqqV1liVDRF","service":"spop","name":"S' Anagnorizo Pali","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":51,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:57 perivolumio volumio[1158]: info: Exploding uri spotify:track:3e8dGS9EJMnsJu35h55Dxq in service spop Oct 31 01:16:57 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:3e8dGS9EJMnsJu35h55Dxq Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:16:57 perivolumio go-librespot[5545]: time="2025-10-31T01:16:57-04:00" level=info msg="zeroconf server listening on port 35501" Oct 31 01:16:58 perivolumio volumio[1158]: info: Exploding uri spotify:track:7jSiq9wgWfQ1Ow5KL6RuZS in service spop Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:7jSiq9wgWfQ1Ow5KL6RuZS Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5W5u3sSROl3tur2lVBWEVm","service":"spop","name":"Hasame Pali","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":143,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1Sdgqp34EFQqXyhQ90T9T0","service":"spop","name":"Stou Tourismou Tin Anohi","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":181,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio volumio[1158]: info: Exploding uri spotify:track:4yeLrBWSXcFvRqhErm1UVr in service spop Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:4yeLrBWSXcFvRqhErm1UVr Oct 31 01:16:58 perivolumio go-librespot[5545]: time="2025-10-31T01:16:58-04:00" level=debug msg="obtained new client token: AAAooTOUQOMRMo/gqhVn2uAUkNDUsDC2oUi+Qh03+6k2mTylut81nHYF7CwmqXQIk/QicG3QkV0nx0kzDK+k1f9LzZ2SCcevx1Mtq+hunG5o/F8GcSV23qqCx8Dc2ChKdIqGQYL9E7/KjGFvPhbEAzH8u8n4iUxR/SY0lXtT8Q78UQpYL2PcTy+N/iceE5jijpXub2eHiJ7cvVS8eDQwCpyS1J9ySanwAI1aqjSQhYTRH7Z4ieMUKjc=" Oct 31 01:16:58 perivolumio volumio[1158]: info: Exploding uri spotify:track:2rBVlQd7e72PTIYnCGH6no in service spop Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:2rBVlQd7e72PTIYnCGH6no Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3e8dGS9EJMnsJu35h55Dxq","service":"spop","name":"To Hioni","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":142,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio go-librespot[5545]: time="2025-10-31T01:16:58-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:16:58 perivolumio volumio[1158]: info: Exploding uri spotify:track:6qyjzj0mzdY8QEyRElCpjx in service spop Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:6qyjzj0mzdY8QEyRElCpjx Oct 31 01:16:58 perivolumio go-librespot[5545]: time="2025-10-31T01:16:58-04:00" level=debug msg="completed keyexchange" Oct 31 01:16:58 perivolumio go-librespot[5545]: time="2025-10-31T01:16:58-04:00" level=debug msg="completed challenge" Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4yeLrBWSXcFvRqhErm1UVr","service":"spop","name":"Apo To Parko Sti Myrovolo","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":150,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio volumio[1158]: info: Exploding uri spotify:track:290zUPJlAxWRbvXrQyMIx6 in service spop Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: EXPLODING URI:spotify:track:290zUPJlAxWRbvXrQyMIx6 Oct 31 01:16:58 perivolumio go-librespot[5545]: time="2025-10-31T01:16:58-04: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 " Oct 31 01:16:58 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:16:58 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7jSiq9wgWfQ1Ow5KL6RuZS","service":"spop","name":"Otan Tha 'Rthei To Kalokairi","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":155,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6qyjzj0mzdY8QEyRElCpjx","service":"spop","name":"Nyhta Magissa","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":110,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:290zUPJlAxWRbvXrQyMIx6","service":"spop","name":"Eisagogi Myrovolos","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":65,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:16:58 perivolumio volumio[1158]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2rBVlQd7e72PTIYnCGH6no","service":"spop","name":"Kyra - Tzeni","artist":"Heimerinoi Kolymvites","album":"Apo To Parko Sti Myrovolo (Tessalonike 1985)","type":"song","duration":137,"albumart":"https://i.scdn.co/image/ab67616d0000b2732ecf3266142ffe9e5a53e662","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Oct 31 01:17:00 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:17:00 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:17:01 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8. Oct 31 01:17:01 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:01 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:01 perivolumio go-librespot[5553]: go-librespot daemon starting... Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="app state loaded" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="stored credentials not found" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=info msg="zeroconf server listening on port 41027" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="obtained new client token: AAALq1hSfJmFWgrbxbzV2c7HizsE9m92cb2BQWaPK6CmTWLLvmgMNWydhlwAyQE1mDUi4t374mEH7pqm+YcmXvgxtQWSUVd6jheoO2NsG43T4/Lb83hO3VizcXlk6elYovDu509Mg344mvjMxPXpmODtAcHXG7t8+o3poC+pkgoHZBFDj+TDrJplaUzkXDFViZoGQG0Bjnozn+Uuj3JRs+aDI3Kn0260X4OMuYWcszfGZSClbR6mun1+Ng==" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="completed keyexchange" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04:00" level=debug msg="completed challenge" Oct 31 01:17:01 perivolumio go-librespot[5555]: time="2025-10-31T01:17:01-04: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 " Oct 31 01:17:01 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:17:01 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:17:02 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 31 01:17:02 perivolumio volumio[1158]: info: In handleBrowseUri, curUri=spotify Oct 31 01:17:02 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:17:02 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:17:02 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:17:02 perivolumio volumio[1158]: info: Preload queue cleared Oct 31 01:17:03 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:17:03 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:17:04 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Oct 31 01:17:04 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:04 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:04 perivolumio go-librespot[5576]: go-librespot daemon starting... Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=debug msg="app state loaded" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=debug msg="stored credentials not found" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:17:04 perivolumio go-librespot[5577]: time="2025-10-31T01:17:04-04:00" level=info msg="zeroconf server listening on port 40171" Oct 31 01:17:05 perivolumio go-librespot[5577]: time="2025-10-31T01:17:05-04:00" level=debug msg="obtained new client token: AABqbHGjsVGtftin2QCEX5yc8Mbfa+UpcX7MeuoKgPzqkgH3/w9l2Nujn9y+liMm7flSsP75zz4AXrILq+aRMiqy4nEqNLvnxIc6Zo1mCHPFX99oOGEyjgoBWJWqhcALmvM/PUsEAexGLs4rnhF1aeESRuDWDz2qcYBaSv7s/Z8hJVTUM/OJLtceccUnD+mutFZ91EkSI137BlGk1ZWWBgDUH2u025bue6eBgA70dj7zI+cQ3ABbfQw=" Oct 31 01:17:05 perivolumio go-librespot[5577]: time="2025-10-31T01:17:05-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:17:05 perivolumio go-librespot[5577]: time="2025-10-31T01:17:05-04:00" level=debug msg="completed keyexchange" Oct 31 01:17:05 perivolumio go-librespot[5577]: time="2025-10-31T01:17:05-04:00" level=debug msg="completed challenge" Oct 31 01:17:05 perivolumio go-librespot[5577]: time="2025-10-31T01:17:05-04: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 " Oct 31 01:17:05 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:17:05 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:17:06 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:17:06 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:17:08 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Oct 31 01:17:08 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:08 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:08 perivolumio go-librespot[5584]: go-librespot daemon starting... Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="app state loaded" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="stored credentials not found" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=info msg="zeroconf server listening on port 38987" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="obtained new client token: AAC+zm6No0vTDqxPfL6e8HZxX0heyXagKt3O8tXczDj9UM3P0VEzfi9DFi/QqWaiShPDhwfn52s5iFnMe8QxeGOweCrXuyT19+jRsX+YcuVp80e5uXJFXSirRMr4fvUo1Qg2dBwGVWRjG4b1Fttpyf+9AAeT3pN79LGVf5nFKpr8A7Bd9ZxjvILJWaQIO/zr8q4GPXxo6Uac9/3t8nc2EJ0YJ9VDcizLJAzot0G/Hignfyxsyo+x53jFDQ==" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="completed keyexchange" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04:00" level=debug msg="completed challenge" Oct 31 01:17:08 perivolumio go-librespot[5585]: time="2025-10-31T01:17:08-04: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 " Oct 31 01:17:08 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:17:08 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:17:09 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:17:09 perivolumio volumio[1158]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:17:11 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Oct 31 01:17:11 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:11 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:11 perivolumio go-librespot[5595]: go-librespot daemon starting... Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=debug msg="app state loaded" Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=debug msg="stored credentials not found" Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 31 01:17:11 perivolumio go-librespot[5597]: time="2025-10-31T01:17:11-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=info msg="zeroconf server listening on port 35347" Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=debug msg="obtained new client token: AACbRZfUUHk2/7EtIiWYxZ21SLJgmFw0z/3kAkkfvHNnVOC9aTASQcFl7z+vCmPWgHELnnQ0zylfqA4IAU+1ItYtUcrSAb7f8dZHVTigf6GJs6N+wGPu/6wEulWfvfp4+d/b0jtD8QM9MA3OF3gpbrk6G8uH1FtTv+KqYsKWAvT+bYGo1A91n0KQJDYiCBRObpqdYI1aAj5GlaflfRebRITLSLxKzF/sEVsSYy27Ssn65zL7UZFype8=" Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.255.62:4070: connect: connection refused" Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=debug msg="connected to ap-gue1.spotify.com:443" Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=debug msg="completed keyexchange" Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=debug msg="completed challenge" Oct 31 01:17:12 perivolumio volumio[1158]: info: Initializing connection to go-librespot Websocket Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04:00" level=debug msg="new websocket client" Oct 31 01:17:12 perivolumio volumio[1158]: info: Connection to go-librespot Websocket established Oct 31 01:17:12 perivolumio go-librespot[5597]: time="2025-10-31T01:17:12-04: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 " Oct 31 01:17:12 perivolumio volumio[1158]: info: Connection to go-librespot Websocket closed Oct 31 01:17:12 perivolumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 31 01:17:12 perivolumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 31 01:17:12 perivolumio volumio[1158]: info: CoreCommandRouter::volumioGetState Oct 31 01:17:12 perivolumio volumio[1158]: info: CorePlayQueue::getTrack 0 Oct 31 01:17:14 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 01:17:14 perivolumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 31 01:17:15 perivolumio volumio[1158]: info: Getting Spotify volume Oct 31 01:17:15 perivolumio volumio[1158]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 01:17:15 perivolumio volumio[1158]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 31 01:17:15 perivolumio volumio[1158]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 31 01:17:15 perivolumio volumio[1158]: errno: -111, Oct 31 01:17:15 perivolumio volumio[1158]: code: 'ECONNREFUSED', Oct 31 01:17:15 perivolumio volumio[1158]: syscall: 'connect', Oct 31 01:17:15 perivolumio volumio[1158]: address: '127.0.0.1', Oct 31 01:17:15 perivolumio volumio[1158]: port: 9879, Oct 31 01:17:15 perivolumio volumio[1158]: response: undefined Oct 31 01:17:15 perivolumio volumio[1158]: } Oct 31 01:17:15 perivolumio volumio[1158]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 01:17:15 perivolumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Oct 31 01:17:15 perivolumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:15 perivolumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 31 01:17:15 perivolumio go-librespot[5632]: go-librespot daemon starting... Oct 31 01:17:15 perivolumio go-librespot[5633]: time="2025-10-31T01:17:15-04:00" level=info msg="running go-librespot 0.4.0" Oct 31 01:17:15 perivolumio go-librespot[5633]: time="2025-10-31T01:17:15-04:00" level=debug msg="app state loaded" Oct 31 01:17:15 perivolumio go-librespot[5633]: time="2025-10-31T01:17:15-04:00" level=debug msg="stored credentials not found" Oct 31 01:17:15 perivolumio go-librespot[5633]: time="2025-10-31T01:17:15-04:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 31 01:17:15 perivolumio sudo[5641]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-31 01:16' Oct 31 01:17:15 perivolumio sudo[5641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) 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="5ef3d56f987d109f3e21bfa246dbbb723cf6a917" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="c7bff9654d2984a81c5720476c2c8ac531869c54" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Oct 9 18:08:11 UTC 2025" VOLUMIO_VERSION="4.062" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="00524295c246b7d72f125e4c54b86a88"