-- Logs begin at Wed 2024-08-07 03:49:28 UTC, end at Sat 2024-08-31 09:58:56 UTC. -- Aug 31 09:58:44 volumioflotus volumio[20172]: [Vollibrespot] : Login error for user "nitzantubul": MAC mismatch Aug 31 09:58:47 volumioflotus volumio[20172]: [Vollibrespot] : Login error for user "nitzantubul": MAC mismatch Aug 31 09:58:50 volumioflotus volumio[20172]: [Vollibrespot] : Login error for user "nitzantubul": MAC mismatch Aug 31 09:58:53 volumioflotus volumio[20172]: [Vollibrespot] : Login error for user "nitzantubul": MAC mismatch Aug 31 09:58:55 volumioflotus volumio[20172]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443" Aug 31 09:58:55 volumioflotus volumio[20172]: [Vollibrespot] : Authenticated as "nitzantubul" ! Aug 31 09:58:55 volumioflotus volumio[20172]: [Vollibrespot] : Using alsa sink Aug 31 09:58:55 volumioflotus volumio[20172]: [Vollibrespot] : Metadata pipe established Aug 31 09:58:55 volumioflotus volumio[20172]: [Vollibrespot] : Country: "IL" Aug 31 09:58:55 volumioflotus volumio[20172]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 } Aug 31 09:58:55 volumioflotus volumio[917]: [SpotifyConnect] Volume Spotify: 100 Volumio: 100 Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Fetching autoplay context uri Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Event: SessionActive { became_active_at: 1725098336097 } Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : SessionActive! Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 199041435786758819099016020510289244549, audio_type: Track } } Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 199041435786758819099016020510289244549, audio_type: Track } } Aug 31 09:58:56 volumioflotus volumio[917]: [SpotifyConnect] A connect session has begun Aug 31 09:58:56 volumioflotus volumio[917]: info: Acquiring new spotify session Aug 31 09:58:56 volumioflotus volumio[917]: info: CoreCommandRouter::volumioStop Aug 31 09:58:56 volumioflotus volumio[917]: info: CoreStateMachine::stop Aug 31 09:58:56 volumioflotus volumio[917]: info: CoreStateMachine::serviceStop Aug 31 09:58:56 volumioflotus volumio[917]: info: CoreCommandRouter::serviceStop Aug 31 09:58:56 volumioflotus volumio[917]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 09:58:56 volumioflotus volumio[917]: TypeError: Cannot read property 'then' of undefined Aug 31 09:58:56 volumioflotus volumio[917]: at SpotConnEvents. (/data/plugins/music_service/spop/index.js:2132:31) Aug 31 09:58:56 volumioflotus volumio[917]: at SpotConnEvents.emit (events.js:315:20) Aug 31 09:58:56 volumioflotus volumio[917]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:92:16) Aug 31 09:58:56 volumioflotus volumio[917]: at Socket. (/data/plugins/music_service/spop/SpotConnController.js:15:12) Aug 31 09:58:56 volumioflotus volumio[917]: at Socket.emit (events.js:315:20) Aug 31 09:58:56 volumioflotus volumio[917]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Aug 31 09:58:56 volumioflotus volumio[917]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 09:58:56 volumioflotus vtcs[19417]: [2024-08-31 09:58:56.120] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0 Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:artist:0FyyOmHt8uDxmkNRJ73zUC"> Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Resolving uri "spotify:station:artist:0FyyOmHt8uDxmkNRJ73zUC" Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQBrFbr9wiXu2vO4t6bWK8VyIcOYxgtYQPCNTKJAZCXxhdq0UncNkcdmenToTneHtFWVIdoB_fFVbp49cpaG89xLzuF9-d5HZbx_JGsOLdAstmRUOD8pUPjKmdO5Xv2BTVT2E5xTy5c5yQnU9mQnAlOM3WxX3qfMeX_pihqVPClmEgP254AeHRTyG0pNYIvKedcHYT8m1Iqy_H4", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Aug 31 09:58:56 volumioflotus volumio[20172]: [Vollibrespot] : Loading <שחרר אותי> with Spotify URI Aug 31 09:58:56 volumioflotus sudo[25180]: volumio : unable to resolve host volumioflotus Aug 31 09:58:56 volumioflotus sudo[25180]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Aug 31 09:58:56 volumioflotus sudo[25180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-31 09:57 Aug 31 09:58:56 volumioflotus sudo[25180]: 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="c87c6e2b1ae33dc5801986cbcbe970898b92e7b4" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="b949d6001d7e656b4668f31c119d2247cdf45158" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 30 Mar 2023 05:45:03 PM CEST" VOLUMIO_VERSION="3.449" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6428d8e2c06e98483f5c5d77e8f01989"