17:35:04 T:140436796606208 DEBUG: CAnnouncementManager - Announcement: OnScanFinished from xbmc 17:35:04 T:140436796606208 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnScanFinished 17:35:04 T:140437664004096 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------ 17:35:16 T:140436521854720 DEBUG: Thread JobWorker 140436521854720 terminating (autodelete) 17:35:16 T:140436538640128 DEBUG: Thread JobWorker 140436538640128 terminating (autodelete) 17:35:16 T:140436788213504 DEBUG: Thread JobWorker 140436788213504 terminating (autodelete) 17:35:21 T:140437664004096 INFO: CheckIdle - Closing session to http://api.tmdb.org (easy=0x7fb9dc2b0ee0, multi=0x7fb9dc163a50) 17:35:32 T:140437664004096 INFO: CheckIdle - Closing session to http://thetvdb.com (easy=0x7fb9dc5d96e0, multi=0x7fb9dc174d50) 17:35:34 T:140436796606208 DEBUG: Thread JobWorker 140436796606208 terminating (autodelete) 17:35:44 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:35:44 T:140437664004096 DEBUG: ------ Window Init (VideoOSD.xml) ------ 17:35:44 T:140437664004096 INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY 17:35:50 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:35:53 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 17:35:54 T:140437664004096 DEBUG: Keyboard: scancode: 0x09, sym: 0x001b, unicode: 0x001b, modifier: 0x0 17:35:54 T:140437664004096 DEBUG: OnKey: escape (0xf01b) pressed, action is Fullscreen 17:35:54 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:35:54 T:140437664004096 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 17:35:54 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:35:54 T:140437664004096 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:35:54 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 17:35:54 T:140437664004096 DEBUG: ParentPath = [videodb://movies/titles/] 17:35:54 T:140437664004096 DEBUG: RunQuery took 24 ms for 786 items query: select * from movie_view 17:35:54 T:140436788213504 DEBUG: Thread BackgroundLoader start, auto delete: false 17:35:54 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:35:54 T:140437664004096 DEBUG: GL: Vertex Shader compilation log: 17:35:54 T:140437664004096 DEBUG: GL: Vertex Shader compiled successfully 17:35:54 T:140437664004096 DEBUG: GL: Pixel Shader compilation log: 17:35:54 T:140437664004096 DEBUG: GL: Fragment Shader compiled successfully 17:35:54 T:140436796606208 DEBUG: Thread JobWorker start, auto delete: true 17:35:54 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:35:54 T:140436538640128 DEBUG: Previous line repeats 1 times. 17:35:54 T:140436538640128 DEBUG: Thread JobWorker start, auto delete: true 17:35:54 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:35:57 T:140436788213504 DEBUG: Previous line repeats 3 times. 17:35:57 T:140436788213504 DEBUG: Thread BackgroundLoader 140436788213504 terminating 17:35:59 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:35:59 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:35:59 T:140436563814144 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 17:36:00 T:140437664004096 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 17:36:00 T:140437664004096 DEBUG: OnKey: down (0xf081) pressed, action is Down 17:36:00 T:140437664004096 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 17:36:00 T:140437664004096 DEBUG: OnKey: down (0xf081) pressed, action is Down 17:36:00 T:140437664004096 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 17:36:00 T:140437664004096 DEBUG: OnKey: down (0xf081) pressed, action is Down 17:36:00 T:140437664004096 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 17:36:00 T:140437664004096 DEBUG: OnKey: down (0xf081) pressed, action is Down 17:36:01 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:36:01 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:36:01 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:36:01 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:36:01 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:36:01 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:36:01 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:36:01 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:36:02 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:36:02 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:36:02 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:36:02 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:36:03 T:140437664004096 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:36:03 T:140437664004096 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:36:03 T:140437664004096 DEBUG: Activating window ID: 12005 17:36:03 T:140437664004096 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:36:03 T:140437664004096 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 17:36:03 T:140437664004096 DEBUG: GL: Vertex Shader compilation log: 17:36:03 T:140437664004096 DEBUG: GL: Vertex Shader compiled successfully 17:36:03 T:140437664004096 DEBUG: GL: Pixel Shader compilation log: 17:36:03 T:140437664004096 DEBUG: GL: Fragment Shader compiled successfully 17:36:18 T:140437198354176 DEBUG: Failed to connect to LIRC. Giving up. 17:36:18 T:140437198354176 DEBUG: Thread RemoteControl 140437198354176 terminating 17:36:25 T:140436796606208 DEBUG: Thread JobWorker 140436796606208 terminating (autodelete) 17:36:25 T:140436538640128 DEBUG: Thread JobWorker 140436538640128 terminating (autodelete) 17:38:27 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:219697959.709379, should be:219687449.870566, error:-10509.838812 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x41, sym: 0x0020, unicode: 0x0020, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: OnKey: space (0xf020) pressed, action is Pause 17:40:56 T:140435947116288 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:40:56 T:140435947116288 DEBUG: CDVDPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 17:40:56 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnPause from xbmc 17:40:56 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPause 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x11, sym: 0x0038, unicode: 0x0038, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: OnKey: eight (0xf038) pressed, action is Number8 17:40:56 T:140437664004096 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x11, sym: 0x0038, unicode: 0x0038, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: OnKey: eight (0xf038) pressed, action is Number8 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x4c, sym: 0x0123, unicode: 0x0000, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: OnKey: f10 (0xf099) pressed, action is VolumeUp 17:40:56 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc 17:40:56 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged 17:40:56 T:140437664004096 DEBUG: ------ Window Init (DialogVolumeBar.xml) ------ 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: OnKey: backspace (0xf008) pressed, action is Fullscreen 17:40:56 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 17:40:56 T:140437664004096 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 17:40:56 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 17:40:56 T:140437664004096 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 17:40:56 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 17:40:56 T:140437664004096 DEBUG: ParentPath = [videodb://movies/titles/] 17:40:56 T:140437664004096 DEBUG: RunQuery took 27 ms for 786 items query: select * from movie_view 17:40:56 T:140436538640128 DEBUG: Thread BackgroundLoader start, auto delete: false 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x4b, sym: 0x0122, unicode: 0x0000, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: OnKey: f9 (0xf098) pressed, action is VolumeDown 17:40:56 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnVolumeChanged from xbmc 17:40:56 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 64, from xbmc, message OnVolumeChanged 17:40:56 T:140437664004096 DEBUG: Keyboard: scancode: 0x30, sym: 0x00e4, unicode: 0x00e4, modifier: 0x0 17:40:56 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 17:40:56 T:140437664004096 DEBUG: Previous line repeats 3 times. 17:40:56 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 17:40:57 T:140437664004096 DEBUG: GL: Vertex Shader compilation log: 17:40:57 T:140437664004096 DEBUG: GL: Vertex Shader compiled successfully 17:40:57 T:140437664004096 DEBUG: GL: Pixel Shader compilation log: 17:40:57 T:140437664004096 DEBUG: GL: Fragment Shader compiled successfully 17:40:57 T:140437664004096 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 17:40:57 T:140437664004096 DEBUG: Keyboard: scancode: 0x30, sym: 0x00e4, unicode: 0x00e4, modifier: 0x0 17:40:57 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 17:40:57 T:140437664004096 DEBUG: Previous line repeats 3 times. 17:40:57 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x30, sym: 0x00e4, unicode: 0x00e4, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 17:40:58 T:140437664004096 DEBUG: Previous line repeats 3 times. 17:40:58 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x30, sym: 0x00e4, unicode: 0x00e4, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 17:40:58 T:140437664004096 DEBUG: Previous line repeats 3 times. 17:40:58 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 17:40:58 T:140437664004096 DEBUG: ------ Window Deinit (DialogVolumeBar.xml) ------ 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0069, unicode: 0x0069, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: OnKey: i (0xf049) pressed, action is Info 17:40:58 T:140437664004096 DEBUG: ------ Window Init (DialogVideoInfo.xml) ------ 17:40:58 T:140437664004096 INFO: Loading skin file: DialogVideoInfo.xml, load type: KEEP_IN_MEMORY 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x20, sym: 0x006f, unicode: 0x006f, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: OnKey: o (0xf04f) pressed, action is 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x2c, sym: 0x006a, unicode: 0x006a, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: OnKey: j (0xf04a) pressed, action is ActivateWindow(RadioChannels) 17:40:58 T:140437664004096 DEBUG: Activating window ID: 10620 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x16, sym: 0x0008, unicode: 0x0008, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: OnKey: backspace (0xf008) pressed, action is Back 17:40:58 T:140437664004096 DEBUG: ------ Window Deinit (DialogVideoInfo.xml) ------ 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x22, sym: 0x00fc, unicode: 0x00fc, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 17:40:58 T:140437664004096 DEBUG: Previous line repeats 3 times. 17:40:58 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x21, sym: 0x0070, unicode: 0x0070, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: OnKey: p (0xf050) pressed, action is Play 17:40:58 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:40:58 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:40:58 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 3 packets of duration 32 17:40:58 T:140436563814144 NOTICE: Previous line repeats 3 times. 17:40:58 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:40:58 T:140435947116288 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:40:58 T:140435947116288 DEBUG: CDVDPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 17:40:58 T:140437664004096 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:40:58 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:40:58 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x30, sym: 0x00e4, unicode: 0x00e4, modifier: 0x0 17:40:58 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 17:40:58 T:140437664004096 DEBUG: Previous line repeats 3 times. 17:40:58 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 17:40:58 T:140435691398912 DEBUG: CDVDPlayerAudio::HandleSyncError - average error -8866.455128 below threshold of 50000.000000 17:40:58 T:140437664004096 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x3e, sym: 0x012f, unicode: 0x0000, modifier: 0x2 17:40:58 T:140437664004096 DEBUG: OnKey: rightshift (0xf0d3) pressed, action is 17:40:58 T:140437664004096 DEBUG: Keyboard: scancode: 0x33, sym: 0x00a3, unicode: 0x00a3, modifier: 0x2 17:40:58 T:140437664004096 DEBUG: OnKey: shift-161 (0x2f0a1) pressed, action is 17:40:59 T:140437664004096 DEBUG: Keyboard: scancode: 0x3e, sym: 0x012f, unicode: 0x0000, modifier: 0x2 17:40:59 T:140437664004096 DEBUG: OnKey: rightshift (0xf0d3) pressed, action is 17:40:59 T:140437664004096 DEBUG: Keyboard: scancode: 0x30, sym: 0x00e0, unicode: 0x00e0, modifier: 0x2 17:40:59 T:140437664004096 DEBUG: OnKey: shift-161 (0x2f0a1) pressed, action is 17:40:59 T:140437664004096 DEBUG: Keyboard: scancode: 0x33, sym: 0x00a3, unicode: 0x00a3, modifier: 0x2 17:40:59 T:140437664004096 DEBUG: OnKey: shift-161 (0x2f0a1) pressed, action is 17:40:59 T:140436538640128 DEBUG: Thread BackgroundLoader 140436538640128 terminating 17:40:59 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:369671449.275566, should be:369692060.872769, error:20611.597203 17:40:59 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:05 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:41:05 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:41:05 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:41:05 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:41:06 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:41:06 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:41:06 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:41:06 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:41:06 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:41:06 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:41:07 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:41:07 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:41:07 T:140437664004096 DEBUG: Keyboard: scancode: 0x71, sym: 0x0114, unicode: 0x0000, modifier: 0x0 17:41:07 T:140437664004096 DEBUG: OnKey: left (0xf082) pressed, action is Left 17:41:09 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:41:09 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:41:09 T:140437664004096 DEBUG: Keyboard: scancode: 0x6f, sym: 0x0111, unicode: 0x0000, modifier: 0x0 17:41:09 T:140437664004096 DEBUG: OnKey: up (0xf080) pressed, action is Up 17:41:09 T:140437664004096 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:41:09 T:140437664004096 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:41:09 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 3 17:41:09 T:140435947116288 DEBUG: demuxer seek to: 0 17:41:09 T:140435947116288 DEBUG: SeekTime - unknown position after seek 17:41:09 T:140435947116288 DEBUG: demuxer seek to: 0, success 17:41:09 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:379844749.160769, should be:379812730.427953, error:-32018.732817 17:41:10 T:140437664004096 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:41:10 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 17:41:10 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 17:41:10 T:140437664004096 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 17:41:10 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:10 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:10 T:140435947116288 DEBUG: CDVDPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:10 T:140435947116288 DEBUG: CDVDPlayer::CheckContinuity - wrapback :2, prev:125125.000000, curr:41708.333333, diff:-83416.666667 17:41:10 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(125125.000000, 1) 17:41:10 T:140436563814144 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 17:41:10 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:10 T:140435947116288 DEBUG: Previous line repeats 1 times. 17:41:10 T:140435947116288 DEBUG: CheckPlayerInit - dropping packet type:1 dts:-4503599627370496.000000 to get to start point at 0.000000 17:41:10 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1) 17:41:10 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 1 17:41:10 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:10 T:140435947116288 DEBUG: Previous line repeats 3 times. 17:41:10 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 2 17:41:10 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 0 17:41:10 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:10 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:41:10 T:140435691398912 DEBUG: CDVDPlayerAudio::HandleSyncError - average error 13124.374566 below threshold of 50000.000000 17:41:10 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:-59093.374556, should be:-45968.374990, error:13124.999566 17:41:10 T:140437664004096 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 17:41:10 T:140437664004096 DEBUG: OnKey: down (0xf081) pressed, action is Down 17:41:11 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:970838.746010, should be:930495.898259, error:-40342.847752 17:41:12 T:140437664004096 DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0 17:41:12 T:140437664004096 DEBUG: OnKey: return (0xf00d) pressed, action is Select 17:41:12 T:140437664004096 DEBUG: Activating window ID: 12005 17:41:12 T:140437664004096 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 17:41:12 T:140437664004096 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 17:41:12 T:140437664004096 DEBUG: GL: Vertex Shader compilation log: 17:41:12 T:140437664004096 DEBUG: GL: Vertex Shader compiled successfully 17:41:12 T:140437664004096 DEBUG: GL: Pixel Shader compilation log: 17:41:12 T:140437664004096 DEBUG: GL: Fragment Shader compiled successfully 17:41:12 T:140437664004096 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 17:41:13 T:140437664004096 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 17:41:13 T:140437664004096 DEBUG: OnKey: right (0xf083) pressed, action is StepForward 17:41:13 T:140437664004096 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 3 17:41:14 T:140435947116288 DEBUG: demuxer seek to: 14167 17:41:14 T:140435947116288 DEBUG: SeekTime - unknown position after seek 17:41:14 T:140435947116288 DEBUG: demuxer seek to: 14167, success 17:41:14 T:140437664004096 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:41:14 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 17:41:14 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:14 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:14 T:140435947116288 DEBUG: CDVDPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:14 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(21120000.000000, 1) 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 1 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(21104416.666667, 0) 17:41:14 T:140436563814144 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:14 T:140435947116288 DEBUG: Previous line repeats 4 times. 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 0 17:41:14 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:41:14 T:140436563814144 NOTICE: Previous line repeats 4 times. 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 2 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:14 T:140435691398912 DEBUG: Previous line repeats 1 times. 17:41:14 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:41:14 T:140435691398912 NOTICE: Previous line repeats 1 times. 17:41:14 T:140435691398912 DEBUG: CDVDPlayerAudio::HandleSyncError - average error -7563.096960 below threshold of 50000.000000 17:41:14 T:140437664004096 DEBUG: Keyboard: scancode: 0x74, sym: 0x0112, unicode: 0x0000, modifier: 0x0 17:41:14 T:140437664004096 DEBUG: OnKey: down (0xf081) pressed, action is ChapterOrBigStepBack 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 3 17:41:14 T:140435947116288 DEBUG: demuxer seek to: -578728 17:41:14 T:140435947116288 DEBUG: SeekTime - unknown position after seek 17:41:14 T:140435947116288 DEBUG: demuxer seek to: -578728, success 17:41:14 T:140437664004096 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:41:14 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 17:41:14 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:14 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:14 T:140435947116288 DEBUG: CDVDPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::CheckContinuity - wrapback :2, prev:125125.000000, curr:41708.333333, diff:-83416.666667 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(125125.000000, 1) 17:41:14 T:140436563814144 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:14 T:140435691398912 DEBUG: Previous line repeats 1 times. 17:41:14 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 1 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:14 T:140435947116288 DEBUG: Previous line repeats 3 times. 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 2 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 4 17:41:14 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(32000.000000, 1) 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:41:14 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 0 17:41:14 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:14 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:41:15 T:140435691398912 NOTICE: Previous line repeats 6 times. 17:41:15 T:140435691398912 DEBUG: CDVDPlayerAudio::HandleSyncError - average error -31805.253770 below threshold of 50000.000000 17:41:15 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:190184.517000, should be:158380.351230, error:-31804.165770 17:41:16 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1179504.000230, should be:1232767.281522, error:53263.281291 17:41:16 T:140437664004096 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 17:41:16 T:140437664004096 DEBUG: OnKey: right (0xf083) pressed, action is StepForward 17:41:17 T:140437664004096 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 17:41:17 T:140437664004096 DEBUG: OnKey: right (0xf083) pressed, action is StepForward 17:41:17 T:140437664004096 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 17:41:17 T:140437664004096 DEBUG: OnKey: right (0xf083) pressed, action is StepForward 17:41:17 T:140437664004096 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 17:41:17 T:140437664004096 DEBUG: OnKey: right (0xf083) pressed, action is StepForward 17:41:18 T:140437664004096 DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0 17:41:18 T:140437664004096 DEBUG: OnKey: right (0xf083) pressed, action is StepForward 17:41:18 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 3 17:41:18 T:140435947116288 DEBUG: demuxer seek to: 303954 17:41:18 T:140435947116288 DEBUG: SeekTime - unknown position after seek 17:41:18 T:140435947116288 DEBUG: demuxer seek to: 303954, success 17:41:18 T:140437664004096 DEBUG: CDVDMsgGeneralSynchronize - global timeout 17:41:18 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc 17:41:18 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek 17:41:18 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:18 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:18 T:140435947116288 DEBUG: CDVDPlayer - CDVDMsg::GENERAL_SYNCHRONIZE 17:41:18 T:140435691398912 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(309184000.000000, 1) 17:41:18 T:140436563814144 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(309183875.000000, 0) 17:41:18 T:140436563814144 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 17:41:18 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:18 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 1 17:41:18 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:18 T:140435947116288 DEBUG: Previous line repeats 2 times. 17:41:18 T:140435947116288 DEBUG: CDVDPlayer::SetCaching - caching state 0 17:41:18 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 32 17:41:18 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:18 T:140435947116288 DEBUG: Previous line repeats 2 times. 17:41:18 T:140435947116288 DEBUG: CDVDPlayer::HandleMessages - player started 2 17:41:18 T:140436563814144 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:41:19 T:140435691398912 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 32 17:41:19 T:140435691398912 DEBUG: CDVDPlayerAudio::HandleSyncError - average error 5539.917769 below threshold of 50000.000000 17:41:20 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:310142781.629167, should be:310112344.997836, error:-30436.631331 17:41:21 T:140437664004096 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 17:41:24 T:140436563814144 DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333 17:45:24 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:554985887.551836, should be:554975752.744550, error:-10134.807286 17:49:37 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:807769665.946550, should be:807759116.490687, error:-10549.455862 17:53:00 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:00 T:140437664004096 DEBUG: ------ Window Init (VideoOSD.xml) ------ 17:53:06 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 17:53:06 T:140437664004096 DEBUG: Activating window ID: 10124 17:53:06 T:140437664004096 DEBUG: ------ Window Init (VideoOSDSettings.xml) ------ 17:53:06 T:140437664004096 INFO: Loading skin file: VideoOSDSettings.xml, load type: KEEP_IN_MEMORY 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.volume) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.volumeamplification) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.delay) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.stream) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.outputtoallspeakers) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.digitalanalog) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (subtitles.enable) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (subtitles.delay) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (subtitles.stream) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (subtitles.browser) was not found. 17:53:06 T:140437664004096 DEBUG: CSettingsManager: requested setting (audio.makedefault) was not found. 17:53:06 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:08 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:10 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:10 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:10 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:10 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:10 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:10 T:140437664004096 DEBUG: Previous line repeats 1 times. 17:53:10 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:10 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:11 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:13 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 17:53:13 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:13 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSDSettings.xml) ------ 17:53:13 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:15 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 17:53:15 T:140437664004096 DEBUG: Activating window ID: 10123 17:53:15 T:140437664004096 DEBUG: ------ Window Init (VideoOSDSettings.xml) ------ 17:53:15 T:140437664004096 INFO: Loading skin file: VideoOSDSettings.xml, load type: KEEP_IN_MEMORY 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.deinterlacemode) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.interlacemethod) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.scalingmethod) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.viewmode) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.zoom) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.verticalshift) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.pixelratio) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.postprocess) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.brightness) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.contrast) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.nonlinearstretch) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.stereoscopicmode) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.stereoscopicinvert) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.save) was not found. 17:53:15 T:140437664004096 DEBUG: CSettingsManager: requested setting (video.calibration) was not found. 17:53:15 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:19 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:20 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:20 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:20 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:20 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:20 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:20 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:20 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheeldown 17:53:23 T:140437664004096 DEBUG: Previous line repeats 13 times. 17:53:23 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 17:53:25 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 17:53:25 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 17:53:26 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSDSettings.xml) ------ 17:53:29 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 17:55:55 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1185122909.651687, should be:1185112680.962636, error:-10228.689051 18:01:21 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1511101245.829636, should be:1511090696.593193, error:-10549.236443 18:05:35 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:1765534279.334193, should be:1765523388.282441, error:-10891.051753 18:12:16 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2166867618.695441, should be:2166856594.723475, error:-11023.971966 18:17:30 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2480721470.156475, should be:2480711312.010383, error:-10158.146092 18:19:28 T:140437664004096 DEBUG: Keyboard: scancode: 0x25, sym: 0x0132, unicode: 0x0000, modifier: 0x40 18:19:28 T:140437664004096 DEBUG: OnKey: ctrl-leftctrl (0x1f0d0) pressed, action is 18:20:00 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 18:20:00 T:140437664004096 DEBUG: ------ Window Init (VideoOSD.xml) ------ 18:20:09 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 18:20:12 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 18:22:50 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:2800580709.241383, should be:2800569606.306758, error:-11102.934625 18:28:28 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:3138445479.846759, should be:3138434801.896476, error:-10677.950283 18:33:46 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:3456371002.460476, should be:3456360415.219321, error:-10587.241155 18:39:44 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:3814691126.768322, should be:3814680790.780109, error:-10335.988212 18:44:47 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:4117877448.358109, should be:4117867439.933376, error:-10008.424733 18:47:59 T:140437664004096 DEBUG: Keyboard: scancode: 0x25, sym: 0x0132, unicode: 0x0000, modifier: 0x40 18:47:59 T:140437664004096 DEBUG: OnKey: ctrl-leftctrl (0x1f0d0) pressed, action is 18:48:03 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 18:48:03 T:140437664004096 DEBUG: ------ Window Init (VideoOSD.xml) ------ 18:48:09 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 18:48:12 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 18:49:53 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:4423211301.659376, should be:4423201271.714023, error:-10029.945354 18:55:29 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:4759513062.972023, should be:4759502791.481081, error:-10271.490942 19:00:12 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:5042777089.546082, should be:5042766931.909828, error:-10157.636254 19:05:28 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:5358437054.775828, should be:5358426839.165238, error:-10215.610590 19:10:40 T:140435691398912 DEBUG: CDVDClock::Discontinuity - CDVDPlayerAudio::HandleSyncError2 - was:5669966773.101239, should be:5669956512.328064, error:-10260.773175 19:14:04 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:04 T:140437664004096 DEBUG: ------ Window Init (VideoOSD.xml) ------ 19:14:11 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:11 T:140437664004096 NOTICE: CDVDPlayer::CloseFile() 19:14:11 T:140437664004096 NOTICE: DVDPlayer: waiting for threads to exit 19:14:11 T:140435947116288 NOTICE: CDVDPlayer::OnExit() 19:14:11 T:140435947116288 NOTICE: Closing stream player 1 19:14:11 T:140435947116288 NOTICE: Waiting for audio thread to exit 19:14:11 T:140435691398912 NOTICE: thread end: CDVDPlayerAudio::OnExit() 19:14:11 T:140435947116288 NOTICE: Closing audio device 19:14:11 T:140435691398912 DEBUG: Thread DVDPlayerAudio 140435691398912 terminating 19:14:12 T:140437150205696 DEBUG: CActiveAE::DiscardStream - audio stream deleted 19:14:12 T:140437150205696 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:14:12 T:140435947116288 NOTICE: Deleting audio codec 19:14:12 T:140435947116288 NOTICE: Closing stream player 2 19:14:12 T:140435947116288 NOTICE: waiting for video thread to exit 19:14:12 T:140437150205696 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:14:12 T:140437217318656 INFO: CActiveAESink::OpenSink - initialize sink 19:14:12 T:140436563814144 NOTICE: thread end: video_thread 19:14:12 T:140436563814144 DEBUG: Thread DVDPlayerVideo 140436563814144 terminating 19:14:12 T:140435947116288 NOTICE: deleting video codec 19:14:12 T:140435947116288 DEBUG: OnPlayBackStopped: play state was 2, starting 0 19:14:12 T:140435947116288 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 19:14:12 T:140435947116288 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 19:14:12 T:140435947116288 DEBUG: Thread DVDPlayer 140435947116288 terminating 19:14:12 T:140437664004096 NOTICE: DVDPlayer: finished waiting 19:14:12 T:140437664004096 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:14:12 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:14:12 T:140437664004096 DEBUG: ------ Window Deinit (VideoOSD.xml) ------ 19:14:12 T:140437664004096 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 19:14:12 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:14:12 T:140437664004096 DEBUG: ------ Window Init (MyVideoNav.xml) ------ 19:14:12 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (videodb://movies/titles/) 19:14:12 T:140437664004096 DEBUG: ParentPath = [videodb://movies/titles/] 19:14:12 T:140437664004096 DEBUG: RunQuery took 24 ms for 786 items query: select * from movie_view 19:14:12 T:140437217318656 DEBUG: CActiveAESink::OpenSink - trying to open device PULSE:Default 19:14:12 T:140437208925952 DEBUG: Thread BackgroundLoader start, auto delete: false 19:14:12 T:140437217318656 DEBUG: PulseAudio: Context authorizing 19:14:12 T:140437217318656 DEBUG: PulseAudio: Context setting name 19:14:12 T:140437217318656 DEBUG: PulseAudio: Context ready 19:14:12 T:140437217318656 DEBUG: PulseAudio: Stream ready 19:14:12 T:140437217318656 NOTICE: PulseAudio: Opened device Default in pcm mode with Buffersize 150 ms 19:14:12 T:140437217318656 DEBUG: CActiveAESink::OpenSink - PULSE Initialized: 19:14:12 T:140437217318656 DEBUG: Output Device : Default 19:14:12 T:140437217318656 DEBUG: Sample Rate : 44100 19:14:12 T:140437217318656 DEBUG: Sample Format : AE_FMT_FLOAT 19:14:12 T:140437217318656 DEBUG: Channel Count : 2 19:14:12 T:140437217318656 DEBUG: Channel Layout: FL,FR 19:14:12 T:140437217318656 DEBUG: Frames : 2205 19:14:12 T:140437217318656 DEBUG: Frame Samples : 4410 19:14:12 T:140437217318656 DEBUG: Frame Size : 8 19:14:12 T:140437150205696 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 19:14:12 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:12 T:140437664004096 NOTICE: CDVDPlayer::CloseFile() 19:14:12 T:140437664004096 NOTICE: DVDPlayer: waiting for threads to exit 19:14:12 T:140437664004096 NOTICE: DVDPlayer: finished waiting 19:14:12 T:140437664004096 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:14:12 T:140437664004096 NOTICE: CDVDPlayer::CloseFile() 19:14:12 T:140437664004096 NOTICE: DVDPlayer: waiting for threads to exit 19:14:12 T:140437664004096 NOTICE: DVDPlayer: finished waiting 19:14:12 T:140437664004096 DEBUG: LinuxRendererGL: Cleaning up GL resources 19:14:12 T:140437664004096 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 19:14:12 T:140435028702976 DEBUG: Thread JobWorker start, auto delete: true 19:14:12 T:140436796606208 DEBUG: Previous line repeats 3 times. 19:14:12 T:140436796606208 DEBUG: DoWork - Saving file state for video item /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Vampire Academy (2014)/Vampire Academy (2014) DL-1080p.mp4 19:14:12 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Phoebe in Wonderland (2008)/00002.m2ts 19:14:12 T:140436796606208 DEBUG: DoWork - Marking video item /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Vampire Academy (2014)/Vampire Academy (2014) DL-1080p.mp4 as watched 19:14:12 T:140436796606208 DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc 19:14:12 T:140436796606208 DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate 19:14:12 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:12 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:12 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] max_analyze_duration 5000000 reached at 5004000 microseconds st:0 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Phoebe in Wonderland (2008)/00002.m2t': 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:40:16.01, start: 0.541711, bitrate: 29650 kb/s 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 90k tbn, 47.95 tbc 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1101]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:13 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/02 englischsprachige Filme/My Sister's keeper (2009)/00027.m2ts 19:14:13 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:13 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Failed to open codec in av_find_stream_info 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:13 T:140436788213504 DEBUG: Previous line repeats 7 times. 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 5 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 6 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 7 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 8 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 9 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 10 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 11 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 12 is not set in estimate_timings_from_pts 19:14:13 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 5 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 6 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 7 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 8 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 9 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 10 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 11 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 12 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/02 englischsprachige Filme/My Siste's keeper (2009)/00027.m2ts': 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:49:22.56, start: 4198.000000, bitrate: 22215 kb/s 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: vc1 (Advanced) (VC-1 / 0x312D4356), yuv420p(bt709), 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 90k tbn, 47.95 tbc 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: truehd (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), s32 (24 bit) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1100]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 640 kb/s 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1101]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 640 kb/s 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:4[0x1102]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 640 kb/s 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:5[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:6[0x1201]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:7[0x1202]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:8[0x1203]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:9[0x1204]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:10[0x1205]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:11[0x1206]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:12[0x1207]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(4, ...) -> 4 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(5, ...) -> 5 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(6, ...) -> 6 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(7, ...) -> 7 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(8, ...) -> 8 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(9, ...) -> 9 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(10, ...) -> 10 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(11, ...) -> 11 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(12, ...) -> 12 19:14:13 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Labor Pains (2009)/00003.m2ts 19:14:13 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:13 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Failed to open codec in av_find_stream_info 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] max_analyze_duration 5000000 reached at 5004000 microseconds st:0 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Labor Pains (2009)/00003.m2t': 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:28:55.91, start: 600.000000, bitrate: 23563 kb/s 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: vc1 (Advanced) (VC-1 / 0x312D4356), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 90k tbn, 47.95 tbc 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD HRA) ([133][0][0][0] / 0x0085), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1101]: Audio: dts (DTS-HD HRA) ([133][0][0][0] / 0x0085), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:13 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:13 T:140435643414272 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Grown Ups (2010)/00011.m2ts 19:14:13 T:140435643414272 DEBUG: Open - probing detected format [mpegts] 19:14:13 T:140435643414272 DEBUG: Open - avformat_find_stream_info starting 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:13 T:140435643414272 DEBUG: Previous line repeats 11 times. 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 7 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 8 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 9 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 10 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 11 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 12 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 13 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 14 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 15 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 16 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 17 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 18 is not set in estimate_timings_from_pts 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 7 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 8 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 9 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 10 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 11 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 12 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 13 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 14 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 15 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 16 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 17 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 18 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:13 T:140435643414272 DEBUG: Open - av_find_stream_info finished 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/02 englischsprachige Filme/Grown Ups (2010)/00011.m2t': 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Duration: 01:42:20.16, start: 11.650667, bitrate: 38477 kb/s 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Program 1 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 90k tbn, 47.95 tbc 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:2[0x1101]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 640 kb/s 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:3[0x1102]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:4[0x1103]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:5[0x1104]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 192 kb/s 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:6[0x1105]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, 5.1(side), fltp, 640 kb/s 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:7[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:8[0x1201]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:9[0x1202]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:10[0x1203]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:11[0x1204]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:12[0x1205]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:13[0x1206]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:14[0x1207]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:15[0x1208]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:16[0x1209]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:17[0x120a]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:18[0x120b]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(4, ...) -> 4 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(5, ...) -> 5 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(6, ...) -> 6 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(7, ...) -> 7 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(8, ...) -> 8 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(9, ...) -> 9 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(10, ...) -> 10 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(11, ...) -> 11 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(12, ...) -> 12 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(13, ...) -> 13 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(14, ...) -> 14 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(15, ...) -> 15 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(16, ...) -> 16 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(17, ...) -> 17 19:14:13 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(18, ...) -> 18 19:14:13 T:140435643414272 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Yoko (2012)/00002.m2ts 19:14:13 T:140435643414272 DEBUG: Open - probing detected format [mpegts] 19:14:13 T:140435643414272 DEBUG: Open - avformat_find_stream_info starting 19:14:13 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:14 T:140435643414272 DEBUG: Previous line repeats 1 times. 19:14:14 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 2 is not set in estimate_timings_from_pts 19:14:14 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:14 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 2 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:14 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:14 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:14 T:140435643414272 DEBUG: ffmpeg[7FB9B8A3B700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:14 T:140435643414272 DEBUG: Open - av_find_stream_info finished 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Yoko (2012)/00002.m2t': 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Duration: 01:38:43.76, start: 11.650667, bitrate: 35878 kb/s 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Program 1 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 25 fps, 25 tbr, 90k tbn, 50 tbc 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:2[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:14 T:140435643414272 INFO: ffmpeg[7FB9B8A3B700]: Stream #0:3[0x1201]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:14 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:14 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:14 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:14 T:140435643414272 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:14 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Vincent will meer (2012)/00007.m2ts 19:14:14 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:14 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:14 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Vincent will meer (2012)/00007.m2t': 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:34:25.02, start: 600.000000, bitrate: 24303 kb/s 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD HRA) ([133][0][0][0] / 0x0085), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1101]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 224 kb/s 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:14 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Und weg bist Du (2012)/00002.m2ts 19:14:14 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:14 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:14 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Und weg bist Du (2012)/00002.m2t': 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:34:21.01, start: 0.220000, bitrate: 17036 kb/s 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 25 fps, 25 tbr, 90k tbn, 50 tbc 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:14 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Teufelskicker (2010)/00003.m2ts 19:14:14 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:14 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Failed to open codec in av_find_stream_info 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 2 is not set in estimate_timings_from_pts 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 2 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:14 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:14 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Teufelskicker (2010)/00003.m2t': 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:51:12.58, start: 4201.000000, bitrate: 21203 kb/s 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: vc1 (Advanced) (VC-1 / 0x312D4356), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:14 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Sputnik (2013)/00003.m2ts 19:14:14 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:14 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:14 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Sputnik (2013)/00003.m2t': 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:22:35.04, start: 600.000000, bitrate: 16109 kb/s 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s16p 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:14 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Ein Tick anders (2011)/00002.m2ts 19:14:14 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:14 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:14 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Ein Tick anders (2011)/00002.m2t': 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:24:23.02, start: 0.220000, bitrate: 23016 kb/s 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 25 fps, 25 tbr, 90k tbn, 50 tbc 19:14:14 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:14 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:15 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Dreiviertelmond (2001)/00009.m2ts 19:14:15 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:15 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:15 T:140436788213504 DEBUG: Previous line repeats 1 times. 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 4 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 5 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 4 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 5 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Dreiviertelmond (2001)/00009.m2t': 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:34:46.34, start: 0.541667, bitrate: 23403 kb/s 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1101]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 192 kb/s 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1102]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 192 kb/s 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:4[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:5[0x1201]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(4, ...) -> 4 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(5, ...) -> 5 19:14:15 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Dead Fucking Last (2012)/00005.m2ts 19:14:15 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:15 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:15 T:140436788213504 DEBUG: Previous line repeats 2 times. 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [h264] Increasing reorder buffer to 1 19:14:15 T:140437208925952 DEBUG: Thread BackgroundLoader 140437208925952 terminating 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 2 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 4 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 2 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 4 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Dead Fucking Last (2012)/00005.m2t': 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:31:58.24, start: 0.540000, bitrate: 27850 kb/s 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], 25 fps, 25 tbr, 90k tbn, 50 tbc 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD MA) ([134][0][0][0] / 0x0086), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1201]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:4[0x1202]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(4, ...) -> 4 19:14:15 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Das Haus der Krokodile (2012)/00008.m2ts 19:14:15 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:15 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:15 T:140436788213504 DEBUG: Previous line repeats 1 times. 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 4 is not set in estimate_timings_from_pts 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 4 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:15 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:15 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Das Haus der Krokodile (2012)/00008.m2t': 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:34:58.02, start: 600.000000, bitrate: 29074 kb/s 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD HRA) ([133][0][0][0] / 0x0085), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1101]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 224 kb/s 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:4[0x1201]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:15 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(4, ...) -> 4 19:14:15 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Da geht noch was (2013)/00007.m2ts 19:14:16 T:140436788213504 DEBUG: Open - probing detected format [mpegts] 19:14:16 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:16 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] parser not found for codec hdmv_pgs_subtitle, packets or times may be invalid. 19:14:16 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] max_analyze_duration 5000000 reached at 5000000 microseconds st:0 19:14:16 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [NULL] start time for stream 3 is not set in estimate_timings_from_pts 19:14:16 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090)): unspecified size 19:14:16 T:140436788213504 DEBUG: ffmpeg[7FB9FCDFF700]: [mpegts] Consider increasing the value for the 'analyzeduration' and 'probesize' options 19:14:16 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, mpegts, /media/ds415/03Video/01 Filme/01 deutschsprachige Filme/Da geht noch was (2013)/00007.m2t': 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 01:40:42.82, start: 600.000000, bitrate: 31293 kb/s 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Program 1 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0[0x1011]: Video: h264 (High) (HDMV / 0x564D4448), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 24 fps, 24 tbr, 90k tbn, 48 tbc 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1[0x1100]: Audio: dts (DTS-HD HRA) ([133][0][0][0] / 0x0085), 48000 Hz, 5.1(side), s32p (24 bit) 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:2[0x1101]: Audio: ac3 (AC-3 / 0x332D4341), 48000 Hz, stereo, fltp, 224 kb/s 19:14:16 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:3[0x1200]: Subtitle: hdmv_pgs_subtitle ([144][0][0][0] / 0x0090) 19:14:16 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:16 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:16 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2 19:14:16 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3 19:14:17 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:17 T:140437664004096 DEBUG: Activating window ID: 10000 19:14:18 T:140437664004096 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------ 19:14:18 T:140437664004096 DEBUG: ------ Window Init (Home.xml) ------ 19:14:18 T:140436796606208 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update 19:14:18 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:18 T:140437664004096 DEBUG: Updating RSS 19:14:18 T:140437160412928 DEBUG: Previous line repeats 2 times. 19:14:18 T:140437160412928 DEBUG: Thread RSSReader start, auto delete: false 19:14:18 T:140437160412928 DEBUG: CurlFile::Open(0x7fba130f3c20) http://feeds.xbmc.org/xbmc 19:14:18 T:140437160412928 INFO: easy_aquire - Created session to http://feeds.xbmc.org 19:14:18 T:140436796606208 DEBUG: RunQuery took 36 ms for 10 items query: select * from movie_view ORDER BY dateAdded desc, idMovie desc LIMIT 10 19:14:18 T:140436796606208 DEBUG: RunQuery took 107 ms for 10 items query: select * from episode_view ORDER BY dateAdded desc, idEpisode desc LIMIT 10 19:14:18 T:140436788213504 DEBUG: DoWork - trying to extract filestream details from video file /media/ds415/03Video/02 Serien/The Big Bang Theory (2007)/Staffel 9/The.Big.Bang.Theory.S09E10.1080p.HDTV.X264-DIMENSION.mkv 19:14:18 T:140436796606208 DEBUG: RunQuery took 1 ms for 0 items query: select * from musicvideo_view ORDER BY dateAdded desc, idMVideo desc LIMIT 10 19:14:18 T:140436796606208 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update 19:14:18 T:140437160412928 DEBUG: Got rss feed: http://feeds.xbmc.org/xbmc 19:14:18 T:140437160412928 DEBUG: RSS feed encoding: UTF-8 19:14:18 T:140437160412928 DEBUG: Parsed rss feed: http://feeds.xbmc.org/xbmc 19:14:18 T:140437160412928 DEBUG: CurlFile::Open(0x7fba130f3c20) http://feeds.xbmc.org/latest_xbmc_addons 19:14:18 T:140437160412928 DEBUG: Got rss feed: http://feeds.xbmc.org/latest_xbmc_addons 19:14:18 T:140437160412928 DEBUG: RSS feed encoding: UTF-8 19:14:18 T:140437160412928 DEBUG: Parsed rss feed: http://feeds.xbmc.org/latest_xbmc_addons 19:14:18 T:140437160412928 DEBUG: CurlFile::Open(0x7fba130f3c20) http://feeds.xbmc.org/updated_xbmc_addons 19:14:18 T:140437160412928 DEBUG: Got rss feed: http://feeds.xbmc.org/updated_xbmc_addons 19:14:18 T:140437160412928 DEBUG: RSS feed encoding: UTF-8 19:14:18 T:140437160412928 DEBUG: Parsed rss feed: http://feeds.xbmc.org/updated_xbmc_addons 19:14:18 T:140436788213504 DEBUG: Open - probing detected format [matroska,webm] 19:14:18 T:140437160412928 DEBUG: Thread RSSReader 140437160412928 terminating 19:14:18 T:140436788213504 DEBUG: Open - avformat_find_stream_info starting 19:14:18 T:140436788213504 DEBUG: Open - av_find_stream_info finished 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Input #0, matroska,webm, /media/ds415/03Video/02 Serien/The Big Bang Theory (2007)/Staffel 9/The.Big.Bang.Theory.S09E10.1080p.HDTV.X264-DIMENSION.mk': 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Metadata: 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: encoder : libebml v0.7.9 + libmatroska v0.8.1 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: creation_time : 2015-12-10 22:18:04 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Duration: 00:21:30.52, start: 0.000000, bitrate: 7938 kb/s 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:0(eng): Video: h264 (High), yuv420p, 1920x1066, SAR 1:1 DAR 960:533, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc 19:14:18 T:140436788213504 INFO: ffmpeg[7FB9FCDFF700]: Stream #0:1: Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s (default) 19:14:18 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0 19:14:18 T:140436788213504 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1 19:14:18 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:24 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:24 T:140437664004096 DEBUG: Activating window ID: 10001 19:14:24 T:140437664004096 DEBUG: ------ Window Deinit (Home.xml) ------ 19:14:24 T:140437664004096 DEBUG: ------ Window Init (MyPrograms.xml) ------ 19:14:24 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/executable) 19:14:24 T:140437664004096 DEBUG: ParentPath = [addons://sources/executable/] 19:14:24 T:140436521854720 DEBUG: Thread BackgroundLoader start, auto delete: false 19:14:24 T:140436521854720 DEBUG: Thread BackgroundLoader 140436521854720 terminating 19:14:24 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:24 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:25 T:140435643414272 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so) 19:14:25 T:140435643414272 DEBUG: Loading: /usr/lib/kodi/system/ImageLib-x86_64-linux.so 19:14:28 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:28 T:140436521854720 DEBUG: Thread LanguageInvoker start, auto delete: false 19:14:28 T:140436521854720 INFO: initializing python engine. 19:14:28 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:28 T:140436521854720 DEBUG: CPythonInvoker(4, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): start processing 19:14:28 T:140436521854720 DEBUG: -->Python Interpreter Initialized<-- 19:14:28 T:140436521854720 DEBUG: CPythonInvoker(4, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): the source file to load is "/home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py" 19:14:28 T:140436521854720 DEBUG: CPythonInvoker(4, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): setting the Python path to /home/thorsten/.kodi/addons/script.xbmc.debug.log:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gst-0.10:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 19:14:28 T:140436521854720 DEBUG: CPythonInvoker(4, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): entering source directory /home/thorsten/.kodi/addons/script.xbmc.debug.log 19:14:28 T:140436521854720 DEBUG: CPythonInvoker(4, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): instantiating addon using automatically obtained id of "script.xbmc.debug.log" dependent on version 2.12.0 of the xbmc.python api 19:14:28 T:140436521854720 NOTICE: Kodi Log Uploader: started 19:14:28 T:140436521854720 NOTICE: Kodi Log Uploader: settings: len(email)=0 19:14:28 T:140436521854720 NOTICE: Kodi Log Uploader: settings: skip_oldlog=True 19:14:28 T:140436521854720 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.xbmc.debug.log/resources/language/German, fallback to strings.xml 19:14:28 T:140436521854720 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.xbmc.debug.log/resources/language/English, fallback to strings.xml 19:14:29 T:140437664004096 DEBUG: ------ Window Init (DialogYesNo.xml) ------ 19:14:30 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:33 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:33 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:33 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:33 T:140437664004096 DEBUG: ------ Window Deinit (DialogYesNo.xml) ------ 19:14:33 T:140436521854720 INFO: CPythonInvoker(4, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): script successfully run 19:14:33 T:140436521854720 INFO: Python script stopped 19:14:33 T:140436521854720 DEBUG: Thread LanguageInvoker 140436521854720 terminating 19:14:38 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:38 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (plugin://script.logviewer/) 19:14:38 T:140437664004096 DEBUG: ParentPath = [addons://sources/executable/] 19:14:38 T:140436796606208 DEBUG: StartScript - calling plugin Log Viewer for Kodi('plugin://script.logviewer/','1','') 19:14:38 T:140436796606208 DEBUG: WaitOnScriptResult - waiting on the Log Viewer for Kodi (id=5) plugin... 19:14:38 T:140436521854720 DEBUG: Thread LanguageInvoker start, auto delete: false 19:14:38 T:140436521854720 INFO: initializing python engine. 19:14:38 T:140436521854720 DEBUG: CPythonInvoker(5, /home/thorsten/.kodi/addons/script.logviewer/default.py): start processing 19:14:38 T:140436521854720 DEBUG: -->Python Interpreter Initialized<-- 19:14:38 T:140436521854720 DEBUG: CPythonInvoker(5, /home/thorsten/.kodi/addons/script.logviewer/default.py): the source file to load is "/home/thorsten/.kodi/addons/script.logviewer/default.py" 19:14:38 T:140436521854720 DEBUG: CPythonInvoker(5, /home/thorsten/.kodi/addons/script.logviewer/default.py): setting the Python path to /home/thorsten/.kodi/addons/script.logviewer:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gst-0.10:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 19:14:38 T:140436521854720 DEBUG: CPythonInvoker(5, /home/thorsten/.kodi/addons/script.logviewer/default.py): entering source directory /home/thorsten/.kodi/addons/script.logviewer 19:14:38 T:140436521854720 DEBUG: CPythonInvoker(5, /home/thorsten/.kodi/addons/script.logviewer/default.py): instantiating addon using automatically obtained id of "script.logviewer" dependent on version 2.1.0 of the xbmc.python api 19:14:39 T:140436521854720 ERROR: EXCEPTION: Non-Existent Control 1 19:14:39 T:140436521854720 DEBUG: LocalizeStrings: no translation available in currently set gui language, at path /home/thorsten/.kodi/addons/script.logviewer/resources/language/German 19:14:39 T:140436521854720 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.logviewer/resources/language/English, fallback to strings.xml 19:14:39 T:140436521854720 DEBUG: LocalizeStrings: no translation available in currently set gui language, at path /home/thorsten/.kodi/addons/script.logviewer/resources/language/German 19:14:39 T:140436521854720 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.logviewer/resources/language/English, fallback to strings.xml 19:14:39 T:140436521854720 INFO: CPythonInvoker(5, /home/thorsten/.kodi/addons/script.logviewer/default.py): script successfully run 19:14:39 T:140436796606208 DEBUG: WaitOnScriptResult- plugin returned successfully 19:14:39 T:140436521854720 INFO: Python script stopped 19:14:39 T:140436521854720 DEBUG: Thread LanguageInvoker 140436521854720 terminating 19:14:39 T:140436521854720 DEBUG: Thread BackgroundLoader start, auto delete: false 19:14:39 T:140436521854720 DEBUG: Thread BackgroundLoader 140436521854720 terminating 19:14:39 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:39 T:140437664004096 DEBUG: Activating window ID: 10147 19:14:39 T:140437664004096 DEBUG: ------ Window Init (DialogTextViewer.xml) ------ 19:14:39 T:140437664004096 INFO: Loading skin file: DialogTextViewer.xml, load type: KEEP_IN_MEMORY 19:14:41 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:44 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:44 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:44 T:140437664004096 DEBUG: ------ Window Deinit (DialogTextViewer.xml) ------ 19:14:44 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:48 T:140437664004096 INFO: CheckIdle - Closing session to http://feeds.xbmc.org (easy=0x7fba0803fa50, multi=0x7fba082105e0) 19:14:49 T:140437664004096 INFO: Python, unloading python shared library because no scripts are running anymore 19:14:49 T:140437664004096 DEBUG: UnloadExtensionLibs, clearing python extension libraries 19:14:49 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:49 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/executable/) 19:14:49 T:140437664004096 DEBUG: ParentPath = [] 19:14:49 T:140436521854720 DEBUG: Thread BackgroundLoader start, auto delete: false 19:14:49 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:49 T:140436521854720 DEBUG: Thread BackgroundLoader 140436521854720 terminating 19:14:50 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:52 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:52 T:140437664004096 DEBUG: CUtil::GetMatchingSource: no matching source found for [addons://all/xbmc.addon.executable] 19:14:52 T:140437664004096 DEBUG: Activating window ID: 10040 19:14:52 T:140437664004096 DEBUG: ------ Window Deinit (MyPrograms.xml) ------ 19:14:52 T:140437664004096 DEBUG: ------ Window Init (AddonBrowser.xml) ------ 19:14:52 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (addons://all/xbmc.addon.executable) 19:14:52 T:140437664004096 DEBUG: ParentPath = [addons://all/xbmc.addon.executable] 19:14:53 T:140436521854720 DEBUG: Thread BackgroundLoader start, auto delete: false 19:14:53 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:53 T:140436521854720 DEBUG: Thread BackgroundLoader 140436521854720 terminating 19:14:55 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:55 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheelup 19:14:55 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:14:55 T:140437664004096 DEBUG: ProcessMouse: trying mouse action wheelup 19:14:57 T:140437664004096 DEBUG: Previous line repeats 5 times. 19:14:57 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:14:59 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:14:59 T:140437664004096 DEBUG: ------ Window Init (DialogAddonInfo.xml) ------ 19:14:59 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:00 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:02 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:02 T:140437664004096 DEBUG: ------ Window Init (DialogAddonSettings.xml) ------ 19:15:02 T:140437664004096 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.xbmc.debug.log/resources/language/German, fallback to strings.xml 19:15:02 T:140437664004096 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.xbmc.debug.log/resources/language/English, fallback to strings.xml 19:15:02 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:03 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:03 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:03 T:140437664004096 INFO: Loading skin file: DialogKeyboard.xml, load type: KEEP_IN_MEMORY 19:15:03 T:140437664004096 DEBUG: ------ Window Init (DialogKeyboard.xml) ------ 19:15:03 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnInputRequested from xbmc 19:15:03 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 128, from xbmc, message OnInputRequested 19:15:03 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:09 T:140437664004096 DEBUG: Keyboard: scancode: 0x28, sym: 0x0064, unicode: 0x0064, modifier: 0x0 19:15:09 T:140437664004096 DEBUG: OnKey: d (0xf044) pressed, trying keyboard action f164 19:15:10 T:140437664004096 DEBUG: Keyboard: scancode: 0x1e, sym: 0x0075, unicode: 0x0075, modifier: 0x0 19:15:10 T:140437664004096 DEBUG: OnKey: u (0xf055) pressed, trying keyboard action f175 19:15:10 T:140437664004096 DEBUG: Keyboard: scancode: 0x3d, sym: 0x002d, unicode: 0x002d, modifier: 0x0 19:15:10 T:140437664004096 DEBUG: OnKey: minus (0xf02d) pressed, trying keyboard action f12d 19:15:10 T:140437664004096 DEBUG: Keyboard: scancode: 0x39, sym: 0x006e, unicode: 0x006e, modifier: 0x0 19:15:10 T:140437664004096 DEBUG: OnKey: n (0xf04e) pressed, trying keyboard action f16e 19:15:11 T:140437664004096 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0069, unicode: 0x0069, modifier: 0x0 19:15:11 T:140437664004096 DEBUG: OnKey: i (0xf049) pressed, trying keyboard action f169 19:15:11 T:140437664004096 DEBUG: Keyboard: scancode: 0x35, sym: 0x0078, unicode: 0x0078, modifier: 0x0 19:15:11 T:140437664004096 DEBUG: OnKey: x (0xf058) pressed, trying keyboard action f178 19:15:11 T:140437664004096 DEBUG: Keyboard: scancode: 0x6c, sym: 0xfe03, unicode: 0x0000, modifier: 0x0 19:15:11 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 19:15:11 T:140437664004096 DEBUG: Previous line repeats 4 times. 19:15:11 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, trying keyboard action f000 19:15:11 T:140437664004096 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200 19:15:11 T:140437664004096 DEBUG: Previous line repeats 1 times. 19:15:11 T:140437664004096 DEBUG: OnKey: 0 (0xf200) pressed, action is 19:15:12 T:140437664004096 DEBUG: Keyboard: scancode: 0x0b, sym: 0x0040, unicode: 0x0040, modifier: 0x0 19:15:12 T:140437664004096 DEBUG: OnKey: at (0xf040) pressed, trying keyboard action f140 19:15:14 T:140437664004096 DEBUG: Keyboard: scancode: 0x1f, sym: 0x0069, unicode: 0x0069, modifier: 0x0 19:15:14 T:140437664004096 DEBUG: OnKey: i (0xf049) pressed, trying keyboard action f169 19:15:14 T:140437664004096 DEBUG: Keyboard: scancode: 0x36, sym: 0x0063, unicode: 0x0063, modifier: 0x0 19:15:14 T:140437664004096 DEBUG: OnKey: c (0xf043) pressed, trying keyboard action f163 19:15:14 T:140437664004096 DEBUG: Keyboard: scancode: 0x2b, sym: 0x0068, unicode: 0x0068, modifier: 0x0 19:15:14 T:140437664004096 DEBUG: OnKey: h (0xf048) pressed, trying keyboard action f168 19:15:14 T:140437664004096 DEBUG: Keyboard: scancode: 0x3d, sym: 0x002d, unicode: 0x002d, modifier: 0x0 19:15:14 T:140437664004096 DEBUG: OnKey: minus (0xf02d) pressed, trying keyboard action f12d 19:15:15 T:140437664004096 DEBUG: Keyboard: scancode: 0x1c, sym: 0x0074, unicode: 0x0074, modifier: 0x0 19:15:15 T:140437664004096 DEBUG: OnKey: t (0xf054) pressed, trying keyboard action f174 19:15:15 T:140437664004096 DEBUG: Keyboard: scancode: 0x26, sym: 0x0061, unicode: 0x0061, modifier: 0x0 19:15:15 T:140437664004096 DEBUG: OnKey: a (0xf041) pressed, trying keyboard action f161 19:15:15 T:140437664004096 DEBUG: Keyboard: scancode: 0x1b, sym: 0x0072, unicode: 0x0072, modifier: 0x0 19:15:15 T:140437664004096 DEBUG: OnKey: r (0xf052) pressed, trying keyboard action f172 19:15:15 T:140437664004096 DEBUG: Keyboard: scancode: 0x1d, sym: 0x007a, unicode: 0x007a, modifier: 0x0 19:15:15 T:140437664004096 DEBUG: OnKey: z (0xf05a) pressed, trying keyboard action f17a 19:15:16 T:140437664004096 DEBUG: Keyboard: scancode: 0x26, sym: 0x0061, unicode: 0x0061, modifier: 0x0 19:15:16 T:140437664004096 DEBUG: OnKey: a (0xf041) pressed, trying keyboard action f161 19:15:16 T:140437664004096 DEBUG: Keyboard: scancode: 0x39, sym: 0x006e, unicode: 0x006e, modifier: 0x0 19:15:16 T:140437664004096 DEBUG: OnKey: n (0xf04e) pressed, trying keyboard action f16e 19:15:16 T:140437664004096 DEBUG: Keyboard: scancode: 0x3c, sym: 0x002e, unicode: 0x002e, modifier: 0x0 19:15:16 T:140437664004096 DEBUG: OnKey: period (0xf02e) pressed, trying keyboard action f12e 19:15:16 T:140437664004096 DEBUG: Keyboard: scancode: 0x28, sym: 0x0064, unicode: 0x0064, modifier: 0x0 19:15:16 T:140437664004096 DEBUG: OnKey: d (0xf044) pressed, trying keyboard action f164 19:15:17 T:140437664004096 DEBUG: Keyboard: scancode: 0x1a, sym: 0x0065, unicode: 0x0065, modifier: 0x0 19:15:17 T:140437664004096 DEBUG: OnKey: e (0xf045) pressed, trying keyboard action f165 19:15:19 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:21 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:21 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:21 T:140437664004096 DEBUG: ------ Window Deinit (DialogKeyboard.xml) ------ 19:15:21 T:140437664004096 DEBUG: CAnnouncementManager - Announcement: OnInputFinished from xbmc 19:15:21 T:140437664004096 DEBUG: GOT ANNOUNCEMENT, type: 128, from xbmc, message OnInputFinished 19:15:21 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:24 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:24 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:24 T:140437664004096 DEBUG: ------ Window Deinit (DialogAddonSettings.xml) ------ 19:15:26 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:27 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:27 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:28 T:140437664004096 DEBUG: ------ Window Deinit (DialogAddonInfo.xml) ------ 19:15:28 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:28 T:140437664004096 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-x86_64-linux.so) 19:15:29 T:140436796606208 DEBUG: Thread JobWorker 140436796606208 terminating (autodelete) 19:15:29 T:140436788213504 DEBUG: Thread JobWorker 140436788213504 terminating (autodelete) 19:15:29 T:140435643414272 DEBUG: Thread JobWorker 140435643414272 terminating (autodelete) 19:15:29 T:140435028702976 DEBUG: Thread JobWorker 140435028702976 terminating (autodelete) 19:15:31 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:31 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 19:15:31 T:140437664004096 DEBUG: ------ Window Deinit (AddonBrowser.xml) ------ 19:15:31 T:140437664004096 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 19:15:31 T:140437664004096 DEBUG: ------ Window Init (MyPrograms.xml) ------ 19:15:31 T:140437664004096 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/executable) 19:15:31 T:140437664004096 DEBUG: ParentPath = [addons://sources/executable] 19:15:31 T:140435028702976 DEBUG: Thread BackgroundLoader start, auto delete: false 19:15:31 T:140435028702976 DEBUG: Thread BackgroundLoader 140435028702976 terminating 19:15:31 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:31 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:32 T:140435028702976 DEBUG: Thread JobWorker start, auto delete: true 19:15:32 T:140435643414272 DEBUG: Previous line repeats 1 times. 19:15:32 T:140435643414272 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so) 19:15:32 T:140435643414272 DEBUG: Loading: /usr/lib/kodi/system/ImageLib-x86_64-linux.so 19:15:33 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:33 T:140436788213504 DEBUG: Thread LanguageInvoker start, auto delete: false 19:15:33 T:140436788213504 INFO: initializing python engine. 19:15:33 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:33 T:140436788213504 DEBUG: CPythonInvoker(6, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): start processing 19:15:34 T:140436788213504 DEBUG: -->Python Interpreter Initialized<-- 19:15:34 T:140436788213504 DEBUG: CPythonInvoker(6, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): the source file to load is "/home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py" 19:15:34 T:140436788213504 DEBUG: CPythonInvoker(6, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): setting the Python path to /home/thorsten/.kodi/addons/script.xbmc.debug.log:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gst-0.10:/usr/lib/python2.7/dist-packages/gtk-2.0:/usr/lib/python2.7/dist-packages/ubuntu-sso-client 19:15:34 T:140436788213504 DEBUG: CPythonInvoker(6, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): entering source directory /home/thorsten/.kodi/addons/script.xbmc.debug.log 19:15:34 T:140436788213504 DEBUG: CPythonInvoker(6, /home/thorsten/.kodi/addons/script.xbmc.debug.log/addon.py): instantiating addon using automatically obtained id of "script.xbmc.debug.log" dependent on version 2.12.0 of the xbmc.python api 19:15:34 T:140436788213504 NOTICE: Kodi Log Uploader: started 19:15:34 T:140436788213504 NOTICE: Kodi Log Uploader: settings: len(email)=20 19:15:34 T:140436788213504 NOTICE: Kodi Log Uploader: settings: skip_oldlog=True 19:15:34 T:140436788213504 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.xbmc.debug.log/resources/language/German, fallback to strings.xml 19:15:34 T:140436788213504 DEBUG: LocalizeStrings: no strings.po file exist at /home/thorsten/.kodi/addons/script.xbmc.debug.log/resources/language/English, fallback to strings.xml 19:15:34 T:140437664004096 DEBUG: ------ Window Init (DialogYesNo.xml) ------ 19:15:35 T:140437664004096 DEBUG: ------ Window Init (Pointer.xml) ------ 19:15:37 T:140437664004096 DEBUG: ProcessMouse: trying mouse action leftclick 19:15:37 T:140437664004096 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:15:37 T:140437664004096 DEBUG: ------ Window Deinit (DialogYesNo.xml) ------ 19:15:37 T:140436788213504 NOTICE: Kodi Log Uploader: reading log...