-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2024-11-22 23:36:10 UTC. -- Nov 22 23:35:55 diningroom volumio[1744]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:443" Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Authenticated as "summer.mitchell" ! Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Setting up new mixer: card:hw:1 mixer:Digital index:0 Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Alsa Mixer info min: 0 (MilliBel(-9999999)[dB]) -- max: 207 (MilliBel(0)[dB]) HW: true Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Using alsa sink Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Metadata pipe established Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Country: "US" Nov 22 23:35:56 diningroom volumio[1744]: [Vollibrespot] : Event: Volume { volume_to_mixer: 0 } Nov 22 23:35:56 diningroom volumio[831]: [SpotifyConnect] 0 Nov 22 23:35:56 diningroom volumio[831]: [SpotifyConnect] Volume: Spotify:0 Volumio: 0 Nov 22 23:35:56 diningroom volumio[831]: info: CoreStateMachine::pushState Nov 22 23:35:56 diningroom volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 23:35:56 diningroom volumio[831]: info: CoreCommandRouter::volumioPushState Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Fetching autoplay context uri Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Event: SessionActive { became_active_at: 1732318569760 } Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : SessionActive! Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 313222034887766211268056886026614964985, audio_type: Track } } Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 313222034887766211268056886026614964985, audio_type: Track } } Nov 22 23:36:09 diningroom volumio[831]: [SpotifyConnect] A connect session has begun Nov 22 23:36:09 diningroom volumio[831]: [SpotifyConnect] Device palyback is active! Nov 22 23:36:09 diningroom volumio[831]: info: CoreCommandRouter::volumioGetState Nov 22 23:36:09 diningroom volumio[831]: [SpotifyConnect] Currently active: tidalconnect Nov 22 23:36:09 diningroom volumio[831]: [SpotifyConnect] Stopping currently active service Nov 22 23:36:09 diningroom volumio[831]: info: CoreCommandRouter::volumioStop Nov 22 23:36:09 diningroom volumio[831]: info: CoreStateMachine::stop Nov 22 23:36:09 diningroom volumio[831]: info: CoreStateMachine::serviceStop Nov 22 23:36:09 diningroom volumio[831]: info: CoreCommandRouter::serviceStop Nov 22 23:36:09 diningroom volumio[831]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 22 23:36:09 diningroom vtcs[1760]: [2024-11-22 23:36:09.776] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0 Nov 22 23:36:09 diningroom volumio[831]: TypeError: Cannot read property 'then' of undefined Nov 22 23:36:09 diningroom volumio[831]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23) Nov 22 23:36:09 diningroom volumio[831]: at SpotConnEvents.emit (events.js:315:20) Nov 22 23:36:09 diningroom volumio[831]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) Nov 22 23:36:09 diningroom volumio[831]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Nov 22 23:36:09 diningroom volumio[831]: at Socket.emit (events.js:315:20) Nov 22 23:36:09 diningroom volumio[831]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Nov 22 23:36:09 diningroom volumio[831]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:66AfxLSuLInCyQWRdQpIO5"> Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Resolving uri "spotify:station:playlist:66AfxLSuLInCyQWRdQpIO5" Nov 22 23:36:09 diningroom volumio[1744]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQAr2O-EjMOH73XTEXJ9rnizidemT43h4TFn2YkudjVOmLKp7LeS7K0fcd3uwIaqm_hGmRnRChAccudf6WyE58VA-DHpaKHuuKX_duwUv_LzK2lCOuRCXnoZ5541FkiE6G3xUVAJpVky88G6hlOs6LlpXwXsTlgoFlEieO3HELHavDgfTqKWXOXCMBnK9Taw6BpQ-lQAo_V_vj2O8LUU", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Nov 22 23:36:10 diningroom volumio[1744]: [Vollibrespot] : Loading with Spotify URI Nov 22 23:36:10 diningroom volumio[1744]: [Vollibrespot] : Reducing normalisation factor to prevent clipping. Please add negative pregain to avoid. Nov 22 23:36:10 diningroom sudo[7771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-22 23:35 Nov 22 23:36:10 diningroom sudo[7771]: 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="e5f8795c07ba36ff2b02d7ba0a21c7a0f29b897e" VOLUMIO_FE_VERSION="473d8facbed5f9754db84a81b093baace7aa4b64" VOLUMIO_FE3_VERSION="934cddf6d46478e7a53a8d3664cd346f4de7cb34" VOLUMIO_BE_VERSION="359b2717b79cfc72b7d1c918d0fc2885a93bca70" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 24 Jan 2022 10:51:57 AM CET" VOLUMIO_VERSION="3.198" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="74e6a9ad035e912732893c8d6b060b17"