-- Logs begin at Sun 2023-08-27 18:53:29 UTC, end at Fri 2024-10-11 20:13:35 UTC. -- Oct 11 20:12:19 volumio volumiossh-tunnel[6455]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Authenticated as "helenavoege" ! Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Setting up new mixer: card:hw:2 mixer:Digital index:0 Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Alsa Mixer info min: 0 (MilliBel(-9999999)[dB]) -- max: 207 (MilliBel(0)[dB]) HW: true Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Using alsa sink Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Metadata pipe established Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Country: "DE" Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Event: Volume { volume_to_mixer: 0 } Oct 11 20:13:34 volumio volumio[807]: [SpotifyConnect] 0 Oct 11 20:13:34 volumio volumio[807]: [SpotifyConnect] Volume: Spotify:0 Volumio: 0 Oct 11 20:13:34 volumio volumio[807]: info: CoreCommandRouter::volumioGetState Oct 11 20:13:34 volumio volumio[807]: info: CoreStateMachine::pushState Oct 11 20:13:34 volumio volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 20:13:34 volumio volumio[807]: info: CoreCommandRouter::volumioPushState Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Fetching autoplay context uri Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Event: SessionActive { became_active_at: 1728677614832 } Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : SessionActive! Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 74029378364915012998978797621746139930, audio_type: Track } } Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 74029378364915012998978797621746139930, audio_type: Track } } Oct 11 20:13:34 volumio volumio[807]: [SpotifyConnect] A connect session has begun Oct 11 20:13:34 volumio volumio[807]: [SpotifyConnect] Device palyback is active! Oct 11 20:13:34 volumio volumio[807]: info: CoreCommandRouter::volumioGetState Oct 11 20:13:34 volumio volumio[807]: [SpotifyConnect] Currently active: tidalconnect Oct 11 20:13:34 volumio volumio[807]: [SpotifyConnect] Stopping currently active service Oct 11 20:13:34 volumio volumio[807]: info: CoreCommandRouter::volumioStop Oct 11 20:13:34 volumio volumio[807]: info: CoreStateMachine::stop Oct 11 20:13:34 volumio volumio[807]: info: CoreStateMachine::serviceStop Oct 11 20:13:34 volumio volumio[807]: info: CoreCommandRouter::serviceStop Oct 11 20:13:34 volumio volumio[807]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 20:13:34 volumio volumio[807]: TypeError: Cannot read property 'then' of undefined Oct 11 20:13:34 volumio volumio[807]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23) Oct 11 20:13:34 volumio volumio[807]: at SpotConnEvents.emit (events.js:315:20) Oct 11 20:13:34 volumio volumio[807]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) Oct 11 20:13:34 volumio volumio[807]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Oct 11 20:13:34 volumio volumio[807]: at Socket.emit (events.js:315:20) Oct 11 20:13:34 volumio volumio[807]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Oct 11 20:13:34 volumio volumio[807]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:3V9aYH7Q1iTTGEf3BzIEPR"> Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Resolving uri "spotify:station:playlist:3V9aYH7Q1iTTGEf3BzIEPR" Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQBaTK0FI2bdgmD3AkN6bTrFIj7gRpm-f9DTQB74J5k3tixxgKSKjfwVjnIXc02AXKYRNxGVNzdAn0EAZOiF__EgOPyUzbpyCReQyA1ZsBgc8LJ2q8rzJl4m3KJh0HrWeYsBNCoTTErFFLCr_VYUEqSMkoWFAoAQIKfGZqDE4Bbr0vE2mPbLNRPeFqwwZ-fdJ1CEVlG22yLfgn8", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Oct 11 20:13:34 volumio volumio[1095]: [Vollibrespot] : Loading with Spotify URI Oct 11 20:13:34 volumio vtcs[1363]: [2024-10-11 20:13:34.941] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0 Oct 11 20:13:34 volumio vtcs[1363]: [2024-10-11 20:13:34] [info] asio async_shutdown error: asio.misc:2 (End of file) Oct 11 20:13:35 volumio sudo[6496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-11 20:12 Oct 11 20:13:35 volumio sudo[6496]: 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="1f061e035f7cb2799b32d3520aa8e55cd07df6f9" VOLUMIO_FE_VERSION="9971a09df9c3edfdedf2ecf438999be8aba9db68" VOLUMIO_FE3_VERSION="3974def988c7b2392ddc85f9b8cb4692d5e8fda9" VOLUMIO_BE_VERSION="b3c53a818b9b3d0e5c13c9d346c4d613c4ca426f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 11 Jul 2022 04:03:33 PM CEST" VOLUMIO_VERSION="3.324" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5b2f59e6e90e57f326ca25c7ca839d52"