2012-01-12, 20:21
Hi,
I seem to be having issues using the XBMC IPlayer plugin. I am running XBMC Dharma and the latest version of the IPlayer addon (2.4.13). Below is an excerpt of a debug log file. The seemingly relevant bits with WARNINGS and ERRORS are in bold. Does anyone have any ideas what might be causing this? Some people have posted that this is related to network issues but the machine has no problem accessing the internet and Iplayer works fine through the browser.
Thanks
LOG FILE:
20:02:14 T:952 M:2410500096 DEBUG: XBPyThread:rocess - The source file to load is C:\Users\mpadmin\AppData\Roaming\XBMC\addons\plugin.video.iplayer\default.py
20:02:14 T:952 M:2410500096 DEBUG: XBPyThread:rocess - Setting the Python path to C:\Users\mpadmin\AppData\Roaming\XBMC\addons\plugin.video.iplayer;C:\Users\mpadmin\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files\XBMC\addons\script.module.pil\lib;C:\Program Files\XBMC\addons\script.module.pysqlite\lib;special://xbmc/system/python/DLLs;special://xbmc/system/python/Lib;special://xbmcbin/system/python/python24.zip;special://xbmc/system/python\DLLs;special://xbmc/system/python\lib;special://xbmc/system/python\lib\plat-win;special://xbmc/system/python\lib\lib-tk;C:\Program Files\XBMC
20:02:14 T:952 M:2410500096 DEBUG: XBPyThread:rocess - Entering source directory C:\Users\mpadmin\AppData\Roaming\XBMC\addons\plugin.video.iplayer
20:02:14 T:952 M:2411716608 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:14 T:952 M:2411716608 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\_socket.pyd)
20:02:14 T:952 M:2411687936 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:14 T:952 M:2411687936 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\_ssl.pyd)
20:02:14 T:952 M:2411499520 DEBUG: Win32DllLoader::Load(MSVCR71.dll)
20:02:15 T:952 M:2393174016 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:15 T:952 M:2393174016 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\zlib.pyd)
20:02:15 T:952 M:2391232512 NOTICE: iplayer2.py: INFO IPlayer: version: 2.4.13
20:02:15 T:952 M:2391232512 NOTICE: .
20:02:15 T:952 M:2391232512 NOTICE: iplayer2.py: INFO IPlayer: Subtitles dir: C:\Users\mpadmin\AppData\Roaming\XBMC\userdata\addon_data\plugin.video.iplayer\Subtitles
20:02:15 T:952 M:2391232512 NOTICE: .
20:02:15 T:952 M:2391228416 NOTICE: iplayer2.py: INFO (None, None, '0', None, None, None, None, 'bbc_one_london', None, None)
20:02:15 T:952 M:2391228416 NOTICE: .
20:02:15 T:952 M:2391228416 NOTICE: iplayer2.py: INFO Video stream prefs 1 - h264 480
20:02:15 T:952 M:2391228416 NOTICE: .
20:02:15 T:952 M:2391228416 NOTICE: iplayer2.py: INFO getting media information from http://www.bbc.co.uk/mediaselector/4/mti...v_lo_live/
20:02:15 T:952 M:2391228416 NOTICE: .
20:02:15 T:952 M:2384375808 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:15 T:952 M:2384375808 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\unicodedata.pyd)
20:02:15 T:952 M:2376761344 NOTICE: iplayer2.py: INFO URL Fetch took 0.52 sec for http://www.bbc.co.uk/mediaselector/4/mti...v_lo_live/
20:02:15 T:952 M:2376761344 NOTICE: .
20:02:15 T:952 M:2376720384 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:15 T:952 M:2376720384 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\pyexpat.pyd)
20:02:16 T:952 M:2376695808 INFO: Loading skin file: DialogProgress.xml
20:02:16 T:952 M:2373283840 DEBUG: ------ Window Init (DialogProgress.xml) ------
20:02:16 T:684 M:2376138752 INFO: XCURL:llLibCurlGlobal::easy_aquire - Created session to http://bbc1live-f.akamaihd.net
20:02:16 T:684 M:2374438912 DEBUG: CFileCurl::GetMimeType - http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599 -> video/x-flv
20:02:16 T:684 M:2367541248 NOTICE: DVDPlayer: Opening: http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:16 T:684 M:2367537152 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
20:02:16 T:2712 M:2367537152 DEBUG: thread start, auto delete: 0
20:02:16 T:2712 M:2367533056 NOTICE: Creating InputStream
20:02:16 T:2712 M:2367483904 DEBUG: CFileCache::Open - opening <bbc1_inlet_480@s24324> using cache
20:02:16 T:2712 M:2372964352 DEBUG: FileCurl::Open(07380670) http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:16 T:684 M:2373218304 DEBUG: ------ Window Init (DialogBusy.xml) ------
20:02:17 T:2712 M:2370605056 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
20:02:17 T:2712 M:2370600960 DEBUG: CUtil::CacheSubtitles: START
20:02:17 T:2712 M:2370596864 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
20:02:17 T:2712 M:2370596864 NOTICE: Creating Demuxer
20:02:17 T:2712 M:2370576384 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/avutil-50.dll)
20:02:17 T:3712 M:2370695168 DEBUG: thread start, auto delete: 0
20:02:17 T:2712 M:2370695168 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/avcodec-52.dll)
20:02:17 T:2712 M:2370609152 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/libfaad.dll)
20:02:17 T:2712 M:2370588672 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/avformat-52.dll)
20:02:17 T:2712 M:2366361600 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [flv]
20:02:17 T:2712 M:2366353408 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
20:02:17 T:3712 M:2359488512 DEBUG: XFILE::CFileCache:rocess, request seek on source to 2147483643
20:02:17 T:3712 M:2359488512 INFO: XCURL:llLibCurlGlobal::easy_aquire - Created session to http://bbc1live-f.akamaihd.net
20:02:43 T:1604 M:2353082368 DEBUG: Thread 1604 terminating (autodelete)
20:02:43 T:2340 M:2353164288 DEBUG: Thread 2340 terminating (autodelete)
20:02:45 T:4076 M:2353250304 DEBUG: Thread 4076 terminating (autodelete)
20:02:56 T:3712 M:2361536512 WARNING: XFILE::CFileCurl::CReadState::FillBuffer: curl failed with code 28
20:02:56 T:3712 M:2361536512 ERROR: CFileCurl::CReadState::Open, didn't get any data from stream.
20:02:56 T:3712 M:2361536512 ERROR: XFILE::CFileCache:rocess, error 0 seeking. seek returned -1
20:02:56 T:2712 M:2361532416 DEBUG: ffmpeg[A98]: [flv] Estimating duration from bitrate, this may be inaccurate
20:02:56 T:2712 M:2362114048 WARNING: could not find codec parameters for http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:56 T:2712 M:2362114048 ERROR: CDVDPlayer::OpenDemuxStream - Error creating demuxer
20:02:56 T:2712 M:2361913344 NOTICE: CDVDPlayer::OnExit()
20:02:56 T:2712 M:2361851904 NOTICE: CDVDPlayer::OnExit() deleting input stream
20:02:56 T:3712 M:2355593216 DEBUG: Thread 3712 terminating
20:02:56 T:2712 M:2358378496 DEBUG: FileCurl::Close(07380670) http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:56 T:2712 M:2361815040 DEBUG: Thread 2712 terminating
20:02:56 T:684 M:2362286080 DEBUG: CAnnouncementManager - Announcement: PlaybackStopped from xbmc
20:02:56 T:684 M:2362253312 ERROR: Playlist Player: skipping unplayable item: 0, path [http://bbc1live-f.akamaihd.net/bbc1_inle...8e1407599]
20:02:56 T:684 M:2362253312 DEBUG: Playlist Player: one or more items failed to play... aborting playback
I seem to be having issues using the XBMC IPlayer plugin. I am running XBMC Dharma and the latest version of the IPlayer addon (2.4.13). Below is an excerpt of a debug log file. The seemingly relevant bits with WARNINGS and ERRORS are in bold. Does anyone have any ideas what might be causing this? Some people have posted that this is related to network issues but the machine has no problem accessing the internet and Iplayer works fine through the browser.
Thanks
LOG FILE:
20:02:14 T:952 M:2410500096 DEBUG: XBPyThread:rocess - The source file to load is C:\Users\mpadmin\AppData\Roaming\XBMC\addons\plugin.video.iplayer\default.py
20:02:14 T:952 M:2410500096 DEBUG: XBPyThread:rocess - Setting the Python path to C:\Users\mpadmin\AppData\Roaming\XBMC\addons\plugin.video.iplayer;C:\Users\mpadmin\AppData\Roaming\XBMC\addons\script.module.beautifulsoup\lib;C:\Program Files\XBMC\addons\script.module.pil\lib;C:\Program Files\XBMC\addons\script.module.pysqlite\lib;special://xbmc/system/python/DLLs;special://xbmc/system/python/Lib;special://xbmcbin/system/python/python24.zip;special://xbmc/system/python\DLLs;special://xbmc/system/python\lib;special://xbmc/system/python\lib\plat-win;special://xbmc/system/python\lib\lib-tk;C:\Program Files\XBMC
20:02:14 T:952 M:2410500096 DEBUG: XBPyThread:rocess - Entering source directory C:\Users\mpadmin\AppData\Roaming\XBMC\addons\plugin.video.iplayer
20:02:14 T:952 M:2411716608 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:14 T:952 M:2411716608 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\_socket.pyd)
20:02:14 T:952 M:2411687936 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:14 T:952 M:2411687936 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\_ssl.pyd)
20:02:14 T:952 M:2411499520 DEBUG: Win32DllLoader::Load(MSVCR71.dll)
20:02:15 T:952 M:2393174016 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:15 T:952 M:2393174016 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\zlib.pyd)
20:02:15 T:952 M:2391232512 NOTICE: iplayer2.py: INFO IPlayer: version: 2.4.13
20:02:15 T:952 M:2391232512 NOTICE: .
20:02:15 T:952 M:2391232512 NOTICE: iplayer2.py: INFO IPlayer: Subtitles dir: C:\Users\mpadmin\AppData\Roaming\XBMC\userdata\addon_data\plugin.video.iplayer\Subtitles
20:02:15 T:952 M:2391232512 NOTICE: .
20:02:15 T:952 M:2391228416 NOTICE: iplayer2.py: INFO (None, None, '0', None, None, None, None, 'bbc_one_london', None, None)
20:02:15 T:952 M:2391228416 NOTICE: .
20:02:15 T:952 M:2391228416 NOTICE: iplayer2.py: INFO Video stream prefs 1 - h264 480
20:02:15 T:952 M:2391228416 NOTICE: .
20:02:15 T:952 M:2391228416 NOTICE: iplayer2.py: INFO getting media information from http://www.bbc.co.uk/mediaselector/4/mti...v_lo_live/
20:02:15 T:952 M:2391228416 NOTICE: .
20:02:15 T:952 M:2384375808 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:15 T:952 M:2384375808 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\unicodedata.pyd)
20:02:15 T:952 M:2376761344 NOTICE: iplayer2.py: INFO URL Fetch took 0.52 sec for http://www.bbc.co.uk/mediaselector/4/mti...v_lo_live/
20:02:15 T:952 M:2376761344 NOTICE: .
20:02:15 T:952 M:2376720384 DEBUG: LoadLibraryExA called with flags:
- LOAD_WITH_ALTERED_SEARCH_PATH
20:02:15 T:952 M:2376720384 DEBUG: Win32DllLoader::Load(special://xbmc/system/python/DLLs\pyexpat.pyd)
20:02:16 T:952 M:2376695808 INFO: Loading skin file: DialogProgress.xml
20:02:16 T:952 M:2373283840 DEBUG: ------ Window Init (DialogProgress.xml) ------
20:02:16 T:684 M:2376138752 INFO: XCURL:llLibCurlGlobal::easy_aquire - Created session to http://bbc1live-f.akamaihd.net
20:02:16 T:684 M:2374438912 DEBUG: CFileCurl::GetMimeType - http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599 -> video/x-flv
20:02:16 T:684 M:2367541248 NOTICE: DVDPlayer: Opening: http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:16 T:684 M:2367537152 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
20:02:16 T:2712 M:2367537152 DEBUG: thread start, auto delete: 0
20:02:16 T:2712 M:2367533056 NOTICE: Creating InputStream
20:02:16 T:2712 M:2367483904 DEBUG: CFileCache::Open - opening <bbc1_inlet_480@s24324> using cache
20:02:16 T:2712 M:2372964352 DEBUG: FileCurl::Open(07380670) http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:16 T:684 M:2373218304 DEBUG: ------ Window Init (DialogBusy.xml) ------
20:02:17 T:2712 M:2370605056 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles
20:02:17 T:2712 M:2370600960 DEBUG: CUtil::CacheSubtitles: START
20:02:17 T:2712 M:2370596864 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done
20:02:17 T:2712 M:2370596864 NOTICE: Creating Demuxer
20:02:17 T:2712 M:2370576384 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/avutil-50.dll)
20:02:17 T:3712 M:2370695168 DEBUG: thread start, auto delete: 0
20:02:17 T:2712 M:2370695168 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/avcodec-52.dll)
20:02:17 T:2712 M:2370609152 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/libfaad.dll)
20:02:17 T:2712 M:2370588672 DEBUG: Win32DllLoader::Load(special://xbmcbin/system/players/dvdplayer/avformat-52.dll)
20:02:17 T:2712 M:2366361600 DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [flv]
20:02:17 T:2712 M:2366353408 DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info starting
20:02:17 T:3712 M:2359488512 DEBUG: XFILE::CFileCache:rocess, request seek on source to 2147483643
20:02:17 T:3712 M:2359488512 INFO: XCURL:llLibCurlGlobal::easy_aquire - Created session to http://bbc1live-f.akamaihd.net
20:02:43 T:1604 M:2353082368 DEBUG: Thread 1604 terminating (autodelete)
20:02:43 T:2340 M:2353164288 DEBUG: Thread 2340 terminating (autodelete)
20:02:45 T:4076 M:2353250304 DEBUG: Thread 4076 terminating (autodelete)
20:02:56 T:3712 M:2361536512 WARNING: XFILE::CFileCurl::CReadState::FillBuffer: curl failed with code 28
20:02:56 T:3712 M:2361536512 ERROR: CFileCurl::CReadState::Open, didn't get any data from stream.
20:02:56 T:3712 M:2361536512 ERROR: XFILE::CFileCache:rocess, error 0 seeking. seek returned -1
20:02:56 T:2712 M:2361532416 DEBUG: ffmpeg[A98]: [flv] Estimating duration from bitrate, this may be inaccurate
20:02:56 T:2712 M:2362114048 WARNING: could not find codec parameters for http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:56 T:2712 M:2362114048 ERROR: CDVDPlayer::OpenDemuxStream - Error creating demuxer
20:02:56 T:2712 M:2361913344 NOTICE: CDVDPlayer::OnExit()
20:02:56 T:2712 M:2361851904 NOTICE: CDVDPlayer::OnExit() deleting input stream
20:02:56 T:3712 M:2355593216 DEBUG: Thread 3712 terminating
20:02:56 T:2712 M:2358378496 DEBUG: FileCurl::Close(07380670) http://bbc1live-f.akamaihd.net/bbc1_inle...38e1407599
20:02:56 T:2712 M:2361815040 DEBUG: Thread 2712 terminating
20:02:56 T:684 M:2362286080 DEBUG: CAnnouncementManager - Announcement: PlaybackStopped from xbmc
20:02:56 T:684 M:2362253312 ERROR: Playlist Player: skipping unplayable item: 0, path [http://bbc1live-f.akamaihd.net/bbc1_inle...8e1407599]
20:02:56 T:684 M:2362253312 DEBUG: Playlist Player: one or more items failed to play... aborting playback