-- Logs begin at Wed 2025-06-04 03:59:52 EEST, end at Wed 2025-06-11 20:22:02 EEST. -- Jun 11 20:21:07 volumio wpa_supplicant[1040]: wlan0: WPA: Group rekeying completed with d4:35:1d:d5:5e:30 [GTK=CCMP] Jun 11 20:22:01 volumio volumio[2017]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Jun 11 20:22:01 volumio volumio[2017]: [Vollibrespot] : Authenticated as "kazakevicius" ! Jun 11 20:22:01 volumio volumio[2017]: [Vollibrespot] : Using alsa sink Jun 11 20:22:01 volumio volumio[2017]: [Vollibrespot] : Country: "LT" Jun 11 20:22:01 volumio volumio[2017]: [Vollibrespot] : Metadata pipe established Jun 11 20:22:01 volumio volumio[2017]: [Vollibrespot] : Event: Volume { volume_to_mixer: 21626 } Jun 11 20:22:01 volumio volumio[1152]: [SpotifyConnect] 32.99916075379568 Jun 11 20:22:01 volumio volumio[1152]: [SpotifyConnect] Volume: Spotify:32.99916075379568 Volumio: 33 Jun 11 20:22:01 volumio volumio[1152]: info: CoreStateMachine::pushState Jun 11 20:22:01 volumio volumio[1152]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 11 20:22:01 volumio volumio[1152]: info: CoreCommandRouter::volumioPushState Jun 11 20:22:01 volumio volumio[1152]: info: MRS: Pushing multiroomSync output update for this device Jun 11 20:22:01 volumio volumio[1152]: info: MRS: Pushing multiroomSync output Jun 11 20:22:01 volumio volumio[1152]: info: CoreCommandRouter::volumioGetState Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Fetching autoplay context uri Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Event: SessionActive { became_active_at: 1749662522153 } Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : SessionActive! Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 134107597444398348780631202051461388619, audio_type: Track } } Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 134107597444398348780631202051461388619, audio_type: Track } } Jun 11 20:22:02 volumio volumio[1152]: [SpotifyConnect] A connect session has begun Jun 11 20:22:02 volumio volumio[1152]: [SpotifyConnect] Device palyback is active! Jun 11 20:22:02 volumio volumio[1152]: info: CoreCommandRouter::volumioGetState Jun 11 20:22:02 volumio volumio[1152]: [SpotifyConnect] Currently active: tidalconnect Jun 11 20:22:02 volumio volumio[1152]: [SpotifyConnect] Stopping currently active service Jun 11 20:22:02 volumio volumio[1152]: info: CoreCommandRouter::volumioStop Jun 11 20:22:02 volumio volumio[1152]: info: CoreStateMachine::stop Jun 11 20:22:02 volumio volumio[1152]: info: CoreStateMachine::serviceStop Jun 11 20:22:02 volumio volumio[1152]: info: CoreCommandRouter::serviceStop Jun 11 20:22:02 volumio volumio[1152]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 11 20:22:02 volumio volumio[1152]: TypeError: Cannot read property 'then' of undefined Jun 11 20:22:02 volumio volumio[1152]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23) Jun 11 20:22:02 volumio volumio[1152]: at SpotConnEvents.emit (events.js:400:28) Jun 11 20:22:02 volumio volumio[1152]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) Jun 11 20:22:02 volumio volumio[1152]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Jun 11 20:22:02 volumio volumio[1152]: at Socket.emit (events.js:400:28) Jun 11 20:22:02 volumio volumio[1152]: at UDP.onMessage [as onmessage] (dgram.js:931:8) Jun 11 20:22:02 volumio volumio[1152]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:album:71vPM5ro3LBizuBvVqSJSS"> Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Resolving uri "spotify:station:album:71vPM5ro3LBizuBvVqSJSS" Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQB0wQJMZ17iC4ypFEU5VINLKoxID4tVNd9sAHkkUsQshfqyRl7OkdsgXdcejtEO31_brDwJs9VFn-xbmuihWJaUf64ba7OYdwbWR-SxOA2c10_56aTQhqrSj0rwWfXeuyVW0HH6K3n7Xn7ltlcThw_m7aVoM2aBL1xcVYdvZ484i_ugveDc1fsJNMV2mAdepsqkovTjfNtm9AkdAdHtkRBQVgD-4WMNsnyw7AS8l-vetvRl", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Jun 11 20:22:02 volumio volumio[2017]: [Vollibrespot] : Loading with Spotify URI Jun 11 20:22:02 volumio sudo[12724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-11 20:21 Jun 11 20:22:02 volumio sudo[12724]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"