Kodi Community Forum

Full Version: AirPlay stream crashes
You're currently viewing a stripped down version of our content. View the full version with proper formatting.
Guys can anyone give me a hand with this issue I've been having..

I have airplay working streaming to several XBMC media centers running frodo 12.2. The issue am having with with one particular app its called foxtelgo its a streaming cable service. The problem is that xbmc detects the stream being pushed through my ipad but the stream wont load and appears to just crash. Ive tried the stream with an apple tv and it works perfectly.

Can someone have a look at this log and tell me what the issue is and if there is a work around or fix for it.



Code:
16:16:46 T:3544   DEBUG: ------ Window Init () ------
16:16:54 T:3544   DEBUG: ------ Window Deinit (Pointer.xml) ------
16:16:56 T:3544   DEBUG: ------ Window Init (Pointer.xml) ------
16:16:59 T:3544   DEBUG: Activating window ID: 12006
16:17:00 T:3544   DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
16:17:00 T:3544   DEBUG: ------ Window Init (MusicVisualisation.xml) ------
16:17:00 T:4176   DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc
16:17:00 T:4176   DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers(pipe://3/)
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
16:17:00 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
16:17:00 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
16:17:00 T:3544   DEBUG: FactoryCodec - Audio: pcm - Opening
16:17:00 T:3544   DEBUG: FactoryCodec - Audio: pcm - Opened
16:17:00 T:5500   DEBUG: AIRPLAY Server: New connection detected
16:17:00 T:5500    INFO: AIRPLAY Server: New connection added
16:17:00 T:5500   DEBUG: AIRPLAY: got request /server-info
16:17:00 T:5500   DEBUG: AIRPLAY Server: New connection detected
16:17:00 T:5500    INFO: AIRPLAY Server: New connection added
16:17:00 T:5500   DEBUG: AIRPLAY: got request /play
16:17:00 T:5500   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/airplay/libplist.dll)
16:17:00 T:5500   DEBUG: AIRPLAY: sending event: loading
16:17:01 T:3544   DEBUG: Previous line repeats 1 times.
16:17:01 T:3544    INFO: AudioDecoder: File is queued
16:17:01 T:3544    INFO: CSoftAE::MakeStream - AE_FMT_S16NE, 44100, FL,FR
16:17:01 T:2180   DEBUG: CSoftAE::Run - Sink was forgotten
16:17:01 T:2180   DEBUG: CSoftAE::Run - Sink restart flagged
16:17:01 T:2180    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
16:17:01 T:2180   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 3081374
16:17:01 T:2180   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
16:17:01 T:2180   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
16:17:01 T:2180   DEBUG:   Audio Device    : Speakers (High Definition Audio Device)
16:17:01 T:2180   DEBUG:   Sample Rate     : 44100
16:17:01 T:2180   DEBUG:   Sample Format   : AE_FMT_FLOAT
16:17:01 T:2180   DEBUG:   Bits Per Sample : 32
16:17:01 T:2180   DEBUG:   Valid Bits/Samp : 32
16:17:01 T:2180   DEBUG:   Channel Count   : 2
16:17:01 T:2180   DEBUG:   Block Align     : 8
16:17:01 T:2180   DEBUG:   Avg. Bytes Sec  : 352800
16:17:01 T:2180   DEBUG:   Samples/Block   : 32
16:17:01 T:2180   DEBUG:   Format cBSize   : 22
16:17:01 T:2180   DEBUG:   Channel Layout  : FL,FR
16:17:01 T:2180   DEBUG:   Channel Mask    : 3
16:17:01 T:2180   DEBUG:   Frames          : 441
16:17:01 T:2180   DEBUG:   Frame Samples   : 882
16:17:01 T:2180   DEBUG:   Frame Size      : 8
16:17:01 T:2180   DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
16:17:01 T:2180   DEBUG:   Output Device : Speakers - Speakers (High Definition Audio Device)
16:17:01 T:2180   DEBUG:   Sample Rate   : 44100
16:17:01 T:2180   DEBUG:   Sample Format : AE_FMT_FLOAT
16:17:01 T:2180   DEBUG:   Channel Count : 2
16:17:01 T:2180   DEBUG:   Channel Layout: FL,FR
16:17:01 T:2180   DEBUG:   Frames        : 441
16:17:01 T:2180   DEBUG:   Frame Samples : 882
16:17:01 T:2180   DEBUG:   Frame Size    : 8
16:17:01 T:2180   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
16:17:01 T:2180   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
16:17:01 T:2180   DEBUG: AERemap: Downmix normalization is disabled
16:17:01 T:2180   DEBUG: CSoftAEStream::CSoftAEStream - Converting from AE_FMT_S16NE to AE_FMT_FLOAT
16:17:01 T:3544   DEBUG: AudioDecoder::GetReplayGain - Final Replaygain applied: 1.000000, Track/Album Gain 89.000000, Peak 0.000000
16:17:01 T:2180   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
16:17:02 T:3544    INFO: PAPlayer::PrepareStream - Ready
16:17:02 T:3544   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
16:17:02 T:3000  NOTICE: Thread PAPlayer start, auto delete: false
16:17:02 T:3000   DEBUG: PAPlayer::Process - Playback started
16:17:02 T:3544   DEBUG: ------ Window Deinit (MusicVisualisation.xml) ------
16:17:02 T:3544   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
16:17:02 T:3544   DEBUG: ------ Window Init (SettingsCategory.xml) ------
16:17:02 T:3544   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
16:17:02 T:3544   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
16:17:02 T:3544    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://192.168.1.103
16:17:02 T:2180   DEBUG: CSoftAE::Run - Sink restart flagged
16:17:02 T:2180   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
16:17:02 T:2180    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 44100hz
16:17:02 T:2180   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
16:17:02 T:2180   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
16:17:05 T:3000    INFO: PAPlayer::ProcessStream - Stream Finished
16:17:05 T:3000   DEBUG: CSoftAEStream::~CSoftAEStream - Destructed
16:17:05 T:3000   DEBUG: PAPlayer::ProcessStreams - Stream Freed
16:17:05 T:2180   DEBUG: CSoftAE::Run - Sink restart flagged
16:17:05 T:2180   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
16:17:05 T:2180    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 44100hz
16:17:05 T:2180   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
16:17:05 T:2180   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
16:17:07 T:3544   DEBUG: CCurlFile::GetMimeType - http://192.168.1.103:52868/server/tokeniser/3/206/542985.m3u8?format=WIFIHIGHLIVE&__gda__=1372747638_ebb64d67fe158e8523e97f2716fec786|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de) -> failed
16:17:07 T:3544   DEBUG: DialogProgress::StartModal called
16:17:07 T:3544   DEBUG: ------ Window Init (DialogProgress.xml) ------
16:17:07 T:3544   DEBUG: CGUIInfoManager::SetCurrentSong(pipe://3/)
16:17:07 T:3544   DEBUG: CFileItem::LoadMusicTag: loading tag information for file: pipe://3/
16:17:07 T:3544   DEBUG: Loading additional tag info for file pipe://3/
16:17:07 T:3544   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
16:17:07 T:3544   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
16:17:07 T:3544   DEBUG: AIRPLAY: sending event: playing
16:17:07 T:3544   DEBUG: Previous line repeats 1 times.
16:17:07 T:3544   DEBUG: CGUIInfoManager::SetCurrentSong(pipe://3/)
16:17:07 T:3544   DEBUG: CFileItem::LoadMusicTag: loading tag information for file: pipe://3/
16:17:07 T:3544   DEBUG: Loading additional tag info for file pipe://3/
16:17:07 T:3544   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
16:17:07 T:3544   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
16:17:07 T:3000   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
16:17:07 T:3000   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
16:17:07 T:3000   DEBUG: AIRPLAY: sending event: stopped
16:17:07 T:3000   DEBUG: Previous line repeats 1 times.
16:17:07 T:3000   DEBUG: Thread PAPlayer 3000 terminating
16:17:07 T:3544   DEBUG: ------ Window Deinit (Pointer.xml) ------
16:17:07 T:5656  NOTICE: Thread CGUIDialogCache start, auto delete: true
16:17:07 T:5656   DEBUG: Thread CGUIDialogCache 5656 terminating (autodelete)
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers(http://192.168.1.103:52868/server/tokeniser/3/206/542985.m3u8?format=WIFIHIGHLIVE&__gda__=1372747638_ebb64d67fe158e8523e97f2716fec786|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de))
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
16:17:07 T:3544   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
16:17:07 T:3544   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
16:17:07 T:3544  NOTICE: DVDPlayer: Opening: http://192.168.1.103:52868/server/tokeniser/3/206/542985.m3u8?format=WIFIHIGHLIVE&__gda__=1372747638_ebb64d67fe158e8523e97f2716fec786|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de)
16:17:07 T:3544 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
16:17:07 T:3544   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
16:17:07 T:3544   DEBUG: DXVA - cheking samples array size using 842094158 render target
16:17:07 T:3544   DEBUG: DXVA - cheking samples array size using 842094169 render target
16:17:07 T:6040  NOTICE: Thread CDVDPlayer start, auto delete: false
16:17:07 T:6040  NOTICE: Creating InputStream
16:17:07 T:6040   DEBUG: CFileCache::Open - opening <server/tokeniser/3/206/542985.m3u8> using cache
16:17:07 T:6040   DEBUG: CurlFile::Open(093C5C10) http://192.168.1.103:52868/server/tokeniser/3/206/542985.m3u8?format=WIFIHIGHLIVE&__gda__=1372747638_ebb64d67fe158e8523e97f2716fec786
16:17:07 T:3544   DEBUG: ------ Window Init (DialogBusy.xml) ------
16:17:07 T:3544   DEBUG: ------ Window Deinit (DialogProgress.xml) ------
16:17:08 T:1296  NOTICE: Thread CFileCache start, auto delete: false
16:17:08 T:1296    INFO: CFileCache::Process - Hit eof.
16:17:08 T:6040    INFO: Auto-selecting http://fxmultihlslive6258.ngcdn.telstra.com/channel002/channel002600.m3u8?SIGV=2&IS=0&ET=1372756231&KO=7&KN=2&US=b31503e8d1bd40371cf29bc9e780539132f64a6b based on configured bandwidth.
16:17:08 T:1296   DEBUG: Thread CFileCache 1296 terminating
16:17:08 T:6040  NOTICE: Creating Demuxer
16:17:08 T:6040   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-51.dll)
16:17:08 T:6040   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53.dll)
16:17:08 T:6040   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53.dll)
16:17:08 T:6040   DEBUG: ffmpeg[1798]: Using network protocols without global network initialization. Please use avformat_network_init(), this will become mandatory later.
16:17:08 T:6040   DEBUG: Previous line repeats 2 times.
16:17:08 T:6040   ERROR: ffmpeg[1798]: Unable to open key file https://foxtel-go-sw.foxtelplayer.foxtel.com.au/server/keyserver/?siteID=206&videoID=542985&profile=tablet&system=rpgr2&subsystem=channel002&key=K5509540600.key
16:17:08 T:6040   DEBUG: ffmpeg[1798]: Using network protocols without global network initialization. Please use avformat_network_init(), this will become mandatory later.
16:17:09 T:6040   DEBUG: Previous line repeats 5 times.
16:17:09 T:6040   DEBUG: Error, could not open file http://fxmultihlslive6258.ngcdn.telstra.com/channel002/channel002600.m3u8?SIGV=2&IS=0&ET=1372756231&KO=7&KN=2&US=b31503e8d1bd40371cf29bc9e780539132f64a6b
16:17:09 T:6040   ERROR: CDVDPlayer::OpenDemuxStream - Error creating demuxer
16:17:09 T:6040  NOTICE: CDVDPlayer::OnExit()
16:17:09 T:6040  NOTICE: CDVDPlayer::OnExit() deleting input stream
16:17:09 T:6040   DEBUG: Thread CDVDPlayer 6040 terminating
16:17:09 T:3544   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
16:17:09 T:3544   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
16:17:09 T:3544  NOTICE: CDVDPlayer::CloseFile()
16:17:09 T:3544 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
16:17:09 T:3544  NOTICE: DVDPlayer: waiting for threads to exit
16:17:09 T:3544  NOTICE: DVDPlayer: finished waiting
16:17:09 T:5500   DEBUG: AIRPLAY: got request /rate with rate 1
16:17:09 T:5500   DEBUG: AIRPLAY: got request /playback-info
16:17:09 T:5500    INFO: AIRPLAY Server: Disconnection detected
16:17:09 T:3544    INFO: Previous line repeats 1 times.
16:17:09 T:3544   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
16:17:09 T:5500   DEBUG: AIRPLAY Server: New connection detected
16:17:09 T:5500    INFO: AIRPLAY Server: New connection added
16:17:09 T:5500   DEBUG: AIRPLAY: got request /server-info
16:17:09 T:5500   DEBUG: AIRPLAY Server: New connection detected
16:17:09 T:5500    INFO: AIRPLAY Server: New connection added
16:17:09 T:5500   DEBUG: AIRPLAY: got request /stop
16:17:09 T:5500    INFO: AIRPLAY Server: Disconnection detected
16:17:09 T:5548    INFO: Previous line repeats 1 times.
16:17:09 T:5548   DEBUG: Thread Jobworker 5548 terminating (autodelete)
16:17:11 T:3544   DEBUG: ------ Window Init (Pointer.xml) ------
16:17:15 T:2180   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
16:17:15 T:2180   DEBUG: Suspended the Sink
16:17:18 T:3544   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
16:17:18 T:3544  NOTICE: Disabled debug logging due to GUI setting. Level 0.
16:17:18 T:3544  NOTICE: Log level changed to 0
[/php]
Code:
ffmpeg[1798]: Unable to open key file https://foxtel-go-sw.foxtelplayer.foxtel.com.au/server/keyserver/?siteID=206&videoID=542985&profile=tablet&system=rpgr2&subsystem=channel002&key=K5509540600.key

ffmpegs fault if you ask me - you could try one of the XBMC 13.0 alpha versions which have a newer version of ffmpeg - and see if this fixes it.
Thanks just tried that, didn't work. Looks like I'll have to buy an apple TV unless anyone else has any suggestions?
Could you post a debug log with a current XBMC version so i can see if the error is stil the same?
Thanks again. This is using 13.0-ALPHA6 Git:20130708-fe1856c, the 08-Jul-2013 nightly.

Code:
10:21:19 T:2424   DEBUG: ------ Window Init () ------
10:21:26 T:2424   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
10:21:26 T:2424   DEBUG: CApplication::ExecuteXBMCAction : Translating PreviousMenu
10:21:26 T:2424   DEBUG: CApplication::ExecuteXBMCAction : To PreviousMenu
10:21:26 T:2424   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
10:21:26 T:2424   DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
10:21:26 T:2424   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
10:21:26 T:2424   DEBUG: ------ Window Init (Settings.xml) ------
10:21:27 T:2424   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
10:21:27 T:2424   DEBUG: CApplication::ExecuteXBMCAction : Translating PreviousMenu
10:21:27 T:2424   DEBUG: CApplication::ExecuteXBMCAction : To PreviousMenu
10:21:27 T:2424   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
10:21:28 T:2424   DEBUG: ------ Window Deinit (Settings.xml) ------
10:21:28 T:2424   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
10:21:28 T:2424   DEBUG: ------ Window Init (Home.xml) ------
10:21:32 T:2424   DEBUG: ------ Window Deinit (Pointer.xml) ------
10:21:56 T:4828   DEBUG: AIRPLAY Server: New connection detected
10:21:56 T:4828    INFO: AIRPLAY Server: New connection added
10:21:56 T:4828   DEBUG: AIRPLAY: got request /server-info
10:21:56 T:4828   DEBUG: AIRPLAY Server: New connection detected
10:21:56 T:4828    INFO: AIRPLAY Server: New connection added
10:21:56 T:4828   DEBUG: AIRPLAY: got request /play
10:21:56 T:4828   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/airplay/libplist.dll)
10:21:56 T:4828   DEBUG: AIRPLAY: sending event: loading
10:21:56 T:2424   DEBUG: Previous line repeats 1 times.
10:21:56 T:2424   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
10:21:56 T:2424   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
10:21:56 T:2424    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://192.168.1.101
10:21:56 T:1780  NOTICE: Thread GUIDialogCache start, auto delete: true
10:21:56 T:3768   DEBUG: Thread JobWorker 3768 terminating (autodelete)
10:22:01 T:1780   DEBUG: DialogProgress::StartModal called
10:22:01 T:1780   DEBUG: ------ Window Init (DialogProgress.xml) ------
10:22:01 T:1780    INFO: Loading skin file: DialogProgress.xml, load type: KEEP_IN_MEMORY
10:22:06 T:2424   ERROR: CCurlFile::Stat - Failed: Timeout was reached(28) for http://192.168.1.101:59693/server/tokeniser/3/206/263970.m3u8?format=WIFIHIGHLIVE&__gda__=1373329512_3a92b0cdf3cfa93762bd016856fcaed7|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de)
10:22:06 T:2424   DEBUG: CCurlFile::GetMimeType - http://192.168.1.101:59693/server/tokeniser/3/206/263970.m3u8?format=WIFIHIGHLIVE&__gda__=1373329512_3a92b0cdf3cfa93762bd016856fcaed7|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de) -> failed
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers(http://192.168.1.101:59693/server/tokeniser/3/206/263970.m3u8?format=WIFIHIGHLIVE&__gda__=1373329512_3a92b0cdf3cfa93762bd016856fcaed7|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de))
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
10:22:06 T:2424   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
10:22:06 T:2424   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
10:22:06 T:2424  NOTICE: DVDPlayer: Opening: http://192.168.1.101:59693/server/tokeniser/3/206/263970.m3u8?format=WIFIHIGHLIVE&__gda__=1373329512_3a92b0cdf3cfa93762bd016856fcaed7|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de)
10:22:06 T:2424 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
10:22:06 T:2424   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
10:22:06 T:2424   DEBUG: DXVA - cheking samples array size using 842094158 render target
10:22:06 T:1780   DEBUG: Thread GUIDialogCache 1780 terminating (autodelete)
10:22:06 T:2424   DEBUG: DXVA - cheking samples array size using 842094169 render target
10:22:06 T:3628  NOTICE: Thread DVDPlayer start, auto delete: false
10:22:06 T:3628  NOTICE: Creating InputStream
10:22:06 T:3628   DEBUG: CFileCache::Open - opening <server/tokeniser/3/206/263970.m3u8> using cache
10:22:06 T:3628   DEBUG: CurlFile::Open(09325238) http://192.168.1.101:59693/server/tokeniser/3/206/263970.m3u8?format=WIFIHIGHLIVE&__gda__=1373329512_3a92b0cdf3cfa93762bd016856fcaed7
10:22:06 T:2424   DEBUG: ------ Window Init (DialogBusy.xml) ------
10:22:06 T:2424   DEBUG: ------ Window Deinit (DialogProgress.xml) ------
10:22:08 T:68  NOTICE: Thread FileCache start, auto delete: false
10:22:08 T:68    INFO: CFileCache::Process - Hit eof.
10:22:08 T:3628    INFO: Auto-selecting http://fxmultihlslive6258.ngcdn.telstra.com/virtual004/virtual0041800.m3u8?SIGV=2&IS=0&ET=1373339758&KO=7&KN=2&US=c1111d2bdb99d3694e5a59f3f6d93d8ac3ce386f based on configured bandwidth.
10:22:08 T:68   DEBUG: Thread FileCache 68 terminating
10:22:08 T:3628  NOTICE: Creating Demuxer
10:22:08 T:3628   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-52.dll)
10:22:08 T:3628   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-54.dll)
10:22:08 T:3628   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-54.dll)
10:22:08 T:3628   ERROR: ffmpeg[E2C]: Unable to open key file https://foxtel-go-sw.foxtelplayer.foxtel.com.au/server/keyserver/?siteID=206&videoID=263970&profile=tablet&system=rpgr3&subsystem=virtual004&key=K6499501800.key
10:22:09 T:3628   ERROR: ffmpeg[E2C]: [hls,applehttp] Error when loading first segment 'http://fxmultihlslive6258.ngcdn.telstra.com/virtual004/virtual0041800/00385/virtual004180020130708T235156_00026.ts'
10:22:09 T:3628   DEBUG: Error, could not open file http://fxmultihlslive6258.ngcdn.telstra.com/virtual004/virtual0041800.m3u8?SIGV=2&IS=0&ET=1373339758&KO=7&KN=2&US=c1111d2bdb99d3694e5a59f3f6d93d8ac3ce386f
10:22:09 T:3628   ERROR: CDVDPlayer::OpenDemuxStream - Error creating demuxer
10:22:09 T:3628  NOTICE: CDVDPlayer::OnExit()
10:22:09 T:3628  NOTICE: CDVDPlayer::OnExit() deleting input stream
10:22:09 T:3628   DEBUG: CApplication::OnPlayBackStopped : play state was 1, starting 1
10:22:09 T:3628   DEBUG: Thread DVDPlayer 3628 terminating
10:22:09 T:2424   DEBUG: CApplication::OnPlayBackStopped : play state was 3, starting 0
10:22:09 T:2424   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
10:22:09 T:2424   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
10:22:09 T:2424   DEBUG: AIRPLAY: sending event: stopped
10:22:09 T:2424   DEBUG: Previous line repeats 1 times.
10:22:09 T:2424  NOTICE: CDVDPlayer::CloseFile()
10:22:09 T:2424 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
10:22:09 T:2424  NOTICE: DVDPlayer: waiting for threads to exit
10:22:09 T:2424  NOTICE: DVDPlayer: finished waiting
10:22:09 T:2424  NOTICE: CDVDPlayer::CloseFile()
10:22:09 T:2424 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
10:22:09 T:2424  NOTICE: DVDPlayer: waiting for threads to exit
10:22:09 T:2424  NOTICE: DVDPlayer: finished waiting
10:22:09 T:4828   DEBUG: AIRPLAY: got request /rate with rate 1
10:22:09 T:4828   DEBUG: AIRPLAY: got request /playback-info
10:22:09 T:4828    INFO: AIRPLAY Server: Disconnection detected
10:22:09 T:2424    INFO: Previous line repeats 1 times.
10:22:09 T:2424   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
10:22:09 T:4828   DEBUG: AIRPLAY Server: New connection detected
10:22:09 T:4828    INFO: AIRPLAY Server: New connection added
10:22:09 T:4828   DEBUG: AIRPLAY Server: New connection detected
10:22:09 T:4828    INFO: AIRPLAY Server: New connection added
10:22:09 T:4828    INFO: AIRPLAY Server: Disconnection detected
10:22:09 T:4828   DEBUG: AIRPLAY: got request /server-info
10:22:09 T:4828   DEBUG: AIRPLAY Server: New connection detected
10:22:09 T:4828    INFO: AIRPLAY Server: New connection added
10:22:09 T:4828   DEBUG: AIRPLAY Server: New connection detected
10:22:09 T:4828    INFO: AIRPLAY Server: New connection added
10:22:09 T:4828    INFO: AIRPLAY Server: Disconnection detected
10:22:09 T:4828   DEBUG: AIRPLAY: got request /stop
10:22:09 T:4828    INFO: AIRPLAY Server: Disconnection detected
10:22:09 T:3308    INFO: Previous line repeats 1 times.
10:22:09 T:3308  NOTICE: Thread JobWorker start, auto delete: true
10:22:09 T:3308   DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item http://192.168.1.101:59693/server/tokeniser/3/206/263970.m3u8?format=WIFIHIGHLIVE&__gda__=1373329512_3a92b0cdf3cfa93762bd016856fcaed7|User-Agent=AppleCoreMedia%2f1.0.0.8F455%20(AppleTV%3b%20U%3b%20CPU%20OS%204_3%20like%20Mac%20OS%20X%3b%20de_de)
10:22:17 T:2424   DEBUG: CApplication::ProcessMouse: trying mouse action wheelup
10:22:17 T:2424   DEBUG: ------ Window Init (Pointer.xml) ------
10:22:20 T:2424   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
10:22:20 T:2424   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(ShutdownMenu)
10:22:20 T:2424   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(ShutdownMenu)
10:22:20 T:2424   DEBUG: Activating window ID: 10111
10:22:20 T:2424   DEBUG: ------ Window Init (DialogButtonMenu.xml) ------
10:22:20 T:2424    INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY
10:22:20 T:2424   DEBUG: CApplication::ExecuteXBMCAction : Translating down
10:22:20 T:2424   DEBUG: CApplication::ExecuteXBMCAction : To down
10:22:22 T:2424   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
10:22:22 T:2424   DEBUG: CApplication::ExecuteXBMCAction : Translating XBMC.Quit()
10:22:22 T:2424   DEBUG: CApplication::ExecuteXBMCAction : To XBMC.Quit()
10:22:22 T:2424   DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc
10:22:22 T:2424   DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit
10:22:22 T:3308   DEBUG: Thread JobWorker 3308 terminating (autodelete)
10:22:22 T:4556   DEBUG: Thread AlarmClock 4556 terminating
10:22:22 T:2424  NOTICE: Storing total System Uptime
10:22:22 T:2424  NOTICE: Saving settings
10:22:22 T:2424  NOTICE: stop all
10:22:22 T:2424    INFO: stopping PVRManager
10:22:22 T:2424   DEBUG: CNetwork::NetworkMessage - Signaling network services to stop
10:22:22 T:2424  NOTICE: ES: Stopping event server
10:22:22 T:2424   DEBUG: ZeroconfMDNS: Removed service servers.airplay
10:22:22 T:2424   DEBUG: CNetwork::NetworkMessage - Waiting for network services to stop
10:22:22 T:2424  NOTICE: stopping zeroconf publishing
10:22:22 T:2424   DEBUG: ZeroconfMDNS: Shutdown services
10:22:22 T:2424   DEBUG: ZeroconfMDNS: Removed service servers.airtunes
10:22:22 T:2424   DEBUG: ZeroconfMDNS: Removed service servers.eventserver
10:22:22 T:2424   DEBUG: ZeroconfMDNS: Removed service servers.jsonrpc-tpc
10:22:23 T:4828   DEBUG: Thread AirPlayServer 4828 terminating
10:22:23 T:3384   DEBUG: Thread TCPServer 3384 terminating
10:22:23 T:5940  NOTICE: ES: UDP Event server stopped
10:22:23 T:5940   DEBUG: Thread EventServer 5940 terminating
10:22:23 T:2428   DEBUG: Thread PeripBusUSB 2428 terminating
10:22:23 T:3420   DEBUG: Thread PeripBusCEC 3420 terminating
10:22:23 T:2424  NOTICE: stop sap announcement listener
10:22:23 T:2424  NOTICE: clean cached files!
10:22:23 T:2424  NOTICE: unload skin
10:22:23 T:2424    INFO: Unloading old skin ...
10:22:23 T:2424   DEBUG: ------ Window Deinit () ------
10:22:23 T:2424   DEBUG: ------ Window Deinit (Home.xml) ------
10:22:23 T:2424   DEBUG: ------ Window Deinit (Pointer.xml) ------
10:22:23 T:2424   DEBUG: CTextureBundleXBT::Cleanup - Closed bundle
10:22:23 T:2424   DEBUG: ADDON: Stopping service addons.
10:22:23 T:2424  NOTICE: stop python
10:22:23 T:3412   DEBUG: Thread SoftAE 3412 terminating
10:22:23 T:2424  NOTICE: stopped
10:22:23 T:2424  NOTICE: destroy
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFD980 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF3680 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFD788 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF3290 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFDE90 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2990 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2090 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5BD90 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED8110 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5A710 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2798 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2318 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5A998 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2120 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFE3A0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5B328 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED7B28 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFEF28 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2AB0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFDFB0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED74B0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2D38 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF1FB8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFE6B8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED7738 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED7BB8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 050B4240 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFD740 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5C3C0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF26C0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5B1C0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 05180EC0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF24C8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5BD48 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFE2C8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFEBC8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF34D0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2BD0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED75D0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5B058 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5C258 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF2360 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5C060 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFE160 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EFEEE0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06ED7D68 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5B9E8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5BC70 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06EF23F0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 06F5B370 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
10:22:23 T:2424  NOTICE: closing down remote control service
10:22:23 T:5732   DEBUG: Thread RemoteControl 5732 terminating
10:22:23 T:2424  NOTICE: unload sections
10:22:23 T:2424   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
10:22:23 T:2424   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
10:22:23 T:2424   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
10:22:23 T:2424   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
10:22:23 T:2424   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
10:22:23 T:2424   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
10:22:23 T:2424  NOTICE: destroy
10:22:23 T:2424 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
10:22:23 T:2424 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
10:22:23 T:2424  NOTICE: closing down remote control service
10:22:23 T:2424  NOTICE: unload sections
10:22:23 T:2424   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
10:22:23 T:2424   DEBUG: Previous line repeats 1 times.
10:22:23 T:2424  NOTICE: application stopped...
10:22:23 T:2424   DEBUG: PVRManager - destroyed
10:22:23 T:2424   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
10:22:23 T:2424   DEBUG: Previous line repeats 1 times.
10:22:23 T:2424   DEBUG: SECTION:UnloadDll(special://xbmcbin/system/libcurl.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/cpluff.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/libcec.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/airplay/libshairplay-1.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/airplay/libplist.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avutil-52.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avcodec-54.dll)
10:22:23 T:2424   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avformat-54.dll)
Code:
ERROR: ffmpeg[E2C]: Unable to open key file https://foxtel-go-sw.foxtelplayer.foxtel.com.au/server/keyserver/?siteID=206&videoID=263970&profile=tablet&system=rpgr3&subsystem=virtual004&key=K6499501800.key
10:22:09 T:3628   ERROR: ffmpeg[E2C]: [hls,applehttp] Error when loading first segment 'http://fxmultihlslive6258.ngcdn.telstra.com/virtual004/virtual0041800/00385/virtual004180020130708T235156_00026.ts'
10:22:09 T:3628   DEBUG: Error, could not open file

Yeah not much i can tell you. Looks like ffmpeg has a problem here to me.
Pretty sure this is because ffmpeg is compiled without openssl or gnutls and therefore does not support https which is used for retrieving the access key. There's a thread of people asking for it here, http://forum.xbmc.org/showthread.php?tid=165278 .
Looks like that is the case. I brought an ATV3 for the time being just so I can play this stream. Hopefully they add it ASAP.