-- Logs begin at Fri 2024-11-22 20:55:58 EET, end at Tue 2024-11-26 20:47:20 EET. -- Nov 26 20:46:19 volumio wpa_supplicant[1024]: wlan0: WPA: Group rekeying completed with d4:35:1d:d5:5e:30 [GTK=CCMP] Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Authenticated as "kazakevicius" ! Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Using alsa sink Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Country: "LT" Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Metadata pipe established Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Event: Volume { volume_to_mixer: 21626 } Nov 26 20:47:19 volumio volumio[1110]: [SpotifyConnect] 32.99916075379568 Nov 26 20:47:19 volumio volumio[1110]: [SpotifyConnect] Volume: Spotify:32.99916075379568 Volumio: 33 Nov 26 20:47:19 volumio volumio[1110]: info: CoreStateMachine::pushState Nov 26 20:47:19 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 20:47:19 volumio volumio[1110]: info: CoreCommandRouter::volumioPushState Nov 26 20:47:19 volumio volumio[1110]: info: MRS: Pushing multiroomSync output update for this device Nov 26 20:47:19 volumio volumio[1110]: info: MRS: Pushing multiroomSync output Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Fetching autoplay context uri Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Event: SessionActive { became_active_at: 1732646839979 } Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : SessionActive! Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 30836200187082039506282874435956731618, audio_type: Track } } Nov 26 20:47:19 volumio volumio[1944]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 30836200187082039506282874435956731618, audio_type: Track } } Nov 26 20:47:19 volumio volumio[1110]: [SpotifyConnect] A connect session has begun Nov 26 20:47:19 volumio volumio[1110]: [SpotifyConnect] Device palyback is active! Nov 26 20:47:19 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Nov 26 20:47:19 volumio volumio[1110]: [SpotifyConnect] Currently active: tidalconnect Nov 26 20:47:19 volumio volumio[1110]: [SpotifyConnect] Stopping currently active service Nov 26 20:47:19 volumio volumio[1110]: info: CoreCommandRouter::volumioStop Nov 26 20:47:19 volumio volumio[1110]: info: CoreStateMachine::stop Nov 26 20:47:19 volumio volumio[1110]: info: CoreStateMachine::serviceStop Nov 26 20:47:19 volumio volumio[1110]: info: CoreCommandRouter::serviceStop Nov 26 20:47:19 volumio volumio[1110]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 20:47:19 volumio volumio[1110]: TypeError: Cannot read property 'then' of undefined Nov 26 20:47:19 volumio volumio[1110]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23) Nov 26 20:47:19 volumio volumio[1110]: at SpotConnEvents.emit (events.js:400:28) Nov 26 20:47:19 volumio volumio[1110]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) Nov 26 20:47:19 volumio volumio[1110]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Nov 26 20:47:19 volumio volumio[1110]: at Socket.emit (events.js:400:28) Nov 26 20:47:19 volumio volumio[1110]: at UDP.onMessage [as onmessage] (dgram.js:931:8) Nov 26 20:47:19 volumio volumio[1110]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 20:47:20 volumio volumio[1944]: [Vollibrespot] : Loading with Spotify URI Nov 26 20:47:20 volumio volumio[1944]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:37i9dQZF1E37JTyOxrA3hQ"> Nov 26 20:47:20 volumio volumio[1944]: [Vollibrespot] : Resolving uri "spotify:station:playlist:37i9dQZF1E37JTyOxrA3hQ" Nov 26 20:47:20 volumio volumio[1944]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQAYVK5XKAyldmh6M8AX11LNIWItU0aPETLMsB6nTTyFLsw_G6yeWnWrNoLgcfGiDUX35j6G58EXHZzdGi1MxEBfBShFnEJumi5ATp4ZCUTNRkyu4JlEbVmo5ajagxigTjA8ULcBCDsuuOS95S3_i49R-v-OJOnkkFwFxb9aZh_noV-pgbTPj-5aXbsmOOVT5pP4lpgf_RyZG-K4", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Nov 26 20:47:20 volumio sudo[14712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 20:46 Nov 26 20:47:20 volumio sudo[14712]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"