-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2024-08-16 19:46:08 UTC. -- Aug 16 19:45:50 volumio vtcs[1453]: [2024-08-16 19:45:50] [error] handle_read_frame error: asio.system:104 (Connection reset by peer) Aug 16 19:45:50 volumio vtcs[1453]: [2024-08-16 19:45:50] [info] asio async_shutdown error: asio.system:32 (Broken pipe) Aug 16 19:45:52 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Aug 16 19:45:52 volumio volumio[1088]: info: CoreStateMachine::pushState Aug 16 19:45:52 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 19:45:52 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Aug 16 19:45:52 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Aug 16 19:45:52 volumio volumio[1088]: info: CoreStateMachine::pushState Aug 16 19:45:52 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 16 19:45:52 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Aug 16 19:46:07 volumio volumio[1408]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Aug 16 19:46:07 volumio volumio[1408]: [Vollibrespot] : Authenticated as "21ojxt7mi4wwjjo6r6ecu2rgq" ! Aug 16 19:46:07 volumio volumio[1408]: [Vollibrespot] : Using alsa sink Aug 16 19:46:07 volumio volumio[1408]: [Vollibrespot] : Metadata pipe established Aug 16 19:46:07 volumio volumio[1408]: [Vollibrespot] : Country: "PL" Aug 16 19:46:07 volumio volumio[1408]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 } Aug 16 19:46:07 volumio volumio[1088]: [SpotifyConnect] Volume Spotify: 100 Volumio: 100 Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Fetching autoplay context uri Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Event: SessionActive { became_active_at: 1723837568032 } Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : SessionActive! Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 60434619998659117422740371115966066797, audio_type: Track } } Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 60434619998659117422740371115966066797, audio_type: Track } } Aug 16 19:46:08 volumio volumio[1088]: [SpotifyConnect] A connect session has begun Aug 16 19:46:08 volumio volumio[1088]: info: Acquiring new spotify session Aug 16 19:46:08 volumio volumio[1088]: info: CoreCommandRouter::volumioStop Aug 16 19:46:08 volumio volumio[1088]: info: CoreStateMachine::stop Aug 16 19:46:08 volumio volumio[1088]: info: CoreStateMachine::serviceStop Aug 16 19:46:08 volumio volumio[1088]: info: CoreCommandRouter::serviceStop Aug 16 19:46:08 volumio volumio[1088]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 16 19:46:08 volumio volumio[1088]: TypeError: Cannot read property 'then' of undefined Aug 16 19:46:08 volumio volumio[1088]: at SpotConnEvents. (/data/plugins/music_service/spop/index.js:2132:31) Aug 16 19:46:08 volumio volumio[1088]: at SpotConnEvents.emit (events.js:315:20) Aug 16 19:46:08 volumio volumio[1088]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:92:16) Aug 16 19:46:08 volumio volumio[1088]: at Socket. (/data/plugins/music_service/spop/SpotConnController.js:15:12) Aug 16 19:46:08 volumio volumio[1088]: at Socket.emit (events.js:315:20) Aug 16 19:46:08 volumio volumio[1088]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Aug 16 19:46:08 volumio volumio[1088]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:3NFEXgusnYyND718UaXrJU"> Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Resolving uri "spotify:station:playlist:3NFEXgusnYyND718UaXrJU" Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQCa3McWrHDM-styiDqZxoNUQy3ABlKO00FwR6LGMnbYeWVovv2xaTclMDZ1TuzKzjEhOnZ7Y8pxA56p2SmVDAqmZu52QpqlSCAGnqHrXAqJDmAdQekzE57OsW3ebQET1ufDI2Y2NziWOOpDoauqp-QO7js9qK_BdsY8P1DqnHaWeo3r0m7bAqnybH-Rah1ssmu7oot9-CYWqhM94W6Hktsm18sUz30ctQ", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Aug 16 19:46:08 volumio volumio[1408]: [Vollibrespot] : Loading with Spotify URI Aug 16 19:46:08 volumio vtcs[1453]: [2024-08-16 19:46:08.263] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:0 Aug 16 19:46:08 volumio sudo[2751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-16 19:45 Aug 16 19:46:08 volumio sudo[2751]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"