-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-04-13 15:32:42 UTC. --
Apr 13 15:32:37 volumio-gp volumio[893]: info: CoreCommandRouter::servicePushState
Apr 13 15:32:37 volumio-gp volumio[893]: info: CoreStateMachine::pushState
Apr 13 15:32:37 volumio-gp volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 15:32:37 volumio-gp volumio[893]: info: CoreCommandRouter::volumioPushState
Apr 13 15:32:41 volumio-gp volumio[1022]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Apr 13 15:32:41 volumio-gp volumio[1022]: [Vollibrespot] : Authenticated as "31x5tjvidsoszdh24rdwt6fh7zhm" !
Apr 13 15:32:41 volumio-gp volumio[1022]: [Vollibrespot] : Using alsa sink
Apr 13 15:32:41 volumio-gp volumio[1022]: [Vollibrespot] : Metadata pipe established
Apr 13 15:32:41 volumio-gp volumio[1022]: [Vollibrespot] : Event: Volume { volume_to_mixer: 55050 }
Apr 13 15:32:41 volumio-gp volumio[1022]: [Vollibrespot] : Country: "PT"
Apr 13 15:32:41 volumio-gp volumio[893]: [SpotifyConnect] Volume Spotify: 84.0009155413138 Volumio: 84
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : Fetching autoplay context uri
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : Event: SessionActive { became_active_at: 1713022362307 }
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : SessionActive!
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 109463673064290640708684375899310891479, audio_type: Track } }
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 109463673064290640708684375899310891479, audio_type: Track } }
Apr 13 15:32:42 volumio-gp volumio[893]: [SpotifyConnect] A connect session has begun
Apr 13 15:32:42 volumio-gp volumio[893]: info: Acquiring new spotify session
Apr 13 15:32:42 volumio-gp volumio[893]: info: CoreCommandRouter::volumioStop
Apr 13 15:32:42 volumio-gp volumio[893]: info: CoreStateMachine::stop
Apr 13 15:32:42 volumio-gp volumio[893]: info: CoreStateMachine::serviceStop
Apr 13 15:32:42 volumio-gp volumio[893]: info: CoreCommandRouter::serviceStop
Apr 13 15:32:42 volumio-gp volumio[893]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 13 15:32:42 volumio-gp volumio[893]: TypeError: Cannot read property 'then' of undefined
Apr 13 15:32:42 volumio-gp volumio[893]: at SpotConnEvents. (/data/plugins/music_service/spop/index.js:2111:31)
Apr 13 15:32:42 volumio-gp volumio[893]: at SpotConnEvents.emit (events.js:315:20)
Apr 13 15:32:42 volumio-gp volumio[893]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16)
Apr 13 15:32:42 volumio-gp volumio[893]: at Socket. (/data/plugins/music_service/spop/SpotConnController.js:15:12)
Apr 13 15:32:42 volumio-gp volumio[893]: at Socket.emit (events.js:315:20)
Apr 13 15:32:42 volumio-gp volumio[893]: at UDP.onMessage [as onmessage] (dgram.js:919:8)
Apr 13 15:32:42 volumio-gp volumio[893]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 13 15:32:42 volumio-gp vtcs[1308]: [2024-04-13 15:32:42] [info] asio async_shutdown error: asio.misc:2 (End of file)
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=spotify:search:halloween+crescer
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : AutoplayError: MercuryError
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQD1Mcd1K4pVCkstE_QT_MfdbMz-_G6l1v9WIEWvORvAhWsgc1etPcISk1LPVhIfaMMblL-aPs5txGi1lQFYmzTL46Olhhv9CVzxmG27XMTgjxRDujsdqtx6wwijx0WFllMmChlBhDV33kD3ueRsFD3nYdAaE2wPRuWHgoZJOlIeIt8nRVL8I_hyFQzYZx75GWzAyUnbFeWsGyIJicR4RTVXwSinqA", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } }
Apr 13 15:32:42 volumio-gp volumio[1022]: [Vollibrespot] : Loading with Spotify URI
Apr 13 15:32:42 volumio-gp vtcs[1308]: [2024-04-13 15:32:42.620] [tisoc] [warning] [PlaybackControllerImpl.cpp:501] Illegal state:0
Apr 13 15:32:42 volumio-gp sudo[2218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-13 15:31
Apr 13 15:32:42 volumio-gp sudo[2218]: 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="f8baf7ad070f376535a93fcc6590774528ddb153"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET"
VOLUMIO_VERSION="3.611"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"