Kodi Community Forum

Full Version: Cache for internet radio streams not working?
You're currently viewing a stripped down version of our content. View the full version with proper formatting.
Hi

When playing an internet stream, i.e. "mms://stream0.orf.at/fm4_live" everything works great, but to start the stream it takes ages! Now i tried to configure the cache size to 256k but this doesn't do a thing. I already tried to disable every cache, but no success. It takes at least 60 seconds to start the stream. It's just "buffering..." for a long time before starting the stream.

P.S: Thanks for this great port. I already loved XBMC on the Xbox but now this is even better on linux!
we cannot determine if the stream is audio or video so cache type unknown is used.
i assume. if you gave us a log we would know.
Sorry. Here's the log. I just went to music and the folder and selected the file to start. Then waited until the stream started and then shutdown XBMC. btw, i have every possible cache set to 256kb. Ant the stream is an wma audio stream, i think.

Thanks for the quick reply! :-)

Oh, cannot attach something. So here is the relevant part (i think!?):
12:27:23 T:3056330592 M:680558592 DEBUG: OnKey: 61480 pressed, action is 4
12:27:23 T:3056330592 M:680599552 DEBUG: OnKey: 61453 pressed, action is 7
12:27:23 T:3056330592 M:680599552 DEBUG: Clearing cached fileitems [/media/d_drive/music/0Internetradio/]
12:27:23 T:3056330592 M:680599552 DEBUG: request to delete file that does not exist: /tmp/xbmc/bb099675.fi
12:27:23 T:3056330592 M:680599552 DEBUG: CGUIMediaWindow::GetDirectory (/media/d_drive/music/0Internetradio/)
12:27:23 T:3056330592 M:680599552 DEBUG: ParentPath = [/media/d_drive/music/]
12:27:23 T:3056330592 M:680599552 WARNING: CreateFile, error 2 opening file </tmp/xbmc/bb099675.fi>, flags:0, mode:100.
12:27:23 T:3010452368 M:680599552 DEBUG: Running thread 3010452368
12:27:23 T:3010452368 M:680599552 DEBUG: thread start, auto delete: 0
12:27:23 T:3010452368 M:680599552 WARNING: CreateFile, error 2 opening file </tmp/xbmc/bb099675.fi>, flags:0, mode:100.
12:27:23 T:3010452368 M:680599552 DEBUG: staticThread, deleting thread graphic context
12:27:23 T:3010452368 M:680599552 DEBUG: Thread 3010452368 terminating
12:27:23 T:3056330592 M:680599552 DEBUG: RetrieveMusicInfo() took 4 msec
12:27:23 T:3056330592 M:680599552 DEBUG: Sort, sorting took 0 millis
12:27:23 T:2931796880 M:680599552 DEBUG: Running thread 2931796880
12:27:23 T:2931796880 M:680599552 DEBUG: thread start, auto delete: 0
12:27:23 T:2931796880 M:680599552 DEBUG: staticThread, deleting thread graphic context
12:27:23 T:2931796880 M:680599552 DEBUG: Thread 2931796880 terminating
12:27:24 T:3056330592 M:680599552 DEBUG: OnKey: 61480 pressed, action is 4
12:27:24 T:3056330592 M:680599552 DEBUG: OnKey: 61453 pressed, action is 7
12:27:24 T:2940189584 M:680599552 DEBUG: Running thread 2940189584
12:27:24 T:2940189584 M:680599552 DEBUG: thread start, auto delete: 1
12:27:24 T:2940189584 M:680599552 DEBUG: CApplication:TonguerocessAndStartPlaylist(/media/d_drive/music/0Internetradio/FM4.strm, 0)
12:27:24 T:2940189584 M:680599552 DEBUG: new file set audiostream:0
12:27:24 T:2940189584 M:680599552 DEBUG: CPlayerCoreFactor::GetPlayers(mms://stream0.orf.at/fm4_live)
12:27:24 T:2940189584 M:680599552 INFO: Loading skin file: DialogProgress.xml
12:27:24 T:2940189584 M:680599552 DEBUG: GL: Sharing screen surface for thread 2940189584
12:27:24 T:2940189584 M:680599552 DEBUG: Load DialogProgress.xml: 88.01ms (0.00 ms xml load)
12:27:24 T:2940189584 M:680599552 DEBUG: ------------------- GUI_MSG_WINDOW_INIT
12:27:24 T:2940189584 M:680599552 DEBUG: Progress dialog
12:27:24 T:2940189584 M:680599552 DEBUG: -------------------
12:27:24 T:2940189584 M:680599552 DEBUG: Alloc resources: 0.00ms (0.00 ms skin load, 0.00 ms preload)
12:27:24 T:2940189584 M:680067072 NOTICE: DVDPlayer: Opening: mms://stream0.orf.at/fm4_live
12:27:24 T:2940189584 M:680067072 NOTICE: CDVDPlayer::CloseFile()
12:27:24 T:2940189584 M:680067072 WARNING: CDVDMessageQueue:Tongueut MSGQ_NOT_INITIALIZED
12:27:24 T:2940189584 M:680067072 NOTICE: DVDPlayer: waiting for threads to exit
12:27:24 T:2940189584 M:680067072 NOTICE: DVDPlayer: finished waiting
12:27:24 T:2940189584 M:680067072 WARNING: CDVDMessageQueue:Tongueut MSGQ_NOT_INITIALIZED
12:27:24 T:2948582288 M:680067072 DEBUG: Running thread 2948582288
12:27:24 T:2948582288 M:680067072 DEBUG: thread start, auto delete: 1
12:27:24 T:2956974992 M:680067072 DEBUG: Running thread 2956974992
12:27:24 T:2956974992 M:680067072 DEBUG: thread start, auto delete: 0
12:27:24 T:2956974992 M:680067072 NOTICE: Creating InputStream
12:27:24 T:2956974992 M:664240128 DEBUG: CFileCache::Open - opening <fm4_live> using cache
12:27:26 T:2956974992 M:664178688 NOTICE: Creating Demuxer
12:27:26 T:2956974992 M:664178688 DEBUG: Loading: /home/steph/XBMC/BUILD/system/players/dvdplayer/avutil-51-i486-linux.so
12:27:26 T:2956974992 M:664178688 DEBUG: Loading: /home/steph/XBMC/BUILD/system/players/dvdplayer/avcodec-51-i486-linux.so
12:27:26 T:2912910224 M:662802432 DEBUG: Running thread 2912910224
12:27:26 T:2912910224 M:662802432 DEBUG: thread start, auto delete: 0
12:27:26 T:2956974992 M:660910080 DEBUG: Loading: /home/steph/XBMC/BUILD/system/players/dvdplayer/avformat-51-i486-linux.so
12:27:33 T:2956974992 M:660045824 INFO: ffmpeg: Input #0, asf, from 'mms://stream0.orf.at/fm4_live':
12:27:33 T:2956974992 M:660045824 INFO: ffmpeg: Duration: 00:00:00.6, start: 515841.205000, bitrate: 64 kb/s
12:27:33 T:2956974992 M:660045824 INFO: ffmpeg: Stream #0.0: Audio: wmav2, 48000 Hz, stereo, 64 kb/s
12:27:33 T:2956974992 M:660045824 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
12:27:33 T:2956974992 M:660045824 DEBUG: CacheSubtitles: START
12:27:33 T:2956974992 M:660045824 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
12:27:33 T:2956974992 M:660045824 NOTICE: Opening audio stream: 0 source: 256
12:27:33 T:2956974992 M:660045824 NOTICE: Finding audio codec for: 86025
12:27:33 T:2956974992 M:660045824 DEBUG: FactoryCodec - Audio: passthrough - Opening
12:27:33 T:2956974992 M:660045824 DEBUG: FactoryCodec - Audio: passthrough - Failed
12:27:33 T:2956974992 M:660045824 DEBUG: FactoryCodec - Audio: FFmpeg - Opening
12:27:33 T:2956974992 M:659787776 DEBUG: FactoryCodec - Audio: FFmpeg - Opened
12:27:33 T:2956974992 M:659787776 NOTICE: Creating audio thread
12:27:33 T:2899073936 M:659787776 DEBUG: Running thread 2899073936
12:27:33 T:2899073936 M:659787776 DEBUG: thread start, auto delete: 0
12:27:33 T:2899073936 M:659787776 NOTICE: running thread: CDVDPlayerAudio:Tonguerocess()
12:27:33 T:2956974992 M:659787776 DEBUG: Playback has started
12:27:33 T:2899073936 M:659787776 NOTICE: Creating audio device with codec id: 86025, channels: 2, sample rate: 48000, no pass-through
12:27:33 T:2899073936 M:659787776 DEBUG: CALSADirectSound::CALSADirectSound - opening alsa device
12:27:33 T:2899073936 M:659787776 DEBUG: CALSADirectSound - using alsa device default
12:27:33 T:2899073936 M:659787776 DEBUG: CDVDPlayerAudio:: Resync - clock:0.000000, delay:6583.329360
12:27:33 T:3056330592 M:659787776 DEBUG: ------------------- GUI_MSG_WINDOW_INIT
12:27:33 T:3056330592 M:659787776 DEBUG:
12:27:33 T:3056330592 M:659787776 DEBUG: -------------------
12:27:33 T:3056330592 M:659787776 DEBUG: Alloc resources: 0.00ms (0.00 ms skin load, 0.00 ms preload)
12:27:33 T:3056330592 M:659787776 DEBUG: ------------------- GUI_MSG_WINDOW_INIT
12:27:33 T:3056330592 M:659787776 DEBUG:
12:27:33 T:3056330592 M:659787776 DEBUG: -------------------
12:27:33 T:3056330592 M:659787776 INFO: Loading skin file: MusicOverlay.xml
12:27:33 T:3056330592 M:659787776 DEBUG: Load MusicOverlay.xml: 0.00ms (0.00 ms xml load)
12:27:33 T:3056330592 M:659787776 DEBUG: Alloc resources: 0.00ms (0.00 ms skin load, 0.00 ms preload)
12:27:33 T:3056330592 M:659787776 DEBUG: CGUIInfoManager::SetCurrentSong(mms://stream0.orf.at/fm4_live)
12:27:33 T:3056330592 M:659787776 DEBUG: Streaming media detected... using /media/d_drive/music/0Internetradio/FM4.strm to find a thumb
12:27:33 T:3056330592 M:659787776 DEBUG: Error: Requested setting (system.ledenableonpaused) was not found. It must be case-sensitive
12:27:33 T:2940189584 M:659787776 DEBUG: staticThread, deleting thread object
12:27:33 T:2940189584 M:659787776 DEBUG: staticThread, deleting thread graphic context
12:27:33 T:2940189584 M:659787776 DEBUG: Thread 2940189584 terminating
12:27:49 T:3056330592 M:659542016 DEBUG: SDLKeyboard found something unknown (unicode <> printable ASCII): scancode: 64, sym: 308, unicode: 0, modifier: 0
12:27:49 T:3056330592 M:659542016 DEBUG: OnKey: 61604 pressed, action is 0
12:27:49 T:3056330592 M:659542016 DEBUG: OnKey: 61479 pressed, action is 2
12:28:28 T:3056330592 M:659402752 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT
12:28:28 T:3056330592 M:659402752 DEBUG:
12:28:28 T:3056330592 M:659402752 DEBUG: -------------------
12:28:28 T:3056330592 M:659361792 DEBUG: Error: Requested setting (system.ledenableonpaused) was not found. It must be case-sensitive
12:28:29 T:2899073936 M:659361792 DEBUG: CDVDPlayerAudio:: Discontinuty - was:664376.346000, should be:1108583.330870, error:444206.984870
12:28:29 T:2948582288 M:659361792 DEBUG: staticThread, deleting thread object
12:28:29 T:2948582288 M:659361792 DEBUG: staticThread, deleting thread graphic context
12:28:29 T:2948582288 M:659361792 DEBUG: Thread 2948582288 terminating
12:28:29 T:3056330592 M:659361792 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT
12:28:29 T:3056330592 M:659361792 DEBUG: Progress dialog
12:28:29 T:3056330592 M:659361792 DEBUG: -------------------
12:28:30 T:2899073936 M:659369984 DEBUG: CDVDPlayerAudio:: Discontinuty - was:2088639.180870, should be:2072019.615206, error:-16619.565664
12:28:31 T:2899073936 M:659361792 DEBUG: CDVDPlayerAudio:: Discontinuty - was:3056075.693206, should be:3067166.668653, error:11090.975448
12:28:31 T:2899073936 M:659353600 DEBUG: CDVDPlayerAudio:: Discontinuty - was:3791207.929653, should be:3781083.324432, error:-10124.605221
12:28:32 T:2899073936 M:659353600 DEBUG: CDVDPlayerAudio:: Discontinuty - was:4761139.175432, should be:4779519.844206, error:18380.668773
12:28:33 T:3056330592 M:659353600 DEBUG: OnKey: 61467 pressed, action is 10
12:28:33 T:3056330592 M:659353600 DEBUG: CGUIWindowManager:TonguereviousWindow: Deactivate
12:28:33 T:3056330592 M:659353600 DEBUG: ------------------- GUI_MSG_WINDOW_DEINIT