-- Logs begin at Fri 2024-05-03 09:18:02 CEST, end at Sun 2024-05-05 11:38:39 CEST. -- May 05 11:38:08 bachstream volumio[1246]: [Vollibrespot] : Loading with Spotify URI May 05 11:38:08 bachstream volumio[1246]: [Vollibrespot] : (165013 ms) loaded May 05 11:38:38 bachstream volumio[1246]: [Vollibrespot] : Event: Next { track_id: SpotifyId { id: 174339359536208248636191941808053724584, audio_type: Track } } May 05 11:38:38 bachstream volumio[1246]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 12679290956291482558487323373035427173, audio_type: Track }, track_id: SpotifyId { id: 174339359536208248636191941808053724584, audio_type: Track } } May 05 11:38:38 bachstream volumio[957]: [SpotifyConnect] One Of Them May 05 11:38:39 bachstream volumio[1246]: [Vollibrespot] : Event: SinkInactive May 05 11:38:39 bachstream volumio[1246]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 174339359536208248636191941808053724584, audio_type: Track } } May 05 11:38:39 bachstream volumio[957]: [SpotifyConnect] PlaybackInactive May 05 11:38:39 bachstream volumio[957]: info: [1714901919177] ControllerSpotify::pushState May 05 11:38:39 bachstream volumio[957]: info: CoreCommandRouter::servicePushState May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::pushState May 05 11:38:39 bachstream volumio[957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 11:38:39 bachstream volumio[957]: info: CoreCommandRouter::volumioPushState May 05 11:38:39 bachstream volumio[957]: info: CorePlayQueue::getTrack 0 May 05 11:38:39 bachstream volumio[957]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"One Of Them","artist":"Hey","album":"Fire","albumart":"https://i.scdn.co/image/ab67616d0000b2730531e1eb64fb0a2396170ba5","uri":"spotify:track:3Zuwk3NhFHxnW2oZVEbJQk","trackType":"spotify","seek":0,"duration":166,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"codec":"","repeatMode":"all"} May 05 11:38:39 bachstream volumio[957]: verbose: CURRENT POSITION 0 May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::syncState stateService stop May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::syncState currentStatus play May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::play index undefined May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::pushState May 05 11:38:39 bachstream volumio[957]: info: CoreCommandRouter::volumioPushState May 05 11:38:39 bachstream volumio[957]: info: CorePlayQueue::getTrack 1 May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::startPlaybackTimer May 05 11:38:39 bachstream volumio[957]: info: CorePlayQueue::getTrack 1 May 05 11:38:39 bachstream volumio[957]: info: [1714901919186] ControllerSpotify::clearAddPlayTrack May 05 11:38:39 bachstream volumio[957]: info: CoreCommandRouter::volumioGetQueue May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::getQueue May 05 11:38:39 bachstream volumio[957]: info: CorePlayQueue::getQueue May 05 11:38:39 bachstream volumio[957]: info: Setting this device active May 05 11:38:39 bachstream volumio[957]: info: Renewing Access Token via Daemon May 05 11:38:39 bachstream volumio[957]: error: Failed to play spotify track: TypeError: self.refreshAccessToken(...).then(...).fail(...).catch is not a function May 05 11:38:39 bachstream volumio[957]: info: CoreStateMachine::pushState May 05 11:38:39 bachstream volumio[957]: info: CoreCommandRouter::volumioPushState May 05 11:38:39 bachstream volumio[957]: info: touch_display: Setting screensaver timeout to 180 seconds. May 05 11:38:39 bachstream volumio[957]: info: Renewing Access Token via Daemon May 05 11:38:39 bachstream volumio[957]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 11:38:39 bachstream volumio[957]: TypeError: self.refreshAccessToken(...).then(...).fail(...).catch is not a function May 05 11:38:39 bachstream volumio[957]: at ControllerSpotify.spotifyCheckAccessToken (/data/plugins/music_service/spop/index.js:251:17) May 05 11:38:39 bachstream volumio[957]: at ControllerSpotify.isPlaybackFromConnectDevice (/data/plugins/music_service/spop/index.js:3115:14) May 05 11:38:39 bachstream volumio[957]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2323:22) May 05 11:38:39 bachstream volumio[957]: at listOnTimeout (internal/timers.js:554:17) May 05 11:38:39 bachstream volumio[957]: at processTimers (internal/timers.js:497:7) May 05 11:38:39 bachstream volumio[957]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 11:38:39 bachstream volumio[1246]: [Vollibrespot] : ReqToken May 05 11:38:39 bachstream sudo[31768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-05 11:37 May 05 11:38:39 bachstream sudo[31768]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"