Project

General

Profile

Bug #1779 » xbmc.log

Glen Browne, 2013-12-21 06:25

 
1
18:08:57 T:4568  NOTICE: -----------------------------------------------------------------------
2
18:08:57 T:4568  NOTICE: Starting XBMC (12.2 Git:20130502-32b1a5e), Platform: Windows 8 64-bit, build 9200. Built on May  2 2013 (compiler 1600)
3
18:08:57 T:4568  NOTICE: Intel(R) Core(TM) i7-2637M CPU @ 1.70GHz
4
18:08:57 T:4568  NOTICE: Desktop Resolution: 1366x768 32Bit at 60Hz
5
18:08:57 T:4568  NOTICE: Running with restricted rights
6
18:08:57 T:4568  NOTICE: Aero is enabled
7
18:08:57 T:4568  NOTICE: special://xbmc/ is mapped to: C:\Program Files (x86)\XBMC
8
18:08:57 T:4568  NOTICE: special://xbmcbin/ is mapped to: C:\Program Files (x86)\XBMC
9
18:08:57 T:4568  NOTICE: special://masterprofile/ is mapped to: C:\Users\Glen\AppData\Roaming\XBMC\userdata
10
18:08:57 T:4568  NOTICE: special://home/ is mapped to: C:\Users\Glen\AppData\Roaming\XBMC\
11
18:08:57 T:4568  NOTICE: special://temp/ is mapped to: C:\Users\Glen\AppData\Roaming\XBMC\cache
12
18:08:57 T:4568  NOTICE: The executable running is: C:\Program Files (x86)\XBMC\XBMC.exe
13
18:08:57 T:4568  NOTICE: Local hostname: XPS13
14
18:08:57 T:4568  NOTICE: Log File is located: C:\Users\Glen\AppData\Roaming\XBMC\xbmc.log
15
18:08:57 T:4568  NOTICE: -----------------------------------------------------------------------
16
18:08:57 T:4568  NOTICE: Found 2 Lists of Devices
17
18:08:57 T:4568  NOTICE: Enumerated DirectSound devices:
18
18:08:57 T:4568  NOTICE:     Device 1
19
18:08:57 T:4568  NOTICE:         m_deviceName      : {56CB0A58-8A04-4D68-8B71-9DFC9C65A194}
20
18:08:57 T:4568  NOTICE:         m_displayName     : Speakers - Speakers (Realtek High Definition Audio)
21
18:08:57 T:4568  NOTICE:         m_displayNameExtra: DirectSound: Speakers (Realtek High Definition Audio)
22
18:08:57 T:4568  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
23
18:08:57 T:4568  NOTICE:         m_channels        : FL,FR
24
18:08:57 T:4568  NOTICE:         m_sampleRates     : 48000
25
18:08:57 T:4568  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_AC3
26
18:08:57 T:4568  NOTICE: Enumerated WASAPI devices:
27
18:08:57 T:4568  NOTICE:     Device 1
28
18:08:57 T:4568  NOTICE:         m_deviceName      : {56CB0A58-8A04-4D68-8B71-9DFC9C65A194}
29
18:08:57 T:4568  NOTICE:         m_displayName     : Speakers - Speakers (Realtek High Definition Audio)
30
18:08:57 T:4568  NOTICE:         m_displayNameExtra: WASAPI: Speakers (Realtek High Definition Audio)
31
18:08:57 T:4568  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
32
18:08:57 T:4568  NOTICE:         m_channels        : FL,FR
33
18:08:57 T:4568  NOTICE:         m_sampleRates     : 192000,96000,48000,44100
34
18:08:57 T:4568  NOTICE:         m_dataFormats     : AE_FMT_S24NE4,AE_FMT_S24LE4,AE_FMT_S24BE4,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_S16BE
35
18:08:57 T:4568  NOTICE: load settings...
36
18:08:57 T:4568  NOTICE: special://profile/ is mapped to: special://masterprofile/
37
18:08:57 T:4568  NOTICE: loading special://masterprofile/guisettings.xml
38
18:08:57 T:4568  NOTICE: Getting hardware information now...
39
18:08:57 T:4568  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
40
18:08:57 T:4568  NOTICE: Loaded playercorefactory configuration
41
18:08:57 T:4568  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
42
18:08:57 T:4568  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
43
18:08:57 T:4568  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
44
18:08:57 T:4568  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
45
18:08:57 T:4568  NOTICE: Default DVD Player: dvdplayer
46
18:08:57 T:4568  NOTICE: Default Video Player: dvdplayer
47
18:08:57 T:4568  NOTICE: Default Audio Player: paplayer
48
18:08:57 T:4568  NOTICE: Enabled debug logging due to GUI setting (2)
49
18:08:57 T:4568  NOTICE: Log level changed to 2
50
18:08:57 T:4568  NOTICE: Loading media sources from special://masterprofile/sources.xml
51
18:08:57 T:4568    INFO: creating subdirectories
52
18:08:57 T:4568    INFO: userdata folder: special://masterprofile/
53
18:08:57 T:4568    INFO: recording folder:
54
18:08:57 T:4568    INFO: screenshots folder:
55
18:08:57 T:4568    INFO: thumbnails folder: special://masterprofile/Thumbnails
56
18:08:57 T:4568    INFO: load language info file: special://xbmc/language/English/langinfo.xml
57
18:08:57 T:4568   DEBUG: trying to set locale to eng_usa
58
18:08:57 T:4568    INFO: global locale set to English_United States.1252
59
18:08:57 T:4568    INFO: load English language file, from path: special://xbmc/language/
60
18:08:57 T:4568   DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: C:\Program Files (x86)\XBMC\language\English\strings.po
61
18:08:57 T:4568   DEBUG: POParser: loaded 2686 strings from file C:\Program Files (x86)\XBMC\language\English\strings.po
62
18:08:57 T:4568    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
63
18:08:57 T:4568   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 65552
64
18:08:57 T:4568   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
65
18:08:57 T:4568   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
66
18:08:57 T:4568   DEBUG:   Audio Device    : Speakers (Realtek High Definition Audio)
67
18:08:57 T:4568   DEBUG:   Sample Rate     : 44100
68
18:08:57 T:4568   DEBUG:   Sample Format   : AE_FMT_FLOAT
69
18:08:57 T:4568   DEBUG:   Bits Per Sample : 32
70
18:08:57 T:4568   DEBUG:   Valid Bits/Samp : 32
71
18:08:57 T:4568   DEBUG:   Channel Count   : 2
72
18:08:57 T:4568   DEBUG:   Block Align     : 8
73
18:08:57 T:4568   DEBUG:   Avg. Bytes Sec  : 352800
74
18:08:57 T:4568   DEBUG:   Samples/Block   : 32
75
18:08:57 T:4568   DEBUG:   Format cBSize   : 22
76
18:08:57 T:4568   DEBUG:   Channel Layout  : FL,FR
77
18:08:57 T:4568   DEBUG:   Channel Mask    : 3
78
18:08:57 T:4568   DEBUG:   Frames          : 441
79
18:08:57 T:4568   DEBUG:   Frame Samples   : 882
80
18:08:57 T:4568   DEBUG:   Frame Size      : 8
81
18:08:57 T:4568   DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
82
18:08:57 T:4568   DEBUG:   Output Device : Speakers - Speakers (Realtek High Definition Audio)
83
18:08:57 T:4568   DEBUG:   Sample Rate   : 44100
84
18:08:57 T:4568   DEBUG:   Sample Format : AE_FMT_FLOAT
85
18:08:57 T:4568   DEBUG:   Channel Count : 2
86
18:08:57 T:4568   DEBUG:   Channel Layout: FL,FR
87
18:08:57 T:4568   DEBUG:   Frames        : 441
88
18:08:57 T:4568   DEBUG:   Frame Samples : 882
89
18:08:57 T:4568   DEBUG:   Frame Size    : 8
90
18:08:57 T:4568   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
91
18:08:57 T:4568   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
92
18:08:57 T:5324  NOTICE: Thread CSoftAE start, auto delete: false
93
18:08:57 T:5324    INFO: CSoftAE::Run - Thread Started
94
18:08:57 T:4568  NOTICE: Running database version Addons15
95
18:08:57 T:4568   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/cpluff.dll)
96
18:08:57 T:5324   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
97
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
98
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
99
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
100
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been installed.'
101
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
102
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been installed.'
103
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
104
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.'
105
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx32.xbmc.org has been installed.'
106
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.'
107
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been installed.'
108
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been installed.'
109
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been installed.'
110
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
111
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
112
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
113
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-ios.xbmc.org has been installed.'
114
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been installed.'
115
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been installed.'
116
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
117
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been installed.'
118
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been installed.'
119
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been installed.'
120
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been installed.'
121
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.'
122
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
123
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
124
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been installed.'
125
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been installed.'
126
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
127
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.'
128
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.'
129
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-android.xbmc.org has been installed.'
130
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
131
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
132
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-win32.xbmc.org has been installed.'
133
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.'
134
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx64.xbmc.org has been installed.'
135
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv.cmyth has been installed.'
136
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
137
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
138
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
139
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been installed.'
140
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
141
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
142
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
143
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
144
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
145
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
146
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
147
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been installed.'
148
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
149
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been installed.'
150
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been installed.'
151
18:08:58 T:4568   DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
152
18:08:58 T:4568   DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "Motorola Nyxboard Hybrid"
153
18:08:58 T:4568   DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "CEC Adapter"
154
18:08:58 T:4568   DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "Pulse-Eight CEC Adapter"
155
18:08:58 T:4568   DEBUG: PERIPHERALS::CPeripherals::LoadMappings - loaded node "iMON HID device"
156
18:08:58 T:4568   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcec.dll)
157
18:08:58 T:6572  NOTICE: Thread XBMC Peripherals start, auto delete: false
158
18:08:58 T:6580  NOTICE: Previous line repeats 1 times.
159
18:08:58 T:6580  NOTICE: Thread CRemoteControl start, auto delete: false
160
18:08:58 T:6580   DEBUG: CRemoteControl::Connect - connecting to: ::1:24000 ...
161
18:08:58 T:4568   DEBUG: CWin32StorageProvider::Initialize: No optical drive found.
162
18:08:58 T:4568  NOTICE: Found screen: Generic PnP Monitor on Intel(R) HD Graphics 3000, adapter 0.
163
18:08:58 T:4568  NOTICE: Primary mode: 1366x768 @ 60.00 - Full Screen
164
18:08:58 T:4568  NOTICE: Additional mode: 320x200 @ 40.00 - Full Screen
165
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
166
18:08:58 T:4568  NOTICE: Additional mode: 320x200 @ 60.00 - Full Screen
167
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
168
18:08:58 T:4568  NOTICE: Additional mode: 320x240 @ 40.00 - Full Screen
169
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
170
18:08:58 T:4568  NOTICE: Additional mode: 320x240 @ 60.00 - Full Screen
171
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
172
18:08:58 T:4568  NOTICE: Additional mode: 400x300 @ 40.00 - Full Screen
173
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
174
18:08:58 T:4568  NOTICE: Additional mode: 400x300 @ 60.00 - Full Screen
175
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
176
18:08:58 T:4568  NOTICE: Additional mode: 512x384 @ 40.00 - Full Screen
177
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
178
18:08:58 T:4568  NOTICE: Additional mode: 512x384 @ 60.00 - Full Screen
179
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
180
18:08:58 T:4568  NOTICE: Additional mode: 640x400 @ 40.00 - Full Screen
181
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
182
18:08:58 T:4568  NOTICE: Additional mode: 640x400 @ 60.00 - Full Screen
183
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
184
18:08:58 T:4568  NOTICE: Additional mode: 640x480 @ 40.00 - Full Screen
185
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
186
18:08:58 T:4568  NOTICE: Additional mode: 640x480 @ 60.00 - Full Screen
187
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
188
18:08:58 T:4568  NOTICE: Additional mode: 800x600 @ 40.00 - Full Screen
189
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
190
18:08:58 T:4568  NOTICE: Additional mode: 800x600 @ 60.00 - Full Screen
191
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
192
18:08:58 T:4568  NOTICE: Additional mode: 1024x768 @ 40.00 - Full Screen
193
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
194
18:08:58 T:4568  NOTICE: Additional mode: 1024x768 @ 60.00 - Full Screen
195
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
196
18:08:58 T:4568  NOTICE: Additional mode: 1280x600 @ 40.00 - Full Screen
197
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
198
18:08:58 T:4568  NOTICE: Additional mode: 1280x600 @ 60.00 - Full Screen
199
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
200
18:08:58 T:4568  NOTICE: Additional mode: 1280x720 @ 40.00 - Full Screen
201
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
202
18:08:58 T:4568  NOTICE: Additional mode: 1280x720 @ 60.00 - Full Screen
203
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
204
18:08:58 T:4568  NOTICE: Additional mode: 1280x768 @ 40.00 - Full Screen
205
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
206
18:08:58 T:4568  NOTICE: Additional mode: 1280x768 @ 60.00 - Full Screen
207
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
208
18:08:58 T:4568  NOTICE: Additional mode: 1360x768 @ 40.00 - Full Screen
209
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
210
18:08:58 T:4568  NOTICE: Additional mode: 1360x768 @ 60.00 - Full Screen
211
18:08:58 T:4568  NOTICE: Previous line repeats 2 times.
212
18:08:58 T:4568  NOTICE: Additional mode: 1366x768 @ 40.00 - Full Screen
213
18:08:58 T:4568  NOTICE: Additional mode: 1366x768 @ 60.00 - Full Screen
214
18:08:58 T:4568  NOTICE: Checking resolution 16
215
18:08:58 T:4568   DEBUG: CWinEventsWin32::WndProc: window resize event
216
18:08:58 T:4568   DEBUG: CWinEventsWin32::WndProc: window move event
217
18:08:58 T:4568   DEBUG: CWinSystemWin32::ResizeInternal - resizing due to size change (0,0,1366,768 fullscreen)->(0,0,1366,768 fullscreen)
218
18:08:58 T:4568   DEBUG: CWinEventsWin32::WndProcWindow is active
219
18:08:58 T:4568   DEBUG: CRenderSystemDX::InitRenderSystem - trying D3D9Ex...
220
18:08:58 T:4568   DEBUG: CRenderSystemDX::InitRenderSystem - using D3D9Ex
221
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice on adapter 0
222
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - using hardware vertex processing
223
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - adapter 0: igdumd32.dll, Intel(R) HD Graphics 3000, VendorId 32902, DeviceId 278
224
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - using D3DCAPS2_DYNAMICTEXTURES
225
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - texture caps: 0x0021EC45
226
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_DXT
227
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_NPOT
228
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - RENDER_CAPS_DXT_NPOT
229
18:08:58 T:4568   DEBUG: CRenderSystemDX::CreateDevice - Intel workaround - specifying minimum pitch for compressed textures.
230
18:08:58 T:4568   DEBUG: CWinSystemWin32::SetFullScreen (windowed fullscreen) on screen 0 with size 1366x768, refresh 60.000000
231
18:08:58 T:4568   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
232
18:08:58 T:4568    INFO: load default splash image: C:\Program Files (x86)\XBMC\media\Splash.png
233
18:08:58 T:4568   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib.dll)
234
18:08:58 T:4568    INFO: load keymapping
235
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/appcommand.xml
236
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/gamepad.xml
237
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Alienware.Dual.Compatible.Controller.xml
238
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.AppleRemote.xml
239
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Harmony.xml
240
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Interact.AxisPad.xml
241
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Logitech.RumblePad.2.xml
242
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.360.Controller.xml
243
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Microsoft.Xbox.Controller.S.xml
244
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.PS3.Remote.Keyboard.xml
245
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.Sony.PLAYSTATION(R)3.Controller.xml
246
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/joystick.WiiRemote.xml
247
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/keyboard.xml
248
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/mouse.xml
249
18:08:58 T:4568    INFO: Loading special://xbmc/system/keymaps/remote.xml
250
18:08:58 T:4568    INFO: Loading special://xbmc/system/IRSSmap.xml
251
18:08:58 T:4568    INFO: * Adding remote mapping for device 'Microsoft MCE'
252
18:08:58 T:4568    INFO: * Adding remote mapping for device 'Abstract'
253
18:08:58 T:4568   DEBUG: CButtonTranslator::Load - no userdata IRSSmap.xml found, skipping
254
18:08:58 T:4568    INFO: GUI format 1366x768, Display 1366x768 @ 60.00 - Full Screen
255
18:08:58 T:4568   DEBUG: guilib: Fill viewport on change for solving rendering passes
256
18:08:58 T:4568   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/libcurl.dll)
257
18:08:58 T:4568  NOTICE: Running database version Addons15
258
18:08:58 T:4568   DEBUG: CDatabaseManager::Initialize, updating databases...
259
18:08:58 T:4568  NOTICE: Running database version ViewModes4
260
18:08:58 T:4568  NOTICE: Running database version Textures13
261
18:08:58 T:4568  NOTICE: Running database version MyMusic32
262
18:08:58 T:4568  NOTICE: Running database version MyVideos75
263
18:08:58 T:4568  NOTICE: Running database version TV22
264
18:08:58 T:4568  NOTICE: Running database version Epg7
265
18:08:58 T:4568   DEBUG: CDatabaseManager::Initialize, updating databases... DONE
266
18:08:58 T:4568  NOTICE: initializing playlistplayer
267
18:08:58 T:4568  NOTICE: DONE initializing playlistplayer
268
18:08:58 T:4568   DEBUG: DPMS: supported power-saving modes: OFF STANDBY
269
18:08:58 T:4568   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
270
18:08:58 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
271
18:08:58 T:4568    INFO: Unloading old skin ...
272
18:08:58 T:4568    INFO:   load skin from: C:\Program Files (x86)\XBMC\addons\skin.confluence (version: 2.1.5)
273
18:08:58 T:4568    INFO:   load fonts for skin...
274
18:08:58 T:4568    INFO: Loading fonts from C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\Font.xml
275
18:08:58 T:4568   DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: C:\Program Files (x86)\XBMC\addons\skin.confluence\language\English\strings.po
276
18:08:58 T:4568   DEBUG: POParser: loaded 131 strings from file C:\Program Files (x86)\XBMC\addons\skin.confluence\language\English\strings.po
277
18:08:58 T:4568    INFO: Loading skin includes from C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\includes.xml
278
18:08:58 T:4568    INFO:   load new skin...
279
18:08:58 T:4568    INFO: Loading user windows, path C:\Program Files (x86)\XBMC\addons\skin.confluence\720p
280
18:08:58 T:4568   DEBUG: Load Skin XML: 4.76ms
281
18:08:58 T:4568    INFO:   initialize new skin...
282
18:08:58 T:4568   DEBUG: guilib: Fill viewport on change for solving rendering passes
283
18:08:58 T:4568    INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
284
18:08:58 T:4568   DEBUG: CTextureBundleXBT::OpenBundle - Opened bundle C:\Program Files (x86)\XBMC\addons\skin.confluence\media\Textures.xbt
285
18:08:58 T:4568    INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
286
18:08:58 T:4568    INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
287
18:08:58 T:4568    INFO: Loading skin file: DialogMuteBug.xml, load type: LOAD_ON_GUI_INIT
288
18:08:58 T:4568    INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
289
18:08:58 T:4568    INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
290
18:08:58 T:4568    INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
291
18:08:58 T:4568    INFO: Loading C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\sounds.xml
292
18:08:58 T:4568    INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\cursor.wav
293
18:08:58 T:4568    INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\click.wav
294
18:08:58 T:4568    INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\back.wav
295
18:08:58 T:4568   DEBUG: AERemap: Downmix normalization is disabled
296
18:08:58 T:4568    INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\shutter.wav
297
18:08:58 T:4568    INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\notify.wav
298
18:08:58 T:4568   DEBUG: AERemap: Downmix normalization is disabled
299
18:08:58 T:4568    INFO: CAEWAVLoader::Initialize - Sound Loaded: C:\Program Files (x86)\XBMC\addons\skin.confluence\sounds\out.wav
300
18:08:58 T:4568   DEBUG: AERemap: Downmix normalization is disabled
301
18:08:58 T:4568    INFO:   skin loaded...
302
18:08:58 T:4568    INFO: JSONRPC v6.0.3: Successfully initialized
303
18:08:58 T:4568   DEBUG: ADDON: Starting service addons.
304
18:08:58 T:4568   DEBUG: Activating window ID: 12999
305
18:08:58 T:4568   DEBUG: ------ Window Init (Startup.xml) ------
306
18:08:58 T:4568    INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
307
18:08:58 T:6560  NOTICE: Thread Jobworker start, auto delete: true
308
18:08:58 T:4568    INFO: removing tempfiles
309
18:08:58 T:4568   DEBUG: ADDON: Starting service addons.
310
18:08:58 T:4568  NOTICE: initialize done
311
18:08:58 T:4568   DEBUG: CJoystick::Initialize : No Joystick found
312
18:08:58 T:4568  NOTICE: Running the application...
313
18:08:58 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating ReplaceWindow(Home)
314
18:08:58 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To ReplaceWindow(Home)
315
18:08:58 T:4568   DEBUG: Activating window ID: 10000
316
18:08:58 T:4568   DEBUG: ------ Window Init () ------
317
18:08:58 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
318
18:08:58 T:4568   DEBUG: ------ Window Deinit (Startup.xml) ------
319
18:08:58 T:4568   DEBUG: ------ Window Init (Home.xml) ------
320
18:08:58 T:4568    INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
321
18:08:59 T:6564  NOTICE: Thread Jobworker start, auto delete: true
322
18:08:59 T:6564   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
323
18:08:59 T:4568   DEBUG: XBPython::Process - no profile autoexec.py (C:\Users\Glen\AppData\Roaming\XBMC\userdata\autoexec.py) found, skipping
324
18:08:59 T:4568   DEBUG: CNetwork::NetworkMessage - Starting network services
325
18:08:59 T:4568  NOTICE: ES: Starting event server
326
18:08:59 T:4568    INFO: JSONRPC Server: Successfully initialized
327
18:08:59 T:6556  NOTICE: Thread CEventServer start, auto delete: false
328
18:08:59 T:6556  NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
329
18:08:59 T:6556  NOTICE: UDP: Listening on port 9777
330
18:08:59 T:6548  NOTICE: Thread CTCPServer start, auto delete: false
331
18:08:59 T:4568   DEBUG: CLastfmScrobbler: Clearing session.
332
18:08:59 T:4568   DEBUG: CLibrefmScrobbler: Clearing session.
333
18:08:59 T:4568   DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
334
18:08:59 T:6564   DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
335
18:08:59 T:6564   DEBUG: CMusicDatabase::GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
336
18:08:59 T:6536  NOTICE: Thread CRssReader start, auto delete: false
337
18:08:59 T:6536   DEBUG: CurlFile::Open(0890F3C4) http://feeds.xbmc.org/xbmc
338
18:08:59 T:6536    INFO: XCURL::DllLibCurlGlobal::easy_aquire - Created session to http://feeds.xbmc.org
339
18:08:59 T:6580   DEBUG: CRemoteControl::Connect - connecting to: 127.0.0.1:24000 ...
340
18:08:59 T:6564   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
341
18:08:59 T:6564   DEBUG: CVideoDatabase::RunQuery took 4 ms for 10 items query: select * from movieview  ORDER BY dateAdded desc, idMovie desc LIMIT 10
342
18:08:59 T:6524  NOTICE: Thread Jobworker start, auto delete: true
343
18:08:59 T:6564   DEBUG: CVideoDatabase::RunQuery took 0 ms for 0 items query: select * from episodeview  ORDER BY dateAdded desc, idEpisode desc LIMIT 10
344
18:08:59 T:6564   DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview  ORDER BY dateAdded desc, idMVideo desc LIMIT 10
345
18:08:59 T:6564   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
346
18:08:59 T:6560   DEBUG: EPG - EPG::CEpg::Load - no database entries found for table 'Sport Mosaic'.
347
18:08:59 T:6560   DEBUG: EPG - EPG::CEpg::Load - no database entries found for table 'TV2 Freeview'.
348
18:08:59 T:6560  NOTICE: EPG::CEpgContainer::Start - EPG thread started
349
18:08:59 T:6560  NOTICE: PVRManager - starting up
350
18:08:59 T:2912  NOTICE: Thread EPG updater start, auto delete: false
351
18:08:59 T:1992  NOTICE: Thread PVR manager start, auto delete: false
352
18:08:59 T:3504  NOTICE: Thread PVR add-on updater start, auto delete: false
353
18:08:59 T:3504   DEBUG: PVR::CPVRClients::RegisterClient - registering add-on 'Tvheadend HTSP Client'
354
18:08:59 T:3504   DEBUG: PVR - PVR::CPVRClient::Create - creating PVR add-on instance 'Tvheadend HTSP Client'
355
18:08:59 T:3504   DEBUG: ADDON: Dll Initializing - Tvheadend HTSP Client
356
18:08:59 T:3504   DEBUG: SECTION:LoadDLL(C:\Program Files (x86)\XBMC\addons\pvr.hts\XBMC_Tvheadend_win32.dll)
357
18:08:59 T:3504   DEBUG: LoadLibraryExA called with flags: 
358
                                             - LOAD_WITH_ALTERED_SEARCH_PATH
359
18:08:59 T:3504   DEBUG: Previous line repeats 2 times.
360
18:08:59 T:3504   DEBUG: AddOnLog: Tvheadend HTSP Client: ADDON_Create - Creating Tvheadend PVR-Client
361
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'host'
362
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'user'
363
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'pass'
364
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'htsp_port'
365
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'http_port'
366
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'connect_timeout'
367
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'response_timeout'
368
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'transcode'
369
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'audio_codec'
370
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'video_codec'
371
18:08:59 T:3504   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::GetAddonSetting - add-on 'Tvheadend HTSP Client' requests setting 'resolution'
372
18:08:59 T:3504   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::OpenSocket - connecting to '192.168.1.76', port '9982'
373
18:08:59 T:3504   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::OpenSocket - connected to '192.168.1.76', port '9982'
374
18:08:59 T:3504  NOTICE: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - CHTSPConnection::SendGreeting - connection opened to 'HTS Tvheadend 3.5.244~gf5c5ffd-dirty', protocol v11 (timeshift enabled)
375
18:08:59 T:3504   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - CHTSPConnection::Auth - authenticating as user 'xbmc' with a password
376
18:08:59 T:1992   DEBUG: PVRManager - PVR::CPVRManager::Load - active clients found. continue to start
377
18:08:59 T:4568   DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
378
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::Load - loading all radio channel groups
379
18:08:59 T:1992   DEBUG: PVRChannelGroup - PVR::CPVRChannelGroup::Load - 3 channels loaded from the database for group 'All radio channels'
380
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRDatabase::Get - group 'All radio channels' loaded from the database
381
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups - 0 user defined radio channel groups fetched from the database
382
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups - 0 new user defined radio channel groups fetched from clients
383
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::PersistAll - persisting all changes in channel groups
384
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::Load - 1 radio channel groups loaded
385
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::Load - loading all TV channel groups
386
18:08:59 T:1992   DEBUG: PVRChannelGroup - PVR::CPVRChannelGroup::Load - 43 channels loaded from the database for group 'All TV channels'
387
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRDatabase::Get - group 'All TV channels' loaded from the database
388
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups - 0 user defined TV channel groups fetched from the database
389
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::LoadUserDefinedChannelGroups - 0 new user defined TV channel groups fetched from clients
390
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::PersistAll - persisting all changes in channel groups
391
18:08:59 T:1992   DEBUG: PVR - PVR::CPVRChannelGroups::Load - 1 TV channel groups loaded
392
18:08:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
393
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 362 on client 1
394
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 361 on client 1
395
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 363 on client 1
396
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 365 on client 1
397
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 367 on client 1
398
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 366 on client 1
399
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 369 on client 1
400
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 368 on client 1
401
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - added timer 371 on client 1
402
18:08:59 T:1992   DEBUG: CPVRRecordings - PVR::CPVRRecordings::Update - updating recordings
403
18:08:59 T:1992   DEBUG: PVRManager - PVR::CPVRManager::Process - entering main loop
404
18:08:59 T:716  NOTICE: Thread PVR GUI info updater start, auto delete: false
405
18:08:59 T:716   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unable to stat path
406
18:08:59 T:716   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unable to stat path'
407
18:08:59 T:4568   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
408
18:08:59 T:2912    INFO: EPG - EPG::CEpg::UpdateFromScraper - updating EPG for channel 'Sport Mosaic' from client '1'
409
18:08:59 T:716   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::GetDriveSpace - failed to get getDiskSpace
410
18:08:59 T:2912    INFO: EPG - EPG::CEpg::UpdateFromScraper - updating EPG for channel 'TV2 Freeview' from client '1'
411
18:08:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
412
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
413
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
414
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
415
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
416
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
417
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
418
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
419
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
420
18:08:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
421
18:08:59 T:4568   DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
422
18:09:00 T:6580   DEBUG: CRemoteControl::Connect - failed to connect
423
18:09:00 T:6580    INFO: CRemoteControl::Process - failed to connect to irss, will keep retrying every 5 seconds
424
18:09:00 T:6536   DEBUG: Got rss feed: http://feeds.xbmc.org/xbmc
425
18:09:00 T:6536   DEBUG: RSS feed encoding: UTF-8
426
18:09:00 T:6536   DEBUG: Parsed rss feed: http://feeds.xbmc.org/xbmc
427
18:09:00 T:6536   DEBUG: Thread CRssReader 6536 terminating
428
18:09:02 T:4568   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
429
18:09:03 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
430
18:09:06 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
431
18:09:08 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
432
18:09:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(PVR)
433
18:09:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(PVR)
434
18:09:08 T:4568   DEBUG: Activating window ID: 10601
435
18:09:08 T:4568   DEBUG: ------ Window Deinit (Home.xml) ------
436
18:09:08 T:4568   DEBUG: ------ Window Init (MyPVR.xml) ------
437
18:09:08 T:4568    INFO: Loading skin file: MyPVR.xml, load type: LOAD_EVERY_TIME
438
18:09:08 T:4568   DEBUG: CGUIMediaWindow::GetDirectory ()
439
18:09:08 T:4568   DEBUG:   ParentPath = []
440
18:09:08 T:4568   DEBUG: CGUIWindowPVRCommon - PVR::CGUIWindowPVRCommon::OnMessageFocus - focus set to window 'tv'
441
18:09:08 T:4568   DEBUG: CGUIWindowPVRChannels - PVR::CGUIWindowPVRChannels::UpdateData - update window 'tv'. set view to 11
442
18:09:08 T:4568   DEBUG: CGUIMediaWindow::GetDirectory (pvr://channels/tv/All TV channels/)
443
18:09:08 T:4568   DEBUG:   ParentPath = []
444
18:09:08 T:6564   DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/All TV channels)
445
18:09:08 T:4568   DEBUG: CGUIWindowPVRCommon - PVR::CGUIWindowPVRCommon::OnMessageFocus - focus set to window 'tv'
446
18:09:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating Setfocus(34)
447
18:09:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To Setfocus(34)
448
18:09:08 T:2412  NOTICE: Thread PVR Channel Window start, auto delete: false
449
18:09:08 T:4568   DEBUG: CGUIWindowPVRCommon - PVR::CGUIWindowPVRCommon::OnMessageFocus - focus set to window 'recordings'
450
18:09:08 T:4568   DEBUG: CGUIWindowPVRRecordings - PVR::CGUIWindowPVRRecordings::UpdateData - update window 'recordings'. set view to 13
451
18:09:08 T:4568   DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/)
452
18:09:08 T:4568   DEBUG:   ParentPath = []
453
18:09:08 T:6524   DEBUG: CPVRDirectory::GetDirectory(pvr://recordings)
454
18:09:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating Setfocus(13)
455
18:09:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To Setfocus(13)
456
18:09:08 T:3052  NOTICE: Thread Background Loader start, auto delete: false
457
18:09:08 T:3052   DEBUG: Thread Background Loader 3052 terminating
458
18:09:10 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
459
18:09:10 T:4568    INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY
460
18:09:10 T:4568   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
461
18:09:10 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action doubleclick
462
18:09:12 T:5324   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
463
18:09:13 T:5324   DEBUG: Suspended the Sink
464
18:09:15 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
465
18:09:15 T:4568   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
466
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers(pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr)
467
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
468
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
469
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
470
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
471
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
472
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
473
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
474
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
475
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
476
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
477
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
478
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
479
18:09:15 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
480
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
481
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
482
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
483
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
484
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
485
18:09:15 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
486
18:09:15 T:4568  NOTICE: DVDPlayer: Opening: pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
487
18:09:15 T:4568 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
488
18:09:15 T:4568   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
489
18:09:15 T:4568   DEBUG: DXVA - cheking samples array size using 842094158 render target
490
18:09:15 T:4568   DEBUG: DXVA - updated maximum samples count to 1
491
18:09:15 T:4568   DEBUG: DXVA - cheking samples array size using 842094169 render target
492
18:09:15 T:3520  NOTICE: Thread CDVDPlayer start, auto delete: false
493
18:09:15 T:3520  NOTICE: Creating InputStream
494
18:09:15 T:3520   DEBUG: PVRManager - PVR::CPVRManager::OpenRecordedStream - opening recorded stream ''
495
18:09:15 T:3520   DEBUG: XFILE::CPVRFile::Open - Recording has started on filename pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
496
18:09:15 T:3520   DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
497
18:09:15 T:3520  NOTICE: Creating Demuxer
498
18:09:15 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avutil-51.dll)
499
18:09:15 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53.dll)
500
18:09:15 T:4568   DEBUG: ------ Window Init (DialogBusy.xml) ------
501
18:09:15 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53.dll)
502
18:09:16 T:3520   DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [matroska,webm]
503
18:09:16 T:3520   DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
504
18:09:16 T:3520   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
505
18:09:16 T:3520    INFO: ffmpeg[DC0]: Input #0, matroska,webm, from 'pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr':
506
18:09:16 T:3520    INFO: ffmpeg[DC0]:   Metadata:
507
18:09:16 T:3520    INFO: ffmpeg[DC0]:     title           : The Story of Science
508
18:09:16 T:3520    INFO: ffmpeg[DC0]:     DATE_BROADCASTED: 2013-12-02 21:30:00
509
18:09:16 T:3520    INFO: ffmpeg[DC0]:     ORIGINAL_MEDIA_TYPE: TV
510
18:09:16 T:3520    INFO: ffmpeg[DC0]:     CONTENT_TYPE    : Education / Science / Factual topics
511
18:09:16 T:3520    INFO: ffmpeg[DC0]:     TVCHANNEL       : BBC Knowledge
512
18:09:16 T:3520    INFO: ffmpeg[DC0]:     SUMMARY         : How Did We Get Here?: Follow the story of how scientists came to explain the beauty and diversity of life on earth, and how its evolution is connected to the long and violent history of our planet.
513
18:09:16 T:3520    INFO: ffmpeg[DC0]:     SUMMARY-eng     : How Did We Get Here?: Follow the story of how scientists came to explain the beauty and diversity of life on earth, and how its evolution is connected to the long and violent history of our planet.
514
18:09:16 T:3520    INFO: ffmpeg[DC0]:   Duration: 00:39:36.60, start: 0.000000, bitrate: 3069 kb/s
515
18:09:16 T:3520    INFO: ffmpeg[DC0]:     Stream #0:0(eng): Video: mpeg2video (Main), yuv420p, 720x576 [SAR 64:45 DAR 16:9], 10000 kb/s, 25 fps, 25 tbr, 1k tbn, 50 tbc (default)
516
18:09:16 T:3520    INFO: ffmpeg[DC0]:     Stream #0:1(eng): Audio: mp2, 48000 Hz, stereo, s16, 160 kb/s (default)
517
18:09:16 T:3520    INFO: ffmpeg[DC0]:     Stream #0:2(eng): Subtitle: text (default)
518
18:09:16 T:3520  NOTICE: Opening video stream: 0 source: 256
519
18:09:16 T:3520  NOTICE: Creating video codec with codec id: 2
520
18:09:16 T:3520   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes DXVA:yes
521
18:09:16 T:3520   DEBUG: FactoryCodec - Video:  - Opening
522
18:09:16 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swscale-2.dll)
523
18:09:16 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0.dll)
524
18:09:16 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avfilter-2.dll)
525
18:09:16 T:3520  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
526
18:09:16 T:3520   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened
527
18:09:16 T:3520  NOTICE: Creating video thread
528
18:09:16 T:3520  NOTICE: Opening audio stream: 1 source: 256
529
18:09:16 T:3520  NOTICE: Finding audio codec for: 86016
530
18:09:16 T:3520   DEBUG: FactoryCodec - Audio: libmad - Opening
531
18:09:16 T:3520   DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/libmad.dll)
532
18:09:16 T:3264  NOTICE: Thread CDVDPlayerVideo start, auto delete: false
533
18:09:16 T:3264  NOTICE: running thread: video_thread
534
18:09:16 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
535
18:09:16 T:3520   DEBUG: FactoryCodec - Audio: libmad - Opened
536
18:09:16 T:3520  NOTICE: Creating audio thread
537
18:09:16 T:3520  NOTICE: Opening Subtitle stream: 2 source: 256
538
18:09:16 T:3520   DEBUG: FactoryCodec - Overlay: Text Subtitle Decoder - Opening
539
18:09:16 T:3520   DEBUG: FactoryCodec - Overlay: Text Subtitle Decoder - Opened
540
18:09:16 T:3520   DEBUG: CDVDPlayer::Process - Start position set to last stopped position: 575000
541
18:09:16 T:6880  NOTICE: Thread CDVDPlayerAudio start, auto delete: false
542
18:09:16 T:6880  NOTICE: running thread: CDVDPlayerAudio::Process()
543
18:09:16 T:3520   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 576160
544
18:09:16 T:3520   DEBUG: CDVDPlayer::Process - starting demuxer from: 575000
545
18:09:16 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 3
546
18:09:16 T:4568   DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr)
547
18:09:16 T:4568   DEBUG: CVideoDatabase::GetMovieId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMovie from movie where idFile=63
548
18:09:16 T:4568   DEBUG: CVideoDatabase::GetEpisodeId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idEpisode from episode where idFile=63
549
18:09:16 T:4568   DEBUG: CVideoDatabase::GetMusicVideoId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMVideo from musicvideo where idFile=63
550
18:09:16 T:4568   DEBUG: CVideoDatabase::GetMovieId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMovie from movie where idFile=63
551
18:09:16 T:4568   DEBUG: CVideoDatabase::GetEpisodeId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idEpisode from episode where idFile=63
552
18:09:16 T:4568   DEBUG: CVideoDatabase::GetMusicVideoId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMVideo from musicvideo where idFile=63
553
18:09:16 T:4568   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
554
18:09:16 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
555
18:09:16 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(576160000.000000, 1)
556
18:09:16 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(575753000.000000, 0)
557
18:09:16 T:3264    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
558
18:09:16 T:6880  NOTICE: Creating audio stream (codec id: 86016, channels: 2, sample rate: 48000, no pass-through)
559
18:09:16 T:6880    INFO: CSoftAE::MakeStream - AE_FMT_FLOAT, 48000, FL,FR
560
18:09:16 T:3264   DEBUG: DXVA - supports 'MPEG2 VLD'
561
18:09:16 T:3264   DEBUG: DXVA - supports 'MPEG2 IDCT'
562
18:09:16 T:3264   DEBUG: DXVA - supports E07EC519-e651-4cd6-ac84-1370cceec851
563
18:09:16 T:3264   DEBUG: DXVA - supports 'Intel VC-1 VLD'
564
18:09:16 T:3264   DEBUG: DXVA - supports 'Intel H.264 VLD, no FGT'
565
18:09:16 T:3264   DEBUG: DXVA - supports 'H.264 VLD, no FGT'
566
18:09:16 T:3264   DEBUG: DXVA - supports A74CCAE2-f466-45ae-86f5-ab8be8af8483
567
18:09:16 T:3264   DEBUG: DXVA - supports 'Windows Media Video 9 IDCT'
568
18:09:16 T:3264   DEBUG: DXVA - supports 'VC-1 IDCT'
569
18:09:16 T:3264   DEBUG: DXVA - supports 49761BEC-4b63-4349-a5ff-87ffdf088466
570
18:09:16 T:3264   DEBUG: DXVA - trying 'MPEG2 VLD'
571
18:09:16 T:3264   DEBUG: DXVA - source requires 1 references
572
18:09:16 T:3264   DEBUG: DXVA - config 0: bitstream type 1
573
18:09:16 T:3264   DEBUG: DXVA - config 1: bitstream type 1, encrypted
574
18:09:16 T:3264   DEBUG: DXVA - config 2: bitstream type 1, encrypted
575
18:09:16 T:3264   DEBUG: DXVA - allocating 7 surfaces
576
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
577
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
578
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
579
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
580
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
581
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
582
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
583
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
584
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
585
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
586
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
587
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
588
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] Failed to execute
589
18:09:16 T:3264   ERROR: ffmpeg[CC0]: [mpeg2video] hardware accelerator failed to decode picture
590
18:09:16 T:3264  NOTICE:  fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 405
591
18:09:16 T:3264   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x576. framerate: 25.00. format: DXVA
592
18:09:16 T:3264  NOTICE: Display resolution DESKTOP : 1366x768 @ 60.00 - Full Screen (16)
593
18:09:16 T:3264  NOTICE: D3D: rendering method forced to DXVA2 processor
594
18:09:16 T:4568   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
595
18:09:16 T:3264   DEBUG: DXVA - processor found Edge directed device
596
18:09:16 T:3264   DEBUG: DXVA - processor found Bob Device
597
18:09:16 T:3264   DEBUG: DXVA - processor found Progressive Device
598
18:09:16 T:3264   DEBUG: DXVA - processor selected Bob Device
599
18:09:16 T:3264   DEBUG: DXVA - processor requires 0 past frames and 0 future frames
600
18:09:16 T:5324   DEBUG: CSoftAE::Run - Sink was forgotten
601
18:09:16 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
602
18:09:16 T:5324    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
603
18:09:16 T:3264   DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 3: DXVA
604
18:09:16 T:4568   DEBUG: created video buffer 0
605
18:09:16 T:4568   DEBUG: created video buffer 1
606
18:09:16 T:4568   DEBUG: Activating window ID: 12005
607
18:09:16 T:4568   DEBUG: ------ Window Deinit (MyPVR.xml) ------
608
18:09:16 T:4568   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
609
18:09:16 T:4568    INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
610
18:09:16 T:5324   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394092
611
18:09:16 T:5324   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
612
18:09:16 T:5324   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
613
18:09:16 T:5324   DEBUG:   Audio Device    : Speakers (Realtek High Definition Audio)
614
18:09:16 T:5324   DEBUG:   Sample Rate     : 48000
615
18:09:16 T:5324   DEBUG:   Sample Format   : AE_FMT_FLOAT
616
18:09:16 T:5324   DEBUG:   Bits Per Sample : 32
617
18:09:16 T:5324   DEBUG:   Valid Bits/Samp : 32
618
18:09:16 T:5324   DEBUG:   Channel Count   : 2
619
18:09:16 T:5324   DEBUG:   Block Align     : 8
620
18:09:16 T:5324   DEBUG:   Avg. Bytes Sec  : 384000
621
18:09:16 T:5324   DEBUG:   Samples/Block   : 32
622
18:09:16 T:5324   DEBUG:   Format cBSize   : 22
623
18:09:16 T:5324   DEBUG:   Channel Layout  : FL,FR
624
18:09:16 T:5324   DEBUG:   Channel Mask    : 3
625
18:09:16 T:5324   DEBUG:   Frames          : 480
626
18:09:16 T:5324   DEBUG:   Frame Samples   : 960
627
18:09:16 T:5324   DEBUG:   Frame Size      : 8
628
18:09:16 T:5324   DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
629
18:09:16 T:5324   DEBUG:   Output Device : Speakers - Speakers (Realtek High Definition Audio)
630
18:09:16 T:5324   DEBUG:   Sample Rate   : 48000
631
18:09:16 T:5324   DEBUG:   Sample Format : AE_FMT_FLOAT
632
18:09:16 T:5324   DEBUG:   Channel Count : 2
633
18:09:16 T:5324   DEBUG:   Channel Layout: FL,FR
634
18:09:16 T:5324   DEBUG:   Frames        : 480
635
18:09:16 T:5324   DEBUG:   Frame Samples : 960
636
18:09:16 T:5324   DEBUG:   Frame Size    : 8
637
18:09:16 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
638
18:09:16 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
639
18:09:16 T:5324   DEBUG: AERemap: Downmix normalization is disabled
640
18:09:16 T:6880   DEBUG: Previous line repeats 3 times.
641
18:09:16 T:6880   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
642
18:09:16 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 1
643
18:09:17 T:5324   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
644
18:09:17 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 2
645
18:09:17 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 4
646
18:09:17 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:576160316.953384, should be:575777000.000000, error:-383316.953384
647
18:09:17 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 0
648
18:09:17 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
649
18:09:17 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
650
18:09:17 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
651
18:09:17 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
652
18:09:17 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
653
18:09:17 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:575918091.345965, should be:575777000.000000, error:-141091.345965
654
18:09:20 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
655
18:09:21 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:579780719.523423, should be:579769745.374253, error:-10974.149170
656
18:09:22 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
657
18:09:30 T:4568    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.xbmc.org (easy=04253C90, multi=01876B08)
658
18:09:46 T:6524   DEBUG: Thread Jobworker 6524 terminating (autodelete)
659
18:09:46 T:6564   DEBUG: Thread Jobworker 6564 terminating (autodelete)
660
18:09:46 T:6560   DEBUG: Thread Jobworker 6560 terminating (autodelete)
661
18:09:56 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:615153103.208586, should be:615142148.865423, error:-10954.343163
662
18:10:11 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:629529822.095540, should be:629519530.122228, error:-10291.973313
663
18:10:19 T:4568   DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 100
664
18:10:19 T:4568   DEBUG: CApplication::OnKey: alt-leftalt (4f0d4) pressed, action is
665
18:10:19 T:4568   DEBUG: CWinEventsWin32::WndProcWindow is active
666
18:10:19 T:4568   DEBUG: CWinEventsWin32::WndProc: Focus switched to process C:\Windows\explorer.exe
667
18:10:29 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:647909732.338486, should be:647892748.882636, error:-16983.455850
668
18:10:46 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:664642492.754116, should be:664925330.700105, error:282837.945988
669
18:10:46 T:3264   DEBUG: CPullupCorrection: pattern lost on diff 280000.000000
670
18:10:48 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:666929180.023485, should be:666954501.074407, error:25321.050923
671
18:10:51 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
672
18:11:02 T:4568   DEBUG: CJoystick::Initialize : No Joystick found
673
18:11:02 T:4568   DEBUG: CWinEventsWin32::WndProcWindow is active
674
18:11:02 T:4568   DEBUG: ------ Window Init (VideoOSD.xml) ------
675
18:11:02 T:4568    INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY
676
18:11:02 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
677
18:11:08 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
678
18:11:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating PlayerControl(SeekPercentage(29))
679
18:11:08 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To PlayerControl(SeekPercentage(29))
680
18:11:08 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 3
681
18:11:08 T:3520   DEBUG: demuxer seek to: 689214
682
18:11:08 T:3520   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 688960
683
18:11:08 T:3520   DEBUG: demuxer seek to: 689214, success
684
18:11:08 T:6880   DEBUG: CSoftAEStream::Flush
685
18:11:08 T:4568   DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
686
18:11:08 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
687
18:11:08 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
688
18:11:08 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
689
18:11:08 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
690
18:11:08 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
691
18:11:08 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
692
18:11:08 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
693
18:11:08 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
694
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:688960000.000000 to get to start point at 689214000.000000
695
18:11:08 T:3264    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
696
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688206000.000000 to get to start point at 689214000.000000
697
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688230000.000000 to get to start point at 689214000.000000
698
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688254000.000000 to get to start point at 689214000.000000
699
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688278000.000000 to get to start point at 689214000.000000
700
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688302000.000000 to get to start point at 689214000.000000
701
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688326000.000000 to get to start point at 689214000.000000
702
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:688840000.000000 to get to start point at 689214000.000000
703
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:688880000.000000 to get to start point at 689214000.000000
704
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:688920000.000000 to get to start point at 689214000.000000
705
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:689120000.000000 to get to start point at 689214000.000000
706
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:689000000.000000 to get to start point at 689214000.000000
707
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:689040000.000000 to get to start point at 689214000.000000
708
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688350000.000000 to get to start point at 689214000.000000
709
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688374000.000000 to get to start point at 689214000.000000
710
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688398000.000000 to get to start point at 689214000.000000
711
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688422000.000000 to get to start point at 689214000.000000
712
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688446000.000000 to get to start point at 689214000.000000
713
18:11:08 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 2
714
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688470000.000000 to get to start point at 689214000.000000
715
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:689080000.000000 to get to start point at 689214000.000000
716
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688494000.000000 to get to start point at 689214000.000000
717
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688518000.000000 to get to start point at 689214000.000000
718
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688542000.000000 to get to start point at 689214000.000000
719
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688566000.000000 to get to start point at 689214000.000000
720
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688590000.000000 to get to start point at 689214000.000000
721
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688614000.000000 to get to start point at 689214000.000000
722
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688638000.000000 to get to start point at 689214000.000000
723
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688662000.000000 to get to start point at 689214000.000000
724
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688686000.000000 to get to start point at 689214000.000000
725
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688710000.000000 to get to start point at 689214000.000000
726
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688734000.000000 to get to start point at 689214000.000000
727
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688758000.000000 to get to start point at 689214000.000000
728
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688782000.000000 to get to start point at 689214000.000000
729
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688806000.000000 to get to start point at 689214000.000000
730
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688830000.000000 to get to start point at 689214000.000000
731
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688854000.000000 to get to start point at 689214000.000000
732
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688878000.000000 to get to start point at 689214000.000000
733
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688902000.000000 to get to start point at 689214000.000000
734
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688926000.000000 to get to start point at 689214000.000000
735
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688950000.000000 to get to start point at 689214000.000000
736
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688974000.000000 to get to start point at 689214000.000000
737
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:688998000.000000 to get to start point at 689214000.000000
738
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689022000.000000 to get to start point at 689214000.000000
739
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689046000.000000 to get to start point at 689214000.000000
740
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689070000.000000 to get to start point at 689214000.000000
741
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689094000.000000 to get to start point at 689214000.000000
742
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689118000.000000 to get to start point at 689214000.000000
743
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689142000.000000 to get to start point at 689214000.000000
744
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689166000.000000 to get to start point at 689214000.000000
745
18:11:08 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:689190000.000000 to get to start point at 689214000.000000
746
18:11:08 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(689214000.000000, 0)
747
18:11:08 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 1
748
18:11:08 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 4
749
18:11:08 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(689280000.000000, 1)
750
18:11:08 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:689280179.305057, should be:689214000.000000, error:-66179.305057
751
18:11:08 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 0
752
18:11:08 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
753
18:11:08 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
754
18:11:08 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
755
18:11:08 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
756
18:11:08 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
757
18:11:08 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:689358133.494728, should be:689214000.000000, error:-144133.494728
758
18:11:10 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
759
18:11:10 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating PlayerControl(SeekPercentage(30))
760
18:11:10 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To PlayerControl(SeekPercentage(30))
761
18:11:10 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 3
762
18:11:10 T:3520   DEBUG: demuxer seek to: 712980
763
18:11:10 T:3520   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 711520
764
18:11:10 T:3520   DEBUG: demuxer seek to: 712980, success
765
18:11:10 T:6880   DEBUG: CSoftAEStream::Flush
766
18:11:10 T:4568   DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
767
18:11:10 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
768
18:11:10 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
769
18:11:10 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
770
18:11:10 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
771
18:11:10 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
772
18:11:10 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
773
18:11:10 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
774
18:11:10 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
775
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711520000.000000 to get to start point at 712980000.000000
776
18:11:10 T:3264    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
777
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711400000.000000 to get to start point at 712980000.000000
778
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711440000.000000 to get to start point at 712980000.000000
779
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711480000.000000 to get to start point at 712980000.000000
780
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711054000.000000 to get to start point at 712980000.000000
781
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711078000.000000 to get to start point at 712980000.000000
782
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711102000.000000 to get to start point at 712980000.000000
783
18:11:10 T:3264 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
784
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711126000.000000 to get to start point at 712980000.000000
785
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711150000.000000 to get to start point at 712980000.000000
786
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711174000.000000 to get to start point at 712980000.000000
787
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711680000.000000 to get to start point at 712980000.000000
788
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711560000.000000 to get to start point at 712980000.000000
789
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711600000.000000 to get to start point at 712980000.000000
790
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711640000.000000 to get to start point at 712980000.000000
791
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711198000.000000 to get to start point at 712980000.000000
792
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711222000.000000 to get to start point at 712980000.000000
793
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711246000.000000 to get to start point at 712980000.000000
794
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711270000.000000 to get to start point at 712980000.000000
795
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711294000.000000 to get to start point at 712980000.000000
796
18:11:10 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 2
797
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711318000.000000 to get to start point at 712980000.000000
798
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711840000.000000 to get to start point at 712980000.000000
799
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711720000.000000 to get to start point at 712980000.000000
800
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711760000.000000 to get to start point at 712980000.000000
801
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711800000.000000 to get to start point at 712980000.000000
802
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711342000.000000 to get to start point at 712980000.000000
803
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711366000.000000 to get to start point at 712980000.000000
804
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711390000.000000 to get to start point at 712980000.000000
805
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711414000.000000 to get to start point at 712980000.000000
806
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711438000.000000 to get to start point at 712980000.000000
807
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711462000.000000 to get to start point at 712980000.000000
808
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712000000.000000 to get to start point at 712980000.000000
809
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711880000.000000 to get to start point at 712980000.000000
810
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711486000.000000 to get to start point at 712980000.000000
811
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711510000.000000 to get to start point at 712980000.000000
812
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711534000.000000 to get to start point at 712980000.000000
813
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711558000.000000 to get to start point at 712980000.000000
814
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711582000.000000 to get to start point at 712980000.000000
815
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711606000.000000 to get to start point at 712980000.000000
816
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711920000.000000 to get to start point at 712980000.000000
817
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:711960000.000000 to get to start point at 712980000.000000
818
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712160000.000000 to get to start point at 712980000.000000
819
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712040000.000000 to get to start point at 712980000.000000
820
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711630000.000000 to get to start point at 712980000.000000
821
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711654000.000000 to get to start point at 712980000.000000
822
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711678000.000000 to get to start point at 712980000.000000
823
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711702000.000000 to get to start point at 712980000.000000
824
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711726000.000000 to get to start point at 712980000.000000
825
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711750000.000000 to get to start point at 712980000.000000
826
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712080000.000000 to get to start point at 712980000.000000
827
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712120000.000000 to get to start point at 712980000.000000
828
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712320000.000000 to get to start point at 712980000.000000
829
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712200000.000000 to get to start point at 712980000.000000
830
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712240000.000000 to get to start point at 712980000.000000
831
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711774000.000000 to get to start point at 712980000.000000
832
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711798000.000000 to get to start point at 712980000.000000
833
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711822000.000000 to get to start point at 712980000.000000
834
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711846000.000000 to get to start point at 712980000.000000
835
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711870000.000000 to get to start point at 712980000.000000
836
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711894000.000000 to get to start point at 712980000.000000
837
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712280000.000000 to get to start point at 712980000.000000
838
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712480000.000000 to get to start point at 712980000.000000
839
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712360000.000000 to get to start point at 712980000.000000
840
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711918000.000000 to get to start point at 712980000.000000
841
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711942000.000000 to get to start point at 712980000.000000
842
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711966000.000000 to get to start point at 712980000.000000
843
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:711990000.000000 to get to start point at 712980000.000000
844
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712014000.000000 to get to start point at 712980000.000000
845
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712038000.000000 to get to start point at 712980000.000000
846
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712400000.000000 to get to start point at 712980000.000000
847
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712440000.000000 to get to start point at 712980000.000000
848
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712640000.000000 to get to start point at 712980000.000000
849
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712520000.000000 to get to start point at 712980000.000000
850
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712062000.000000 to get to start point at 712980000.000000
851
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712086000.000000 to get to start point at 712980000.000000
852
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712110000.000000 to get to start point at 712980000.000000
853
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712134000.000000 to get to start point at 712980000.000000
854
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712158000.000000 to get to start point at 712980000.000000
855
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712182000.000000 to get to start point at 712980000.000000
856
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712560000.000000 to get to start point at 712980000.000000
857
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712600000.000000 to get to start point at 712980000.000000
858
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712800000.000000 to get to start point at 712980000.000000
859
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712680000.000000 to get to start point at 712980000.000000
860
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712206000.000000 to get to start point at 712980000.000000
861
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712230000.000000 to get to start point at 712980000.000000
862
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712254000.000000 to get to start point at 712980000.000000
863
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712278000.000000 to get to start point at 712980000.000000
864
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712302000.000000 to get to start point at 712980000.000000
865
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712326000.000000 to get to start point at 712980000.000000
866
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712720000.000000 to get to start point at 712980000.000000
867
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712760000.000000 to get to start point at 712980000.000000
868
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712960000.000000 to get to start point at 712980000.000000
869
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712350000.000000 to get to start point at 712980000.000000
870
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712374000.000000 to get to start point at 712980000.000000
871
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712398000.000000 to get to start point at 712980000.000000
872
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712422000.000000 to get to start point at 712980000.000000
873
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712446000.000000 to get to start point at 712980000.000000
874
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712470000.000000 to get to start point at 712980000.000000
875
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712494000.000000 to get to start point at 712980000.000000
876
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712840000.000000 to get to start point at 712980000.000000
877
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712880000.000000 to get to start point at 712980000.000000
878
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:712920000.000000 to get to start point at 712980000.000000
879
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712518000.000000 to get to start point at 712980000.000000
880
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712542000.000000 to get to start point at 712980000.000000
881
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712566000.000000 to get to start point at 712980000.000000
882
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712590000.000000 to get to start point at 712980000.000000
883
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712614000.000000 to get to start point at 712980000.000000
884
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712638000.000000 to get to start point at 712980000.000000
885
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712662000.000000 to get to start point at 712980000.000000
886
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712686000.000000 to get to start point at 712980000.000000
887
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712710000.000000 to get to start point at 712980000.000000
888
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712734000.000000 to get to start point at 712980000.000000
889
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712758000.000000 to get to start point at 712980000.000000
890
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712782000.000000 to get to start point at 712980000.000000
891
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712806000.000000 to get to start point at 712980000.000000
892
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712830000.000000 to get to start point at 712980000.000000
893
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712854000.000000 to get to start point at 712980000.000000
894
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712878000.000000 to get to start point at 712980000.000000
895
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712902000.000000 to get to start point at 712980000.000000
896
18:11:10 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712926000.000000 to get to start point at 712980000.000000
897
18:11:10 T:6880 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
898
18:11:11 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712950000.000000 to get to start point at 712980000.000000
899
18:11:11 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:712974000.000000 to get to start point at 712980000.000000
900
18:11:11 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(712998000.000000, 0)
901
18:11:11 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 1
902
18:11:11 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 0
903
18:11:11 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:712980655.036993, should be:712889283.510274, error:-91371.526719
904
18:11:11 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
905
18:11:11 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
906
18:11:11 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
907
18:11:11 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
908
18:11:11 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
909
18:11:11 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(713120000.000000, 1)
910
18:11:11 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:713080263.825959, should be:712897018.380278, error:-183245.445682
911
18:11:13 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
912
18:11:13 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating PlayerControl(SeekPercentage(32))
913
18:11:13 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To PlayerControl(SeekPercentage(32))
914
18:11:13 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 3
915
18:11:13 T:3520   DEBUG: demuxer seek to: 760512
916
18:11:13 T:3520   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 759040
917
18:11:13 T:3520   DEBUG: demuxer seek to: 760512, success
918
18:11:13 T:4568   DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
919
18:11:13 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
920
18:11:13 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:714809230.745082, should be:714771793.182631, error:-37437.562451
921
18:11:13 T:6880   DEBUG: CSoftAEStream::Flush
922
18:11:13 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
923
18:11:13 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
924
18:11:13 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
925
18:11:13 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
926
18:11:13 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
927
18:11:13 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
928
18:11:13 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
929
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759040000.000000 to get to start point at 760512000.000000
930
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:758920000.000000 to get to start point at 760512000.000000
931
18:11:13 T:3264    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
932
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:758960000.000000 to get to start point at 760512000.000000
933
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759000000.000000 to get to start point at 760512000.000000
934
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758334000.000000 to get to start point at 760512000.000000
935
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758358000.000000 to get to start point at 760512000.000000
936
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758382000.000000 to get to start point at 760512000.000000
937
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758406000.000000 to get to start point at 760512000.000000
938
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758430000.000000 to get to start point at 760512000.000000
939
18:11:13 T:3264 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
940
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758454000.000000 to get to start point at 760512000.000000
941
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759200000.000000 to get to start point at 760512000.000000
942
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759080000.000000 to get to start point at 760512000.000000
943
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759120000.000000 to get to start point at 760512000.000000
944
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759160000.000000 to get to start point at 760512000.000000
945
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759360000.000000 to get to start point at 760512000.000000
946
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759240000.000000 to get to start point at 760512000.000000
947
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758478000.000000 to get to start point at 760512000.000000
948
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758502000.000000 to get to start point at 760512000.000000
949
18:11:13 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 2
950
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758526000.000000 to get to start point at 760512000.000000
951
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758550000.000000 to get to start point at 760512000.000000
952
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758574000.000000 to get to start point at 760512000.000000
953
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758598000.000000 to get to start point at 760512000.000000
954
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759280000.000000 to get to start point at 760512000.000000
955
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759320000.000000 to get to start point at 760512000.000000
956
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758622000.000000 to get to start point at 760512000.000000
957
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758646000.000000 to get to start point at 760512000.000000
958
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758670000.000000 to get to start point at 760512000.000000
959
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758694000.000000 to get to start point at 760512000.000000
960
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758718000.000000 to get to start point at 760512000.000000
961
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758742000.000000 to get to start point at 760512000.000000
962
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759520000.000000 to get to start point at 760512000.000000
963
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759400000.000000 to get to start point at 760512000.000000
964
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759440000.000000 to get to start point at 760512000.000000
965
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759480000.000000 to get to start point at 760512000.000000
966
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758766000.000000 to get to start point at 760512000.000000
967
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758790000.000000 to get to start point at 760512000.000000
968
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758814000.000000 to get to start point at 760512000.000000
969
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758838000.000000 to get to start point at 760512000.000000
970
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758862000.000000 to get to start point at 760512000.000000
971
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758886000.000000 to get to start point at 760512000.000000
972
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759680000.000000 to get to start point at 760512000.000000
973
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759560000.000000 to get to start point at 760512000.000000
974
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759600000.000000 to get to start point at 760512000.000000
975
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759640000.000000 to get to start point at 760512000.000000
976
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759840000.000000 to get to start point at 760512000.000000
977
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758910000.000000 to get to start point at 760512000.000000
978
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758934000.000000 to get to start point at 760512000.000000
979
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758958000.000000 to get to start point at 760512000.000000
980
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:758982000.000000 to get to start point at 760512000.000000
981
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759006000.000000 to get to start point at 760512000.000000
982
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759030000.000000 to get to start point at 760512000.000000
983
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759720000.000000 to get to start point at 760512000.000000
984
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759760000.000000 to get to start point at 760512000.000000
985
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759800000.000000 to get to start point at 760512000.000000
986
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759054000.000000 to get to start point at 760512000.000000
987
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759078000.000000 to get to start point at 760512000.000000
988
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759102000.000000 to get to start point at 760512000.000000
989
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759126000.000000 to get to start point at 760512000.000000
990
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759150000.000000 to get to start point at 760512000.000000
991
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759174000.000000 to get to start point at 760512000.000000
992
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760000000.000000 to get to start point at 760512000.000000
993
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759880000.000000 to get to start point at 760512000.000000
994
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759920000.000000 to get to start point at 760512000.000000
995
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759198000.000000 to get to start point at 760512000.000000
996
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759222000.000000 to get to start point at 760512000.000000
997
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759246000.000000 to get to start point at 760512000.000000
998
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759270000.000000 to get to start point at 760512000.000000
999
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759294000.000000 to get to start point at 760512000.000000
1000
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759318000.000000 to get to start point at 760512000.000000
1001
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759342000.000000 to get to start point at 760512000.000000
1002
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:759960000.000000 to get to start point at 760512000.000000
1003
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760160000.000000 to get to start point at 760512000.000000
1004
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760040000.000000 to get to start point at 760512000.000000
1005
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760080000.000000 to get to start point at 760512000.000000
1006
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760120000.000000 to get to start point at 760512000.000000
1007
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759366000.000000 to get to start point at 760512000.000000
1008
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759390000.000000 to get to start point at 760512000.000000
1009
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759414000.000000 to get to start point at 760512000.000000
1010
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759438000.000000 to get to start point at 760512000.000000
1011
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759462000.000000 to get to start point at 760512000.000000
1012
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759486000.000000 to get to start point at 760512000.000000
1013
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760320000.000000 to get to start point at 760512000.000000
1014
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760200000.000000 to get to start point at 760512000.000000
1015
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760240000.000000 to get to start point at 760512000.000000
1016
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760280000.000000 to get to start point at 760512000.000000
1017
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759510000.000000 to get to start point at 760512000.000000
1018
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759534000.000000 to get to start point at 760512000.000000
1019
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759558000.000000 to get to start point at 760512000.000000
1020
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759582000.000000 to get to start point at 760512000.000000
1021
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759606000.000000 to get to start point at 760512000.000000
1022
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759630000.000000 to get to start point at 760512000.000000
1023
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760480000.000000 to get to start point at 760512000.000000
1024
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759654000.000000 to get to start point at 760512000.000000
1025
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759678000.000000 to get to start point at 760512000.000000
1026
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759702000.000000 to get to start point at 760512000.000000
1027
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759726000.000000 to get to start point at 760512000.000000
1028
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759750000.000000 to get to start point at 760512000.000000
1029
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759774000.000000 to get to start point at 760512000.000000
1030
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760360000.000000 to get to start point at 760512000.000000
1031
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760400000.000000 to get to start point at 760512000.000000
1032
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:760440000.000000 to get to start point at 760512000.000000
1033
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759798000.000000 to get to start point at 760512000.000000
1034
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759822000.000000 to get to start point at 760512000.000000
1035
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759846000.000000 to get to start point at 760512000.000000
1036
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759870000.000000 to get to start point at 760512000.000000
1037
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759894000.000000 to get to start point at 760512000.000000
1038
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759918000.000000 to get to start point at 760512000.000000
1039
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759942000.000000 to get to start point at 760512000.000000
1040
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759966000.000000 to get to start point at 760512000.000000
1041
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:759990000.000000 to get to start point at 760512000.000000
1042
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760014000.000000 to get to start point at 760512000.000000
1043
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760038000.000000 to get to start point at 760512000.000000
1044
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760062000.000000 to get to start point at 760512000.000000
1045
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760086000.000000 to get to start point at 760512000.000000
1046
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760110000.000000 to get to start point at 760512000.000000
1047
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760134000.000000 to get to start point at 760512000.000000
1048
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760158000.000000 to get to start point at 760512000.000000
1049
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760182000.000000 to get to start point at 760512000.000000
1050
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760206000.000000 to get to start point at 760512000.000000
1051
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760230000.000000 to get to start point at 760512000.000000
1052
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760254000.000000 to get to start point at 760512000.000000
1053
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760278000.000000 to get to start point at 760512000.000000
1054
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760302000.000000 to get to start point at 760512000.000000
1055
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760326000.000000 to get to start point at 760512000.000000
1056
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760350000.000000 to get to start point at 760512000.000000
1057
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760374000.000000 to get to start point at 760512000.000000
1058
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760398000.000000 to get to start point at 760512000.000000
1059
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760422000.000000 to get to start point at 760512000.000000
1060
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760446000.000000 to get to start point at 760512000.000000
1061
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760470000.000000 to get to start point at 760512000.000000
1062
18:11:13 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:760494000.000000 to get to start point at 760512000.000000
1063
18:11:13 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(760518000.000000, 0)
1064
18:11:13 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 1
1065
18:11:13 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 0
1066
18:11:13 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:760512543.952379, should be:760518000.000000, error:5456.047621
1067
18:11:13 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(760640000.000000, 1)
1068
18:11:13 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1069
18:11:13 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
1070
18:11:13 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
1071
18:11:13 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1072
18:11:13 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1073
18:11:13 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:760733540.610784, should be:760518000.000000, error:-215540.610784
1074
18:11:18 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
1075
18:11:20 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
1076
18:11:20 T:4568   DEBUG: Keyboard: scancode: 38, sym: 0134, unicode: 0000, modifier: 100
1077
18:11:20 T:4568   DEBUG: CApplication::OnKey: alt-leftalt (4f0d4) pressed, action is
1078
18:11:20 T:4568   DEBUG: ------ Window Deinit (VideoOSD.xml) ------
1079
18:11:20 T:4568   DEBUG: CWinEventsWin32::WndProcWindow is active
1080
18:11:20 T:4568   DEBUG: CWinEventsWin32::WndProc: Focus switched to process C:\Windows\explorer.exe
1081
18:11:50 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:797279164.456546, should be:797264616.626340, error:-14547.830206
1082
18:11:53 T:4568   DEBUG: CJoystick::Initialize : No Joystick found
1083
18:11:53 T:4568   DEBUG: CWinEventsWin32::WndProcWindow is active
1084
18:11:53 T:4568   DEBUG: ------ Window Init (VideoOSD.xml) ------
1085
18:11:53 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
1086
18:11:55 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1087
18:11:55 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating PlayerControl(SeekPercentage(34))
1088
18:11:55 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To PlayerControl(SeekPercentage(34))
1089
18:11:55 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 3
1090
18:11:55 T:3520   DEBUG: demuxer seek to: 808044
1091
18:11:55 T:3520   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 808000
1092
18:11:55 T:3520   DEBUG: demuxer seek to: 808044, success
1093
18:11:55 T:4568   DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
1094
18:11:55 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
1095
18:11:55 T:6880   DEBUG: CSoftAEStream::Flush
1096
18:11:55 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
1097
18:11:55 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
1098
18:11:55 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1099
18:11:55 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
1100
18:11:55 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
1101
18:11:55 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1102
18:11:55 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1103
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:808000000.000000 to get to start point at 808044000.000000
1104
18:11:55 T:3264    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
1105
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:807880000.000000 to get to start point at 808044000.000000
1106
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:807920000.000000 to get to start point at 808044000.000000
1107
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:807960000.000000 to get to start point at 808044000.000000
1108
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807678000.000000 to get to start point at 808044000.000000
1109
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807702000.000000 to get to start point at 808044000.000000
1110
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807726000.000000 to get to start point at 808044000.000000
1111
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807750000.000000 to get to start point at 808044000.000000
1112
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807774000.000000 to get to start point at 808044000.000000
1113
18:11:55 T:3264 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
1114
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807798000.000000 to get to start point at 808044000.000000
1115
18:11:55 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(808160000.000000, 1)
1116
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807822000.000000 to get to start point at 808044000.000000
1117
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807846000.000000 to get to start point at 808044000.000000
1118
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807870000.000000 to get to start point at 808044000.000000
1119
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807894000.000000 to get to start point at 808044000.000000
1120
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807918000.000000 to get to start point at 808044000.000000
1121
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807942000.000000 to get to start point at 808044000.000000
1122
18:11:55 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 2
1123
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807966000.000000 to get to start point at 808044000.000000
1124
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:807990000.000000 to get to start point at 808044000.000000
1125
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:808014000.000000 to get to start point at 808044000.000000
1126
18:11:55 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:808038000.000000 to get to start point at 808044000.000000
1127
18:11:55 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(808062000.000000, 0)
1128
18:11:56 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 1
1129
18:11:56 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 4
1130
18:11:56 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1131
18:11:56 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
1132
18:11:56 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
1133
18:11:56 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1134
18:11:56 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1135
18:11:56 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:808160377.325457, should be:808062000.000000, error:-98377.325457
1136
18:11:56 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 0
1137
18:11:56 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:808207163.442295, should be:808062000.000000, error:-145163.442295
1138
18:11:57 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1139
18:11:57 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating PlayerControl(SeekPercentage(35))
1140
18:11:57 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To PlayerControl(SeekPercentage(35))
1141
18:11:57 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 3
1142
18:11:57 T:3520   DEBUG: demuxer seek to: 831810
1143
18:11:57 T:3520   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 831520
1144
18:11:57 T:3520   DEBUG: demuxer seek to: 831810, success
1145
18:11:57 T:6880   DEBUG: CSoftAEStream::Flush
1146
18:11:57 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1147
18:11:57 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
1148
18:11:57 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
1149
18:11:57 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1150
18:11:57 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1151
18:11:57 T:4568   DEBUG: CAnnouncementManager - Announcement: OnSeek from xbmc
1152
18:11:57 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnSeek
1153
18:11:57 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
1154
18:11:57 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
1155
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831520000.000000 to get to start point at 831810000.000000
1156
18:11:57 T:3264    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
1157
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830790000.000000 to get to start point at 831810000.000000
1158
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830814000.000000 to get to start point at 831810000.000000
1159
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830838000.000000 to get to start point at 831810000.000000
1160
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830862000.000000 to get to start point at 831810000.000000
1161
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830886000.000000 to get to start point at 831810000.000000
1162
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830910000.000000 to get to start point at 831810000.000000
1163
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831400000.000000 to get to start point at 831810000.000000
1164
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831440000.000000 to get to start point at 831810000.000000
1165
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831480000.000000 to get to start point at 831810000.000000
1166
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831680000.000000 to get to start point at 831810000.000000
1167
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831560000.000000 to get to start point at 831810000.000000
1168
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831600000.000000 to get to start point at 831810000.000000
1169
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830934000.000000 to get to start point at 831810000.000000
1170
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830958000.000000 to get to start point at 831810000.000000
1171
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:830982000.000000 to get to start point at 831810000.000000
1172
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831006000.000000 to get to start point at 831810000.000000
1173
18:11:57 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 2
1174
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831030000.000000 to get to start point at 831810000.000000
1175
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831054000.000000 to get to start point at 831810000.000000
1176
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831078000.000000 to get to start point at 831810000.000000
1177
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:2 dts:831640000.000000 to get to start point at 831810000.000000
1178
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831102000.000000 to get to start point at 831810000.000000
1179
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831126000.000000 to get to start point at 831810000.000000
1180
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831150000.000000 to get to start point at 831810000.000000
1181
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831174000.000000 to get to start point at 831810000.000000
1182
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831198000.000000 to get to start point at 831810000.000000
1183
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831222000.000000 to get to start point at 831810000.000000
1184
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831246000.000000 to get to start point at 831810000.000000
1185
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831270000.000000 to get to start point at 831810000.000000
1186
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831294000.000000 to get to start point at 831810000.000000
1187
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831318000.000000 to get to start point at 831810000.000000
1188
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831342000.000000 to get to start point at 831810000.000000
1189
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831366000.000000 to get to start point at 831810000.000000
1190
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831390000.000000 to get to start point at 831810000.000000
1191
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831414000.000000 to get to start point at 831810000.000000
1192
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831438000.000000 to get to start point at 831810000.000000
1193
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831462000.000000 to get to start point at 831810000.000000
1194
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831486000.000000 to get to start point at 831810000.000000
1195
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831510000.000000 to get to start point at 831810000.000000
1196
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831534000.000000 to get to start point at 831810000.000000
1197
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831558000.000000 to get to start point at 831810000.000000
1198
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831582000.000000 to get to start point at 831810000.000000
1199
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831606000.000000 to get to start point at 831810000.000000
1200
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831630000.000000 to get to start point at 831810000.000000
1201
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831654000.000000 to get to start point at 831810000.000000
1202
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831678000.000000 to get to start point at 831810000.000000
1203
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831702000.000000 to get to start point at 831810000.000000
1204
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831726000.000000 to get to start point at 831810000.000000
1205
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831750000.000000 to get to start point at 831810000.000000
1206
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831774000.000000 to get to start point at 831810000.000000
1207
18:11:57 T:3520   DEBUG: CDVDPlayer::CheckPlayerInit - dropping packet type:1 dts:831798000.000000 to get to start point at 831810000.000000
1208
18:11:57 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(831822000.000000, 0)
1209
18:11:58 T:3520   DEBUG: CDVDPlayer::HandleMessages - player started 1
1210
18:11:58 T:3520   DEBUG: CDVDPlayer::SetCaching - caching state 0
1211
18:11:58 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(831840000.000000, 1)
1212
18:11:58 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:831840304.275248, should be:831822000.000000, error:-18304.275248
1213
18:11:58 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1214
18:11:58 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
1215
18:11:58 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
1216
18:11:58 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1217
18:11:58 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1218
18:11:58 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:831967517.826364, should be:831822000.000000, error:-145517.826364
1219
18:12:02 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
1220
18:12:04 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
1221
18:12:05 T:4568   DEBUG: ------ Window Deinit (VideoOSD.xml) ------
1222
18:12:22 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:856575346.876802, should be:856559938.691278, error:-15408.185524
1223
18:12:31 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:864699345.052683, should be:865013797.071351, error:314452.018667
1224
18:12:33 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:867123736.427603, should be:867144090.311602, error:20353.883998
1225
18:12:36 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
1226
18:12:51 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:885526998.977711, should be:885627464.010698, error:100465.032987
1227
18:13:10 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:904622806.305259, should be:904913134.856118, error:290328.550859
1228
18:13:12 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:906913352.195581, should be:906929938.672231, error:16586.476650
1229
18:13:16 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
1230
18:13:22 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:916956843.486602, should be:916938689.485154, error:-18154.001448
1231
18:13:59 T:2912    INFO: EPG - EPG::CEpg::UpdateFromScraper - updating EPG for channel 'Sport Mosaic' from client '1'
1232
18:13:59 T:2912    INFO: EPG - EPG::CEpg::UpdateFromScraper - updating EPG for channel 'TV2 Freeview' from client '1'
1233
18:13:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1234
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1235
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1236
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1237
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1238
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1239
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1240
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1241
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1242
18:13:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1243
18:14:02 T:6580   DEBUG: Thread CRemoteControl 6580 terminating
1244
18:15:15 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:1029692018.250334, should be:1029681931.875506, error:-10086.374828
1245
18:15:30 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:1044688492.508688, should be:1045005082.712759, error:316590.204071
1246
18:15:32 T:6880   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:1047118210.318191, should be:1047137740.543066, error:19530.224875
1247
18:15:34 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadMessage - failed to read packet (Unknown error)
1248
18:15:34 T:4128   DEBUG: AddOnLog: Tvheadend HTSP Client: reconnect triggered
1249
18:15:34 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: connection dropped, trying to restore
1250
18:15:34 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadMessage - not connected
1251
18:15:34 T:4556   DEBUG: POParser: PO file has Win Style Line Endings. Converted in memory to Linux LF for file: C:\Program Files (x86)\XBMC\addons\pvr.hts\resources\language\English\strings.po
1252
18:15:34 T:4556   DEBUG: POParser: loaded 15 strings from file C:\Program Files (x86)\XBMC\addons\pvr.hts\resources\language\English\strings.po
1253
18:15:34 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadMessage - not connected
1254
18:15:34 T:4556   ERROR: Previous line repeats 1 times.
1255
18:15:34 T:4556   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Disconnected from 'HTS Tvheadend''
1256
18:15:34 T:4556   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::OpenSocket - connecting to '192.168.1.76', port '9982'
1257
18:15:34 T:3520   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - No response received
1258
18:15:34 T:3520   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: No response received'
1259
18:15:34 T:4568   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
1260
18:15:34 T:4556   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::OpenSocket - connected to '192.168.1.76', port '9982'
1261
18:15:34 T:4556  NOTICE: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - CHTSPConnection::SendGreeting - connection opened to 'HTS Tvheadend 3.5.244~gf5c5ffd-dirty', protocol v11 (timeshift enabled)
1262
18:15:34 T:4556   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - CHTSPConnection::Auth - authenticating as user 'xbmc' with a password
1263
18:15:34 T:3520   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::ReadRecordedStream - failed to fileRead
1264
18:15:34 T:3520   ERROR: ffmpeg[DC0]: [matroska,webm] Read error
1265
18:15:34 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1266
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1267
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1268
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1269
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1270
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1271
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1272
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1273
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1274
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1275
18:15:34 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1276
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1277
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1278
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1279
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1280
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1281
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1282
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1283
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1284
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1285
18:15:34 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1286
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1287
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1288
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1289
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1290
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1291
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1292
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1293
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1294
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1295
18:15:34 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1296
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1297
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1298
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1299
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1300
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1301
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1302
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1303
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1304
18:15:34 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1305
18:15:34 T:4556   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Info Message : 'Reconnected to 'HTS Tvheadend''
1306
18:15:34 T:4556   DEBUG: AddOnLog: Tvheadend HTSP Client: connection restored
1307
18:15:35 T:3520   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unknown file id
1308
18:15:35 T:3520   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unknown file id'
1309
18:15:35 T:3520   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::ReadRecordedStream - failed to fileRead
1310
18:15:35 T:3520   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unknown file id
1311
18:15:35 T:3520   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unknown file id'
1312
18:15:35 T:3520   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::ReadRecordedStream - failed to fileRead
1313
18:15:35 T:3264   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
1314
18:15:41 T:4568   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
1315
18:15:41 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF
1316
18:15:41 T:6880 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
1317
18:15:42 T:5324   DEBUG: CSoftAEStream::GetFrame - Underrun
1318
18:15:42 T:6880   DEBUG: CSoftAEStream::Flush
1319
18:15:43 T:3264   DEBUG: Previous line repeats 3 times.
1320
18:15:43 T:3264 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
1321
18:15:43 T:3520    INFO: CDVDPlayer::Process - eof reading from demuxer
1322
18:15:43 T:3520  NOTICE: CDVDPlayer::OnExit()
1323
18:15:43 T:3520  NOTICE: DVDPlayer: eof, waiting for queues to empty
1324
18:15:43 T:3520  NOTICE: DVDPlayer: closing audio stream
1325
18:15:43 T:3520  NOTICE: Closing audio stream
1326
18:15:43 T:3520  NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
1327
18:15:43 T:6880   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
1328
18:15:43 T:6880   DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
1329
18:15:43 T:3520  NOTICE: Waiting for audio thread to exit
1330
18:15:43 T:6880  NOTICE: thread end: CDVDPlayerAudio::OnExit()
1331
18:15:43 T:3520  NOTICE: Closing audio device
1332
18:15:43 T:6880   DEBUG: Thread CDVDPlayerAudio 6880 terminating
1333
18:15:43 T:3520   DEBUG: CSoftAEStream::~CSoftAEStream - Destructed
1334
18:15:43 T:3520  NOTICE: Deleting audio codec
1335
18:15:43 T:3520  NOTICE: DVDPlayer: closing video stream
1336
18:15:43 T:3520  NOTICE: Closing video stream
1337
18:15:43 T:3520  NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
1338
18:15:43 T:3264   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
1339
18:15:43 T:3520  NOTICE: waiting for video thread to exit
1340
18:15:43 T:3264   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
1341
18:15:43 T:3264  NOTICE: thread end: video_thread
1342
18:15:43 T:3264   DEBUG: Thread CDVDPlayerVideo 3264 terminating
1343
18:15:43 T:3520  NOTICE: deleting video codec
1344
18:15:43 T:3520  NOTICE: DVDPlayer: closing subtitle stream
1345
18:15:43 T:3520  NOTICE: Closing subtitle stream
1346
18:15:43 T:3520  NOTICE: CDVDPlayer::OnExit() deleting demuxer
1347
18:15:43 T:3520  NOTICE: CDVDPlayer::OnExit() deleting input stream
1348
18:15:43 T:3520   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unknown file id
1349
18:15:43 T:3520   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unknown file id'
1350
18:15:43 T:4568   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
1351
18:15:43 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1352
18:15:43 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats Incompatible due to different :Sample Rates
1353
18:15:43 T:5324    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
1354
18:15:43 T:5324   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
1355
18:15:43 T:3520   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::CloseRecordedStream - failed to fileClose
1356
18:15:43 T:3520   DEBUG: CDVDInputStreamPVRManager::Close - stream closed
1357
18:15:43 T:3520   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
1358
18:15:43 T:3520   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
1359
18:15:43 T:3520   DEBUG: Thread CDVDPlayer 3520 terminating
1360
18:15:43 T:4568   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
1361
18:15:43 T:4568   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
1362
18:15:43 T:4568   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
1363
18:15:43 T:4568   DEBUG: ------ Window Init (MyPVR.xml) ------
1364
18:15:43 T:4568    INFO: Loading skin file: MyPVR.xml, load type: LOAD_EVERY_TIME
1365
18:15:43 T:4568   DEBUG: Using already stored xml root node for C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\MyPVR.xml
1366
18:15:43 T:5324   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394092
1367
18:15:43 T:5324   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
1368
18:15:43 T:5324   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
1369
18:15:43 T:5324   DEBUG:   Audio Device    : Speakers (Realtek High Definition Audio)
1370
18:15:43 T:5324   DEBUG:   Sample Rate     : 44100
1371
18:15:43 T:5324   DEBUG:   Sample Format   : AE_FMT_FLOAT
1372
18:15:43 T:5324   DEBUG:   Bits Per Sample : 32
1373
18:15:43 T:5324   DEBUG:   Valid Bits/Samp : 32
1374
18:15:43 T:5324   DEBUG:   Channel Count   : 2
1375
18:15:43 T:5324   DEBUG:   Block Align     : 8
1376
18:15:43 T:5324   DEBUG:   Avg. Bytes Sec  : 352800
1377
18:15:43 T:5324   DEBUG:   Samples/Block   : 32
1378
18:15:43 T:5324   DEBUG:   Format cBSize   : 22
1379
18:15:43 T:5324   DEBUG:   Channel Layout  : FL,FR
1380
18:15:43 T:5324   DEBUG:   Channel Mask    : 3
1381
18:15:43 T:5324   DEBUG:   Frames          : 441
1382
18:15:43 T:5324   DEBUG:   Frame Samples   : 882
1383
18:15:43 T:5324   DEBUG:   Frame Size      : 8
1384
18:15:43 T:5324   DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
1385
18:15:43 T:5324   DEBUG:   Output Device : Speakers - Speakers (Realtek High Definition Audio)
1386
18:15:43 T:5324   DEBUG:   Sample Rate   : 44100
1387
18:15:43 T:5324   DEBUG:   Sample Format : AE_FMT_FLOAT
1388
18:15:43 T:5324   DEBUG:   Channel Count : 2
1389
18:15:43 T:5324   DEBUG:   Channel Layout: FL,FR
1390
18:15:43 T:5324   DEBUG:   Frames        : 441
1391
18:15:43 T:5324   DEBUG:   Frame Samples : 882
1392
18:15:43 T:5324   DEBUG:   Frame Size    : 8
1393
18:15:43 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1394
18:15:43 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
1395
18:15:43 T:5324   DEBUG: AERemap: Downmix normalization is disabled
1396
18:15:43 T:4568   DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/)
1397
18:15:43 T:4568   DEBUG:   ParentPath = [pvr://recordings/]
1398
18:15:43 T:4568   DEBUG: CPVRDirectory::GetDirectory(pvr://recordings)
1399
18:15:43 T:5324   DEBUG: AERemap: Downmix normalization is disabled
1400
18:15:43 T:4568   DEBUG: Previous line repeats 1 times.
1401
18:15:43 T:4568   DEBUG: CGUIWindowPVRCommon - PVR::CGUIWindowPVRCommon::OnMessageFocus - focus set to window 'recordings'
1402
18:15:43 T:4568   DEBUG: CGUIWindowPVRRecordings - PVR::CGUIWindowPVRRecordings::UpdateData - update window 'recordings'. set view to 13
1403
18:15:43 T:4568   DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/)
1404
18:15:43 T:4568   DEBUG:   ParentPath = [pvr://recordings/]
1405
18:15:43 T:5008  NOTICE: Thread Jobworker start, auto delete: true
1406
18:15:43 T:5008   DEBUG: CPVRDirectory::GetDirectory(pvr://recordings)
1407
18:15:43 T:3008  NOTICE: Thread Background Loader start, auto delete: false
1408
18:15:43 T:4568  NOTICE: CDVDPlayer::CloseFile()
1409
18:15:43 T:4568 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
1410
18:15:43 T:4568  NOTICE: DVDPlayer: waiting for threads to exit
1411
18:15:43 T:4568  NOTICE: DVDPlayer: finished waiting
1412
18:15:43 T:3008   DEBUG: Thread Background Loader 3008 terminating
1413
18:15:43 T:5324   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
1414
18:15:43 T:4568   DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib.dll)
1415
18:15:43 T:5008   DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
1416
18:15:46 T:4568   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
1417
18:15:46 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
1418
18:15:53 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
1419
18:15:55 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1420
18:15:55 T:4568   DEBUG: ------ Window Init (DialogContextMenu.xml) ------
1421
18:15:55 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
1422
18:15:55 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action doubleclick
1423
18:15:56 T:5324   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
1424
18:15:56 T:5324   DEBUG: Suspended the Sink
1425
18:15:58 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1426
18:15:58 T:4568   DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
1427
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers(pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr)
1428
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
1429
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
1430
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
1431
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp
1432
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
1433
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
1434
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
1435
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
1436
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
1437
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
1438
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
1439
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
1440
18:15:58 T:4568   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio
1441
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
1442
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
1443
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
1444
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
1445
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
1446
18:15:58 T:4568   DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
1447
18:15:58 T:4568  NOTICE: DVDPlayer: Opening: pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
1448
18:15:58 T:4568 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
1449
18:15:58 T:4568   DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
1450
18:15:58 T:4568   DEBUG: DXVA - cheking samples array size using 842094158 render target
1451
18:15:58 T:4568   DEBUG: DXVA - updated maximum samples count to 1
1452
18:15:58 T:4568   DEBUG: DXVA - cheking samples array size using 842094169 render target
1453
18:15:58 T:1220  NOTICE: Thread CDVDPlayer start, auto delete: false
1454
18:15:58 T:1220  NOTICE: Creating InputStream
1455
18:15:58 T:1220   DEBUG: PVRManager - PVR::CPVRManager::OpenRecordedStream - opening recorded stream ''
1456
18:15:58 T:1220   DEBUG: XFILE::CPVRFile::Open - Recording has started on filename pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
1457
18:15:58 T:1220   DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
1458
18:15:58 T:1220  NOTICE: Creating Demuxer
1459
18:15:58 T:4568   DEBUG: ------ Window Init (DialogBusy.xml) ------
1460
18:15:58 T:1220   DEBUG: CDVDDemuxFFmpeg::Open - probing detected format [matroska,webm]
1461
18:15:58 T:1220   DEBUG: CDVDDemuxFFmpeg::Open - avformat_find_stream_info starting
1462
18:15:58 T:1220   DEBUG: CDVDDemuxFFmpeg::Open - av_find_stream_info finished
1463
18:15:58 T:1220    INFO: ffmpeg[4C4]: Input #0, matroska,webm, from 'pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr':
1464
18:15:58 T:1220    INFO: ffmpeg[4C4]:   Metadata:
1465
18:15:58 T:1220    INFO: ffmpeg[4C4]:     title           : The Story of Science
1466
18:15:58 T:1220    INFO: ffmpeg[4C4]:     DATE_BROADCASTED: 2013-12-02 21:30:00
1467
18:15:58 T:1220    INFO: ffmpeg[4C4]:     ORIGINAL_MEDIA_TYPE: TV
1468
18:15:58 T:1220    INFO: ffmpeg[4C4]:     CONTENT_TYPE    : Education / Science / Factual topics
1469
18:15:58 T:1220    INFO: ffmpeg[4C4]:     TVCHANNEL       : BBC Knowledge
1470
18:15:58 T:1220    INFO: ffmpeg[4C4]:     SUMMARY         : How Did We Get Here?: Follow the story of how scientists came to explain the beauty and diversity of life on earth, and how its evolution is connected to the long and violent history of our planet.
1471
18:15:58 T:1220    INFO: ffmpeg[4C4]:     SUMMARY-eng     : How Did We Get Here?: Follow the story of how scientists came to explain the beauty and diversity of life on earth, and how its evolution is connected to the long and violent history of our planet.
1472
18:15:58 T:1220    INFO: ffmpeg[4C4]:   Duration: 00:39:36.60, start: 0.000000, bitrate: 3069 kb/s
1473
18:15:58 T:1220    INFO: ffmpeg[4C4]:     Stream #0:0(eng): Video: mpeg2video (Main), yuv420p, 720x576 [SAR 64:45 DAR 16:9], 10000 kb/s, 25 fps, 25 tbr, 1k tbn, 50 tbc (default)
1474
18:15:58 T:1220    INFO: ffmpeg[4C4]:     Stream #0:1(eng): Audio: mp2, 48000 Hz, stereo, s16, 160 kb/s (default)
1475
18:15:58 T:1220    INFO: ffmpeg[4C4]:     Stream #0:2(eng): Subtitle: text (default)
1476
18:15:58 T:1220  NOTICE: Opening video stream: 0 source: 256
1477
18:15:58 T:1220  NOTICE: Creating video codec with codec id: 2
1478
18:15:58 T:1220   DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:yes DXVA:yes
1479
18:15:58 T:1220   DEBUG: FactoryCodec - Video:  - Opening
1480
18:15:58 T:1220  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
1481
18:15:58 T:1220   DEBUG: FactoryCodec - Video: ff-mpeg2video - Opened
1482
18:15:58 T:1220  NOTICE: Creating video thread
1483
18:15:58 T:1220  NOTICE: Opening audio stream: 1 source: 256
1484
18:15:58 T:1220  NOTICE: Finding audio codec for: 86016
1485
18:15:58 T:1220   DEBUG: FactoryCodec - Audio: libmad - Opening
1486
18:15:58 T:1220   DEBUG: FactoryCodec - Audio: libmad - Opened
1487
18:15:58 T:1220  NOTICE: Creating audio thread
1488
18:15:58 T:1220  NOTICE: Opening Subtitle stream: 2 source: 256
1489
18:15:58 T:1220   DEBUG: FactoryCodec - Overlay: Text Subtitle Decoder - Opening
1490
18:15:58 T:1220   DEBUG: FactoryCodec - Overlay: Text Subtitle Decoder - Opened
1491
18:15:58 T:6908  NOTICE: Thread CDVDPlayerVideo start, auto delete: false
1492
18:15:58 T:1220   DEBUG: CDVDPlayer::Process - Start position set to last stopped position: 575000
1493
18:15:58 T:6908  NOTICE: running thread: video_thread
1494
18:15:58 T:4272  NOTICE: Thread CDVDPlayerAudio start, auto delete: false
1495
18:15:58 T:6908   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
1496
18:15:58 T:4272  NOTICE: running thread: CDVDPlayerAudio::Process()
1497
18:15:58 T:1220   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 576160
1498
18:15:58 T:1220   DEBUG: CDVDPlayer::Process - starting demuxer from: 575000
1499
18:15:58 T:1220   DEBUG: CDVDPlayer::SetCaching - caching state 3
1500
18:15:59 T:4568   DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr)
1501
18:15:59 T:4568   DEBUG: CVideoDatabase::GetMovieId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMovie from movie where idFile=63
1502
18:15:59 T:4568   DEBUG: CVideoDatabase::GetEpisodeId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idEpisode from episode where idFile=63
1503
18:15:59 T:4568   DEBUG: CVideoDatabase::GetMusicVideoId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMVideo from musicvideo where idFile=63
1504
18:15:59 T:4568   DEBUG: CVideoDatabase::GetMovieId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMovie from movie where idFile=63
1505
18:15:59 T:4568   DEBUG: CVideoDatabase::GetEpisodeId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idEpisode from episode where idFile=63
1506
18:15:59 T:4568   DEBUG: CVideoDatabase::GetMusicVideoId (pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr), query = select idMVideo from musicvideo where idFile=63
1507
18:15:59 T:4568   DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
1508
18:15:59 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
1509
18:15:59 T:4568   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
1510
18:15:59 T:6908   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(576160000.000000, 1)
1511
18:15:59 T:6908    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
1512
18:15:59 T:4272   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(575753000.000000, 0)
1513
18:15:59 T:6908   DEBUG: DXVA - supports 'MPEG2 VLD'
1514
18:15:59 T:6908   DEBUG: DXVA - supports 'MPEG2 IDCT'
1515
18:15:59 T:6908   DEBUG: DXVA - supports E07EC519-e651-4cd6-ac84-1370cceec851
1516
18:15:59 T:4272  NOTICE: Creating audio stream (codec id: 86016, channels: 2, sample rate: 48000, no pass-through)
1517
18:15:59 T:4272    INFO: CSoftAE::MakeStream - AE_FMT_FLOAT, 48000, FL,FR
1518
18:15:59 T:6908   DEBUG: DXVA - supports 'Intel VC-1 VLD'
1519
18:15:59 T:6908   DEBUG: DXVA - supports 'Intel H.264 VLD, no FGT'
1520
18:15:59 T:6908   DEBUG: DXVA - supports 'H.264 VLD, no FGT'
1521
18:15:59 T:6908   DEBUG: DXVA - supports A74CCAE2-f466-45ae-86f5-ab8be8af8483
1522
18:15:59 T:6908   DEBUG: DXVA - supports 'Windows Media Video 9 IDCT'
1523
18:15:59 T:6908   DEBUG: DXVA - supports 'VC-1 IDCT'
1524
18:15:59 T:6908   DEBUG: DXVA - supports 49761BEC-4b63-4349-a5ff-87ffdf088466
1525
18:15:59 T:6908   DEBUG: DXVA - trying 'MPEG2 VLD'
1526
18:15:59 T:6908   DEBUG: DXVA - source requires 1 references
1527
18:15:59 T:6908   DEBUG: DXVA - config 0: bitstream type 1
1528
18:15:59 T:6908   DEBUG: DXVA - config 1: bitstream type 1, encrypted
1529
18:15:59 T:6908   DEBUG: DXVA - config 2: bitstream type 1, encrypted
1530
18:15:59 T:6908   DEBUG: DXVA - allocating 7 surfaces
1531
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1532
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1533
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1534
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1535
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1536
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1537
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1538
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1539
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1540
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1541
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1542
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1543
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] Failed to execute
1544
18:15:59 T:6908   ERROR: ffmpeg[1AFC]: [mpeg2video] hardware accelerator failed to decode picture
1545
18:15:59 T:6908  NOTICE:  fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 405
1546
18:15:59 T:6908   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 720x576. framerate: 25.00. format: DXVA
1547
18:15:59 T:6908  NOTICE: Display resolution DESKTOP : 1366x768 @ 60.00 - Full Screen (16)
1548
18:15:59 T:6908  NOTICE: D3D: rendering method forced to DXVA2 processor
1549
18:15:59 T:6908   DEBUG: DXVA - processor found Edge directed device
1550
18:15:59 T:6908   DEBUG: DXVA - processor found Bob Device
1551
18:15:59 T:6908   DEBUG: DXVA - processor found Progressive Device
1552
18:15:59 T:6908   DEBUG: DXVA - processor selected Bob Device
1553
18:15:59 T:6908   DEBUG: DXVA - processor requires 0 past frames and 0 future frames
1554
18:15:59 T:6908   DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 3: DXVA
1555
18:15:59 T:4568   DEBUG: Activating window ID: 12005
1556
18:15:59 T:4568   DEBUG: ------ Window Deinit (MyPVR.xml) ------
1557
18:15:59 T:4568   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
1558
18:15:59 T:5324   DEBUG: CSoftAE::Run - Sink was forgotten
1559
18:15:59 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1560
18:15:59 T:5324    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
1561
18:15:59 T:5324   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394092
1562
18:15:59 T:5324   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
1563
18:15:59 T:5324   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
1564
18:15:59 T:5324   DEBUG:   Audio Device    : Speakers (Realtek High Definition Audio)
1565
18:15:59 T:5324   DEBUG:   Sample Rate     : 48000
1566
18:15:59 T:5324   DEBUG:   Sample Format   : AE_FMT_FLOAT
1567
18:15:59 T:5324   DEBUG:   Bits Per Sample : 32
1568
18:15:59 T:5324   DEBUG:   Valid Bits/Samp : 32
1569
18:15:59 T:5324   DEBUG:   Channel Count   : 2
1570
18:15:59 T:5324   DEBUG:   Block Align     : 8
1571
18:15:59 T:5324   DEBUG:   Avg. Bytes Sec  : 384000
1572
18:15:59 T:5324   DEBUG:   Samples/Block   : 32
1573
18:15:59 T:5324   DEBUG:   Format cBSize   : 22
1574
18:15:59 T:5324   DEBUG:   Channel Layout  : FL,FR
1575
18:15:59 T:5324   DEBUG:   Channel Mask    : 3
1576
18:15:59 T:5324   DEBUG:   Frames          : 480
1577
18:15:59 T:5324   DEBUG:   Frame Samples   : 960
1578
18:15:59 T:5324   DEBUG:   Frame Size      : 8
1579
18:15:59 T:5324   DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
1580
18:15:59 T:5324   DEBUG:   Output Device : Speakers - Speakers (Realtek High Definition Audio)
1581
18:15:59 T:5324   DEBUG:   Sample Rate   : 48000
1582
18:15:59 T:5324   DEBUG:   Sample Format : AE_FMT_FLOAT
1583
18:15:59 T:5324   DEBUG:   Channel Count : 2
1584
18:15:59 T:5324   DEBUG:   Channel Layout: FL,FR
1585
18:15:59 T:5324   DEBUG:   Frames        : 480
1586
18:15:59 T:5324   DEBUG:   Frame Samples : 960
1587
18:15:59 T:5324   DEBUG:   Frame Size    : 8
1588
18:15:59 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1589
18:15:59 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1590
18:15:59 T:5324   DEBUG: AERemap: Downmix normalization is disabled
1591
18:15:59 T:4272   DEBUG: Previous line repeats 3 times.
1592
18:15:59 T:4272   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
1593
18:15:59 T:4568   DEBUG: created video buffer 0
1594
18:15:59 T:4568   DEBUG: created video buffer 1
1595
18:15:59 T:1220   DEBUG: CDVDPlayer::HandleMessages - player started 1
1596
18:15:59 T:1220   DEBUG: CDVDPlayer::HandleMessages - player started 2
1597
18:15:59 T:1220   DEBUG: CDVDPlayer::SetCaching - caching state 4
1598
18:15:59 T:5324   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
1599
18:15:59 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1600
18:15:59 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats compatible - reusing existing sink
1601
18:15:59 T:5324    INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz
1602
18:15:59 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1603
18:15:59 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3840
1604
18:15:59 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:576198104.437649, should be:575777000.000000, error:-421104.437649
1605
18:15:59 T:1220   DEBUG: CDVDPlayer::SetCaching - caching state 0
1606
18:15:59 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:576057891.333287, should be:575939098.133673, error:-118793.199614
1607
18:16:01 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:578052748.561258, should be:578017775.638964, error:-34972.922294
1608
18:16:02 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
1609
18:16:04 T:6908   DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00, frameduration: 40000.000000
1610
18:16:29 T:5008   DEBUG: Thread Jobworker 5008 terminating (autodelete)
1611
18:16:30 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:607026547.097463, should be:607016283.265479, error:-10263.831983
1612
18:16:39 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:615279055.732192, should be:615266637.420659, error:-12418.311532
1613
18:16:51 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:627531245.198394, should be:627519048.283853, error:-12196.914540
1614
18:16:57 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadMessage - failed to read packet (Unknown error)
1615
18:16:57 T:4128   DEBUG: AddOnLog: Tvheadend HTSP Client: reconnect triggered
1616
18:16:57 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: connection dropped, trying to restore
1617
18:16:57 T:4128   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadMessage - not connected
1618
18:16:57 T:6784   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Disconnected from 'HTS Tvheadend''
1619
18:16:57 T:6784   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::OpenSocket - connecting to '192.168.1.76', port '9982'
1620
18:16:57 T:1220   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - No response received
1621
18:16:57 T:1220   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: No response received'
1622
18:16:57 T:4568   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
1623
18:16:59 T:6784   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::OpenSocket - connected to '192.168.1.76', port '9982'
1624
18:16:59 T:6784  NOTICE: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - CHTSPConnection::SendGreeting - connection opened to 'HTS Tvheadend 3.5.244~gf5c5ffd-dirty', protocol v11 (timeshift enabled)
1625
18:16:59 T:6784   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPConnection - CHTSPConnection::Auth - authenticating as user 'xbmc' with a password
1626
18:16:59 T:1220   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::ReadRecordedStream - failed to fileRead
1627
18:16:59 T:1220   ERROR: ffmpeg[4C4]: [matroska,webm] Read error
1628
18:16:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1629
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1630
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1631
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1632
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1633
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1634
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1635
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1636
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1637
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1638
18:16:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1639
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1640
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1641
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1642
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1643
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1644
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1645
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1646
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1647
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1648
18:16:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1649
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1650
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1651
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1652
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1653
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1654
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1655
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1656
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1657
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1658
18:16:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1659
18:16:59 T:1220   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unknown file id
1660
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1661
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1662
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1663
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1664
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1665
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1666
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1667
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1668
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1669
18:16:59 T:1992   DEBUG: CPVRTimers - PVR::CPVRTimers::Update - updating timers
1670
18:16:59 T:6784   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Info Message : 'Reconnected to 'HTS Tvheadend''
1671
18:16:59 T:1220   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unknown file id'
1672
18:16:59 T:6784   DEBUG: AddOnLog: Tvheadend HTSP Client: connection restored
1673
18:16:59 T:1220   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::ReadRecordedStream - failed to fileRead
1674
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 362 on client 1
1675
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 361 on client 1
1676
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 363 on client 1
1677
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 365 on client 1
1678
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 367 on client 1
1679
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 366 on client 1
1680
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 369 on client 1
1681
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 368 on client 1
1682
18:16:59 T:1992   DEBUG: PVRTimers - PVR::CPVRTimers::UpdateEntries - updated timer 371 on client 1
1683
18:16:59 T:1220   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unknown file id
1684
18:16:59 T:1220   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unknown file id'
1685
18:16:59 T:1220   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::ReadRecordedStream - failed to fileRead
1686
18:17:03 T:4272   DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:639779306.857442, should be:639769130.478502, error:-10176.378940
1687
18:17:04 T:4568   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
1688
18:17:04 T:4272   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_EOF
1689
18:17:04 T:4272 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
1690
18:17:05 T:5324   DEBUG: CSoftAEStream::GetFrame - Underrun
1691
18:17:05 T:4272   DEBUG: CSoftAEStream::Flush
1692
18:17:05 T:6908   DEBUG: Previous line repeats 1 times.
1693
18:17:05 T:6908 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
1694
18:17:05 T:1220    INFO: CDVDPlayer::Process - eof reading from demuxer
1695
18:17:05 T:1220  NOTICE: CDVDPlayer::OnExit()
1696
18:17:05 T:1220  NOTICE: DVDPlayer: eof, waiting for queues to empty
1697
18:17:05 T:1220  NOTICE: DVDPlayer: closing audio stream
1698
18:17:05 T:1220  NOTICE: Closing audio stream
1699
18:17:05 T:1220  NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty
1700
18:17:05 T:4272   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
1701
18:17:05 T:4272   DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread
1702
18:17:05 T:1220  NOTICE: Waiting for audio thread to exit
1703
18:17:05 T:4272  NOTICE: thread end: CDVDPlayerAudio::OnExit()
1704
18:17:05 T:1220  NOTICE: Closing audio device
1705
18:17:05 T:4272   DEBUG: Thread CDVDPlayerAudio 4272 terminating
1706
18:17:05 T:1220   DEBUG: CSoftAEStream::~CSoftAEStream - Destructed
1707
18:17:05 T:1220  NOTICE: Deleting audio codec
1708
18:17:05 T:1220  NOTICE: DVDPlayer: closing video stream
1709
18:17:05 T:1220  NOTICE: Closing video stream
1710
18:17:05 T:1220  NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty
1711
18:17:05 T:6908   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
1712
18:17:05 T:1220  NOTICE: waiting for video thread to exit
1713
18:17:05 T:6908   ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true
1714
18:17:05 T:6908  NOTICE: thread end: video_thread
1715
18:17:05 T:6908   DEBUG: Thread CDVDPlayerVideo 6908 terminating
1716
18:17:05 T:1220  NOTICE: deleting video codec
1717
18:17:05 T:1220  NOTICE: DVDPlayer: closing subtitle stream
1718
18:17:05 T:1220  NOTICE: Closing subtitle stream
1719
18:17:05 T:1220  NOTICE: CDVDPlayer::OnExit() deleting demuxer
1720
18:17:05 T:1220  NOTICE: CDVDPlayer::OnExit() deleting input stream
1721
18:17:05 T:1220   ERROR: AddOnLog: Tvheadend HTSP Client: CHTSPConnection::ReadResult - command failed - Unknown file id
1722
18:17:05 T:5324   DEBUG: CSoftAE::Run - Sink restart flagged
1723
18:17:05 T:5324   DEBUG: CAESinkDirectSound::IsCompatible: Formats Incompatible due to different :Sample Rates
1724
18:17:05 T:5324    INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting
1725
18:17:05 T:5324   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
1726
18:17:05 T:1220   DEBUG: CAddonCallbacksAddon - ADDON::CAddonCallbacksAddon::QueueNotification - Tvheadend HTSP Client - Error Message : 'Command failed: Unknown file id'
1727
18:17:05 T:1220   DEBUG: AddOnLog: Tvheadend HTSP Client: CHTSPData::CloseRecordedStream - failed to fileClose
1728
18:17:05 T:1220   DEBUG: CDVDInputStreamPVRManager::Close - stream closed
1729
18:17:05 T:1220   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
1730
18:17:05 T:1220   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
1731
18:17:05 T:1220   DEBUG: Thread CDVDPlayer 1220 terminating
1732
18:17:05 T:4568   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
1733
18:17:05 T:4568   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
1734
18:17:05 T:4568   DEBUG: CGUIWindowManager::PreviousWindow: Activate new
1735
18:17:05 T:4568   DEBUG: ------ Window Init (MyPVR.xml) ------
1736
18:17:05 T:4568    INFO: Loading skin file: MyPVR.xml, load type: LOAD_EVERY_TIME
1737
18:17:05 T:4568   DEBUG: Using already stored xml root node for C:\Program Files (x86)\XBMC\addons\skin.confluence\720p\MyPVR.xml
1738
18:17:05 T:5324   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 394092
1739
18:17:05 T:5324   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created
1740
18:17:05 T:5324   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:
1741
18:17:05 T:5324   DEBUG:   Audio Device    : Speakers (Realtek High Definition Audio)
1742
18:17:05 T:5324   DEBUG:   Sample Rate     : 44100
1743
18:17:05 T:5324   DEBUG:   Sample Format   : AE_FMT_FLOAT
1744
18:17:05 T:5324   DEBUG:   Bits Per Sample : 32
1745
18:17:05 T:5324   DEBUG:   Valid Bits/Samp : 32
1746
18:17:05 T:5324   DEBUG:   Channel Count   : 2
1747
18:17:05 T:5324   DEBUG:   Block Align     : 8
1748
18:17:05 T:5324   DEBUG:   Avg. Bytes Sec  : 352800
1749
18:17:05 T:5324   DEBUG:   Samples/Block   : 32
1750
18:17:05 T:5324   DEBUG:   Format cBSize   : 22
1751
18:17:05 T:5324   DEBUG:   Channel Layout  : FL,FR
1752
18:17:05 T:5324   DEBUG:   Channel Mask    : 3
1753
18:17:05 T:5324   DEBUG:   Frames          : 441
1754
18:17:05 T:5324   DEBUG:   Frame Samples   : 882
1755
18:17:05 T:5324   DEBUG:   Frame Size      : 8
1756
18:17:05 T:5324   DEBUG: CSoftAE::InternalOpenSink - DirectSound Initialized:
1757
18:17:05 T:5324   DEBUG:   Output Device : Speakers - Speakers (Realtek High Definition Audio)
1758
18:17:05 T:5324   DEBUG:   Sample Rate   : 44100
1759
18:17:05 T:5324   DEBUG:   Sample Format : AE_FMT_FLOAT
1760
18:17:05 T:5324   DEBUG:   Channel Count : 2
1761
18:17:05 T:5324   DEBUG:   Channel Layout: FL,FR
1762
18:17:05 T:5324   DEBUG:   Frames        : 441
1763
18:17:05 T:5324   DEBUG:   Frame Samples : 882
1764
18:17:05 T:5324   DEBUG:   Frame Size    : 8
1765
18:17:05 T:5324   DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0
1766
18:17:05 T:5324   DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 3528
1767
18:17:05 T:5324   DEBUG: AERemap: Downmix normalization is disabled
1768
18:17:05 T:4568   DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/)
1769
18:17:05 T:4568   DEBUG:   ParentPath = [pvr://recordings/]
1770
18:17:05 T:5324   DEBUG: AERemap: Downmix normalization is disabled
1771
18:17:05 T:4568   DEBUG: Previous line repeats 1 times.
1772
18:17:05 T:4568   DEBUG: CPVRDirectory::GetDirectory(pvr://recordings)
1773
18:17:05 T:4568   DEBUG: CGUIWindowPVRCommon - PVR::CGUIWindowPVRCommon::OnMessageFocus - focus set to window 'recordings'
1774
18:17:05 T:4568   DEBUG: CGUIWindowPVRRecordings - PVR::CGUIWindowPVRRecordings::UpdateData - update window 'recordings'. set view to 13
1775
18:17:05 T:4568   DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/)
1776
18:17:05 T:4568   DEBUG:   ParentPath = [pvr://recordings/]
1777
18:17:05 T:2280  NOTICE: Thread Jobworker start, auto delete: true
1778
18:17:05 T:2280   DEBUG: CPVRDirectory::GetDirectory(pvr://recordings)
1779
18:17:05 T:6464  NOTICE: Thread Background Loader start, auto delete: false
1780
18:17:05 T:4568   DEBUG: ------ Window Init (DialogKaiToast.xml) ------
1781
18:17:06 T:4568  NOTICE: CDVDPlayer::CloseFile()
1782
18:17:06 T:4568 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
1783
18:17:06 T:4568  NOTICE: DVDPlayer: waiting for threads to exit
1784
18:17:06 T:4568  NOTICE: DVDPlayer: finished waiting
1785
18:17:06 T:5324   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback
1786
18:17:06 T:6464   DEBUG: Thread Background Loader 6464 terminating
1787
18:17:06 T:2280   DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item pvr://recordings///The Story of Science, TV (BBC Knowledge), 20131202_083000.pvr
1788
18:17:09 T:4568   DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
1789
18:17:09 T:4568   DEBUG: ------ Window Init (Pointer.xml) ------
1790
18:17:15 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action mousedrag
1791
18:17:16 T:4568   DEBUG: Previous line repeats 1 times.
1792
18:17:16 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1793
18:17:16 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(home)
1794
18:17:16 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(home)
1795
18:17:16 T:4568   DEBUG: Activating window ID: 10000
1796
18:17:16 T:4568   DEBUG: ------ Window Deinit (MyPVR.xml) ------
1797
18:17:16 T:4568   DEBUG: ------ Window Init (Home.xml) ------
1798
18:17:18 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1799
18:17:18 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating ActivateWindow(ShutdownMenu)
1800
18:17:18 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To ActivateWindow(ShutdownMenu)
1801
18:17:18 T:4568   DEBUG: Activating window ID: 10111
1802
18:17:18 T:4568   DEBUG: ------ Window Init (DialogButtonMenu.xml) ------
1803
18:17:18 T:4568    INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY
1804
18:17:18 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating down
1805
18:17:18 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To down
1806
18:17:19 T:5324   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up
1807
18:17:19 T:5324   DEBUG: Suspended the Sink
1808
18:17:20 T:4568   DEBUG: CApplication::ProcessMouse: trying mouse action leftclick
1809
18:17:20 T:4568   DEBUG: CApplication::ExecuteXBMCAction : Translating XBMC.Quit()
1810
18:17:20 T:4568   DEBUG: CApplication::ExecuteXBMCAction : To XBMC.Quit()
1811
18:17:20 T:4568   DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc
1812
18:17:20 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit
1813
18:17:20 T:4568  NOTICE: Storing total System Uptime
1814
18:17:20 T:2280   DEBUG: Thread Jobworker 2280 terminating (autodelete)
1815
18:17:20 T:4568  NOTICE: Saving settings
1816
18:17:20 T:4568  NOTICE: stop all
1817
18:17:20 T:4568    INFO: stopping PVRManager
1818
18:17:20 T:2912   DEBUG: Thread EPG updater 2912 terminating
1819
18:17:20 T:4568  NOTICE: PVRManager - stopping
1820
18:17:20 T:1992   DEBUG: Thread PVR manager 1992 terminating
1821
18:17:20 T:716   DEBUG: Thread PVR GUI info updater 716 terminating
1822
18:17:20 T:3504   DEBUG: Thread PVR add-on updater 3504 terminating
1823
18:17:20 T:4568   DEBUG: PVR - PVR::CPVRClient::Destroy - destroying PVR add-on 'HTS Tvheadend:192.168.1.76:9982'
1824
18:17:20 T:4568   DEBUG: SECTION:UnloadDll(C:\Program Files (x86)\XBMC\addons\pvr.hts\XBMC_Tvheadend_win32.dll)
1825
18:17:20 T:4568    INFO: ADDON: Dll Destroyed - Tvheadend HTSP Client
1826
18:17:20 T:4568   DEBUG: CNetwork::NetworkMessage - Signaling network services to stop
1827
18:17:20 T:4568  NOTICE: ES: Stopping event server
1828
18:17:20 T:4568   DEBUG: CNetwork::NetworkMessage - Waiting for network services to stop
1829
18:17:20 T:4568  NOTICE: stopping zeroconf publishing
1830
18:17:21 T:6548   DEBUG: Thread CTCPServer 6548 terminating
1831
18:17:21 T:6556  NOTICE: ES: UDP Event server stopped
1832
18:17:21 T:6556   DEBUG: Thread CEventServer 6556 terminating
1833
18:17:21 T:6576   DEBUG: Thread XBMC Peripherals 6576 terminating
1834
18:17:21 T:6572   DEBUG: Thread XBMC Peripherals 6572 terminating
1835
18:17:21 T:4568  NOTICE: stop sap announcement listener
1836
18:17:21 T:4568  NOTICE: clean cached files!
1837
18:17:21 T:4568  NOTICE: unload skin
1838
18:17:21 T:4568    INFO: Unloading old skin ...
1839
18:17:21 T:4568   DEBUG: ------ Window Deinit () ------
1840
18:17:21 T:4568   DEBUG: ------ Window Deinit (Home.xml) ------
1841
18:17:21 T:4568   DEBUG: ------ Window Deinit (Pointer.xml) ------
1842
18:17:21 T:4568 WARNING: CGUITextureManager::Cleanup: Having to cleanup texture button-focus.png
1843
18:17:21 T:4568 WARNING: CGUITextureManager::Cleanup: Having to cleanup texture button-nofocus.png
1844
18:17:21 T:4568   DEBUG: CTextureBundleXBT::Cleanup - Closed bundle
1845
18:17:21 T:4568   DEBUG: ADDON: Stopping service addons.
1846
18:17:21 T:4568  NOTICE: stop python
1847
18:17:21 T:5324   DEBUG: Thread CSoftAE 5324 terminating
1848
18:17:21 T:4568  NOTICE: stopped
1849
18:17:21 T:4568  NOTICE: destroy
1850
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been uninstalled.'
1851
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been uninstalled.'
1852
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.xbmc.org has been uninstalled.'
1853
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been uninstalled.'
1854
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been uninstalled.'
1855
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been uninstalled.'
1856
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.euphoria has been uninstalled.'
1857
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been uninstalled.'
1858
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been uninstalled.'
1859
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx32.xbmc.org has been uninstalled.'
1860
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.projectm has been uninstalled.'
1861
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in script.module.simplejson has been uninstalled.'
1862
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in weather.wunderground has been uninstalled.'
1863
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been uninstalled.'
1864
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been uninstalled.'
1865
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-ios.xbmc.org has been uninstalled.'
1866
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been uninstalled.'
1867
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in skin.confluence has been uninstalled.'
1868
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.glspectrum has been uninstalled.'
1869
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.amazon.de has been uninstalled.'
1870
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in script.module.pil has been uninstalled.'
1871
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.milkdrop has been uninstalled.'
1872
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been uninstalled.'
1873
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.dxspectrum has been uninstalled.'
1874
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been uninstalled.'
1875
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been uninstalled.'
1876
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been uninstalled.'
1877
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.demo has been uninstalled.'
1878
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.solarwinds has been uninstalled.'
1879
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been uninstalled.'
1880
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been uninstalled.'
1881
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been uninstalled.'
1882
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-android.xbmc.org has been uninstalled.'
1883
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been uninstalled.'
1884
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been uninstalled.'
1885
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been uninstalled.'
1886
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-win32.xbmc.org has been uninstalled.'
1887
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been uninstalled.'
1888
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been uninstalled.'
1889
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been uninstalled.'
1890
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv.cmyth has been uninstalled.'
1891
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in repository.pvr-osx64.xbmc.org has been uninstalled.'
1892
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.last.fm has been uninstalled.'
1893
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been uninstalled.'
1894
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been uninstalled.'
1895
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been uninstalled.'
1896
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been uninstalled.'
1897
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been uninstalled.'
1898
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been uninstalled.'
1899
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in screensaver.rsxs.plasma has been uninstalled.'
1900
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been uninstalled.'
1901
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been uninstalled.'
1902
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in script.module.pysqlite has been uninstalled.'
1903
18:17:21 T:4568   DEBUG: ADDON: cpluff: 'Plug-in metadata.common.hdtrailers.net has been uninstalled.'
1904
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 043680C0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1905
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368C48 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1906
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368588 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1907
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368108 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1908
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04812C10 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1909
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368A50 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1910
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04367F10 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1911
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368150 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1912
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368A98 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1913
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368858 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1914
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368CD8 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1915
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 043F4320 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1916
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368228 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1917
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0439AC30 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1918
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 04368930 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1919
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 043684B0 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1920
18:17:21 T:4568    INFO: ADDON: cpluff: 'An unreleased information object was encountered at address 0439AC78 with reference count 1 when destroying the associated plug-in context. Not releasing the object.'
1921
18:17:21 T:4568  NOTICE: closing down remote control service
1922
18:17:21 T:4568  NOTICE: unload sections
1923
18:17:21 T:4568    INFO: lastfm destroyed
1924
18:17:21 T:4568   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
1925
18:17:21 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
1926
18:17:21 T:4568   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
1927
18:17:21 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
1928
18:17:21 T:2412   DEBUG: Thread PVR Channel Window 2412 terminating
1929
18:17:21 T:4568   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
1930
18:17:21 T:4568   DEBUG: GOT ANNOUNCEMENT, type: 2, from xbmc, message OnClear
1931
18:17:21 T:4568  NOTICE: destroy
1932
18:17:21 T:4568 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
1933
18:17:21 T:4568 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
1934
18:17:21 T:4568 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
1935
18:17:21 T:4568 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
1936
18:17:21 T:4568 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
1937
18:17:21 T:4568 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
1938
18:17:21 T:4568 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
1939
18:17:21 T:4568 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist
1940
18:17:21 T:4568 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
1941
18:17:21 T:4568 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
1942
18:17:21 T:4568 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
1943
18:17:21 T:4568  NOTICE: closing down remote control service
1944
18:17:21 T:4568  NOTICE: unload sections
1945
18:17:21 T:4568   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
1946
18:17:21 T:4568   DEBUG: Previous line repeats 1 times.
1947
18:17:21 T:4568  NOTICE: application stopped...
1948
18:17:21 T:4568   DEBUG: PVRManager - destroyed
1949
18:17:21 T:4568   DEBUG: CAnnouncementManager - Announcement: OnClear from xbmc
1950
18:17:21 T:4568   DEBUG: Previous line repeats 1 times.
1951
18:17:21 T:4568   DEBUG: SECTION:UnloadDll(special://xbmcbin/system/libcurl.dll)
1952
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/cpluff.dll)
1953
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/libcec.dll)
1954
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avutil-51.dll)
1955
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avcodec-53.dll)
1956
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avformat-53.dll)
1957
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/swscale-2.dll)
1958
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/swresample-0.dll)
1959
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/avfilter-2.dll)
1960
18:17:21 T:4568   DEBUG: SECTION:UnloadAll(DLL: special://xbmcbin/system/players/dvdplayer/libmad.dll)
(2-2/5)