glk1001 / plugin.audio.spotify

Unofficial Spotify for Kodi Add-on updated for Kodi 19 and 20.
GNU General Public License v3.0
10 stars 4 forks source link

Tracks Frequently Skip to Next Shortly After Starting #4

Open Maci74 opened 9 months ago

Maci74 commented 9 months ago

I'm experiencing an issue with the Spotify addon on Kodi where tracks frequently skip to the next one shortly after they begin playing. This problem occurs randomly but consistently across different tracks and playlists, making it challenging to listen to a full song without interruptions. There are no error messages displayed, and my internet connection is stable, which suggests the issue might be related to the addon or its integration with Spotify.

If helpful, I am willing to share the Kodi logs for further investigation.

I would like to conclude by expressing my gratitude to glk1001 for your ongoing maintenance of the Spotify addon for Kodi. Your efforts are greatly appreciated.

glk1001 commented 3 months ago

Sorry for the long delay responding. Are you still having this issue? If so, can you get me some logs.

Kaizaaaa commented 2 hours ago

Hi there,

I have the same issue since a long time, but did not follow up. Now I stumbeled across this issue. Here is a log file:

2024-11-27 15:25:08.790 T:3117     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:08.792 T:3117     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:08.793 T:3117     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:08.795 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:08.796 T:3117     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:08.797 T:3117     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=0-'.
2024-11-27 15:25:08.799 T:3117     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:08.800 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 0
2024-11-27 15:25:08.802 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:08.803 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_send_wav_header: Sending wav header for track '6cgDytKIjMM5f7trLys7p4'.
2024-11-27 15:25:08.804 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:08.805 T:3117     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:08.807 T:3117     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:08.853 T:1147    debug <general>: CMusicGUIInfo::InitCurrentItem(http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533)
2024-11-27 15:25:08.853 T:1147    debug <general>: CPlayerGUIInfo::InitCurrentItem(http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533)
2024-11-27 15:25:08.887 T:1182    debug <general>: [plugin.googledrive][MainThread-140733444910848]: playback started: http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533
2024-11-27 15:25:08.887 T:1182    debug <CAddonSettings[0@plugin.googledrive]>: trying to load setting definitions from old format...
2024-11-27 15:25:08.887 T:1182    debug <CSettingsManager>: requested setting (download.service.port) was not found.
2024-11-27 15:25:08.887 T:1182    debug <CSettingsManager>: requested setting (source.service.port) was not found.
2024-11-27 15:25:08.950 T:1277    debug <general>: Twitch: Player: |onPlayBackStarted| isTwitch |False| SeekTime ||
2024-11-27 15:25:08.953 T:1147    debug <general>: ------ Window Init (DialogBusy.xml) ------
2024-11-27 15:25:09.002 T:3116    debug <general>: CFileCache::Open - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> source chunk size is 0, setting cache chunk size to 131072
2024-11-27 15:25:09.002 T:3116    debug <general>: CFileCache::Open - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> using single memory cache sized 20971520 bytes
2024-11-27 15:25:09.003 T:3120    debug <general>: Thread FileCache start, auto delete: false
2024-11-27 15:25:09.003 T:3116     info <general>: Creating Demuxer
2024-11-27 15:25:09.089 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:10.570 T:3117     info <general>: Skipped 6 duplicate messages..
2024-11-27 15:25:10.570 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   0.5MB (  1%).
2024-11-27 15:25:10.571 T:3116    debug <general>: Open - probing detected format [wav]
2024-11-27 15:25:10.571 T:3116    debug <general>: Open - avformat_find_stream_info starting
2024-11-27 15:25:10.586 T:3116    debug <general>: Open - av_find_stream_info finished
2024-11-27 15:25:10.586 T:3116     info <general>: ffmpeg[0x2ea250e0]: Input #0, wav, from 'http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533':
2024-11-27 15:25:10.586 T:3116     info <general>: ffmpeg[0x2ea250e0]:   Duration: 00:03:21.00, bitrate: 1411 kb/s
2024-11-27 15:25:10.586 T:3116     info <general>: ffmpeg[0x2ea250e0]:   Stream #0:0: Audio: pcm_s16le ([1][0][0][0] / 0x0001), 44100 Hz, 2 channels, s16, 1411 kb/s
2024-11-27 15:25:10.586 T:3116    debug <general>: CDVDDemuxFFmpeg::AddStream ID: 0
2024-11-27 15:25:10.586 T:3116    debug <general>: CFileCache::IoControl - setting maxRate to 1.48 Mbit/s with processWait of 100 ms
2024-11-27 15:25:10.586 T:3116    debug <general>: CDVDInputStreamFile::SetReadRate - set cache throttle rate to 194040 bytes per second
2024-11-27 15:25:10.586 T:3116     info <general>: Opening stream: 0 source: 256
2024-11-27 15:25:10.586 T:3116     info <general>: Finding audio codec for: 65536
2024-11-27 15:25:10.586 T:3116     info <general>: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder pcm_s16le
2024-11-27 15:25:10.586 T:3116     info <general>: OpenStream: Allowing max Out-Of-Sync Value of 50 ms
2024-11-27 15:25:10.586 T:3116     info <general>: Creating audio thread
2024-11-27 15:25:10.586 T:3124    debug <general>: Thread VideoPlayerAudio start, auto delete: false
2024-11-27 15:25:10.586 T:3124     info <general>: running thread: CVideoPlayerAudio::Process()
2024-11-27 15:25:10.586 T:3116    debug <general>: CVideoPlayer::SetCaching - caching state 1
2024-11-27 15:25:10.586 T:3116    debug <general>: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2024-11-27 15:25:10.586 T:3116    debug <general>: CVideoPlayer::SetCaching - caching state 1
2024-11-27 15:25:10.586 T:3116    debug <general>: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2024-11-27 15:25:10.586 T:3093    debug <general>: OnAVChange: CApplication::OnAVChange
2024-11-27 15:25:10.596 T:3124    debug <general>: CVideoPlayerAudio - CDVDMsg::GENERAL_PAUSE: false
2024-11-27 15:25:10.596 T:3124    debug <general>: CDVDAudio::Pause - pausing audio stream
2024-11-27 15:25:10.596 T:3124     info <general>: Skipped 1 duplicate messages..
2024-11-27 15:25:10.596 T:3124     info <general>: Creating audio stream (codec id: 65536, channels: 2, sample rate: 44100, no pass-through)
2024-11-27 15:25:10.596 T:3124    debug <general>: CVideoPlayerAudio:: synctype set to 0: clock feedback
2024-11-27 15:25:10.597 T:1154    debug <general>: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2024-11-27 15:25:10.604 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   1.0MB (  2%).
2024-11-27 15:25:10.604 T:3116    debug <general>: CVideoPlayer::HandleMessages - player 1 reported state: 0
2024-11-27 15:25:10.604 T:3116    debug <general>: CVideoPlayer::HandleMessages - player started 1
2024-11-27 15:25:10.604 T:3116    debug <general>: VideoPlayer::Sync - Audio - pts: 278639.000000, cache: 461376.996556, totalcache: 800000.011921
2024-11-27 15:25:10.604 T:3093    debug <general>: OnAVChange: CApplication::OnAVChange
2024-11-27 15:25:10.604 T:3124    debug <general>: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-182737.996556), level: 27, cache: 454049.070556
2024-11-27 15:25:10.604 T:3116  warning <general>: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
2024-11-27 15:25:10.604 T:3116    debug <general>: CVideoPlayer::SetCaching - caching state 0
2024-11-27 15:25:10.604 T:3116    debug <general>: CDVDClock::SetSpeedAdjust - adjusted:0.000000
2024-11-27 15:25:10.605 T:3093    debug <general>: OnAVStarted: CApplication::OnAVStarted
2024-11-27 15:25:10.605 T:3124    debug <general>: CDVDAudio::Resume - resume audio stream
2024-11-27 15:25:10.605 T:1154    debug <general>: ActiveAE - start sync of audio stream
2024-11-27 15:25:10.653 T:1147    debug <general>: ------ Window Deinit (DialogBusy.xml) ------
2024-11-27 15:25:10.708 T:1154    debug <general>: ActiveAE::SyncStream - average error of 12.871467, start adjusting
2024-11-27 15:25:10.708 T:1154    debug <general>: ActiveAE::SyncStream - average error 0.871467 below threshold of 30.000000
2024-11-27 15:25:10.779 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   1.5MB (  4%).
2024-11-27 15:25:11.057 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   2.0MB (  5%).
2024-11-27 15:25:11.199 T:3117     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   2.5MB (  7%).
2024-11-27 15:25:11.789 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:11.819 T:3084     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:11.819 T:3084    debug <general>: easy_acquire - Created session to http://localhost
2024-11-27 15:25:11.822 T:3125     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:11.824 T:3125     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:11.825 T:3117    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:11] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 2621484

2024-11-27 15:25:11.825 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:11.825 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:11.828 T:3126     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:11.829 T:3125     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:11.831 T:3126     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:11.832 T:3125     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:11.835 T:3126     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:11.835 T:3125     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:11.838 T:3125     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:11.839 T:3126     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:11.841 T:3125     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:11.842 T:3126     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:11.843 T:3125    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:11] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:11.845 T:3126     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=2621484-'.
2024-11-27 15:25:11.846 T:3126     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 2621484-35456444/35456444, length = 32834960
2024-11-27 15:25:11.848 T:3126     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 2621484
2024-11-27 15:25:11.849 T:3126     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:11.851 T:3126     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:11.852 T:3126     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:11.854 T:3126     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:11.854 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:13.505 T:3131     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:13.505 T:3131     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:13.506 T:3131     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:13.507 T:3126    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:13] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:13.507 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:13.507 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:13.508 T:3131     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:13.511 T:3132     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:13.513 T:3132     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:13.513 T:3131     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:13.516 T:3132     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:13.517 T:3131     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:13.519 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:13.520 T:3131     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:13.521 T:3132     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:13.524 T:3132     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=2621484-'.
2024-11-27 15:25:13.524 T:3131     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:13.525 T:3131    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:13] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:13.526 T:3132     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 2621484-35456444/35456444, length = 32834960
2024-11-27 15:25:13.528 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 2621484
2024-11-27 15:25:13.529 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:13.530 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:13.532 T:3132     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:13.533 T:3132     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:13.535 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:14.363 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   0.5MB (  1%).
2024-11-27 15:25:14.419 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   1.0MB (  2%).
2024-11-27 15:25:14.721 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   1.5MB (  4%).
2024-11-27 15:25:14.761 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   2.0MB (  5%).
2024-11-27 15:25:15.068 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   2.5MB (  7%).
2024-11-27 15:25:15.103 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:15.117 T:3132     info <general>: Skipped 1 duplicate messages..
2024-11-27 15:25:15.117 T:3132     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   3.0MB (  8%).
2024-11-27 15:25:15.125 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:15.139 T:3137     info <general>: Skipped 1 duplicate messages..
2024-11-27 15:25:15.139 T:3137     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:15.140 T:3137     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:15.141 T:3132    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:15] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 3145728

2024-11-27 15:25:15.142 T:3137     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:15.144 T:3137     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:15.145 T:3137     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:15.146 T:3137     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:15.148 T:3137     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:15.148 T:3137    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:15] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:15.160 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:16.747 T:3139     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:16.747 T:3139     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:16.748 T:3139     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:16.749 T:3139     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:16.751 T:3139     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:16.752 T:3139     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:16.753 T:3139     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:16.755 T:3139     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:16.755 T:3139    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:16] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:16.765 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:18.030 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:18.030 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:18.032 T:3140     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:18.033 T:3140     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:18.035 T:3140     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:18.036 T:3140     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:18.037 T:3140     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:18.039 T:3140     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:18.040 T:3140     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:18.042 T:3140     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:18.043 T:3140     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:18.045 T:3140     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:18.046 T:3140     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:18.048 T:3140     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:18.324 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:18.359 T:3145     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:18.359 T:3145     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:18.360 T:3145     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:18.361 T:3140    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:18] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:18.361 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:18.361 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:18.363 T:3145     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:18.365 T:3146     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:18.366 T:3145     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:18.368 T:3146     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:18.369 T:3145     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:18.371 T:3146     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:18.372 T:3145     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:18.375 T:3145     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:18.375 T:3146     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:18.376 T:3145    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:18] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:18.377 T:3146     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:18.378 T:3146     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:18.380 T:3146     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:18.381 T:3146     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:18.382 T:3146     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:18.384 T:3146     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:18.386 T:3146     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:18.387 T:3146     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:18.387 T:3084    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:19.979 T:3152     info <general>: Skipped 6 duplicate messages..
2024-11-27 15:25:19.979 T:3152     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:19.981 T:3152     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:19.983 T:3146    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:19] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:19.983 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:19.983 T:3120  warning <general>: CFileCache::Process - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> source read returned 0! Will retry
2024-11-27 15:25:19.984 T:3152     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:19.986 T:3152     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:19.988 T:3152     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:19.990 T:3152     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:19.992 T:3152     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:19.993 T:3152    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:19] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:20.004 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:21.576 T:3154     info <general>: Skipped 6 duplicate messages..
2024-11-27 15:25:21.576 T:3154     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:21.578 T:3154     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:21.580 T:3154     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:21.583 T:3154     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:21.585 T:3154     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:21.587 T:3154     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:21.589 T:3154     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:21.589 T:3154    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:21] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:21.602 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:21.983 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:21.987 T:3155     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:21.988 T:3155     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:21.991 T:3155     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:21.993 T:3155     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:21.995 T:3155     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:21.997 T:3155     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:21.999 T:3155     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:22.001 T:3155     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:22.003 T:3155     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:22.006 T:3155     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:22.008 T:3155     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:22.010 T:3155     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:23.147 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:23.177 T:3160     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:23.177 T:3160     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:23.178 T:3160     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:23.179 T:3155    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:23] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:23.179 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:23.179 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:23.182 T:3161     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:23.183 T:3160     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:23.185 T:3161     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:23.186 T:3160     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:23.188 T:3161     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:23.190 T:3160     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:23.191 T:3161     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:23.193 T:3160     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:23.194 T:3161     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:23.196 T:3160     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:23.197 T:3161     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:23.198 T:3161     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:23.199 T:3160    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:23] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:23.200 T:3161     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:23.202 T:3161     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:23.203 T:3161     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:23.205 T:3161     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:23.206 T:3161     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:23.222 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:24.917 T:3166     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:24.917 T:3166     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:24.918 T:3166     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:24.919 T:3161    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:24] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:24.919 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:24.919 T:3120  warning <general>: CFileCache::Process - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> source read returned 0! Will retry
2024-11-27 15:25:24.920 T:3166     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:24.921 T:3166     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:24.923 T:3166     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:24.924 T:3166     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:24.926 T:3166     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:24.926 T:3166    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:24] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:24.940 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:25.680 T:1189     info <general>: [plugin.video.youtube] HTTPServer: Shutting down |0.0.0.0:50152|
2024-11-27 15:25:26.487 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:26.517 T:3168     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:26.517 T:3168     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:26.519 T:3168     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:26.520 T:3168     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:26.522 T:3168     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:26.523 T:3168     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:26.524 T:3168     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:26.526 T:3168     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:26.526 T:3168    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:26] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:26.537 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:26.920 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:26.922 T:3169     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:26.923 T:3169     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:26.925 T:3169     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:26.926 T:3169     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:26.928 T:3169     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:26.929 T:3169     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:26.930 T:3169     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:26.932 T:3169     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:26.933 T:3169     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:26.935 T:3169     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:26.936 T:3169     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:26.938 T:3169     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:28.087 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:28.120 T:3174     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:28.120 T:3174     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:28.122 T:3174     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:28.124 T:3169    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:28] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:28.125 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:28.125 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:28.126 T:3174     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:28.130 T:3175     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:28.132 T:3175     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:28.133 T:3174     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:28.137 T:3174     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:28.138 T:3175     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:28.142 T:3174     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:28.142 T:3175     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:28.146 T:3174     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:28.147 T:3175     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:28.149 T:3175     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:28.151 T:3174    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:28] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:28.152 T:3175     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:28.154 T:3175     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:28.156 T:3175     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:28.159 T:3175     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:28.161 T:3175     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:28.163 T:3175     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:28.213 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:28.362 T:3175    error <general>: plugin.audio.spotify:spotty_audio_streamer:send_part_audio_stream: Nothing read from stdout.
2024-11-27 15:25:28.362 T:3175    debug <CAddonSettings[0@plugin.audio.spotify]>: trying to load setting definitions from old format...
2024-11-27 15:25:28.362 T:3175    debug <CSettingsManager>: requested setting (cache_checksum) was not found.
2024-11-27 15:25:28.362 T:3175    debug <CSettingsManager>: requested setting (password) was not found.
2024-11-27 15:25:28.362 T:3175    debug <CSettingsManager>: requested setting (username) was not found.
2024-11-27 15:25:28.500 T:3175     info <general>: plugin.audio.spotify:save_recently_played:save_track: Saved track '6cgDytKIjMM5f7trLys7p4' to 'My Recently Played' playlist.
2024-11-27 15:25:28.503 T:3175     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_finished_sending: Finished sending track '6cgDytKIjMM5f7trLys7p4' - range begin 5767212 - range end 0 - 0.0MB.
2024-11-27 15:25:28.503 T:3175    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:28] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:28.503 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:28.503 T:3120  warning <general>: CFileCache::Process - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> source read returned 0! Will retry
2024-11-27 15:25:29.150 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:29.767 T:3178     info <general>: Skipped 6 duplicate messages..
2024-11-27 15:25:29.767 T:3178     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:29.769 T:3178     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:29.771 T:3178     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:29.773 T:3178     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:29.775 T:3178     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:29.777 T:3178     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:29.779 T:3178     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:29.780 T:3178    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:29] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:29.790 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:30.503 T:3120     info <general>: Skipped 2 duplicate messages..
2024-11-27 15:25:30.503 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:30.506 T:3179     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:30.508 T:3179     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:30.510 T:3179     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:30.513 T:3179     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:30.515 T:3179     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:30.517 T:3179     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:30.519 T:3179     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:30.521 T:3179     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:30.523 T:3179     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:30.526 T:3179     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:30.528 T:3179     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:30.530 T:3179     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:31.323 T:1191    debug <general>: [ script.embuary.helper ] Start new fanart grabber process
2024-11-27 15:25:31.330 T:1191    debug <general>: GetArtistsByWhereJSON query: SELECT a1.*, art.art_id AS idArt, art.type AS artType, art.url AS artURL FROM (SELECT artist.idArtist, strArtist FROM artist  WHERE (EXISTS (SELECT 1 FROM song_artist WHERE song_artist.idArtist = artist.idArtist AND song_artist.idRole = 1) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idArtist = artist.idArtist)) AND (artist.strArtist != '') ORDER BY RANDOM() LIMIT 40) AS a1 LEFT JOIN art ON art.media_id = a1.idArtist AND art.media_type = 'artist' GROUP BY a1.idArtist, art.art_id ORDER BY a1.idArtist, arttype
2024-11-27 15:25:31.330 T:1191    debug <general>: GetArtistsByWhereJSON - query took 0 ms
2024-11-27 15:25:31.331 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:31.361 T:3184     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:31.361 T:3184     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:31.363 T:3184     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:31.365 T:3179    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:31] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:31.365 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:31.365 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:31.366 T:3184     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:31.370 T:3185     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:31.371 T:3184     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:31.374 T:3185     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:31.376 T:3184     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:31.379 T:3185     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:31.380 T:3184     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:31.384 T:3185     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:31.385 T:3184     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:31.389 T:3185     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:31.389 T:3184    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:31] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:31.392 T:3185     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=5767212-'.
2024-11-27 15:25:31.394 T:3185     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 5767212-35456444/35456444, length = 29689232
2024-11-27 15:25:31.396 T:3185     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 5767212
2024-11-27 15:25:31.398 T:3185     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:31.401 T:3185     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:31.403 T:3185     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:31.405 T:3185     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:31.439 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:32.759 T:3185     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_continue_sending: Continue sending track '6cgDytKIjMM5f7trLys7p4' - sent so far:   0.5MB (  1%).
2024-11-27 15:25:32.981 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:33.025 T:3190     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:33.025 T:3190     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:33.026 T:3190     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:33.027 T:3185    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:33] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 524288

2024-11-27 15:25:33.027 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:33.027 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:33.029 T:3190     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:33.031 T:3191     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:33.033 T:3190     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:33.033 T:3191     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:33.036 T:3191     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:33.036 T:3190     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:33.038 T:3191     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:33.040 T:3191     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:33.041 T:3190     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:33.043 T:3191     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=6291500-'.
2024-11-27 15:25:33.045 T:3190     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:33.046 T:3191     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 6291500-35456444/35456444, length = 29164944
2024-11-27 15:25:33.047 T:3190    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:33] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:33.047 T:3191     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 6291500
2024-11-27 15:25:33.049 T:3191     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:33.050 T:3191     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:33.052 T:3191     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:33.053 T:3191     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:33.062 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:34.704 T:3196     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:34.704 T:3196     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:34.706 T:3196     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:34.707 T:3191    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:34] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:34.707 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:34.707 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:34.708 T:3196     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:34.711 T:3196     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:34.711 T:3197     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:34.714 T:3197     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:34.714 T:3196     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:34.716 T:3197     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:34.718 T:3196     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:34.719 T:3197     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:34.721 T:3197     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:34.723 T:3196     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:34.724 T:3197     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=6291500-'.
2024-11-27 15:25:34.725 T:3197     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 6291500-35456444/35456444, length = 29164944
2024-11-27 15:25:34.726 T:3196    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:34] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:34.727 T:3197     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 6291500
2024-11-27 15:25:34.729 T:3197     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:34.730 T:3197     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:34.732 T:3197     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:34.733 T:3197     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:34.735 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: Database driver: Internal (sqlite)
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:StoreSQLite]: StoreSQLite DBFile: /storage/.kodi/userdata/addon_data/plugin.video.mediathekview/filmliste-v3.db
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: Last Update 2024-09-10 19:05:44
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: Last Full Update 2024-09-10 19:05:44
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: version 3
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: status IDLE
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: update interval 7200
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: Update Mode "Automatic"
2024-11-27 15:25:35.410 T:1185    debug <general>: [plugin.video.mediathekview-1.1.3:MediathekViewUpdater]: nothing to do
2024-11-27 15:25:36.282 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:36.316 T:3202     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:36.316 T:3202     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:36.317 T:3202     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:36.318 T:3197    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:36] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:36.319 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:36.319 T:3120  warning <general>: CFileCache::Process - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> source read returned 0! Will retry
2024-11-27 15:25:36.319 T:3202     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:36.321 T:3202     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:36.322 T:3202     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:36.323 T:3202     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:36.325 T:3202     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:36.325 T:3202    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:36] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:36.341 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:37.912 T:3203     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:37.912 T:3203     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:37.914 T:3203     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:37.916 T:3203     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:37.918 T:3203     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:37.920 T:3203     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:37.923 T:3203     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:37.925 T:3203     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:37.925 T:3203    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:37] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:37.940 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:38.319 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 1
2024-11-27 15:25:38.322 T:3204     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:38.324 T:3204     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:38.326 T:3204     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:38.328 T:3204     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:38.330 T:3204     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:38.332 T:3204     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=6291500-'.
2024-11-27 15:25:38.334 T:3204     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 6291500-35456444/35456444, length = 29164944
2024-11-27 15:25:38.337 T:3204     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 6291500
2024-11-27 15:25:38.339 T:3204     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:38.341 T:3204     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:38.343 T:3204     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:38.346 T:3204     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:39.178 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:39.501 T:3209     info <general>: Skipped 6 duplicate messages..
2024-11-27 15:25:39.501 T:3209     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:39.502 T:3209     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:39.504 T:3204    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:39] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:39.504 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:39.504 T:3120  warning <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Reconnect, (re)try 2
2024-11-27 15:25:39.505 T:3209     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:39.507 T:3210     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:39.509 T:3209     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:39.511 T:3210     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:39.511 T:3209     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:39.513 T:3210     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:39.515 T:3209     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:39.516 T:3210     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:39.518 T:3210     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:39.520 T:3209     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:39.520 T:3210     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=6291500-'.
2024-11-27 15:25:39.521 T:3209    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:39] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:39.524 T:3210     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Partial request, range = bytes 6291500-35456444/35456444, length = 29164944
2024-11-27 15:25:39.526 T:3210     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '6cgDytKIjMM5f7trLys7p4' - range begin: 6291500
2024-11-27 15:25:39.527 T:3210     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:39.528 T:3210     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:6cgDytKIjMM5f7trLys7p4', length = 35456444 (33.8MB).
2024-11-27 15:25:39.530 T:3210     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:39.531 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:39.532 T:3210     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:6cgDytKIjMM5f7trLys7p4
2024-11-27 15:25:39.569 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:40.605 T:3095     info <general>: Skipped 1 duplicate messages..
2024-11-27 15:25:40.605 T:3095    debug <general>: Thread JobWorker 140732112105216 terminating (autodelete)
2024-11-27 15:25:40.605 T:3093    debug <general>: Thread JobWorker 140732199825152 terminating (autodelete)
2024-11-27 15:25:41.081 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:41.113 T:3215     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:41.113 T:3215     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:41.115 T:3215     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:41.116 T:3210    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:41] "GET /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 206 0

2024-11-27 15:25:41.116 T:3120    error <general>: CCurlFile::CReadState::FillBuffer - (0x7ffed97ebb50) Failed: Transferred a partial file(18)
2024-11-27 15:25:41.116 T:3120    error <general>: CFileCache::Process - <http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533> source read didn't return any data before eof!
2024-11-27 15:25:41.117 T:3215     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: Terminated running streamer.
2024-11-27 15:25:41.118 T:3215     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:41.119 T:3215     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:41.121 T:3215     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:41.122 T:3215     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:41.122 T:3215    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:41] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:41.134 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:42.714 T:3216     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:42.714 T:3216     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:42.716 T:3216     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:42.717 T:3216     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:42.719 T:3216     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:42.720 T:3216     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:42.721 T:3216     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:42.723 T:3216     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:42.723 T:3216    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:42] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:42.736 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:44.320 T:3217     info <general>: Skipped 4 duplicate messages..
2024-11-27 15:25:44.320 T:3217     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:44.322 T:3217     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:44.324 T:3217     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:44.326 T:3217     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:44.328 T:3217     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:44.330 T:3217     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:44.332 T:3217     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:44.333 T:3217    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:44] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:44.344 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:45.720 T:3116     info <general>: CVideoPlayer::OnExit()
2024-11-27 15:25:45.720 T:3116     info <general>: VideoPlayer: eof, waiting for queues to empty
2024-11-27 15:25:45.720 T:3116    debug <general>: CVideoPlayer: updating file item stream details with available streams
2024-11-27 15:25:45.720 T:3116     info <general>: Closing stream player 1
2024-11-27 15:25:45.720 T:3116     info <general>: CDVDMessageQueue(audio)::WaitUntilEmpty
2024-11-27 15:25:45.720 T:3124    debug <general>: CVideoPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
2024-11-27 15:25:45.720 T:3116     info <general>: Waiting for audio thread to exit
2024-11-27 15:25:45.720 T:3124     info <general>: thread end: CVideoPlayerAudio::OnExit()
2024-11-27 15:25:45.720 T:3124    debug <general>: Thread VideoPlayerAudio 140732103651072 terminating
2024-11-27 15:25:45.721 T:3116     info <general>: Closing audio device
2024-11-27 15:25:45.885 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:45.921 T:3218     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:45.921 T:3218     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:45.923 T:3218     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:45.925 T:3218     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:45.927 T:3218     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:45.929 T:3218     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:45.931 T:3218     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:45.933 T:3218     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:45.934 T:3218    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:45] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:45.965 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:46.109 T:1154    debug <general>: CActiveAE::DiscardStream - audio stream deleted
2024-11-27 15:25:46.109 T:1154    debug <general>: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2024-11-27 15:25:46.109 T:3116     info <general>: Skipped 2 duplicate messages..
2024-11-27 15:25:46.109 T:3116     info <general>: Deleting audio codec
2024-11-27 15:25:46.110 T:3219    debug <general>: Thread JobWorker start, auto delete: true
2024-11-27 15:25:46.110 T:3219    debug <general>: [threads] name: 'JobWorker' priority: '1'
2024-11-27 15:25:46.110 T:3120    debug <general>: Thread FileCache 140732120559360 terminating
2024-11-27 15:25:46.110 T:3116    debug <general>: Thread VideoPlayer 140732261658368 terminating
2024-11-27 15:25:46.111 T:3219     info <general>: Deleting settings information for files http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533
2024-11-27 15:25:46.112 T:3220    debug <general>: Thread JobWorker start, auto delete: true
2024-11-27 15:25:46.112 T:3220    debug <general>: [threads] name: 'JobWorker' priority: '1'
2024-11-27 15:25:46.112 T:3220    debug <general>: DoWork - Saving file state for video item http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533
2024-11-27 15:25:46.113 T:1147    debug <general>: Flush - flushing renderer
2024-11-27 15:25:46.116 T:3221     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533>
2024-11-27 15:25:46.118 T:3221     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:46.120 T:3221     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:46.123 T:3221     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:46.125 T:3221     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '6cgDytKIjMM5f7trLys7p4', track length 35456444.
2024-11-27 15:25:46.127 T:3221     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: ''.
2024-11-27 15:25:46.129 T:3221     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:46.129 T:3221    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:46] "HEAD /track/6cgDytKIjMM5f7trLys7p4/201.533 HTTP/1.1" 200 0

2024-11-27 15:25:46.139 T:3220    debug <general>: DoWork - Saving file state for audio item http://localhost:52308/track/6cgDytKIjMM5f7trLys7p4/201.533
2024-11-27 15:25:46.139 T:3219    debug <general>: OnPlayBackEnded: CApplicationPlayerCallback::OnPlayBackEnded
2024-11-27 15:25:46.154 T:1147     info <general>: VideoPlayer::OpenFile: http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826
2024-11-27 15:25:46.154 T:3222    debug <general>: Thread VideoPlayer start, auto delete: false
2024-11-27 15:25:46.154 T:1147    debug <general>: OnPlayBackStarted: CApplication::OnPlayBackStarted
2024-11-27 15:25:46.154 T:3222     info <general>: Creating InputStream
2024-11-27 15:25:46.155 T:3222    debug <general>: CFileCache::Open - <http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826> opening
2024-11-27 15:25:46.155 T:3222    debug <general>: CurlFile::Open - <http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826>
2024-11-27 15:25:46.157 T:3220    debug <general>: Loading settings for http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826
2024-11-27 15:25:46.158 T:1147    debug <general>: CMusicGUIInfo::InitCurrentItem(http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826)
2024-11-27 15:25:46.158 T:1147    debug <general>: CPlayerGUIInfo::InitCurrentItem(http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826)
2024-11-27 15:25:46.159 T:1277    debug <general>: Twitch: Player: |onPlayBackEnded| isTwitch |False|
2024-11-27 15:25:46.160 T:3223     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: GET http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826>
2024-11-27 15:25:46.160 T:1277    debug <general>: Twitch: Player: |onPlayBackStarted| isTwitch |False| SeekTime ||
2024-11-27 15:25:46.162 T:3223     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:46.164 T:3223     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:__terminate_streaming: No running streamer. Nothing to terminate.
2024-11-27 15:25:46.166 T:3223     info <general>: plugin.audio.spotify:spotty_audio_streamer:__create_wav_header: Start getting wav header. Duration = 201
2024-11-27 15:25:46.168 T:3223     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Start streaming spotify track '0MZq5dbqFQrvDFyl8ou7dm', track length 35456444.
2024-11-27 15:25:46.170 T:3223     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Request header range: 'bytes=0-'.
2024-11-27 15:25:46.172 T:3223     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Full request, content length = 35456444.
2024-11-27 15:25:46.175 T:3223     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Start transfer for track '0MZq5dbqFQrvDFyl8ou7dm' - range begin: 0
2024-11-27 15:25:46.177 T:3223     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_transfer: Use Spotify normalization: True.
2024-11-27 15:25:46.179 T:3223     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_send_wav_header: Sending wav header for track '0MZq5dbqFQrvDFyl8ou7dm'.
2024-11-27 15:25:46.181 T:3223     info <general>: plugin.audio.spotify:spotty_audio_streamer:__log_start_reading_audio: Start reading audio data for track: 'spotify:track:0MZq5dbqFQrvDFyl8ou7dm', length = 35456444 (33.8MB).
2024-11-27 15:25:46.183 T:3223     info <general>: plugin.audio.spotify:spotty:run_spotty: Running spotty...
2024-11-27 15:25:46.184 T:3223     info <general>: plugin.audio.spotify:spotty:run_spotty: Spotty args: /storage/.kodi/addons/plugin.audio.spotify/resources/lib/deps/spotty/arm-linux/spotty-muslhf --cache /storage/.kodi/userdata/addon_data/plugin.audio.spotify/spotty-cache --verbose --name Kodi-Spotty --disable-audio-cache --disable-discovery --bitrate 320 --initial-volume 50 --enable-volume-normalisation --normalisation-gain-type track --single-track spotify:track:0MZq5dbqFQrvDFyl8ou7dm
2024-11-27 15:25:46.186 T:1182    debug <general>: [plugin.googledrive][MainThread-140733444910848]: playback started: http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826
2024-11-27 15:25:46.187 T:1182    debug <CAddonSettings[0@plugin.googledrive]>: trying to load setting definitions from old format...
2024-11-27 15:25:46.187 T:1182    debug <CSettingsManager>: requested setting (download.service.port) was not found.
2024-11-27 15:25:46.187 T:1182    debug <CSettingsManager>: requested setting (source.service.port) was not found.
2024-11-27 15:25:46.250 T:1189     info <general>: [plugin.video.youtube] PlayerMonitor active threads: ||
2024-11-27 15:25:46.258 T:1147    debug <general>: ------ Window Init (DialogBusy.xml) ------
2024-11-27 15:25:46.378 T:3222    debug <general>: CFileCache::Open - <http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826> source chunk size is 0, setting cache chunk size to 131072
2024-11-27 15:25:46.379 T:3222    debug <general>: CFileCache::Open - <http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826> using single memory cache sized 20971520 bytes
2024-11-27 15:25:46.379 T:3226    debug <general>: Thread FileCache start, auto delete: false
2024-11-27 15:25:46.379 T:3222     info <general>: Creating Demuxer
2024-11-27 15:25:46.485 T:1154    debug <general>: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
2024-11-27 15:25:46.833 T:1170    debug <general>: CRepositoryUpdater: running scheduled update
2024-11-27 15:25:46.833 T:3220    debug <general>: CRepositoryUpdateJob[repository.castagnait] checking for updates.
2024-11-27 15:25:46.833 T:3219    debug <general>: CRepositoryUpdateJob[repository.kodinerds] checking for updates.
2024-11-27 15:25:46.833 T:3227    debug <general>: Thread JobWorker start, auto delete: true
2024-11-27 15:25:46.833 T:3227    debug <general>: [threads] name: 'JobWorker' priority: '1'
2024-11-27 15:25:46.833 T:3227    debug <general>: CRepositoryUpdateJob[repository.libreelec.tv] checking for updates.
2024-11-27 15:25:46.833 T:1170    debug <general>: Thread Timer 140734031982336 terminating
2024-11-27 15:25:46.834 T:3220    debug <general>: CurlFile::Open - <https://github.com/CastagnaIT/repository.castagnait/raw/kodi/kodi19/addons.xml.md5>
2024-11-27 15:25:46.834 T:3219    debug <general>: CurlFile::Open - <https://repo.kodinerds.net/addons/addons.xml.md5>
2024-11-27 15:25:46.834 T:3220    debug <general>: easy_acquire - Created session to https://github.com
2024-11-27 15:25:46.834 T:3227    debug <general>: CurlFile::Open - <https://addons.libreelec.tv/12.0.0/ARMv8/aarch64/addons.xml.gz.sha256>
2024-11-27 15:25:46.834 T:3219    debug <general>: easy_acquire - Created session to https://repo.kodinerds.net
2024-11-27 15:25:46.834 T:3227    debug <general>: easy_acquire - Created session to https://addons.libreelec.tv
2024-11-27 15:25:46.962 T:3219    debug <general>: CurlFile::Open - <https://repo.kodinerds.net/addons/omega/addons.xml.md5>
2024-11-27 15:25:46.987 T:3219    debug <general>: CurlFile::Open - <https://repo.kodinerds.net/addons/nexus/addons.xml.md5>
2024-11-27 15:25:47.005 T:3219    debug <general>: CurlFile::Open - <https://repo.kodinerds.net/addons/matrix/addons.xml.md5>
2024-11-27 15:25:47.064 T:3219    debug <general>: CRepositoryUpdateJob[repository.kodinerds] checksum not changed.
2024-11-27 15:25:47.064 T:3219    debug <general>: CRepositoryUpdateJob[repository.mediathekview] checking for updates.
2024-11-27 15:25:47.065 T:3219    debug <general>: CurlFile::Open - <https://kodirepo.mediathekview.de/repo-mv/addons.xml.md5>
2024-11-27 15:25:47.065 T:3219    debug <general>: easy_acquire - Created session to https://kodirepo.mediathekview.de
2024-11-27 15:25:47.187 T:3227    debug <general>: CRepositoryUpdateJob[repository.libreelec.tv] checksum not changed.
2024-11-27 15:25:47.187 T:3227    debug <general>: CRepositoryUpdateJob[repository.sandmann79.plugins] checking for updates.
2024-11-27 15:25:47.188 T:3227    debug <general>: CurlFile::Open - <https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages/addons.xml.md5>
2024-11-27 15:25:47.188 T:3227    debug <general>: easy_acquire - Created session to https://raw.githubusercontent.com
2024-11-27 15:25:47.372 T:3219    debug <general>: CurlFile::Open - <https://kodirepo.mediathekview.de/repo-matrix/addons.xml.md5>
2024-11-27 15:25:47.415 T:3220    debug <general>: CCurlFile::Open - <https://github.com/CastagnaIT/repository.castagnait/raw/kodi/kodi19/addons.xml.md5> Effective URL is https://raw.githubusercontent.com/CastagnaIT/repository.castagnait/kodi/kodi19/addons.xml.md5
2024-11-27 15:25:47.428 T:3220    debug <general>: CRepositoryUpdateJob[repository.castagnait] checksum not changed.
2024-11-27 15:25:47.428 T:3220    debug <general>: CRepositoryUpdateJob[repository.xbmc.org] checking for updates.
2024-11-27 15:25:47.428 T:3220    debug <general>: CurlFile::Open - <https://mirrors.kodi.tv/addons/omega/addons.xml.gz?sha256>
2024-11-27 15:25:47.428 T:3220    debug <general>: easy_acquire - Created session to https://mirrors.kodi.tv
2024-11-27 15:25:47.460 T:3227    debug <general>: CurlFile::Open - <https://raw.githubusercontent.com/Sandmann79/xbmc/master/packages-py3/addons.xml.md5>
2024-11-27 15:25:47.495 T:3151    debug <CWebserver[8080]>: request received for /jsonrpc
2024-11-27 15:25:47.536 T:3237     info <general>: Skipped 3 duplicate messages..
2024-11-27 15:25:47.536 T:3237     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: GET request: <LocalRequest: HEAD http://localhost:52308/track/0MZq5dbqFQrvDFyl8ou7dm/201.826>
2024-11-27 15:25:47.538 T:3237     info <general>: plugin.audio.spotify:http_spotty_audio_streamer:spotty_stream_audio_track: Already streaming. Terminating current streamer.
2024-11-27 15:25:47.538 T:3223    error <general>: 127.0.0.1 - - [27/Nov/2024 15:25:47] "GET /track/0MZq5dbqFQrvDFyl8ou7dm/201.826 HTTP/1.1" 200 44