-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sat 2025-01-18 11:18:19 GMT. -- Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Authenticated as "mpeacock32" ! Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Using alsa sink Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Metadata pipe established Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Country: "GB" Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Event: Volume { volume_to_mixer: 40305 } Jan 18 11:18:18 pi-dac volumio[973]: [SpotifyConnect] Volume Spotify: 61.50148775463493 Volumio: 62 Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Event: SessionActive { became_active_at: 1737199098970 } Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : SessionActive! Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Fetching autoplay context uri Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 230856336881578593258210467542745668372, audio_type: Track } } Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 230856336881578593258210467542745668372, audio_type: Track } } Jan 18 11:18:18 pi-dac volumio[973]: [SpotifyConnect] A connect session has begun Jan 18 11:18:18 pi-dac volumio[973]: info: Acquiring new spotify session Jan 18 11:18:18 pi-dac volumio[973]: info: CoreCommandRouter::volumioStop Jan 18 11:18:18 pi-dac volumio[973]: info: CoreStateMachine::stop Jan 18 11:18:18 pi-dac volumio[973]: info: CoreStateMachine::serviceStop Jan 18 11:18:18 pi-dac volumio[973]: info: CoreCommandRouter::serviceStop Jan 18 11:18:18 pi-dac volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 11:18:18 pi-dac volumio[973]: TypeError: Cannot read property 'then' of undefined Jan 18 11:18:18 pi-dac volumio[973]: at SpotConnEvents. (/data/plugins/music_service/spop/index.js:2111:31) Jan 18 11:18:18 pi-dac volumio[973]: at SpotConnEvents.emit (events.js:315:20) Jan 18 11:18:18 pi-dac volumio[973]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16) Jan 18 11:18:18 pi-dac volumio[973]: at Socket. (/data/plugins/music_service/spop/SpotConnController.js:15:12) Jan 18 11:18:18 pi-dac volumio[973]: at Socket.emit (events.js:315:20) Jan 18 11:18:18 pi-dac volumio[973]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Jan 18 11:18:18 pi-dac volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 11:18:18 pi-dac vtcs[1478]: [2025-01-18 11:18:18.991] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:0 Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:0lX36rCJP33SIigmKEaH58"> Jan 18 11:18:18 pi-dac volumio[1458]: [Vollibrespot] : Resolving uri "spotify:station:playlist:0lX36rCJP33SIigmKEaH58" Jan 18 11:18:19 pi-dac volumio[1458]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQBkXL9y1eyCgimD8oCtHFC0YV0Z6gZ7JQ7YdAubBIxzpxsAPRiWlSqm6xI7W6xIt-ZvFKuX3zW0FRALf4cqet170VzjHw0t58YvqhcixYuxWIrefFtzMNs6HfPtRsTwehIHRnWb-9hDIVHpyH1W5RK_m5SiY1ewZDGXrEQf81MY3Uq3F64CKYymWaFhHsSNstQ3kYjo_1dhaQ", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Jan 18 11:18:19 pi-dac volumio[1458]: [Vollibrespot] : Loading with Spotify URI Jan 18 11:18:19 pi-dac volumio[1458]: [Vollibrespot] : Resolved 50 tracks from <"spotify:playlist:0lX36rCJP33SIigmKEaH58"> Jan 18 11:18:19 pi-dac volumio[1458]: [Vollibrespot] : (338000 ms) loaded Jan 18 11:18:19 pi-dac volumio[1458]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 230856336881578593258210467542745668372, audio_type: Track } } Jan 18 11:18:19 pi-dac sudo[14942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 11:17 Jan 18 11:18:19 pi-dac sudo[14942]: pam_unix(sudo:session): session opened for user root by (uid=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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"