-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Thu 2024-11-21 00:46:51 UTC. -- Nov 21 00:46:50 volumio volumio[1194]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:443" Nov 21 00:46:50 volumio volumio[1194]: [Vollibrespot] : Authenticated as "21lhaqpcfndj3a7bhfakqfwpa" ! Nov 21 00:46:50 volumio volumio[1194]: [Vollibrespot] : Using alsa sink Nov 21 00:46:50 volumio volumio[1194]: [Vollibrespot] : Metadata pipe established Nov 21 00:46:50 volumio volumio[1194]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 } Nov 21 00:46:50 volumio volumio[1194]: [Vollibrespot] : Country: "US" Nov 21 00:46:50 volumio volumio[634]: [SpotifyConnect] 100 Nov 21 00:46:50 volumio volumio[634]: [SpotifyConnect] Volume: Spotify:100 Volumio: 100 Nov 21 00:46:50 volumio volumio[634]: info: CoreStateMachine::pushState Nov 21 00:46:50 volumio volumio[634]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 00:46:50 volumio volumio[634]: info: CoreCommandRouter::volumioPushState Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Fetching autoplay context uri Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Event: SessionActive { became_active_at: 1732150011025 } Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : SessionActive! Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 316948238676851524279368433852264257477, audio_type: Track } } Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 316948238676851524279368433852264257477, audio_type: Track } } Nov 21 00:46:51 volumio volumio[634]: [SpotifyConnect] A connect session has begun Nov 21 00:46:51 volumio volumio[634]: [SpotifyConnect] Device palyback is active! Nov 21 00:46:51 volumio volumio[634]: info: CoreCommandRouter::volumioGetState Nov 21 00:46:51 volumio volumio[634]: [SpotifyConnect] Currently active: tidalconnect Nov 21 00:46:51 volumio volumio[634]: [SpotifyConnect] Stopping currently active service Nov 21 00:46:51 volumio volumio[634]: info: CoreCommandRouter::volumioStop Nov 21 00:46:51 volumio volumio[634]: info: CoreStateMachine::stop Nov 21 00:46:51 volumio volumio[634]: info: CoreStateMachine::serviceStop Nov 21 00:46:51 volumio volumio[634]: info: CoreCommandRouter::serviceStop Nov 21 00:46:51 volumio volumio[634]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 00:46:51 volumio volumio[634]: TypeError: Cannot read property 'then' of undefined Nov 21 00:46:51 volumio volumio[634]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23) Nov 21 00:46:51 volumio volumio[634]: at SpotConnEvents.emit (events.js:315:20) Nov 21 00:46:51 volumio volumio[634]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) Nov 21 00:46:51 volumio volumio[634]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Nov 21 00:46:51 volumio volumio[634]: at Socket.emit (events.js:315:20) Nov 21 00:46:51 volumio volumio[634]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Nov 21 00:46:51 volumio volumio[634]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:album:7C1SBUAwmHxWVMYzJJFRiB"> Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Resolving uri "spotify:station:album:7C1SBUAwmHxWVMYzJJFRiB" Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQB9yLXAQgg40-dN7FGKMn4XLXvR6l9MOtCpLuJUz5yAMzR9aBASGC3gyM-AChl1fHPcUl1Ck8EmcqPnkEOF70W4Xphj5liABhQLvnmXqtOMhpcX0o1ZBF32wGk5J-QithSguvJAcVgATIqmm66RKEF7Uw4a5-JAOBxKiQz0zGbsJxBUr-30TRXNUa5giQxHmQ41M9HjXqnw4-r2HctVXkh0pGu9oaEVzw", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Loading with Spotify URI Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : (304160 ms) loaded Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 316948238676851524279368433852264257477, audio_type: Track } } Nov 21 00:46:51 volumio sudo[4336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 00:45 Nov 21 00:46:51 volumio sudo[4336]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 00:46:51 volumio volumio[1194]: [Vollibrespot] : Unable to parse JSONContext Error("invalid type: map, expected a string", line: 0, column: 0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="543f2de901f774399af6eae9d76f06fe4162e5dd" VOLUMIO_FE_VERSION="175efecbf4f79404c553a8a73d0a8929ba9e68ab" VOLUMIO_FE3_VERSION="9cf29de04cd974cb1504bd8ef33d64f591b09aef" VOLUMIO_BE_VERSION="0bba7bb5721ae1c828390745b52735c56d7c014a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 13 Dec 2021 03:52:13 PM CET" VOLUMIO_VERSION="3.175" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="c1271baa6039839be7f5b1630f3422f4"