-- Logs begin at Tue 2025-05-20 21:28:52 EEST, end at Sat 2025-05-24 12:46:10 EEST. -- May 24 12:46:09 volumio volumio[29072]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" May 24 12:46:09 volumio volumio[29072]: [Vollibrespot] : Authenticated as "kazakevicius" ! May 24 12:46:09 volumio volumio[29072]: [Vollibrespot] : Using alsa sink May 24 12:46:09 volumio volumio[29072]: [Vollibrespot] : Country: "LT" May 24 12:46:09 volumio volumio[29072]: [Vollibrespot] : Metadata pipe established May 24 12:46:09 volumio volumio[29072]: [Vollibrespot] : Event: Volume { volume_to_mixer: 21626 } May 24 12:46:09 volumio volumio[1139]: [SpotifyConnect] 32.99916075379568 May 24 12:46:09 volumio volumio[1139]: [SpotifyConnect] Volume: Spotify:32.99916075379568 Volumio: 33 May 24 12:46:09 volumio volumio[1139]: info: CoreStateMachine::pushState May 24 12:46:09 volumio volumio[1139]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 24 12:46:09 volumio volumio[1139]: info: CoreCommandRouter::volumioPushState May 24 12:46:09 volumio volumio[1139]: info: MRS: Pushing multiroomSync output update for this device May 24 12:46:09 volumio volumio[1139]: info: MRS: Pushing multiroomSync output May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Fetching autoplay context uri May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Event: SessionActive { became_active_at: 1748079970027 } May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : SessionActive! May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 145200755292126301789352747229780760500, audio_type: Track } } May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 145200755292126301789352747229780760500, audio_type: Track } } May 24 12:46:10 volumio volumio[1139]: [SpotifyConnect] A connect session has begun May 24 12:46:10 volumio volumio[1139]: [SpotifyConnect] Device palyback is active! May 24 12:46:10 volumio volumio[1139]: info: CoreCommandRouter::volumioGetState May 24 12:46:10 volumio volumio[1139]: [SpotifyConnect] Currently active: tidalconnect May 24 12:46:10 volumio volumio[1139]: [SpotifyConnect] Stopping currently active service May 24 12:46:10 volumio volumio[1139]: info: CoreCommandRouter::volumioStop May 24 12:46:10 volumio volumio[1139]: info: CoreStateMachine::stop May 24 12:46:10 volumio volumio[1139]: info: CoreStateMachine::serviceStop May 24 12:46:10 volumio volumio[1139]: info: CoreCommandRouter::serviceStop May 24 12:46:10 volumio volumio[1139]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 12:46:10 volumio volumio[1139]: TypeError: Cannot read property 'then' of undefined May 24 12:46:10 volumio volumio[1139]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23) May 24 12:46:10 volumio volumio[1139]: at SpotConnEvents.emit (events.js:400:28) May 24 12:46:10 volumio volumio[1139]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) May 24 12:46:10 volumio volumio[1139]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) May 24 12:46:10 volumio volumio[1139]: at Socket.emit (events.js:400:28) May 24 12:46:10 volumio volumio[1139]: at UDP.onMessage [as onmessage] (dgram.js:931:8) May 24 12:46:10 volumio volumio[1139]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:album:6uJEtjqPAEXmo8aoixewot"> May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Resolving uri "spotify:station:album:6uJEtjqPAEXmo8aoixewot" May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQC45TdI22ghvdFa73SnajslUNWU83zJ4soHAxtY6UCZKPqYtMcqEXbMfR4OqZQ-nhbn8iIWCaB3WN4vdoZmi_uaULTMOFO5dxrzXuV2sHWwfkE6CvUhTdFX6tg-jsbvaxjQyI1CW_q8I4016g07SF1sdcIeOco5U5c-msO_CeM8JqbT9thLc6VwpKRGoDQqOnHXs9Y72oPYrH9J15bVC9g4MG-Qt99x4gFd6F5HdvYw7Rmc", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } May 24 12:46:10 volumio volumio[29072]: [Vollibrespot] : Loading with Spotify URI May 24 12:46:10 volumio sudo[28489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 12:45 May 24 12:46:10 volumio sudo[28489]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"