-- Logs begin at Thu 2024-10-03 15:07:45 UTC, end at Thu 2024-10-03 15:11:16 UTC. -- Oct 03 15:10:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:00 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 03 15:10:00 jklmusic volumio[1085]: info: In handleBrowseUri, curUri=spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 Oct 03 15:10:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:02 jklmusic kernel: Voltage normalised (0x00000000) Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::ClearQueue Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:02 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::addQueueItems Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::addQueueItems Oct 03 15:10:02 jklmusic volumio[1085]: info: Adding Item to queue: spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 Oct 03 15:10:02 jklmusic volumio[1085]: info: Exploding uri spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 in service spop Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:02 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:02 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:02 jklmusic volumio[1085]: [SpotifyConnect] pause Oct 03 15:10:02 jklmusic volumio[1305]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 256321479350166866420719291536901134821, audio_type: Track }, position_ms: 125408 } Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPlay Oct 03 15:10:02 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:10:02 jklmusic volumio[1085]: [SpotifyConnect] unSetVolatile called Oct 03 15:10:02 jklmusic volumio[1085]: info: Spotify Unset Volatile called Oct 03 15:10:02 jklmusic volumio[1085]: [SpotifyConnect] Relinquishing Volumio State to another service Oct 03 15:10:02 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::play index 0 Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:02 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::stPlaybackTimer Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 03 15:10:02 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:02 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:03 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:03 jklmusic volumio[1085]: [SpotifyConnect] An Overture To Moves Oct 03 15:10:03 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : Event: SinkInactive Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 256321479350166866420719291536901134821, audio_type: Track } } Oct 03 15:10:03 jklmusic volumio[1085]: [SpotifyConnect] Sink released Oct 03 15:10:03 jklmusic volumio[1085]: info: [1727968203228] ControllerSpotify::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"An Overture To Moves","artist":"Coffee Jazz Melody","album":"Sunday Childhood","albumart":"https://i.scdn.co/image/ab67616d0000b27323bda2a88df5e040039c5b7c","uri":"spotify:track:5RScfOWfJiUzZDmhiI2RTf","trackType":"spotify","seek":125408,"duration":302,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:03 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: info: No code Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:03 jklmusic volumio[1085]: [SpotifyConnect] Device palyback is inactive Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::play index undefined Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::startPlaybackTimer Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: [1727968203496] ControllerSpotify::clearAddPlayTrack Oct 03 15:10:03 jklmusic volumio[1085]: info: Setting this device active Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : Fetching autoplay context uri Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 256321479350166866420719291536901134821, audio_type: Track }, track_id: SpotifyId { id: 256321479350166866420719291536901134821, audio_type: Track } } Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri= Oct 03 15:10:03 jklmusic volumio[1305]: [Vollibrespot] : AutoplayError: MercuryError Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: Is Not Connect Playback Oct 03 15:10:03 jklmusic volumio[1085]: info: [1727968203846] ControllerSpotify::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"An Overture To Moves","artist":"Coffee Jazz Melody","album":"Sunday Childhood","albumart":"https://i.scdn.co/image/ab67616d0000b27323bda2a88df5e040039c5b7c","uri":"spotify:track:5RScfOWfJiUzZDmhiI2RTf","trackType":"spotify","seek":125408,"duration":302,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:03 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: info: No code Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:03 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : Fetching autoplay context uri Oct 03 15:10:04 jklmusic kernel: Under-voltage detected! (0x00050005) Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri= Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : AutoplayError: MercuryError Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : Loading with Spotify URI Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1085]: [SpotifyConnect] An Overture To Moves Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 256321479350166866420719291536901134821, audio_type: Track } } Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 256321479350166866420719291536901134821, audio_type: Track }, track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:04 jklmusic volumio[1085]: info: [1727968204262] ControllerSpotify::pushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"An Overture To Moves","artist":"Coffee Jazz Melody","album":"Sunday Childhood","albumart":"https://i.scdn.co/image/ab67616d0000b27323bda2a88df5e040039c5b7c","uri":"spotify:track:5RScfOWfJiUzZDmhiI2RTf","trackType":"spotify","seek":0,"duration":302,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:04 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:04 jklmusic volumio[1085]: info: No code Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:04 jklmusic volumio[1085]: [SpotifyConnect] Device palyback is inactive Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : (182280 ms) loaded Oct 03 15:10:04 jklmusic kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:04 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:04 jklmusic volumio[1085]: [SpotifyConnect] Pleasure Shop Oct 03 15:10:04 jklmusic volumio[1305]: [Vollibrespot] : Event: SinkActive Oct 03 15:10:04 jklmusic volumio[1085]: [SpotifyConnect] Sink acquired Oct 03 15:10:04 jklmusic volumio[1085]: info: Continuing Spotify Session Oct 03 15:10:04 jklmusic volumio[1085]: info: Checking Spotify Web API Oct 03 15:10:04 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Active Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:04 jklmusic volumio[1085]: info: [1727968204694] ControllerSpotify::pushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: Is Not Connect Playback Oct 03 15:10:05 jklmusic volumio[1085]: info: [1727968205448] ControllerSpotify::pushState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::ClearQueue Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::addQueueItems Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::addQueueItems Oct 03 15:10:07 jklmusic volumio[1085]: info: Adding Item to queue: spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 Oct 03 15:10:07 jklmusic volumio[1085]: info: Exploding uri spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 in service spop Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:07 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:07 jklmusic volumio[1305]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track }, position_ms: 3350 } Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] pause Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPlay Oct 03 15:10:07 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] unSetVolatile called Oct 03 15:10:07 jklmusic volumio[1085]: info: Spotify Unset Volatile called Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] Relinquishing Volumio State to another service Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::play index 0 Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:07 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::stPlaybackTimer Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:07 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:07 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Pleasure Shop Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::play index undefined Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::startPlaybackTimer Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: [1727968208353] ControllerSpotify::clearAddPlayTrack Oct 03 15:10:08 jklmusic volumio[1085]: info: Setting this device active Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Event: SinkInactive Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Sink released Oct 03 15:10:08 jklmusic volumio[1085]: info: [1727968208367] ControllerSpotify::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Pleasure Shop","artist":"KEY","album":"Pleasure Shop - The 3rd Mini Album","albumart":"https://i.scdn.co/image/ab67616d0000b273cdd2d7af5d636ec8668138b1","uri":"spotify:track:2022n4pxaEaDC2YvzVl1w7","trackType":"spotify","seek":3350,"duration":183,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:08 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:08 jklmusic volumio[1085]: info: No code Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Device palyback is inactive Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Fetching autoplay context uri Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track }, track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri= Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : AutoplayError: MercuryError Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Fetching autoplay context uri Oct 03 15:10:08 jklmusic kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Pleasure Shop Oct 03 15:10:08 jklmusic volumio[1085]: info: [1727968208965] ControllerSpotify::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track }, track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Pleasure Shop","artist":"KEY","album":"Pleasure Shop - The 3rd Mini Album","albumart":"https://i.scdn.co/image/ab67616d0000b273cdd2d7af5d636ec8668138b1","uri":"spotify:track:2022n4pxaEaDC2YvzVl1w7","trackType":"spotify","seek":0,"duration":183,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:08 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:08 jklmusic volumio[1085]: info: No code Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:08 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:08 jklmusic volumio[1085]: [SpotifyConnect] Device palyback is inactive Oct 03 15:10:08 jklmusic volumio[1305]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri= Oct 03 15:10:09 jklmusic volumio[1305]: [Vollibrespot] : AutoplayError: MercuryError Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:09 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:09 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:09 jklmusic volumio[1305]: [Vollibrespot] : Event: SinkActive Oct 03 15:10:09 jklmusic volumio[1085]: [SpotifyConnect] Pleasure Shop Oct 03 15:10:09 jklmusic volumio[1085]: info: [1727968209353] ControllerSpotify::pushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:09 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:09 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Pleasure Shop","artist":"KEY","album":"Pleasure Shop - The 3rd Mini Album","albumart":"https://i.scdn.co/image/ab67616d0000b273cdd2d7af5d636ec8668138b1","uri":"spotify:track:2022n4pxaEaDC2YvzVl1w7","trackType":"spotify","seek":0,"duration":183,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:09 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:09 jklmusic volumio[1085]: info: No code Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:09 jklmusic volumio[1085]: [SpotifyConnect] Sink acquired Oct 03 15:10:09 jklmusic volumio[1085]: info: Continuing Spotify Session Oct 03 15:10:09 jklmusic volumio[1085]: info: Checking Spotify Web API Oct 03 15:10:09 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Active Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:09 jklmusic volumio[1085]: info: [1727968209389] ControllerSpotify::pushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:16 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:16 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:16 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:16 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:16 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:17 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:17 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:17 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:17 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:17 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:18 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:18 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:18 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:18 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:18 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:19 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:19 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:19 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:19 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:20 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:20 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:20 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:20 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:20 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:21 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:21 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:21 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:21 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:21 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:22 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:22 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:22 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:22 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:22 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:23 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:23 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:23 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:24 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:24 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:24 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:24 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:24 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:25 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:25 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:25 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:25 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:25 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:26 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:26 jklmusic volumio[1305]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:10:26 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:26 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:26 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:27 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:27 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:27 jklmusic volumio[1305]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:10:27 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:27 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 03 15:10:27 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:27 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:28 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:29 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:29 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:29 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:29 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:30 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:30 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:30 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:30 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:30 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:31 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:31 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:31 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:31 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:31 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:32 jklmusic volumio[1305]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:32 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:33 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:33 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:33 jklmusic volumio[1305]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:10:33 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:33 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:33 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:34 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:34 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:34 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:34 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:34 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:35 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:35 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:35 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:35 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:36 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:36 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:36 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:36 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:36 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:37 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:37 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:37 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:37 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:37 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:38 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:38 jklmusic volumio[1305]: [Vollibrespot] : Pause Oct 03 15:10:38 jklmusic volumio[1085]: [SpotifyConnect] Pause Oct 03 15:10:38 jklmusic volumio[1305]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track }, position_ms: 29435 } Oct 03 15:10:38 jklmusic volumio[1085]: [SpotifyConnect] pause Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:38 jklmusic volumio[1085]: [SpotifyConnect] Pleasure Shop Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:38 jklmusic sudo[1937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop nanosoundcd_progressweb Oct 03 15:10:38 jklmusic sudo[1937]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:38 jklmusic systemd[1]: Stopping NanoSound CD Progress Web Service... Oct 03 15:10:38 jklmusic sudo[627]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:38 jklmusic systemd[1]: Stopped NanoSound CD Progress Web Service. Oct 03 15:10:38 jklmusic sudo[1937]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:38 jklmusic volumio[1305]: [Vollibrespot] : Event: SinkInactive Oct 03 15:10:38 jklmusic volumio[1085]: [SpotifyConnect] Sink released Oct 03 15:10:38 jklmusic volumio[1085]: info: [1727968238947] ControllerSpotify::pushState Oct 03 15:10:38 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:38 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 0 Oct 03 15:10:38 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Pleasure Shop","artist":"KEY","album":"Pleasure Shop - The 3rd Mini Album","albumart":"https://i.scdn.co/image/ab67616d0000b273cdd2d7af5d636ec8668138b1","uri":"spotify:track:2022n4pxaEaDC2YvzVl1w7","trackType":"spotify","seek":29435,"duration":183,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:38 jklmusic volumio[1085]: verbose: CURRENT POSITION 0 Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus play Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::play index undefined Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:38 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 1 Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::startPlaybackTimer Oct 03 15:10:38 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 1 Oct 03 15:10:38 jklmusic volumio[1085]: info: [1727968238976] ControllerSpotify::clearAddPlayTrack Oct 03 15:10:38 jklmusic volumio[1085]: info: Setting this device active Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:38 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:39 jklmusic volumio[1085]: [SpotifyConnect] Device palyback is inactive Oct 03 15:10:39 jklmusic sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop nanosoundcd_web Oct 03 15:10:39 jklmusic sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:39 jklmusic systemd[1]: Stopping NanoSound CD Web Service... Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic sudo[636]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:39 jklmusic sudo[1950]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:39 jklmusic systemd[1]: Stopped NanoSound CD Web Service. Oct 03 15:10:39 jklmusic volumio[1085]: info: NanoSound CD daemon stopped Oct 03 15:10:39 jklmusic volumio[1085]: info: Disabling plugin nanosound_cd Oct 03 15:10:39 jklmusic volumio[1085]: info: Done. Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : Fetching autoplay context uri Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track }, track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri= Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : AutoplayError: MercuryError Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : Fetching autoplay context uri Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri= Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : AutoplayError: MercuryError Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : Loading with Spotify URI Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track } } Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : Event: TrackChanged { old_track_id: SpotifyId { id: 87371662800728616247950609914293044243, audio_type: Track }, track_id: SpotifyId { id: 172664509862673176711759516398571482862, audio_type: Track } } Oct 03 15:10:39 jklmusic volumio[1085]: [SpotifyConnect] Pleasure Shop Oct 03 15:10:39 jklmusic volumio[1085]: info: [1727968239633] ControllerSpotify::pushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:39 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 1 Oct 03 15:10:39 jklmusic volumio[1085]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Pleasure Shop","artist":"KEY","album":"Pleasure Shop - The 3rd Mini Album","albumart":"https://i.scdn.co/image/ab67616d0000b273cdd2d7af5d636ec8668138b1","uri":"spotify:track:2022n4pxaEaDC2YvzVl1w7","trackType":"spotify","seek":0,"duration":183,"samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","channels":2,"stream":false,"repeatMode":"all"} Oct 03 15:10:39 jklmusic volumio[1085]: verbose: CURRENT POSITION 1 Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreStateMachine::syncState stateService stop Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreStateMachine::syncState currentStatus stop Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:39 jklmusic volumio[1085]: info: No code Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:39 jklmusic volumio[1085]: [SpotifyConnect] Device palyback is inactive Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 03 15:10:39 jklmusic volumio[1305]: [Vollibrespot] : (187507 ms) loaded Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:39 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1305]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 172664509862673176711759516398571482862, audio_type: Track } } Oct 03 15:10:40 jklmusic volumio[1085]: [SpotifyConnect] SOS Oct 03 15:10:40 jklmusic volumio[1305]: [Vollibrespot] : Event: SinkActive Oct 03 15:10:40 jklmusic volumio[1085]: [SpotifyConnect] Sink acquired Oct 03 15:10:40 jklmusic volumio[1085]: info: Continuing Spotify Session Oct 03 15:10:40 jklmusic volumio[1085]: info: Checking Spotify Web API Oct 03 15:10:40 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Active Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 03 15:10:40 jklmusic volumio[1085]: info: [1727968240019] ControllerSpotify::pushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: Enabling plugin nanosound_cd Oct 03 15:10:40 jklmusic volumio[1085]: info: Loading plugin "nanosound_cd"... Oct 03 15:10:40 jklmusic volumio[1085]: info: Applying required configuration parameters for plugin nanosound_cd Oct 03 15:10:40 jklmusic volumio[1085]: info: PLUGIN START: nanosound_cd Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 15:10:40 jklmusic volumio[1085]: info: [1727968240267] CoreMusicLibrary::Adding element NanoSound CD Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:10:40 jklmusic sudo[1979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start nanosoundcd_progressweb Oct 03 15:10:40 jklmusic sudo[1979]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:40 jklmusic systemd[1]: Starting NanoSound CD Progress Web Service... Oct 03 15:10:40 jklmusic systemd[1]: Started NanoSound CD Progress Web Service. Oct 03 15:10:40 jklmusic sudo[1979]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:40 jklmusic sudo[1987]: root : TTY=unknown ; PWD=/home/volumio/nanomesher_nanosoundcd ; USER=root ; COMMAND=/usr/bin/python -c import ripprogress_web; ripprogress_web.main() Oct 03 15:10:40 jklmusic sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:40 jklmusic sudo[1992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start nanosoundcd_web Oct 03 15:10:40 jklmusic sudo[1992]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:40 jklmusic systemd[1]: Starting NanoSound CD Web Service... Oct 03 15:10:40 jklmusic systemd[1]: Started NanoSound CD Web Service. Oct 03 15:10:40 jklmusic sudo[1992]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:40 jklmusic volumio[1085]: info: NanoSound CD daemon started Oct 03 15:10:40 jklmusic volumio[1085]: info: Done. Oct 03 15:10:40 jklmusic sudo[2005]: root : TTY=unknown ; PWD=/home/volumio/nanomesher_nanosoundcd ; USER=root ; COMMAND=/usr/bin/python -c import nanosoundcd_web; nanosoundcd_web.main() Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic sudo[2005]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: Is Not Connect Playback Oct 03 15:10:40 jklmusic volumio[1085]: info: [1727968240724] ControllerSpotify::pushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::servicePushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:40 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:41 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:41 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:41 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:41 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:10:42 jklmusic volumio[1085]: [SpotifyConnect] Closing metadata listener Oct 03 15:10:42 jklmusic volumio[1085]: info: Disabling plugin spop Oct 03 15:10:42 jklmusic volumio[1085]: info: Done. Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:42 jklmusic sudo[2037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Oct 03 15:10:42 jklmusic sudo[2037]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:42 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:10:42 jklmusic systemd[1]: Stopped Volspotconnect2 Daemon. Oct 03 15:10:42 jklmusic sudo[2037]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:42 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Daemon service stoped! Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:42 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:43 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:43 jklmusic volumio[1085]: [SpotifyConnect] Stopping Vollibrespot daemon Oct 03 15:10:43 jklmusic volumio[1085]: [SpotifyConnect] Closing metadata listener Oct 03 15:10:43 jklmusic volumio[1085]: info: Disabling plugin volspotconnect2 Oct 03 15:10:43 jklmusic volumio[1085]: info: Done. Oct 03 15:10:43 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:43 jklmusic sudo[2047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect2.service Oct 03 15:10:43 jklmusic sudo[2047]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:43 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:10:43 jklmusic systemd[1]: Stopped Volspotconnect2 Daemon. Oct 03 15:10:43 jklmusic sudo[2047]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:43 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Daemon service stoped! Oct 03 15:10:43 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:43 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:44 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:44 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:44 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:44 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:44 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:45 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:45 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:45 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:45 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:45 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:46 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:46 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:46 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:46 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:46 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:47 jklmusic volumio[1085]: info: Enabling plugin volspotconnect2 Oct 03 15:10:47 jklmusic volumio[1085]: info: Loading plugin "volspotconnect2"... Oct 03 15:10:47 jklmusic volumio[1085]: info: PLUGIN START: volspotconnect2 Oct 03 15:10:47 jklmusic volumio[1085]: [SpotifyConnect] Creating VLS config file Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:47 jklmusic volumio[1085]: [SpotifyConnect] Starting metadata listener Oct 03 15:10:47 jklmusic sudo[2065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Oct 03 15:10:47 jklmusic sudo[2065]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:47 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:10:47 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:10:47 jklmusic sudo[2065]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:47 jklmusic volumio[2070]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Oct 03 15:10:47 jklmusic volumio[2070]: Reading Config from "volspotify.toml" Oct 03 15:10:47 jklmusic volumio[2070]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:10:47 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 03 15:10:47 jklmusic volumio[1085]: [Metrics] SpotifyConnect: 0s 55.65ms Oct 03 15:10:47 jklmusic volumio[1085]: info: Done. Oct 03 15:10:47 jklmusic volumio[2070]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:47 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:48 jklmusic volumio[1085]: info: Enabling plugin spop Oct 03 15:10:48 jklmusic volumio[1085]: info: Loading plugin "spop"... Oct 03 15:10:48 jklmusic volumio[1085]: info: PLUGIN START: spop Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 03 15:10:48 jklmusic volumio[1085]: [SpotifyConnect] Creating VLS config file Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:10:48 jklmusic volumio[1085]: [SpotifyConnect] Starting metadata listener Oct 03 15:10:48 jklmusic sudo[2078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 03 15:10:48 jklmusic volumio[1085]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Oct 03 15:10:48 jklmusic volumio[1085]: at Object._errnoException (util.js:1022:11) Oct 03 15:10:48 jklmusic volumio[1085]: at _exceptionWithHostPort (util.js:1044:20) Oct 03 15:10:48 jklmusic volumio[1085]: at _handle.lookup (dgram.js:266:18) Oct 03 15:10:48 jklmusic volumio[1085]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Oct 03 15:10:48 jklmusic volumio[1085]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 03 15:10:48 jklmusic sudo[2078]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:48 jklmusic volumio[1085]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Oct 03 15:10:48 jklmusic volumio[1085]: at Socket.onListenError (dgram.js:362:22) Oct 03 15:10:48 jklmusic volumio[1085]: at Object.onceWrapper (events.js:315:30) Oct 03 15:10:48 jklmusic volumio[1085]: at emitOne (events.js:121:20) Oct 03 15:10:48 jklmusic volumio[1085]: at Socket.emit (events.js:211:7) Oct 03 15:10:48 jklmusic volumio[1085]: at _handle.lookup (dgram.js:267:14) Oct 03 15:10:48 jklmusic volumio[1085]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Oct 03 15:10:48 jklmusic volumio[1085]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 03 15:10:48 jklmusic sudo[2078]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:48 jklmusic sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Oct 03 15:10:48 jklmusic sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:10:48 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:48 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:10:48 jklmusic sudo[2082]: pam_unix(sudo:session): session closed for user root Oct 03 15:10:48 jklmusic volumio[2092]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:10:48 jklmusic volumio[2092]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:10:48 jklmusic volumio[1085]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 03 15:10:48 jklmusic volumio[1085]: [Metrics] SpotifyConnect: 0s 138.29ms Oct 03 15:10:48 jklmusic volumio[1085]: info: Done. Oct 03 15:10:48 jklmusic volumio[2092]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:10:48 jklmusic volumio[2092]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:48 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:49 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:49 jklmusic volumio[2092]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:10:49 jklmusic volumio[2092]: stack backtrace: Oct 03 15:10:49 jklmusic volumio[2092]: 0: 0x989c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:10:49 jklmusic volumio[2092]: 1: 0x989c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:10:49 jklmusic volumio[2092]: 2: 0x989c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:10:49 jklmusic volumio[2092]: 3: 0x989c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:10:49 jklmusic volumio[2092]: 4: 0x9afd68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:10:49 jklmusic volumio[2092]: 5: 0x9835d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:10:49 jklmusic volumio[2092]: 6: 0x98b728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:10:49 jklmusic volumio[2092]: 7: 0x98b728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:10:49 jklmusic volumio[2092]: 8: 0x98b728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:10:49 jklmusic volumio[2092]: 9: 0x98b23c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:10:49 jklmusic volumio[2092]: 10: 0x98bf44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:10:49 jklmusic volumio[2092]: 11: 0x98bc30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:10:49 jklmusic volumio[2092]: 12: 0x98a1bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:10:49 jklmusic volumio[2092]: 13: 0x98b9ec - rust_begin_unwind Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:10:49 jklmusic volumio[2092]: 14: 0x46ee2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:10:49 jklmusic volumio[2092]: 15: 0x64b538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:10:49 jklmusic volumio[2092]: 16: 0x665af4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:10:49 jklmusic volumio[2092]: 17: 0x647ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:10:49 jklmusic volumio[2092]: 18: 0x6d1fc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:10:49 jklmusic volumio[2092]: 19: 0x497dd8 - ::poll::h06f390c1cf340695 Oct 03 15:10:49 jklmusic volumio[2092]: 20: 0x4af18c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:10:49 jklmusic volumio[2092]: 21: 0x4d0f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:10:49 jklmusic volumio[2092]: 22: 0x49f924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:10:49 jklmusic volumio[2092]: 23: 0x4d0bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:10:49 jklmusic volumio[2092]: 24: 0x4bf604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:10:49 jklmusic volumio[2092]: 25: 0x48eda4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:10:49 jklmusic volumio[2092]: 26: 0x4999a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:10:49 jklmusic volumio[2092]: 27: 0x4b76fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:10:49 jklmusic volumio[2092]: 28: 0x4cf278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:10:49 jklmusic volumio[2092]: 29: 0x97cbcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:10:49 jklmusic volumio[2092]: 30: 0x97cbcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:49 jklmusic volumio[2092]: 31: 0x97cbcc - std::panicking::try::h3145f518af029892 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:49 jklmusic volumio[2092]: 32: 0x97cbcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:49 jklmusic volumio[2092]: 33: 0x97cbcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:10:49 jklmusic volumio[2092]: 34: 0x97cbcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:49 jklmusic volumio[2092]: 35: 0x97cbcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:49 jklmusic volumio[2092]: 36: 0x97cbcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:49 jklmusic volumio[2092]: 37: 0x97cbcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:10:49 jklmusic volumio[2092]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:10:49 jklmusic volumio[2092]: 38: 0x49a11c - main Oct 03 15:10:49 jklmusic volumio[2092]: 39: 0xb6c77678 - __libc_start_main Oct 03 15:10:49 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:49 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:49 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:49 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPause Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreStateMachine::pause Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreStateMachine::stPlaybackTimer Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreStateMachine::servicePause Oct 03 15:10:50 jklmusic volumio[1085]: info: CoreCommandRouter::servicePause Oct 03 15:10:50 jklmusic volumio[1085]: info: Spotify Received pause Oct 03 15:10:51 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: ReferenceError: error is not defined Oct 03 15:10:51 jklmusic volumio[1085]: at spotifyApi.pause.then (/data/plugins/music_service/spop/index.js:2694:51) Oct 03 15:10:51 jklmusic volumio[1085]: at Oct 03 15:10:51 jklmusic volumio[1085]: at process._tickCallback (internal/process/next_tick.js:188:7) Oct 03 15:10:51 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 1) Oct 03 15:10:51 jklmusic volumio[1085]: (node:1085) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:51 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:10:51 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:10:51 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:10:51 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:10:51 jklmusic volumio[2109]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:10:51 jklmusic volumio[2109]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:10:51 jklmusic volumio[2109]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:51 jklmusic volumio[2109]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPause Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreStateMachine::pause Oct 03 15:10:51 jklmusic volumio[2109]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:10:51 jklmusic volumio[2109]: stack backtrace: Oct 03 15:10:51 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:51 jklmusic volumio[2109]: 0: 0xa31c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:10:51 jklmusic volumio[2109]: 1: 0xa31c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:10:51 jklmusic volumio[2109]: 2: 0xa31c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:10:51 jklmusic volumio[2109]: 3: 0xa31c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:10:51 jklmusic volumio[2109]: 4: 0xa57d68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:10:51 jklmusic volumio[2109]: 5: 0xa2b5d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:10:51 jklmusic volumio[2109]: 6: 0xa33728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:10:51 jklmusic volumio[2109]: 7: 0xa33728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:10:51 jklmusic volumio[2109]: 8: 0xa33728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:10:51 jklmusic volumio[2109]: 9: 0xa3323c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:10:51 jklmusic volumio[2109]: 10: 0xa33f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:10:51 jklmusic volumio[2109]: 11: 0xa33c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:10:51 jklmusic volumio[2109]: 12: 0xa321bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:10:51 jklmusic volumio[2109]: 13: 0xa339ec - rust_begin_unwind Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:10:51 jklmusic volumio[2109]: 14: 0x516e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:10:51 jklmusic volumio[2109]: 15: 0x6f3538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:10:51 jklmusic volumio[2109]: 16: 0x70daf4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:10:51 jklmusic volumio[2109]: 17: 0x6efba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:10:51 jklmusic volumio[2109]: 18: 0x779fc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:10:51 jklmusic volumio[2109]: 19: 0x53fdd8 - ::poll::h06f390c1cf340695 Oct 03 15:10:51 jklmusic volumio[2109]: 20: 0x55718c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:10:51 jklmusic volumio[2109]: 21: 0x578f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:10:51 jklmusic volumio[2109]: 22: 0x547924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:10:51 jklmusic volumio[2109]: 23: 0x578bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:10:51 jklmusic volumio[2109]: 24: 0x567604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:10:51 jklmusic volumio[2109]: 25: 0x536da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:10:51 jklmusic volumio[2109]: 26: 0x5419a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:10:51 jklmusic volumio[2109]: 27: 0x55f6fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:10:51 jklmusic volumio[2109]: 28: 0x577278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:10:51 jklmusic volumio[2109]: 29: 0xa24bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:10:51 jklmusic volumio[2109]: 30: 0xa24bcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:51 jklmusic volumio[2109]: 31: 0xa24bcc - std::panicking::try::h3145f518af029892 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:51 jklmusic volumio[2109]: 32: 0xa24bcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:51 jklmusic volumio[2109]: 33: 0xa24bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:10:51 jklmusic volumio[2109]: 34: 0xa24bcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:51 jklmusic volumio[2109]: 35: 0xa24bcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:51 jklmusic volumio[2109]: 36: 0xa24bcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:51 jklmusic volumio[2109]: 37: 0xa24bcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:10:51 jklmusic volumio[2109]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:10:51 jklmusic volumio[2109]: 38: 0x54211c - main Oct 03 15:10:51 jklmusic volumio[2109]: 39: 0xb6c93678 - __libc_start_main Oct 03 15:10:52 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:52 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:52 jklmusic volumio[1085]: info: Checking Spotify Web API Oct 03 15:10:52 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:52 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:52 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioSeek Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreStateMachine::seek Oct 03 15:10:53 jklmusic volumio[1085]: info: Spotify seek to: 50000 Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreStateMachine::startPlaybackTimer Oct 03 15:10:53 jklmusic volumio[1085]: info: CorePlayQueue::getTrack 1 Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreStateMachine::pushState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:53 jklmusic volumio[1085]: [SpotifyConnect] Unauthorized Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:53 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:54 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:54 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:10:54 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:10:54 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:10:54 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:10:54 jklmusic volumio[2122]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:10:54 jklmusic volumio[2122]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:10:54 jklmusic volumio[2122]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:10:54 jklmusic volumio[2122]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:10:54 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:54 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:54 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:54 jklmusic volumio[2122]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:10:54 jklmusic volumio[2122]: stack backtrace: Oct 03 15:10:54 jklmusic volumio[2122]: 0: 0xa5ac40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:10:54 jklmusic volumio[2122]: 1: 0xa5ac40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:10:54 jklmusic volumio[2122]: 2: 0xa5ac40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:10:54 jklmusic volumio[2122]: 3: 0xa5ac40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:10:54 jklmusic volumio[2122]: 4: 0xa80d68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:10:54 jklmusic volumio[2122]: 5: 0xa545d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:10:54 jklmusic volumio[2122]: 6: 0xa5c728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:10:54 jklmusic volumio[2122]: 7: 0xa5c728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:10:54 jklmusic volumio[2122]: 8: 0xa5c728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:10:54 jklmusic volumio[2122]: 9: 0xa5c23c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:10:54 jklmusic volumio[2122]: 10: 0xa5cf44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:10:54 jklmusic volumio[2122]: 11: 0xa5cc30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:10:54 jklmusic volumio[2122]: 12: 0xa5b1bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:10:54 jklmusic volumio[2122]: 13: 0xa5c9ec - rust_begin_unwind Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:10:54 jklmusic volumio[2122]: 14: 0x53fe2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:10:54 jklmusic volumio[2122]: 15: 0x71c538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:10:54 jklmusic volumio[2122]: 16: 0x736af4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:10:54 jklmusic volumio[2122]: 17: 0x718ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:10:54 jklmusic volumio[2122]: 18: 0x7a2fc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:10:54 jklmusic volumio[2122]: 19: 0x568dd8 - ::poll::h06f390c1cf340695 Oct 03 15:10:54 jklmusic volumio[2122]: 20: 0x58018c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:10:54 jklmusic volumio[2122]: 21: 0x5a1f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:10:54 jklmusic volumio[2122]: 22: 0x570924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:10:54 jklmusic volumio[2122]: 23: 0x5a1bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:10:54 jklmusic volumio[2122]: 24: 0x590604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:10:54 jklmusic volumio[2122]: 25: 0x55fda4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:10:54 jklmusic volumio[2122]: 26: 0x56a9a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:10:54 jklmusic volumio[2122]: 27: 0x5886fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:10:54 jklmusic volumio[2122]: 28: 0x5a0278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:10:54 jklmusic volumio[2122]: 29: 0xa4dbcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:10:54 jklmusic volumio[2122]: 30: 0xa4dbcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:54 jklmusic volumio[2122]: 31: 0xa4dbcc - std::panicking::try::h3145f518af029892 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:54 jklmusic volumio[2122]: 32: 0xa4dbcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:54 jklmusic volumio[2122]: 33: 0xa4dbcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:10:54 jklmusic volumio[2122]: 34: 0xa4dbcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:54 jklmusic volumio[2122]: 35: 0xa4dbcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:54 jklmusic volumio[2122]: 36: 0xa4dbcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:54 jklmusic volumio[2122]: 37: 0xa4dbcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:10:54 jklmusic volumio[2122]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:10:54 jklmusic volumio[2122]: 38: 0x56b11c - main Oct 03 15:10:54 jklmusic volumio[2122]: 39: 0xb6c3f678 - __libc_start_main Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreStateMachine::ClearQueue Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:55 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:55 jklmusic volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 03 15:10:55 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreStateMachine::addQueueItems Oct 03 15:10:55 jklmusic volumio[1085]: info: CorePlayQueue::addQueueItems Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2022n4pxaEaDC2YvzVl1w7 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:2022n4pxaEaDC2YvzVl1w7 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3X76Lal4GwBFqriHz1FbLU Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3X76Lal4GwBFqriHz1FbLU in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3AoEQRuFf8zVXWqSLo2UOi Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3AoEQRuFf8zVXWqSLo2UOi in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:72gPDy1zVt95zVNali0IhK Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:72gPDy1zVt95zVNali0IhK in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6pqyZNnLKyJKtrlf42FQoq Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6pqyZNnLKyJKtrlf42FQoq in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4AwUc1mdlX4ARHkUNG0iho Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:4AwUc1mdlX4ARHkUNG0iho in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2Ti4DCTo6Ag7QvaYex8A8B Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:2Ti4DCTo6Ag7QvaYex8A8B in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1QPV3QoWw3rRKPeYoX8kO8 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1QPV3QoWw3rRKPeYoX8kO8 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3AXryyinIY17WLddIcNjwT Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3AXryyinIY17WLddIcNjwT in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4UVsqRoSys14kMLBfpJDTQ Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:4UVsqRoSys14kMLBfpJDTQ in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:09keT5ocFhEd5W5HidiUNq Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:09keT5ocFhEd5W5HidiUNq in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0GqHe3PHWp2t5Pxkn0lCqD Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:0GqHe3PHWp2t5Pxkn0lCqD in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:13U2hhhgeN57hffBCuaUcw Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:13U2hhhgeN57hffBCuaUcw in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0guoHdAofMWLQELiKSZfsf Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:0guoHdAofMWLQELiKSZfsf in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6kEU60ykxhb0shZMTiPWZL Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6kEU60ykxhb0shZMTiPWZL in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:28HVi8XtrlKauIVUxSlc6q Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:28HVi8XtrlKauIVUxSlc6q in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2ehtxaFn31gfhARCEn8QtA Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:2ehtxaFn31gfhARCEn8QtA in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0T6J3Ipbe06lm7p3grH2bg Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:0T6J3Ipbe06lm7p3grH2bg in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6bdA8NPhCKyS38Zsg2xui9 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6bdA8NPhCKyS38Zsg2xui9 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:26z9YaukqS3xtQm2fhm4UV Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:26z9YaukqS3xtQm2fhm4UV in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3Zice5cXhiPVLwrdBJlyHc Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3Zice5cXhiPVLwrdBJlyHc in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:7ov3TDp5D00Rnu5R1viX4w Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:7ov3TDp5D00Rnu5R1viX4w in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:564FztYymI6tdSy7hV8nYS Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:564FztYymI6tdSy7hV8nYS in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0Md02V4hwKO5Vu5B7GD8tQ Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:0Md02V4hwKO5Vu5B7GD8tQ in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4e1aewX6ATPcdfQIqr7gqO Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:4e1aewX6ATPcdfQIqr7gqO in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6oNLSQX8bcAdbCElZYju3v Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6oNLSQX8bcAdbCElZYju3v in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3RkSwrsIadAvqVtMp5yhaB Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3RkSwrsIadAvqVtMp5yhaB in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6mslYkzyL8uDfacJezJnof Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6mslYkzyL8uDfacJezJnof in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6rXZhduf6TZb1mS1RjkHQ0 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6rXZhduf6TZb1mS1RjkHQ0 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6vvPecFTmWxDfEJ6cYT1wa Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6vvPecFTmWxDfEJ6cYT1wa in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6aSwH4whSmRnIZGwjXZS4C Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6aSwH4whSmRnIZGwjXZS4C in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6aJn7Cst74cj4lNIiPRgav Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6aJn7Cst74cj4lNIiPRgav in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4PAMDOg5KBjnzocJ60eMpl Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:4PAMDOg5KBjnzocJ60eMpl in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:294hRgOqnGW2BemqP8D35X Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:294hRgOqnGW2BemqP8D35X in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:5eWcGfUCrVFMoYskyfkEPE Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:5eWcGfUCrVFMoYskyfkEPE in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0V2passWyAXnON67kfAj7y Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:0V2passWyAXnON67kfAj7y in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1njlnn8ZKHI77Pe9szIONR Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1njlnn8ZKHI77Pe9szIONR in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4lR8sYGMGZPvthF2yUfo7T Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:4lR8sYGMGZPvthF2yUfo7T in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:5ocSQW5sIUIOFojwXEz9Ki Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:5ocSQW5sIUIOFojwXEz9Ki in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2VdSktBqFfkW7y6q5Ik4Z4 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:2VdSktBqFfkW7y6q5Ik4Z4 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2UE9XGbAzicJIyo4bB6sqM Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:2UE9XGbAzicJIyo4bB6sqM in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1aKvZDoLGkNMxoRYgkckZG Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1aKvZDoLGkNMxoRYgkckZG in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1SS0WlKhJewviwEDZ6dWj0 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1SS0WlKhJewviwEDZ6dWj0 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0vaxYDAuAO1nPolC6bQp7V Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:0vaxYDAuAO1nPolC6bQp7V in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:38tXZcL1gZRfbqfOG0VMTH Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:38tXZcL1gZRfbqfOG0VMTH in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1AtFSBJibfaqfiOByQCwZ5 Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1AtFSBJibfaqfiOByQCwZ5 in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1BAtAtx0VgWgAMROWK9WYf Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1BAtAtx0VgWgAMROWK9WYf in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6Ixrp3yXfzv5brZXmZuXXN Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:6Ixrp3yXfzv5brZXmZuXXN in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3VHD84tIdyxRTtRc167YSR Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3VHD84tIdyxRTtRc167YSR in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3pDGJRDN3p6kCNZcD97FYY Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:3pDGJRDN3p6kCNZcD97FYY in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1OhIn0L6iofnk5bjalWfHq Oct 03 15:10:55 jklmusic volumio[1085]: info: Exploding uri spotify:track:1OhIn0L6iofnk5bjalWfHq in service spop Oct 03 15:10:55 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 2) Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 3) Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 4) Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 5) Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 6) Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:56 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 7) Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreStateMachine::ClearQueue Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:56 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:56 jklmusic volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 03 15:10:56 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:56 jklmusic volumio[1085]: info: CoreStateMachine::addQueueItems Oct 03 15:10:56 jklmusic volumio[1085]: info: CorePlayQueue::addQueueItems Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2022n4pxaEaDC2YvzVl1w7 Oct 03 15:10:56 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:10:56 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:10:56 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:10:56 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:2022n4pxaEaDC2YvzVl1w7 in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3X76Lal4GwBFqriHz1FbLU Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:3X76Lal4GwBFqriHz1FbLU in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3AoEQRuFf8zVXWqSLo2UOi Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:3AoEQRuFf8zVXWqSLo2UOi in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:72gPDy1zVt95zVNali0IhK Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:72gPDy1zVt95zVNali0IhK in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6pqyZNnLKyJKtrlf42FQoq Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:6pqyZNnLKyJKtrlf42FQoq in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4AwUc1mdlX4ARHkUNG0iho Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:4AwUc1mdlX4ARHkUNG0iho in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2Ti4DCTo6Ag7QvaYex8A8B Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:2Ti4DCTo6Ag7QvaYex8A8B in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1QPV3QoWw3rRKPeYoX8kO8 Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:1QPV3QoWw3rRKPeYoX8kO8 in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3AXryyinIY17WLddIcNjwT Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:3AXryyinIY17WLddIcNjwT in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4UVsqRoSys14kMLBfpJDTQ Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:4UVsqRoSys14kMLBfpJDTQ in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:09keT5ocFhEd5W5HidiUNq Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:09keT5ocFhEd5W5HidiUNq in service spop Oct 03 15:10:56 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0GqHe3PHWp2t5Pxkn0lCqD Oct 03 15:10:56 jklmusic volumio[1085]: info: Exploding uri spotify:track:0GqHe3PHWp2t5Pxkn0lCqD in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:13U2hhhgeN57hffBCuaUcw Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:13U2hhhgeN57hffBCuaUcw in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0guoHdAofMWLQELiKSZfsf Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:0guoHdAofMWLQELiKSZfsf in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6kEU60ykxhb0shZMTiPWZL Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6kEU60ykxhb0shZMTiPWZL in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:28HVi8XtrlKauIVUxSlc6q Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:28HVi8XtrlKauIVUxSlc6q in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2ehtxaFn31gfhARCEn8QtA Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:2ehtxaFn31gfhARCEn8QtA in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0T6J3Ipbe06lm7p3grH2bg Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:0T6J3Ipbe06lm7p3grH2bg in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6bdA8NPhCKyS38Zsg2xui9 Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6bdA8NPhCKyS38Zsg2xui9 in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:26z9YaukqS3xtQm2fhm4UV Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:26z9YaukqS3xtQm2fhm4UV in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3Zice5cXhiPVLwrdBJlyHc Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:3Zice5cXhiPVLwrdBJlyHc in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:7ov3TDp5D00Rnu5R1viX4w Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:7ov3TDp5D00Rnu5R1viX4w in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:564FztYymI6tdSy7hV8nYS Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:564FztYymI6tdSy7hV8nYS in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0Md02V4hwKO5Vu5B7GD8tQ Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:0Md02V4hwKO5Vu5B7GD8tQ in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4e1aewX6ATPcdfQIqr7gqO Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:4e1aewX6ATPcdfQIqr7gqO in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6oNLSQX8bcAdbCElZYju3v Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6oNLSQX8bcAdbCElZYju3v in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3RkSwrsIadAvqVtMp5yhaB Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:3RkSwrsIadAvqVtMp5yhaB in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6mslYkzyL8uDfacJezJnof Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6mslYkzyL8uDfacJezJnof in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6rXZhduf6TZb1mS1RjkHQ0 Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6rXZhduf6TZb1mS1RjkHQ0 in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6vvPecFTmWxDfEJ6cYT1wa Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6vvPecFTmWxDfEJ6cYT1wa in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6aSwH4whSmRnIZGwjXZS4C Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6aSwH4whSmRnIZGwjXZS4C in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6aJn7Cst74cj4lNIiPRgav Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6aJn7Cst74cj4lNIiPRgav in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4PAMDOg5KBjnzocJ60eMpl Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:4PAMDOg5KBjnzocJ60eMpl in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:294hRgOqnGW2BemqP8D35X Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:294hRgOqnGW2BemqP8D35X in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:5eWcGfUCrVFMoYskyfkEPE Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:5eWcGfUCrVFMoYskyfkEPE in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0V2passWyAXnON67kfAj7y Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:0V2passWyAXnON67kfAj7y in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1njlnn8ZKHI77Pe9szIONR Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:1njlnn8ZKHI77Pe9szIONR in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:4lR8sYGMGZPvthF2yUfo7T Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:4lR8sYGMGZPvthF2yUfo7T in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:5ocSQW5sIUIOFojwXEz9Ki Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:5ocSQW5sIUIOFojwXEz9Ki in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2VdSktBqFfkW7y6q5Ik4Z4 Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:2VdSktBqFfkW7y6q5Ik4Z4 in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:2UE9XGbAzicJIyo4bB6sqM Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:2UE9XGbAzicJIyo4bB6sqM in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1aKvZDoLGkNMxoRYgkckZG Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:1aKvZDoLGkNMxoRYgkckZG in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1SS0WlKhJewviwEDZ6dWj0 Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:1SS0WlKhJewviwEDZ6dWj0 in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:0vaxYDAuAO1nPolC6bQp7V Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:0vaxYDAuAO1nPolC6bQp7V in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:38tXZcL1gZRfbqfOG0VMTH Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:38tXZcL1gZRfbqfOG0VMTH in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1AtFSBJibfaqfiOByQCwZ5 Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:1AtFSBJibfaqfiOByQCwZ5 in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1BAtAtx0VgWgAMROWK9WYf Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:1BAtAtx0VgWgAMROWK9WYf in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:6Ixrp3yXfzv5brZXmZuXXN Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:6Ixrp3yXfzv5brZXmZuXXN in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3VHD84tIdyxRTtRc167YSR Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:3VHD84tIdyxRTtRc167YSR in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:3pDGJRDN3p6kCNZcD97FYY Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:3pDGJRDN3p6kCNZcD97FYY in service spop Oct 03 15:10:57 jklmusic volumio[1085]: info: Adding Item to queue: spotify:track:1OhIn0L6iofnk5bjalWfHq Oct 03 15:10:57 jklmusic volumio[1085]: info: Exploding uri spotify:track:1OhIn0L6iofnk5bjalWfHq in service spop Oct 03 15:10:57 jklmusic volumio[2135]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:10:57 jklmusic volumio[2135]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:10:57 jklmusic volumio[2135]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:10:57 jklmusic volumio[2135]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 8) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 9) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 10) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 11) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 12) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 13) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 14) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 15) Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:57 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 16) Oct 03 15:10:57 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:57 jklmusic volumio[2135]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:10:57 jklmusic volumio[2135]: stack backtrace: Oct 03 15:10:57 jklmusic volumio[2135]: 0: 0xa62c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:10:57 jklmusic volumio[2135]: 1: 0xa62c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:10:57 jklmusic volumio[2135]: 2: 0xa62c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:10:57 jklmusic volumio[2135]: 3: 0xa62c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:10:57 jklmusic volumio[2135]: 4: 0xa88d68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:10:57 jklmusic volumio[2135]: 5: 0xa5c5d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:10:57 jklmusic volumio[2135]: 6: 0xa64728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:10:57 jklmusic volumio[2135]: 7: 0xa64728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:10:57 jklmusic volumio[2135]: 8: 0xa64728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:10:57 jklmusic volumio[2135]: 9: 0xa6423c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:10:57 jklmusic volumio[2135]: 10: 0xa64f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:10:57 jklmusic volumio[2135]: 11: 0xa64c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:10:57 jklmusic volumio[2135]: 12: 0xa631bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:10:57 jklmusic volumio[2135]: 13: 0xa649ec - rust_begin_unwind Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:10:57 jklmusic volumio[2135]: 14: 0x547e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:10:57 jklmusic volumio[2135]: 15: 0x724538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:10:57 jklmusic volumio[2135]: 16: 0x73eaf4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:10:57 jklmusic volumio[2135]: 17: 0x720ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:10:57 jklmusic volumio[2135]: 18: 0x7aafc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:10:57 jklmusic volumio[2135]: 19: 0x570dd8 - ::poll::h06f390c1cf340695 Oct 03 15:10:57 jklmusic volumio[2135]: 20: 0x58818c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:10:57 jklmusic volumio[2135]: 21: 0x5a9f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:10:57 jklmusic volumio[2135]: 22: 0x578924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:10:57 jklmusic volumio[2135]: 23: 0x5a9bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:10:57 jklmusic volumio[2135]: 24: 0x598604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:10:57 jklmusic volumio[2135]: 25: 0x567da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:10:57 jklmusic volumio[2135]: 26: 0x5729a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:10:57 jklmusic volumio[2135]: 27: 0x5906fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:10:57 jklmusic volumio[2135]: 28: 0x5a8278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:10:57 jklmusic volumio[2135]: 29: 0xa55bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:10:57 jklmusic volumio[2135]: 30: 0xa55bcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:57 jklmusic volumio[2135]: 31: 0xa55bcc - std::panicking::try::h3145f518af029892 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:57 jklmusic volumio[2135]: 32: 0xa55bcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:57 jklmusic volumio[2135]: 33: 0xa55bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:10:57 jklmusic volumio[2135]: 34: 0xa55bcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:10:57 jklmusic volumio[2135]: 35: 0xa55bcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:10:57 jklmusic volumio[2135]: 36: 0xa55bcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:10:57 jklmusic volumio[2135]: 37: 0xa55bcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:10:57 jklmusic volumio[2135]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:10:57 jklmusic volumio[2135]: 38: 0x57311c - main Oct 03 15:10:57 jklmusic volumio[2135]: 39: 0xb6c6d678 - __libc_start_main Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 17) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 18) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 19) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 20) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 21) Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 22) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 23) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 24) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 25) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 26) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 27) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 28) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 29) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 30) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 31) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 32) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 33) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 34) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 35) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 36) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 37) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 38) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 39) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 40) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 41) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 42) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 43) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 44) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 45) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 46) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 47) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 48) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 49) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 50) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 51) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 52) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 53) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 54) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 55) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 56) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 57) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 58) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 59) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 60) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 61) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 62) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 63) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 64) Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 65) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 66) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 67) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 68) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 69) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 70) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 71) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 72) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 73) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 74) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 75) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 76) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 77) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 78) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 79) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 80) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 81) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 82) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 83) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 84) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 85) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 86) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 87) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 88) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 89) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 90) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 91) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 92) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 93) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 94) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 95) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 96) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 97) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 98) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 99) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 100) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 101) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 102) Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning Oct 03 15:10:58 jklmusic volumio[1085]: (node:1085) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 103) Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreStateMachine::ClearQueue Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:10:58 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:58 jklmusic volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 03 15:10:58 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreStateMachine::addQueueItems Oct 03 15:10:58 jklmusic volumio[1085]: info: CorePlayQueue::addQueueItems Oct 03 15:10:58 jklmusic volumio[1085]: info: Adding Item to queue: spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 Oct 03 15:10:58 jklmusic volumio[1085]: info: Exploding uri spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 in service spop Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:58 jklmusic volumio[1085]: error: An error occurred while exploding listing Spotify playlist tracks WebapiError: Unauthorized Oct 03 15:10:58 jklmusic volumio[1085]: error: Cannot explode uri spotify:user:spotify:playlist:37i9dQZF1DX9tPFwDMOaN1 from service spop: WebapiError: Unauthorized Oct 03 15:10:58 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 03 15:10:58 jklmusic volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 03 15:10:58 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPlay Oct 03 15:10:58 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:10:58 jklmusic volumio[1085]: [SpotifyConnect] unSetVolatile called Oct 03 15:10:58 jklmusic volumio[1085]: info: Spotify Unset Volatile called Oct 03 15:10:58 jklmusic volumio[1085]: [SpotifyConnect] Relinquishing Volumio State to another service Oct 03 15:10:58 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:10:59 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:59 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:59 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:59 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:10:59 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:10:59 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:10:59 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:10:59 jklmusic volumio[2146]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:10:59 jklmusic volumio[2146]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:10:59 jklmusic volumio[2146]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:10:59 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:10:59 jklmusic volumio[2146]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:10:59 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:00 jklmusic volumio[2146]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:11:00 jklmusic volumio[2146]: stack backtrace: Oct 03 15:11:00 jklmusic volumio[2146]: 0: 0x9d6c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:11:00 jklmusic volumio[2146]: 1: 0x9d6c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:11:00 jklmusic volumio[2146]: 2: 0x9d6c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:11:00 jklmusic volumio[2146]: 3: 0x9d6c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:11:00 jklmusic volumio[2146]: 4: 0x9fcd68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:11:00 jklmusic volumio[2146]: 5: 0x9d05d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:11:00 jklmusic volumio[2146]: 6: 0x9d8728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:11:00 jklmusic volumio[2146]: 7: 0x9d8728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:11:00 jklmusic volumio[2146]: 8: 0x9d8728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:11:00 jklmusic volumio[2146]: 9: 0x9d823c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:11:00 jklmusic volumio[2146]: 10: 0x9d8f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:11:00 jklmusic volumio[2146]: 11: 0x9d8c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:11:00 jklmusic volumio[2146]: 12: 0x9d71bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:11:00 jklmusic volumio[2146]: 13: 0x9d89ec - rust_begin_unwind Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:11:00 jklmusic volumio[2146]: 14: 0x4bbe2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:11:00 jklmusic volumio[2146]: 15: 0x698538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:11:00 jklmusic volumio[2146]: 16: 0x6b2af4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:11:00 jklmusic volumio[2146]: 17: 0x694ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:11:00 jklmusic volumio[2146]: 18: 0x71efc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:11:00 jklmusic volumio[2146]: 19: 0x4e4dd8 - ::poll::h06f390c1cf340695 Oct 03 15:11:00 jklmusic volumio[2146]: 20: 0x4fc18c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:11:00 jklmusic volumio[2146]: 21: 0x51df24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:11:00 jklmusic volumio[2146]: 22: 0x4ec924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:11:00 jklmusic volumio[2146]: 23: 0x51dbac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:11:00 jklmusic volumio[2146]: 24: 0x50c604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:11:00 jklmusic volumio[2146]: 25: 0x4dbda4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:11:00 jklmusic volumio[2146]: 26: 0x4e69a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:11:00 jklmusic volumio[2146]: 27: 0x5046fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:11:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:00 jklmusic volumio[2146]: 28: 0x51c278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:11:00 jklmusic volumio[2146]: 29: 0x9c9bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:11:00 jklmusic volumio[2146]: 30: 0x9c9bcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:00 jklmusic volumio[2146]: 31: 0x9c9bcc - std::panicking::try::h3145f518af029892 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:00 jklmusic volumio[2146]: 32: 0x9c9bcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:00 jklmusic volumio[2146]: 33: 0x9c9bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:11:00 jklmusic volumio[2146]: 34: 0x9c9bcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:00 jklmusic volumio[2146]: 35: 0x9c9bcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:00 jklmusic volumio[2146]: 36: 0x9c9bcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:00 jklmusic volumio[2146]: 37: 0x9c9bcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:11:00 jklmusic volumio[2146]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:11:00 jklmusic volumio[2146]: 38: 0x4e711c - main Oct 03 15:11:00 jklmusic volumio[2146]: 39: 0xb6bd9678 - __libc_start_main Oct 03 15:11:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:00 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:01 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:02 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:11:02 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:11:02 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:11:02 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:11:02 jklmusic volumio[2159]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:11:02 jklmusic volumio[2159]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:11:02 jklmusic volumio[2159]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:11:02 jklmusic volumio[2159]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:11:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:02 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:02 jklmusic volumio[2070]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:11:02 jklmusic volumio[2159]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:11:02 jklmusic volumio[2159]: stack backtrace: Oct 03 15:11:03 jklmusic volumio[2159]: 0: 0xa43c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:11:03 jklmusic volumio[2159]: 1: 0xa43c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:11:03 jklmusic volumio[2159]: 2: 0xa43c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:11:03 jklmusic volumio[2159]: 3: 0xa43c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:11:03 jklmusic volumio[2159]: 4: 0xa69d68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:11:03 jklmusic volumio[2159]: 5: 0xa3d5d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:11:03 jklmusic volumio[2159]: 6: 0xa45728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:11:03 jklmusic volumio[2159]: 7: 0xa45728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:11:03 jklmusic volumio[2159]: 8: 0xa45728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:11:03 jklmusic volumio[2159]: 9: 0xa4523c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:11:03 jklmusic volumio[2159]: 10: 0xa45f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:11:03 jklmusic volumio[2159]: 11: 0xa45c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:11:03 jklmusic volumio[2159]: 12: 0xa441bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:11:03 jklmusic volumio[2159]: 13: 0xa459ec - rust_begin_unwind Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:11:03 jklmusic volumio[2159]: 14: 0x528e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:11:03 jklmusic volumio[2159]: 15: 0x705538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:11:03 jklmusic volumio[2159]: 16: 0x71faf4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:11:03 jklmusic volumio[2159]: 17: 0x701ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:11:03 jklmusic volumio[2159]: 18: 0x78bfc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:11:03 jklmusic volumio[2159]: 19: 0x551dd8 - ::poll::h06f390c1cf340695 Oct 03 15:11:03 jklmusic volumio[2159]: 20: 0x56918c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:11:03 jklmusic volumio[2159]: 21: 0x58af24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:11:03 jklmusic volumio[2159]: 22: 0x559924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:11:03 jklmusic volumio[2159]: 23: 0x58abac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:11:03 jklmusic volumio[2159]: 24: 0x579604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:11:03 jklmusic volumio[2159]: 25: 0x548da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:11:03 jklmusic volumio[2159]: 26: 0x5539a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:11:03 jklmusic volumio[2159]: 27: 0x5716fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:11:03 jklmusic volumio[2159]: 28: 0x589278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:11:03 jklmusic volumio[2159]: 29: 0xa36bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:11:03 jklmusic volumio[2159]: 30: 0xa36bcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:03 jklmusic volumio[2159]: 31: 0xa36bcc - std::panicking::try::h3145f518af029892 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:03 jklmusic volumio[2159]: 32: 0xa36bcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:03 jklmusic volumio[2159]: 33: 0xa36bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:11:03 jklmusic volumio[2159]: 34: 0xa36bcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:03 jklmusic volumio[2159]: 35: 0xa36bcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:03 jklmusic volumio[2159]: 36: 0xa36bcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:03 jklmusic volumio[2159]: 37: 0xa36bcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:11:03 jklmusic volumio[2159]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:11:03 jklmusic volumio[2159]: 38: 0x55411c - main Oct 03 15:11:03 jklmusic volumio[2159]: 39: 0xb6c2c678 - __libc_start_main Oct 03 15:11:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:03 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:03 jklmusic volumio[2070]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:11:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:04 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:05 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:11:05 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:11:05 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:11:05 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:11:05 jklmusic volumio[2170]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:11:05 jklmusic volumio[2170]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:11:05 jklmusic volumio[2170]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:11:05 jklmusic volumio[2170]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:11:05 jklmusic sudo[2177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 03 15:11:05 jklmusic sudo[2177]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:05 jklmusic sudo[2177]: pam_unix(sudo:session): session closed for user root Oct 03 15:11:05 jklmusic sudo[2180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 03 15:11:05 jklmusic sudo[2180]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:11:05 jklmusic volumio[2070]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:11:05 jklmusic sudo[2180]: pam_unix(sudo:session): session closed for user root Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetVisibleSources Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetQueue Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreStateMachine::getQueue Oct 03 15:11:05 jklmusic volumio[1085]: info: CorePlayQueue::getQueue Oct 03 15:11:05 jklmusic volumio[1085]: info: Listing playlists Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:05 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:05 jklmusic volumio[2170]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:11:05 jklmusic volumio[2170]: stack backtrace: Oct 03 15:11:05 jklmusic volumio[2170]: 0: 0xa42c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:11:05 jklmusic volumio[2170]: 1: 0xa42c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:11:05 jklmusic volumio[2170]: 2: 0xa42c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:11:05 jklmusic volumio[2170]: 3: 0xa42c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:11:05 jklmusic volumio[2170]: 4: 0xa68d68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:11:05 jklmusic volumio[2170]: 5: 0xa3c5d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:11:05 jklmusic volumio[2170]: 6: 0xa44728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:11:05 jklmusic volumio[2170]: 7: 0xa44728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:11:05 jklmusic volumio[2170]: 8: 0xa44728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:11:05 jklmusic volumio[2170]: 9: 0xa4423c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:11:05 jklmusic volumio[2170]: 10: 0xa44f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:11:05 jklmusic volumio[2170]: 11: 0xa44c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:11:05 jklmusic volumio[2170]: 12: 0xa431bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:11:05 jklmusic volumio[2170]: 13: 0xa449ec - rust_begin_unwind Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:11:05 jklmusic volumio[2170]: 14: 0x527e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:11:05 jklmusic volumio[2170]: 15: 0x704538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:11:05 jklmusic volumio[2170]: 16: 0x71eaf4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:11:05 jklmusic volumio[2170]: 17: 0x700ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:11:05 jklmusic volumio[2170]: 18: 0x78afc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:11:05 jklmusic volumio[2170]: 19: 0x550dd8 - ::poll::h06f390c1cf340695 Oct 03 15:11:05 jklmusic volumio[2170]: 20: 0x56818c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:11:05 jklmusic volumio[2170]: 21: 0x589f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:11:05 jklmusic volumio[2170]: 22: 0x558924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:11:05 jklmusic volumio[2170]: 23: 0x589bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:11:05 jklmusic volumio[2170]: 24: 0x578604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:11:05 jklmusic volumio[2170]: 25: 0x547da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:11:05 jklmusic volumio[2170]: 26: 0x5529a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:11:05 jklmusic volumio[2170]: 27: 0x5706fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:11:05 jklmusic volumio[2170]: 28: 0x588278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:11:05 jklmusic volumio[2170]: 29: 0xa35bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:11:05 jklmusic volumio[2170]: 30: 0xa35bcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:05 jklmusic volumio[2170]: 31: 0xa35bcc - std::panicking::try::h3145f518af029892 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:05 jklmusic volumio[2170]: 32: 0xa35bcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:05 jklmusic volumio[2170]: 33: 0xa35bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:11:05 jklmusic volumio[2170]: 34: 0xa35bcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:05 jklmusic volumio[2170]: 35: 0xa35bcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:05 jklmusic volumio[2170]: 36: 0xa35bcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:05 jklmusic volumio[2170]: 37: 0xa35bcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:11:05 jklmusic volumio[2170]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:11:05 jklmusic volumio[2170]: 38: 0x55311c - main Oct 03 15:11:05 jklmusic volumio[2170]: 39: 0xb6be5678 - __libc_start_main Oct 03 15:11:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:06 jklmusic volumio[2070]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.31:5353): query type 65 is invalid Oct 03 15:11:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:06 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:07 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:07 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:11:07 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:11:07 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:11:07 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:11:07 jklmusic volumio[2205]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:11:07 jklmusic volumio[2205]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:11:07 jklmusic volumio[2205]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:11:08 jklmusic volumio[2205]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:11:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:08 jklmusic volumio[2205]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 Oct 03 15:11:08 jklmusic volumio[2205]: stack backtrace: Oct 03 15:11:08 jklmusic volumio[2205]: 0: 0x975c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 Oct 03 15:11:08 jklmusic volumio[2205]: 1: 0x975c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 Oct 03 15:11:08 jklmusic volumio[2205]: 2: 0x975c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 Oct 03 15:11:08 jklmusic volumio[2205]: 3: 0x975c40 - ::fmt::hf1c91d83d30a63b5 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 Oct 03 15:11:08 jklmusic volumio[2205]: 4: 0x99bd68 - core::fmt::write::he7b81f119cac9e82 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 Oct 03 15:11:08 jklmusic volumio[2205]: 5: 0x96f5d4 - std::io::Write::write_fmt::hd6a547671801193b Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 Oct 03 15:11:08 jklmusic volumio[2205]: 6: 0x977728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 Oct 03 15:11:08 jklmusic volumio[2205]: 7: 0x977728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 Oct 03 15:11:08 jklmusic volumio[2205]: 8: 0x977728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 Oct 03 15:11:08 jklmusic volumio[2205]: 9: 0x97723c - std::panicking::default_hook::h3b931251a9c4b1f6 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 Oct 03 15:11:08 jklmusic volumio[2205]: 10: 0x977f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 Oct 03 15:11:08 jklmusic volumio[2205]: 11: 0x977c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 Oct 03 15:11:08 jklmusic volumio[2205]: 12: 0x9761bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 Oct 03 15:11:08 jklmusic volumio[2205]: 13: 0x9779ec - rust_begin_unwind Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 Oct 03 15:11:08 jklmusic volumio[2205]: 14: 0x45ae2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 Oct 03 15:11:08 jklmusic volumio[2205]: 15: 0x637538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 Oct 03 15:11:08 jklmusic volumio[2205]: 16: 0x651af4 - as futures::future::Future>::poll::h38eb93796db62721 Oct 03 15:11:08 jklmusic volumio[2205]: 17: 0x633ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 Oct 03 15:11:08 jklmusic volumio[2205]: 18: 0x6bdfc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 Oct 03 15:11:08 jklmusic volumio[2205]: 19: 0x483dd8 - ::poll::h06f390c1cf340695 Oct 03 15:11:08 jklmusic volumio[2205]: 20: 0x49b18c - futures::task_impl::std::set::h917345edbb2d7b17 Oct 03 15:11:08 jklmusic volumio[2205]: 21: 0x4bcf24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 Oct 03 15:11:08 jklmusic volumio[2205]: 22: 0x48b924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 Oct 03 15:11:08 jklmusic volumio[2205]: 23: 0x4bcbac - std::thread::local::LocalKey::with::hb9ef5b7276039152 Oct 03 15:11:08 jklmusic volumio[2205]: 24: 0x4ab604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d Oct 03 15:11:08 jklmusic volumio[2205]: 25: 0x47ada4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c Oct 03 15:11:08 jklmusic volumio[2205]: 26: 0x4859a0 - vollibrespot::main::haa33a046348d736f Oct 03 15:11:08 jklmusic volumio[2205]: 27: 0x4a36fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 Oct 03 15:11:08 jklmusic volumio[2205]: 28: 0x4bb278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 Oct 03 15:11:08 jklmusic volumio[2205]: 29: 0x968bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 Oct 03 15:11:08 jklmusic volumio[2205]: 30: 0x968bcc - std::panicking::try::do_call::h7a5efa020212c0f3 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:08 jklmusic volumio[2205]: 31: 0x968bcc - std::panicking::try::h3145f518af029892 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:08 jklmusic volumio[2205]: 32: 0x968bcc - std::panic::catch_unwind::h876d78503e730edb Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:08 jklmusic volumio[2205]: 33: 0x968bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 Oct 03 15:11:08 jklmusic volumio[2205]: 34: 0x968bcc - std::panicking::try::do_call::h6affa17582fe803e Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 Oct 03 15:11:08 jklmusic volumio[2205]: 35: 0x968bcc - std::panicking::try::hf3254f9f909f508b Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 Oct 03 15:11:08 jklmusic volumio[2205]: 36: 0x968bcc - std::panic::catch_unwind::h17abded8b6d92414 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 Oct 03 15:11:08 jklmusic volumio[2205]: 37: 0x968bcc - std::rt::lang_start_internal::h62925866154f59e6 Oct 03 15:11:08 jklmusic volumio[2205]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 Oct 03 15:11:08 jklmusic volumio[2205]: 38: 0x48611c - main Oct 03 15:11:08 jklmusic volumio[2205]: 39: 0xb6bb6678 - __libc_start_main Oct 03 15:11:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:08 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:09 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 03 15:11:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:09 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:10 jklmusic systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 03 15:11:10 jklmusic systemd[1]: Stopping Volspotconnect2 Daemon... Oct 03 15:11:10 jklmusic systemd[1]: Starting Volspotconnect2 Daemon... Oct 03 15:11:10 jklmusic systemd[1]: Started Volspotconnect2 Daemon. Oct 03 15:11:10 jklmusic volumio[2218]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 03 15:11:10 jklmusic volumio[2218]: Reading Config from "/tmp/volspotify.toml" Oct 03 15:11:10 jklmusic volumio[2218]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 03 15:11:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:10 jklmusic volumio[2218]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Oct 03 15:11:10 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 03 15:11:10 jklmusic volumio[2218]: [Vollibrespot] : Could not connect to server: Connection refused (os error 111) Oct 03 15:11:10 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:11 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:12 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreStateMachine::ClearQueue Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreStateMachine::stop Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreStateMachine::serviceStop Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::serviceStop Oct 03 15:11:13 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:11:13 jklmusic volumio[1085]: info: CorePlayQueue::clearPlayQueue Oct 03 15:11:13 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushState Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreStateMachine::addQueueItems Oct 03 15:11:13 jklmusic volumio[1085]: info: CorePlayQueue::addQueueItems Oct 03 15:11:13 jklmusic volumio[1085]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012 Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 03 15:11:13 jklmusic volumio[1085]: info: CorePlayQueue::saveQueue Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPushQueue Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreStateMachine::updateTrackBlock Oct 03 15:11:13 jklmusic volumio[1085]: info: CorePlayQueue::getTrackBlock Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPlay Oct 03 15:11:13 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:11:13 jklmusic volumio[1085]: [SpotifyConnect] unSetVolatile called Oct 03 15:11:13 jklmusic volumio[1085]: info: Spotify Unset Volatile called Oct 03 15:11:13 jklmusic volumio[1085]: [SpotifyConnect] Relinquishing Volumio State to another service Oct 03 15:11:13 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:13 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:14 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioGetState Oct 03 15:11:15 jklmusic volumio[1085]: info: CoreCommandRouter::volumioPlay Oct 03 15:11:15 jklmusic volumio[1085]: verbose: UNSET VOLATILE Oct 03 15:11:15 jklmusic volumio[1085]: [SpotifyConnect] unSetVolatile called Oct 03 15:11:15 jklmusic volumio[1085]: info: Spotify Unset Volatile called Oct 03 15:11:15 jklmusic volumio[1085]: [SpotifyConnect] Relinquishing Volumio State to another service Oct 03 15:11:15 jklmusic volumio[1085]: [SpotifyConnect] Spotify Received stop Oct 03 15:11:15 jklmusic volumio[1085]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 15:11:15 jklmusic volumio[1085]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Oct 03 15:11:15 jklmusic volumio[1085]: at Socket._healthCheck (dgram.js:638:11) Oct 03 15:11:15 jklmusic volumio[1085]: at Socket.send (dgram.js:435:8) Oct 03 15:11:15 jklmusic volumio[1085]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Oct 03 15:11:15 jklmusic volumio[1085]: at ControllerSpotify.stop (/data/plugins/music_service/spop/index.js:2674:19) Oct 03 15:11:15 jklmusic volumio[1085]: at ControllerSpotify.spotConnUnsetVolatile (/data/plugins/music_service/spop/index.js:2355:17) Oct 03 15:11:15 jklmusic volumio[1085]: at ControllerSpotify.unsetVol (/data/plugins/music_service/spop/index.js:68:21) Oct 03 15:11:15 jklmusic volumio[1085]: at CoreStateMachine.unSetVolatile (/volumio/app/statemachine.js:1519:27) Oct 03 15:11:15 jklmusic volumio[1085]: at CoreCommandRouter.volumioPlay (/volumio/app/index.js:1305:21) Oct 03 15:11:15 jklmusic volumio[1085]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:202:35) Oct 03 15:11:15 jklmusic volumio[1085]: at emitTwo (events.js:126:13) Oct 03 15:11:15 jklmusic volumio[1085]: at Socket.emit (events.js:214:7) Oct 03 15:11:15 jklmusic volumio[1085]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 03 15:11:15 jklmusic volumio[1085]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 03 15:11:15 jklmusic volumio[1085]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 03 15:11:15 jklmusic volumio[1085]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 15:11:16 jklmusic sudo[2242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-03 15:10 Oct 03 15:11:16 jklmusic sudo[2242]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"