Until recently Kodi was integrating nicely with a VU+ box and letting me stream channels OTA to my KODI box. This has since stopped working and I cannot see why.
When I start Kodi, it starts up the client and downloads the channel list, if I go into live TV I can browse the channel lists and I can even see the recordings on the box. But if I try to stream a channel it sits 'working' for a few seconds, then tells me to check the log files.
There's nothing obvious that I can see in the log files (I'll add a sample below), so wondered if anyone could help?
Thanks
When I start Kodi, it starts up the client and downloads the channel list, if I go into live TV I can browse the channel lists and I can even see the recordings on the box. But if I try to stream a channel it sits 'working' for a few seconds, then tells me to check the log files.
There's nothing obvious that I can see in the log files (I'll add a sample below), so wondered if anyone could help?
Thanks
Code:
18:37:03 T:1765226648 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc
18:37:03 T:1765226648 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated
18:37:03 T:1765226648 DEBUG: ------ Window Init () ------
18:37:03 T:1765226648 DEBUG: Alloc resources: 0.01ms (0.00 ms skin load)
18:37:08 T:1848055552 INFO: AddOnLog: VU+ / Enigma2 Client: Process Perform Updates!
18:37:08 T:1848055552 INFO: AddOnLog: VU+ / Enigma2 Client: GetHttpXML Open webAPI with URL: 'http://user:[email protected]:80/web/timerlist'
18:37:08 T:1848055552 DEBUG: CFileCache::Open - opening <web/timerlist> using cache
18:37:08 T:1848055552 DEBUG: CurlFile::Open(0x76fc8650) http://some-where.noip.me:80/web/timerlist
18:37:08 T:1838157904 NOTICE: Thread FileCache start, auto delete: false
18:37:08 T:1838157904 INFO: CFileCache::Process - Hit eof.
18:37:08 T:1838157904 DEBUG: Thread FileCache 1838157904 terminating
18:37:08 T:1848055552 INFO: AddOnLog: VU+ / Enigma2 Client: GetHttpXML Got result. Length: 68
18:37:08 T:1848055552 DEBUG: AddOnLog: VU+ / Enigma2 Client: Could not find <e2timer> element
18:37:08 T:1848055552 INFO: AddOnLog: VU+ / Enigma2 Client: TimerUpdates No of timers: removed [0], untouched [0], updated '0', new '0'
18:37:08 T:1838861528 DEBUG: CPVRRecordings - void PVR::CPVRRecordings::Update() - updating recordings
18:37:08 T:1838861528 INFO: AddOnLog: VU+ / Enigma2 Client: GetHttpXML Open webAPI with URL: 'http://user:[email protected]:80/web/movielist?dirname=%2Fmedia%2Fhdd%2Fmovie%2F'
18:37:08 T:1838861528 DEBUG: CFileCache::Open - opening <web/movielist> using cache
18:37:08 T:1838861528 DEBUG: CurlFile::Open(0x73669650) http://some-where.noip.me:80/web/movielist?dirname=%2Fmedia%2Fhdd%2Fmovie%2F
18:37:09 T:1948093768 NOTICE: Thread FileCache start, auto delete: false
18:37:09 T:1948093768 INFO: CFileCache::Process - Hit eof.
18:37:09 T:1838861528 INFO: AddOnLog: VU+ / Enigma2 Client: GetHttpXML Got result. Length: 41924
18:37:09 T:1948093768 DEBUG: Thread FileCache 1948093768 terminating
18:37:09 T:1838861528 DEBUG: AddOnLog: VU+ / Enigma2 Client: GetRecordingFromLocation loaded Recording entry 'Home Alone', start '1417364820', length '7078'
18:37:09 T:1838861528 DEBUG: AddOnLog: VU+ / Enigma2 Client: GetRecordingFromLocation loaded Recording entry 'The Snowman and the Snowdog', start '1387913220', length '2578'
18:37:09 T:1838861528 INFO: AddOnLog: VU+ / Enigma2 Client: GetRecordingFromLocation Loaded 46 Recording Entries from folder '/media/hdd/movie/'
18:37:09 T:1838861528 DEBUG: AddOnLog: VU+ / Enigma2 Client: IsInRecordingFolder Found Recording title 'Home Alone' in recordings vector!
18:37:10 T:1838861528 DEBUG: AddOnLog: VU+ / Enigma2 Client: IsInRecordingFolder Found Recording title 'The Snowman and the Snowdog' in recordings vector!
18:37:10 T:1838861528 DEBUG: AddOnLog: VU+ / Enigma2 Client: RestoreLastPlayedPositions Load recording data from file: 'recordings.xml'
18:37:10 T:1838861528 DEBUG: AddOnLog: VU+ / Enigma2 Client: Unable to parse XML: Failed to open file at line 0
18:37:13 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:14 T:1800769456 DEBUG: Previous line repeats 4 times.
18:37:14 T:1800769456 NOTICE: Thread JobWorker start, auto delete: true
18:37:14 T:1800769456 INFO: void XCURL::DllLibCurlGlobal::easy_aquire(const char*, const char*, XCURL::CURL_HANDLE**, XCURL::CURLM**) - Created session to http://www.google.com
18:37:14 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:15 T:1765226648 DEBUG: Previous line repeats 2 times.
18:37:15 T:1765226648 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc
18:37:15 T:1765226648 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated
18:37:15 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, screen saver/dpms woken up
18:37:16 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:37:16 T:1783735160 INFO: CActiveAESink::OpenSink - initialize sink
18:37:16 T:1783735160 DEBUG: CActiveAESink::OpenSink - trying to open device AUDIOTRACK:AudioTrack
18:37:16 T:1783735160 DEBUG: CActiveAESink::OpenSink - AUDIOTRACK Initialized:
18:37:16 T:1783735160 DEBUG: Output Device : android
18:37:16 T:1783735160 DEBUG: Sample Rate : 48000
18:37:16 T:1783735160 DEBUG: Sample Format : AE_FMT_S16NE
18:37:16 T:1783735160 DEBUG: Channel Count : 2
18:37:16 T:1783735160 DEBUG: Channel Layout: FL,FR
18:37:16 T:1783735160 DEBUG: Frames : 1536
18:37:16 T:1783735160 DEBUG: Frame Samples : 3072
18:37:16 T:1783735160 DEBUG: Frame Size : 4
18:37:16 T:1765226648 DEBUG: ------ Window Deinit () ------
18:37:16 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:17 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:17 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 167 (0xa7) pressed, action is Down
18:37:18 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:19 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:19 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xd8) pressed, action is Back
18:37:19 T:1765226648 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:37:19 T:1765226648 DEBUG: ------ Window Deinit (FileManager.xml) ------
18:37:19 T:1765226648 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:37:19 T:1765226648 DEBUG: ------ Window Init (Home.xml) ------
18:37:19 T:1765226648 DEBUG: Window Home.xml was already loaded
18:37:19 T:1765226648 DEBUG: Alloc resources: 5.62m
18:37:20 T:1847078728 DEBUG: webserver: request received for /jsonrpc
18:37:22 T:1765226648 DEBUG: Previous line repeats 3 times.
18:37:22 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:37:23 T:1851224384 DEBUG: Previous line repeats 3 times.
18:37:23 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:24 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:24 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:37:24 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:24 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:24 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:37:26 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 167 (0xa7) pressed, action is Down
18:37:26 T:1847078728 DEBUG: webserver: request received for /jsonrpc
18:37:28 T:1765226648 DEBUG: Previous line repeats 3 times.
18:37:28 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 11 (0x0b) pressed, action is Select
18:37:28 T:1765226648 DEBUG: Activating window ID: 10601
18:37:28 T:1765226648 DEBUG: ------ Window Deinit (Home.xml) ------
18:37:28 T:1765226648 DEBUG: ------ Window Init (MyPVR.xml) ------
18:37:28 T:1765226648 INFO: Loading skin file: MyPVR.xml, load type: LOAD_EVERY_TIME
18:37:28 T:1765226648 DEBUG: Load MyPVR.xml: 112.11ms
18:37:28 T:1765226648 DEBUG: Alloc resources: 120.59ms (112.33 ms skin load)
18:37:28 T:1765226648 DEBUG: CGUIMediaWindow::GetDirectory ()
18:37:28 T:1765226648 DEBUG: ParentPath = []
18:37:28 T:1765226648 DEBUG: CGUIWindowPVRCommon - virtual bool PVR::CGUIWindowPVRCommon::OnMessageFocus(CGUIMessage&) - focus set to window 'tv'
18:37:28 T:1765226648 DEBUG: CGUIWindowPVRChannels - virtual void PVR::CGUIWindowPVRChannels::UpdateData(bool) - update window 'tv'. set view to 11
18:37:28 T:1765226648 DEBUG: CGUIMediaWindow::GetDirectory (pvr://channels/tv/All TV channels/)
18:37:28 T:1765226648 DEBUG: ParentPath = []
18:37:28 T:1800769456 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/All TV channels)
18:37:29 T:1765226648 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:37:29 T:1765226648 DEBUG: Window DialogBusy.xml was already loaded
18:37:29 T:1765226648 DEBUG: Alloc resources: 0.03m
18:37:29 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:30 T:1765226648 DEBUG: CGUIWindowPVRCommon - virtual bool PVR::CGUIWindowPVRCommon::OnMessageFocus(CGUIMessage&) - focus set to window 'tv'
18:37:30 T:1995902400 DEBUG: Previous line repeats 1 times.
18:37:30 T:1995902400 NOTICE: Thread JobWorker start, auto delete: true
18:37:30 T:1800769456 NOTICE: Previous line repeats 2 times.
18:37:30 T:1800769456 DEBUG: SECTION:LoadDLL(libImageLib-arm.so)
18:37:30 T:1800769456 DEBUG: Loading: /data/app-lib/org.xbmc.xbmc-1/libImageLib-arm.so
18:37:30 T:1765226648 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:37:30 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:32 T:1765226648 DEBUG: Previous line repeats 4 times.
18:37:32 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 11 (0x0b) pressed, action is Select
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers(pvr://channels/tv/All TV channels/0.pvr)
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
18:37:32 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
18:37:32 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
18:37:32 T:1765226648 NOTICE: DVDPlayer: Opening: pvr://channels/tv/All TV channels/0.pvr
18:37:32 T:1765226648 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
18:37:32 T:1765226648 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
18:37:32 T:1765226648 DEBUG: LinuxRendererGL: Cleaning up GL resources
18:37:32 T:1996376304 NOTICE: Thread DVDPlayer start, auto delete: false
18:37:32 T:1996376304 NOTICE: Creating InputStream
18:37:32 T:1996376304 DEBUG: PVRManager - bool PVR::CPVRManager::OpenLiveStream(const CFileItem&) - opening live stream on channel '1 - BBC One Wales'
18:37:32 T:1996376304 DEBUG: opening live stream on url 'pvr://stream/tv/1.ts'
18:37:32 T:1996376304 DEBUG: PVRFile - virtual bool XFILE::CPVRFile::Open(const CURL&) - playback has started on filename pvr://channels/tv/All TV channels/0.pvr
18:37:32 T:1996376304 DEBUG: CFileCache::Open - opening <1:0:1:2847:7FE:2:11A0000:0:0:0> using cache
18:37:32 T:1996376304 DEBUG: CurlFile::Open(0x775a1958) http://some-where.noip.me:8001/1:0:1:2847:7FE:2:11A0000:0:0:0
18:37:33 T:1765226648 DEBUG: ------ Window Init (DialogBusy.xml) ------
18:37:33 T:1765226648 DEBUG: Window DialogBusy.xml was already loaded
18:37:33 T:1765226648 DEBUG: Alloc resources: 0.03m
18:37:33 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:33 T:1840238072 DEBUG: Previous line repeats 1 times.
18:37:33 T:1840238072 DEBUG: webserver: request received for /image/image%3A%2F%2Fhttp%253a%252f%252fuser%253apassword%2540some-where.noip.me%253a80%252fpicon%252f1_0_1_2847_7FE_2_11A0000_0_0_0.png%2F
18:37:35 T:1840238072 DEBUG: Previous line repeats 1 times.
18:37:35 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:42 T:1996376304 DEBUG: Previous line repeats 12 times.
18:37:42 T:1996376304 ERROR: CCurlFile::FillBuffer - Failed: Timeout was reached(28)
18:37:42 T:1996376304 ERROR: CCurlFile::CReadState::Connect, didn't get any data from stream.
18:37:42 T:1996376304 ERROR: virtual bool XFILE::CFileCache::Open(const CURL&) - failed to open source <http://USERNAME:[email protected]:8001/1:0:1:2847:7FE:2:11A0000:0:0:0>
18:37:42 T:1996376304 ERROR: CDVDInputStreamPVRManager::Open - error opening [http://user:[email protected]:8001/1:0:1:2847:7FE:2:11A0000:0:0:0]
18:37:42 T:1996376304 ERROR: CDVDPlayer::OpenInputStream - error opening [pvr://channels/tv/All TV channels/0.pvr]
18:37:42 T:1996376304 NOTICE: CDVDPlayer::OnExit()
18:37:42 T:1996376304 NOTICE: CDVDPlayer::OnExit() deleting input stream
18:37:42 T:1996376304 DEBUG: CDVDInputStreamPVRManager::Close - stream closed
18:37:42 T:1996376304 DEBUG: virtual void CApplication::OnPlayBackStopped() : play state was 1, starting 1
18:37:42 T:1996376304 DEBUG: Thread DVDPlayer 1996376304 terminating
18:37:42 T:1765226648 DEBUG: virtual void CApplication::OnPlayBackStopped() : play state was 3, starting 0
18:37:42 T:1765226648 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
18:37:42 T:1765226648 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
18:37:42 T:1765226648 NOTICE: CDVDPlayer::CloseFile()
18:37:42 T:1765226648 NOTICE: DVDPlayer: waiting for threads to exit
18:37:42 T:1765226648 NOTICE: DVDPlayer: finished waiting
18:37:42 T:1765226648 DEBUG: LinuxRendererGL: Cleaning up GL resources
18:37:42 T:1765226648 NOTICE: CDVDPlayer::CloseFile()
18:37:42 T:1765226648 NOTICE: DVDPlayer: waiting for threads to exit
18:37:42 T:1765226648 NOTICE: DVDPlayer: finished waiting
18:37:42 T:1765226648 DEBUG: LinuxRendererGL: Cleaning up GL resources
18:37:42 T:1765226648 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
18:37:43 T:1847078728 DEBUG: webserver: request received for /jsonrpc
18:37:44 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:44 T:1765226648 INFO: void XCURL::DllLibCurlGlobal::CheckIdle() - Closing session to http://www.google.com (easy=0x76f8b028, multi=0x0)
18:37:44 T:1847078728 DEBUG: webserver: request received for /jsonrpc
18:37:48 T:1765226648 DEBUG: Previous line repeats 5 times.
18:37:48 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): menu (0xd8) pressed, action is Back
18:37:48 T:1765226648 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
18:37:48 T:1765226648 DEBUG: ------ Window Deinit (MyPVR.xml) ------
18:37:48 T:1765226648 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
18:37:48 T:1765226648 DEBUG: ------ Window Init (Home.xml) ------
18:37:48 T:1765226648 DEBUG: Window Home.xml was already loaded
18:37:48 T:1765226648 DEBUG: Alloc resources: 5.00m
18:37:49 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:50 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:50 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:37:50 T:1847260008 DEBUG: Previous line repeats 2 times.
18:37:50 T:1847260008 DEBUG: webserver: request received for /jsonrpc
18:37:51 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:51 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 168 (0xa8) pressed, action is Right
18:37:52 T:1847078728 DEBUG: webserver: request received for /jsonrpc
18:37:54 T:1765226648 DEBUG: Previous line repeats 3 times.
18:37:54 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 167 (0xa7) pressed, action is Down
18:37:55 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:55 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:55 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 168 (0xa8) pressed, action is Right
18:37:56 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 11 (0x0b) pressed, action is Select
18:37:56 T:1765226648 DEBUG: Activating window ID: 10003
18:37:56 T:1765226648 DEBUG: ------ Window Deinit (Home.xml) ------
18:37:56 T:1765226648 DEBUG: ------ Window Init (FileManager.xml) ------
18:37:56 T:1765226648 DEBUG: Window FileManager.xml was already loaded
18:37:56 T:1765226648 DEBUG: Alloc resources: 2.23m
18:37:57 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:37:58 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:58 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 167 (0xa7) pressed, action is Down
18:37:58 T:1840238072 DEBUG: webserver: request received for /jsonrpc
18:37:59 T:1765226648 DEBUG: Previous line repeats 1 times.
18:37:59 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:38:00 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:38:00 T:1765226648 DEBUG: Previous line repeats 1 times.
18:38:00 T:1765226648 DEBUG: SECTION:UnloadDelayed(DLL: libImageLib-arm.so)
18:38:00 T:1765226648 DEBUG: Unloading: libImageLib-arm.so
18:38:01 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 229 (0xe5) pressed, action is ContextMenu
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers(special://logpath/xbmc.log)
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
18:38:01 T:1765226648 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
18:38:01 T:1765226648 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
18:38:01 T:1765226648 DEBUG: CFavourites::Load - no system favourites found, skipping
18:38:01 T:1765226648 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
18:38:01 T:1765226648 DEBUG: Window DialogContextMenu.xml was already loaded
18:38:01 T:1765226648 DEBUG: Alloc resources: 0.35m
18:38:01 T:1847078728 DEBUG: webserver: request received for /jsonrpc
18:38:02 T:1765226648 DEBUG: Previous line repeats 1 times.
18:38:02 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 167 (0xa7) pressed, action is Down
18:38:03 T:1847260008 DEBUG: Previous line repeats 3 times.
18:38:03 T:1847260008 DEBUG: webserver: request received for /jsonrpc
18:38:04 T:1765226648 DEBUG: Previous line repeats 1 times.
18:38:04 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 11 (0x0b) pressed, action is Select
18:38:04 T:1765226648 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
18:38:04 T:1765226648 DEBUG: ------ Window Init (DialogYesNo.xml) ------
18:38:04 T:1765226648 DEBUG: Window DialogYesNo.xml was already loaded
18:38:04 T:1765226648 DEBUG: Alloc resources: 0.11m
18:38:05 T:1851224384 DEBUG: webserver: request received for /jsonrpc
18:38:06 T:1765226648 DEBUG: Previous line repeats 1 times.
18:38:06 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 169 (0xa9) pressed, action is Left
18:38:06 T:1847260008 DEBUG: webserver: request received for /jsonrpc
18:38:06 T:1765226648 DEBUG: Previous line repeats 1 times.
18:38:06 T:1765226648 DEBUG: bool CApplication::OnKey(const CKey&): 11 (0x0b) pressed, action is Select
18:38:07 T:1765226648 DEBUG: ------ Window Deinit (DialogYesNo.xml) ------
18:38:07 T:1765226648 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
18:38:07 T:1765226648 DEBUG: Window DialogExtendedProgressBar.xml was already loaded
18:38:07 T:1765226648 DEBUG: Alloc resources: 0.04m
18:38:07 T:1933542160 DEBUG: FileManager: copy special://logpath/xbmc.log -> /storage/external_storage/sda2/xbmc.log