-- Logs begin at Wed 2023-05-17 17:18:23 UTC, end at Tue 2024-04-23 22:02:41 UTC. --
Apr 23 22:02:27 minidsp-shd volumio[1714]: [Vollibrespot] : error sending packet Os { code: 1, kind: PermissionDenied, message: "Operation not permitted" }
Apr 23 22:02:39 minidsp-shd volumio[1714]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Authenticated as "a1sdf4qv7olvx652ns4xz8j0p" !
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Using alsa sink
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Metadata pipe established
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Country: "GB"
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Event: Volume { volume_to_mixer: 21626 }
Apr 23 22:02:40 minidsp-shd volumio[744]: [SpotifyConnect] Volume Spotify: 32.99916075379568 Volumio: 33
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Event: SessionActive { became_active_at: 1713909759307 }
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : SessionActive!
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Fetching autoplay context uri
Apr 23 22:02:40 minidsp-shd volumio[744]: [SpotifyConnect] A connect session has begun
Apr 23 22:02:40 minidsp-shd volumio[744]: info: Acquiring new spotify session
Apr 23 22:02:40 minidsp-shd volumio[744]: info: CoreCommandRouter::volumioStop
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 166429427381791888506933237899671859568, audio_type: Track } }
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 166429427381791888506933237899671859568, audio_type: Track } }
Apr 23 22:02:40 minidsp-shd volumio[744]: info: CoreStateMachine::stop
Apr 23 22:02:40 minidsp-shd volumio[744]: info: CoreStateMachine::serviceStop
Apr 23 22:02:40 minidsp-shd volumio[744]: info: CoreCommandRouter::serviceStop
Apr 23 22:02:40 minidsp-shd volumio[744]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 22:02:40 minidsp-shd volumio[744]: TypeError: Cannot read property 'then' of undefined
Apr 23 22:02:40 minidsp-shd volumio[744]: at SpotConnEvents.SpotConn.on (/data/plugins/music_service/spop/index.js:2095:31)
Apr 23 22:02:40 minidsp-shd volumio[744]: at emitNone (events.js:106:13)
Apr 23 22:02:40 minidsp-shd volumio[744]: at SpotConnEvents.emit (events.js:208:7)
Apr 23 22:02:40 minidsp-shd volumio[744]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16)
Apr 23 22:02:40 minidsp-shd volumio[744]: at Socket.SpotConnEvents._udpsource.on.msg (/data/plugins/music_service/spop/SpotConnController.js:15:12)
Apr 23 22:02:40 minidsp-shd volumio[744]: at emitTwo (events.js:126:13)
Apr 23 22:02:40 minidsp-shd volumio[744]: at Socket.emit (events.js:214:7)
Apr 23 22:02:40 minidsp-shd volumio[744]: at UDP.onMessage [as onmessage] (dgram.js:659:8)
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:4VCcqjOfYEJFv5rR2xZW1V">
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Resolving uri "spotify:station:playlist:4VCcqjOfYEJFv5rR2xZW1V"
Apr 23 22:02:40 minidsp-shd volumio[744]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 22:02:40 minidsp-shd vtcs[968]: [2024-04-23 22:02:40] [info] asio async_shutdown error: asio.misc:2 (End of file)
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQDyJ6lZzDWpKtr4sAwdCl30zO6-RkaV1v2qmM3GsjFd5bEHQmGdD4AATqFhqur-byhg2AlDymHtCOCIMN0A012gk1cr4Sr291q2MyboCoxVxmQaxIDUE5WdMyOlZ-gVx3Ff8Jmwll4bJsJxTiMNQGgstZpfKkQSBGEgnNnVIzPTTkTHoSruUqGGOre8x7dOoXVLexSyw_Y1xj-uxEUfd_u4_w", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } }
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Loading with Spotify URI
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : (354120 ms) loaded
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Event: SinkActive
Apr 23 22:02:40 minidsp-shd volumio[1714]: [Vollibrespot] : Resolved 50 tracks from <"spotify:playlist:4VCcqjOfYEJFv5rR2xZW1V">
Apr 23 22:02:41 minidsp-shd sudo[3966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 22:01
Apr 23 22:02:41 minidsp-shd sudo[3966]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="minidspshd"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Jul 26 13:26:42 CEST 2022"
VOLUMIO_VERSION="1.125"
VOLUMIO_HARDWARE="nanopineo2"
VOLUMIO_VENDOR="miniDSP"
VOLUMIO_MODEL="SHD"
VOLUMIO_VENDOR_MODEL="miniDSP SHD"
VOLUMIO_HASH="9c17c7c45298f5ca9f5ec80e116295fd"