Kodi temporary freeze before playing video stream from my addon
#1
Hello everybody,

I am beginner in Kodi addon development. However I have managed to create my own addon which basically plays IPTV channels for which I have source URLs.

Problem is that every time when I click on any channel to play, Kodi temporary freeze for about 10 - 15 seconds and it shows "working..." info box after which the channel is played.
I have this ERROR in log every time for every channel which I am unable to solve:

ERROR: CCurlFile::Stat - Failed: Timeout was reached(28) for http://some.stream-provider.com:80/live?...s=somepass

I have enabled TV module in Kodi and loaded my m3u playlist. From there every channel is played normally without any problems.

I have searched for a solution to this problem everywhere but had no success.
Can anybody help me to resolve this issue?
Reply
#2
You would need to post the actual log.
Always read the Wiki, FAQ and search the forum before posting.
Read/follow the forum rules.
Reply
#3
Here is log file
Code:
18:24:46 T:2528  NOTICE: special://profile/ is mapped to: special://masterprofile/
18:24:46 T:2528  NOTICE: -----------------------------------------------------------------------
18:24:46 T:2528  NOTICE: Starting Kodi (16.0 Git:20160220-a5f3a99). Platform: Windows NT x86 32-bit
18:24:46 T:2528  NOTICE: Using Release Kodi x32 build
18:24:46 T:2528  NOTICE: Kodi compiled Feb 20 2016 by MSVC 180030723 for Windows NT x86 32-bit version 6.0 (0x06000000)
18:24:46 T:2528  NOTICE: Running on Acer Predator G9-791 with Windows 10, kernel: Windows NT x86 64-bit version 10.0
18:24:46 T:2528  NOTICE: Host CPU: Intel(R) Core(TM) i7-6700HQ CPU @ 2.60GHz, 8 cores available
18:24:46 T:2528  NOTICE: Desktop Resolution: 1920x1080 32Bit at 60Hz
18:24:46 T:2528  NOTICE: Running with restricted rights
18:24:46 T:2528  NOTICE: Aero is enabled
18:24:46 T:2528  NOTICE: special://xbmc/ is mapped to: E:\Kodi
18:24:46 T:2528  NOTICE: special://xbmcbin/ is mapped to: E:\Kodi
18:24:46 T:2528  NOTICE: special://masterprofile/ is mapped to: C:\Users\WIN-USER\AppData\Roaming\Kodi\userdata
18:24:46 T:2528  NOTICE: special://home/ is mapped to: C:\Users\WIN-USER\AppData\Roaming\Kodi\
18:24:46 T:2528  NOTICE: special://temp/ is mapped to: C:\Users\WIN-USER\AppData\Roaming\Kodi\cache
18:24:46 T:2528  NOTICE: The executable running is: E:\Kodi\Kodi.exe
18:24:46 T:2528  NOTICE: Local hostname: PC-NAME
18:24:46 T:2528  NOTICE: Log File is located: C:\Users\WIN-USER\AppData\Roaming\Kodi\kodi.log
18:24:46 T:2528  NOTICE: -----------------------------------------------------------------------
18:24:47 T:2528  NOTICE: load settings...
18:24:47 T:2528 WARNING: CSettingString: unknown options filler "timezonecountries" of "locale.timezonecountry"
18:24:47 T:2528 WARNING: CSettingString: unknown options filler "timezones" of "locale.timezone"
18:24:47 T:2528  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
18:24:47 T:2528  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
18:24:47 T:2528  NOTICE: Default DVD Player: dvdplayer
18:24:47 T:2528  NOTICE: Default Video Player: dvdplayer
18:24:47 T:2528  NOTICE: Default Audio Player: paplayer
18:24:47 T:2528  NOTICE: Disabled debug logging due to GUI setting. Level 0.
18:24:47 T:2528  NOTICE: Log level changed to "LOG_LEVEL_NORMAL"
18:24:47 T:2528  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
18:24:47 T:2528  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
18:24:47 T:2528  NOTICE: Loaded playercorefactory configuration
18:24:47 T:2528  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
18:24:47 T:2528  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
18:24:47 T:9372  NOTICE: Found 2 Lists of Devices
18:24:47 T:9372  NOTICE: Enumerated DIRECTSOUND devices:
18:24:47 T:9372  NOTICE:     Device 1
18:24:47 T:9372  NOTICE:         m_deviceName      : {9025BD7C-4D95-4B82-AC12-6080E8CD58E8}
18:24:47 T:9372  NOTICE:         m_displayName     : Speakers - Speakers (Realtek High Definition Audio)
18:24:47 T:9372  NOTICE:         m_displayNameExtra: DIRECTSOUND: Speakers (Realtek High Definition Audio)
18:24:47 T:9372  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
18:24:47 T:9372  NOTICE:         m_channels        : FL,FR
18:24:47 T:9372  NOTICE:         m_sampleRates     : 48000
18:24:47 T:9372  NOTICE:         m_dataFormats     : AE_FMT_FLOAT
18:24:47 T:9372  NOTICE:     Device 2
18:24:47 T:9372  NOTICE:         m_deviceName      : default
18:24:47 T:9372  NOTICE:         m_displayName     : default
18:24:47 T:9372  NOTICE:         m_displayNameExtra:
18:24:47 T:9372  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
18:24:47 T:9372  NOTICE:         m_channels        : FL,FR
18:24:47 T:9372  NOTICE:         m_sampleRates     : 48000
18:24:47 T:9372  NOTICE:         m_dataFormats     : AE_FMT_FLOAT
18:24:47 T:9372  NOTICE: Enumerated WASAPI devices:
18:24:47 T:9372  NOTICE:     Device 1
18:24:47 T:9372  NOTICE:         m_deviceName      : {9025BD7C-4D95-4B82-AC12-6080E8CD58E8}
18:24:47 T:9372  NOTICE:         m_displayName     : Speakers - Speakers (Realtek High Definition Audio)
18:24:47 T:9372  NOTICE:         m_displayNameExtra: WASAPI: Speakers (Realtek High Definition Audio)
18:24:47 T:9372  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
18:24:47 T:9372  NOTICE:         m_channels        : FL,FR
18:24:47 T:9372  NOTICE:         m_sampleRates     : 48000,44100
18:24:47 T:9372  NOTICE:         m_dataFormats     : AE_FMT_S24NE4MSB,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE
18:24:47 T:9372  NOTICE:     Device 2
18:24:47 T:9372  NOTICE:         m_deviceName      : default
18:24:47 T:9372  NOTICE:         m_displayName     : default
18:24:47 T:9372  NOTICE:         m_displayNameExtra:
18:24:47 T:9372  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
18:24:47 T:9372  NOTICE:         m_channels        : FL,FR
18:24:47 T:9372  NOTICE:         m_sampleRates     : 48000,44100
18:24:47 T:9372  NOTICE:         m_dataFormats     : AE_FMT_S24NE4MSB,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE
18:24:47 T:2528  NOTICE: Running database version Addons20
18:24:47 T:2528  NOTICE: ADDONS: Using repository repository.xbmc.org
18:24:47 T:2528  NOTICE: ADDONS: Using repository superrepo.kodi.jarvis.all
18:24:47 T:2528  NOTICE: Found screen: Generic PnP Monitor on Intel(R) HD Graphics 530, adapter 0.
18:24:47 T:2528  NOTICE: Primary mode: 1920x1080@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Additional mode: 320x200@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 320x240@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 400x300@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 512x384@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 640x400@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 640x480@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 800x600@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1024x768@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1152x864@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1280x600@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1280x720@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1280x768@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1280x800@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1280x960@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1280x1024@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1360x768@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1366x768@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1400x1050@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1440x900@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1600x900@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1680x1050@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Previous line repeats 2 times.
18:24:47 T:2528  NOTICE: Additional mode: 1920x1080@ 60.00 - Full Screen
18:24:47 T:2528  NOTICE: Checking resolution 16
18:24:48 T:2528  NOTICE: Running database version Addons20
18:24:48 T:2528  NOTICE: Running database version ViewModes6
18:24:48 T:2528  NOTICE: Running database version Textures13
18:24:48 T:2528  NOTICE: Running database version MyMusic56
18:24:48 T:2528  NOTICE: Running database version MyVideos99
18:24:48 T:2528  NOTICE: Running database version TV29
18:24:48 T:2528  NOTICE: Running database version Epg11
18:24:48 T:2528 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
18:24:48 T:2528  NOTICE: ActiveAE DSP - starting
18:24:48 T:2528  NOTICE: initialize done
18:24:48 T:2528  NOTICE: Running the application...
18:24:48 T:2528  NOTICE: starting upnp client
18:24:48 T:8912  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
18:24:48 T:8912  NOTICE: UDP: Listening on port 9777
18:25:12 T:2528   ERROR: CCurlFile::Stat - Failed: Timeout was reached(28) for http://some.stream-provider.com/live?channelId=xxx&uid=xx&User=someuser&Pass=somepass
18:25:12 T:2528  NOTICE: DVDPlayer: Opening: http://some.stream-provider.com/live?channelId=xxx&uid=xx&User=someuser&Pass=somepass
18:25:12 T:2528 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
18:25:12 T:11068  NOTICE: Creating InputStream
18:25:22 T:11068   ERROR: CCurlFile::Stat - Failed: Timeout was reached(28) for http://some.stream-provider.com/live?channelId=xxx&uid=xx&User=someuser&Pass=somepass
18:25:22 T:11068  NOTICE: Creating Demuxer
18:25:22 T:11068  NOTICE: Opening stream: 1 source: 256
18:25:22 T:11068  NOTICE: Creating video codec with codec id: 28
18:25:22 T:11068  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
18:25:22 T:11068  NOTICE: Creating video thread
18:25:22 T:11068  NOTICE: Opening stream: 0 source: 256
18:25:22 T:11068  NOTICE: Finding audio codec for: 86018
18:25:22 T:2696  NOTICE: running thread: video_thread
18:25:22 T:11068  NOTICE: Creating audio thread
18:25:22 T:2884  NOTICE: running thread: CDVDPlayerAudio::Process()
18:25:23 T:11068  NOTICE: Opening stream: 1 source: 256
18:25:23 T:11068  NOTICE: Creating video codec with codec id: 28
18:25:23 T:11068  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
18:25:23 T:2884  NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through)
18:25:23 T:2884  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 21
18:25:23 T:2696  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(720x576)
18:25:23 T:2696  NOTICE:  fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 405
18:25:23 T:2696  NOTICE: Display resolution DESKTOP : 1920x1080@ 60.00 - Full Screen (16)
18:25:23 T:2696  NOTICE: D3D: rendering method forced to DXVA processor
18:25:23 T:2696  NOTICE: DXVA::CProcessorHD::InitProcessor - Supported deinterlace methods: Blend:yes, Bob:yes, Adaptive:yes, MoComp:no.
18:25:23 T:2528 WARNING: CWinRenderer::UpdateVideoFilter - chosen scaling method 1 is not supported by renderer
18:25:23 T:2884  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 21
18:25:27 T:2528  NOTICE: Previous line repeats 2 times.
18:25:27 T:2528  NOTICE: CDVDPlayer::CloseFile()
18:25:27 T:2528  NOTICE: DVDPlayer: waiting for threads to exit
18:25:27 T:11068  NOTICE: CDVDPlayer::OnExit()
18:25:27 T:11068  NOTICE: Closing stream player 1
18:25:27 T:11068  NOTICE: Waiting for audio thread to exit
18:25:27 T:2884  NOTICE: thread end: CDVDPlayerAudio::OnExit()
18:25:27 T:11068  NOTICE: Closing audio device
18:25:27 T:11068  NOTICE: Deleting audio codec
18:25:27 T:11068  NOTICE: Closing stream player 2
18:25:27 T:11068  NOTICE: waiting for video thread to exit
18:25:27 T:2696  NOTICE: thread end: video_thread
18:25:27 T:11068  NOTICE: deleting video codec
18:25:27 T:11068  NOTICE: DXVA::CDecoder::Close - closing decoder
18:25:27 T:11068  NOTICE: DXVA::Close - closing decoder context
18:25:27 T:2528  NOTICE: DVDPlayer: finished waiting
18:25:27 T:2528  NOTICE: CDVDPlayer::CloseFile()
18:25:27 T:2528  NOTICE: DVDPlayer: waiting for threads to exit
18:25:27 T:2528  NOTICE: DVDPlayer: finished waiting
18:25:27 T:2528  NOTICE: CDVDPlayer::CloseFile()
18:25:27 T:2528  NOTICE: DVDPlayer: waiting for threads to exit
18:25:27 T:2528  NOTICE: DVDPlayer: finished waiting
18:25:27 T:2528   ERROR: Control 50 in window 10025 has been asked to focus, but it can't
18:25:36 T:2528  NOTICE: Storing total System Uptime
18:25:36 T:2528  NOTICE: Saving settings
18:25:36 T:2528  NOTICE: stop all
18:25:36 T:2528  NOTICE: stop player
18:25:36 T:2528  NOTICE: ES: Stopping event server
18:25:36 T:2528  NOTICE: stopping upnp
18:25:36 T:8912  NOTICE: ES: UDP Event server stopped
18:25:36 T:2528  NOTICE: stop sap announcement listener
18:25:36 T:2528  NOTICE: clean cached files!
18:25:36 T:2528  NOTICE: unload skin
18:25:37 T:2528  NOTICE: stopped
18:25:37 T:2528  NOTICE: destroy
18:25:37 T:2528  NOTICE: closing down remote control service
18:25:38 T:2528  NOTICE: unload sections
18:25:38 T:2528  NOTICE: special://profile/ is mapped to: special://masterprofile/
18:25:38 T:2528  NOTICE: destroy
18:25:38 T:2528 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
18:25:38 T:2528 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
18:25:38 T:2528  NOTICE: closing down remote control service
18:25:38 T:2528  NOTICE: unload sections
18:25:38 T:2528  NOTICE: application stopped...
18:25:38 T:2528   ERROR: dllFreeLibrary - Invalid hModule specified
Reply

Logout Mark Read Team Forum Stats Members Help
Kodi temporary freeze before playing video stream from my addon0