-- Logs begin at Thu 2024-04-25 21:16:58 UTC, end at Sun 2024-04-28 12:09:54 UTC. --
Apr 28 12:08:22 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:08:22 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:08:22 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:08:22 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:08:23 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:08:23 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:08:23 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:08:23 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:08:27 volumio vtcs[1430]: [2024-04-28 12:08:27] [info] asio async_shutdown error: asio.misc:2 (End of file)
Apr 28 12:08:30 volumio volumio[999]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 28 12:08:30 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 28 12:08:30 volumio volumio[999]: info: CoreCommandRouter::volumioGetState
Apr 28 12:08:30 volumio volumio[999]: info: CoreCommandRouter::volumioGetQueue
Apr 28 12:08:30 volumio volumio[999]: info: CoreStateMachine::getQueue
Apr 28 12:08:30 volumio volumio[999]: info: CorePlayQueue::getQueue
Apr 28 12:08:30 volumio volumio[999]: info: Listing playlists
Apr 28 12:08:30 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 28 12:08:33 volumio volumio[1183]: [Vollibrespot] : couldn't parse packet from V4(192.168.1.104:5353): query type 65 is invalid
Apr 28 12:08:34 volumio volumio[1183]: [Vollibrespot] : couldn't parse packet from V4(192.168.1.104:5353): query type 65 is invalid
Apr 28 12:08:38 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:08:38 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:08:38 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:08:38 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:08:44 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:08:44 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:08:44 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:08:44 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:08:46 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:08:46 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:08:46 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:08:46 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:09:00 volumio vtcs[1430]: [2024-04-28 12:09:00] [info] asio async_shutdown error: asio.misc:2 (End of file)
Apr 28 12:09:00 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:09:00 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:09:00 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:09:00 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:09:01 volumio volumio[999]: info: CoreCommandRouter::servicePushState
Apr 28 12:09:01 volumio volumio[999]: info: CoreStateMachine::pushState
Apr 28 12:09:01 volumio volumio[999]: info: CoreCommandRouter::volumioPushState
Apr 28 12:09:01 volumio volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 28 12:09:02 volumio vtcs[1430]: [2024-04-28 12:09:02] [info] asio async_shutdown error: asio.misc:2 (End of file)
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Fetching autoplay context uri
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Event: SessionActive { became_active_at: 1714306194476 }
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : SessionActive!
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 333846378101376466441294396327100009620, audio_type: Track } }
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 333846378101376466441294396327100009620, audio_type: Track } }
Apr 28 12:09:54 volumio volumio[999]: [SpotifyConnect] A connect session has begun
Apr 28 12:09:54 volumio volumio[999]: info: Acquiring new spotify session
Apr 28 12:09:54 volumio volumio[999]: info: CoreCommandRouter::volumioStop
Apr 28 12:09:54 volumio volumio[999]: info: CoreStateMachine::stop
Apr 28 12:09:54 volumio volumio[999]: info: CoreStateMachine::serviceStop
Apr 28 12:09:54 volumio volumio[999]: info: CoreCommandRouter::serviceStop
Apr 28 12:09:54 volumio volumio[999]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 28 12:09:54 volumio volumio[999]: TypeError: Cannot read property 'then' of undefined
Apr 28 12:09:54 volumio volumio[999]: at SpotConnEvents.SpotConn.on (/data/plugins/music_service/spop/index.js:2095:31)
Apr 28 12:09:54 volumio volumio[999]: at emitNone (events.js:106:13)
Apr 28 12:09:54 volumio volumio[999]: at SpotConnEvents.emit (events.js:208:7)
Apr 28 12:09:54 volumio volumio[999]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16)
Apr 28 12:09:54 volumio volumio[999]: at Socket.SpotConnEvents._udpsource.on.msg (/data/plugins/music_service/spop/SpotConnController.js:15:12)
Apr 28 12:09:54 volumio volumio[999]: at emitTwo (events.js:126:13)
Apr 28 12:09:54 volumio volumio[999]: at Socket.emit (events.js:214:7)
Apr 28 12:09:54 volumio volumio[999]: at UDP.onMessage [as onmessage] (dgram.js:659:8)
Apr 28 12:09:54 volumio volumio[999]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:album:6frjpRu2P0fdF9xSS9stjY">
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Resolving uri "spotify:station:album:6frjpRu2P0fdF9xSS9stjY"
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQBeMQNSFLczoChIauLjEQBNWKxVz7-qE2OL6JfEOnBa8zTfkoJi8ZWhnNG7oIh-PovQiLAufmUaezweTxjAh1Rr2hA0BGWF_KW0u5bjCFccExEHSCKCy019XLQWsZDM7OeKlEjkITIDDVdLoDrBsSrrljQeGI8hBScdg3-LtDQ6gDXy_Sbqr2ZLpYE59L6B5Jf2u315", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } }
Apr 28 12:09:54 volumio volumio[27627]: [Vollibrespot] : Loading with Spotify URI
Apr 28 12:09:54 volumio sudo[30111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 12:08
Apr 28 12:09:54 volumio sudo[30111]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="cd11dc738d0d82822d0aa776d0729686b82e3758"
VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6"
VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021"
VOLUMIO_VERSION="2.907"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"