-- Logs begin at Wed 2024-08-07 04:14:17 UTC, end at Wed 2024-09-04 17:48:41 UTC. -- Sep 04 17:48:12 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::servicePushState Sep 04 17:48:12 volumiowohnzimmer volumio[856]: info: CoreStateMachine::pushState Sep 04 17:48:12 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 17:48:12 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioPushState Sep 04 17:48:23 volumiowohnzimmer volumio[856]: verbose: New Socket.io Connection to 192.168.178.41 from 192.168.178.123 UA: Mozilla/5.0 (Linux; Android 14; SM-S711B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioGetState Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: Received Get System Info Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: Discovery: Getting this device information Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioGetState Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioGetState Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: Listing playlists Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioGetQueue Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreStateMachine::getQueue Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CorePlayQueue::getQueue Sep 04 17:48:23 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 17:48:40 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Connecting to AP "ap2-gew4.spotify.com:443" Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Authenticated as "lsbhhixyjsen5v2myc9cmhqa5" ! Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Using alsa sink Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Country: "DE" Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Metadata pipe established Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: Volume { volume_to_mixer: 65535 } Sep 04 17:48:41 volumiowohnzimmer volumio[856]: [SpotifyConnect] Volume Spotify: 100 Volumio: 100 Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: SessionActive { became_active_at: 1725472121373 } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : SessionActive! Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Fetching autoplay context uri Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 22606419245784167909426566964751514820, audio_type: Track } } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 22606419245784167909426566964751514820, audio_type: Track } } Sep 04 17:48:41 volumiowohnzimmer volumio[856]: [SpotifyConnect] A connect session has begun Sep 04 17:48:41 volumiowohnzimmer volumio[856]: info: Acquiring new spotify session Sep 04 17:48:41 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::volumioStop Sep 04 17:48:41 volumiowohnzimmer volumio[856]: info: CoreStateMachine::stop Sep 04 17:48:41 volumiowohnzimmer volumio[856]: info: CoreStateMachine::serviceStop Sep 04 17:48:41 volumiowohnzimmer volumio[856]: info: CoreCommandRouter::serviceStop Sep 04 17:48:41 volumiowohnzimmer volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 17:48:41 volumiowohnzimmer volumio[856]: TypeError: Cannot read property 'then' of undefined Sep 04 17:48:41 volumiowohnzimmer volumio[856]: at SpotConnEvents. (/data/plugins/music_service/spop/index.js:2132:31) Sep 04 17:48:41 volumiowohnzimmer volumio[856]: at SpotConnEvents.emit (events.js:315:20) Sep 04 17:48:41 volumiowohnzimmer volumio[856]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:92:16) Sep 04 17:48:41 volumiowohnzimmer volumio[856]: at Socket. (/data/plugins/music_service/spop/SpotConnController.js:15:12) Sep 04 17:48:41 volumiowohnzimmer volumio[856]: at Socket.emit (events.js:315:20) Sep 04 17:48:41 volumiowohnzimmer volumio[856]: at UDP.onMessage [as onmessage] (dgram.js:919:8) Sep 04 17:48:41 volumiowohnzimmer volumio[856]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:6LdooqvsV47MzmiI3eHIWh"> Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Resolving uri "spotify:station:playlist:6LdooqvsV47MzmiI3eHIWh" Sep 04 17:48:41 volumiowohnzimmer vtcs[1687]: [2024-09-04 17:48:41] [info] asio async_shutdown error: asio.misc:2 (End of file) Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQCOkPrDNl7teBTiss_yfsT4TML2uzpiJ6QuE4E61xregReFuKrKzb3-wqBu8DiHVsceCigsQydQCothjmA8su3iK53Z6_68nZewdPr-WkVQmgYS6OJxcrRaUIJaHXmP5t5UiNlor9u0Omvh1RozZUjPB_uyX9WL0SygB2ubc-mH3BMIXOv158yaXW73bPhNk-H1dL9Xu1RAE1vRaXkE7Wyh5uGqE1lrow", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Loading with Spotify URI Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : channel error: 2 0 Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load encrypted file. Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: Skipping to next track Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 22606419245784167909426566964751514820, audio_type: Track }, track_id: SpotifyId { id: 320215944868489047594398556879054163172, audio_type: Track } } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Loading with Spotify URI Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : channel error: 2 0 Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load encrypted file. Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: Skipping to next track Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Loading with Spotify URI Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 320215944868489047594398556879054163172, audio_type: Track } } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: Next { track_id: SpotifyId { id: 320215944868489047594398556879054163172, audio_type: Track } } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 320215944868489047594398556879054163172, audio_type: Track }, track_id: SpotifyId { id: 186166521452657140964725732323204414883, audio_type: Track } } Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : channel error: 2 0 Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load encrypted file. Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: Skipping to next track Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Loading with Spotify URI Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : channel error: 2 0 Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load encrypted file. Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Unable to load Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: Skipping to next track Sep 04 17:48:41 volumiowohnzimmer volumio[2763]: [Vollibrespot] : Loading with Spotify URI Sep 04 17:48:41 volumiowohnzimmer sudo[3415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 17:47 Sep 04 17:48:41 volumiowohnzimmer sudo[3415]: 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"