11:54:38 T:3001826160 M:1953501184 INFO: ffmpeg[B2EC3B70]: Input #0, mpeg, from '/media/sda4/filme2/doku/Kaminfeuer/VIDEO_TS/VIDEO_TS.IFO': 11:54:38 T:3001826160 M:1953501184 INFO: ffmpeg[B2EC3B70]: Duration: N/A, start: 0.280000, bitrate: 4192 kb/s 11:54:38 T:3001826160 M:1953501184 INFO: ffmpeg[B2EC3B70]: Stream #0.0[0x1e0]: Video: mpeg2video, yuv420p, 720x576 [PAR 16:15 DAR 4:3], 4000 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc 11:54:38 T:3001826160 M:1953501184 INFO: ffmpeg[B2EC3B70]: Stream #0.1[0x80]: Audio: ac3, 48000 Hz, stereo, s16, 192 kb/s 11:54:38 T:3001826160 M:1953501184 NOTICE: Opening video stream: 0 source: 256 11:54:38 T:3001826160 M:1953501184 INFO: GetVideoAspectRatio - Aspect wanted: 0, Scale permissions: 3 11:54:38 T:3001826160 M:1953501184 NOTICE: Creating video codec with codec id: 2 11:54:38 T:3001826160 M:1953501184 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no OpenMax:no VDPAU:yes VAAPI:no 11:54:38 T:3001826160 M:1953501184 DEBUG: FactoryCodec - Video: libmpeg2 - Opening 11:54:38 T:3001826160 M:1953501184 DEBUG: DllLibMpeg2: Using libmpeg2 system library 11:54:38 T:3078719360 M:1953501184 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 11:54:38 T:3001826160 M:1953406976 DEBUG: FactoryCodec - Video: libmpeg2 - Opened 11:54:38 T:2903165808 M:1953406976 DEBUG: thread start, auto delete: 0 11:54:38 T:2903165808 M:1953406976 DEBUG: CVideoReferenceClock: Setting up GLX 11:54:38 T:3078719360 M:1953411072 DEBUG: SECTION:UnloadDelayed(DLL: libmad.so.0) 11:54:38 T:3078719360 M:1953411072 DEBUG: Unloading: libmad.so.0 11:54:39 T:2903165808 M:1950752768 DEBUG: CVideoReferenceClock: output of nvidia-settings -nt -q RefreshRate3: 50,000 Hz 11:54:39 T:2903165808 M:1950752768 DEBUG: CVideoReferenceClock: Detected refreshrate by nvidia-settings: 50.000000 hertz, rounding to 50 hertz 11:54:39 T:3001826160 M:1950752768 NOTICE: Creating video thread 11:54:39 T:2924432240 M:1950752768 DEBUG: thread start, auto delete: 0 11:54:39 T:3001826160 M:1950752768 NOTICE: Opening audio stream: 1 source: 256 11:54:39 T:3001826160 M:1950752768 NOTICE: Finding audio codec for: 86020 11:54:39 T:3001826160 M:1950752768 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 11:54:39 T:3001826160 M:1950752768 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 11:54:39 T:2924432240 M:1950752768 DEBUG: LinuxRendererGL: Cleaning up GL resources 11:54:39 T:3001826160 M:1951006720 NOTICE: Creating audio thread 11:54:39 T:3001826160 M:1950986240 DEBUG: CDVDPlayer::SetCaching - caching state 2 11:54:39 T:2942303088 M:1950986240 DEBUG: thread start, auto delete: 0 11:54:39 T:2942303088 M:1950986240 NOTICE: running thread: CDVDPlayerAudio::Process() 11:54:39 T:2942303088 M:1950986240 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(0.000000, 0) 11:54:39 T:2924432240 M:1950994432 NOTICE: running thread: video_thread 11:54:39 T:2924432240 M:1950994432 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(0.000000, 1) 11:54:39 T:2942303088 M:1951342592 NOTICE: Creating audio device with codec id: 86020, channels: 2, sample rate: 48000, no pass-through 11:54:39 T:2942303088 M:1951326208 INFO: AudioRendererFactory: not a explicit device, trying to autodetect. 11:54:39 T:2942303088 M:1951326208 INFO: CPCMRemap: Configured speaker layout: 2.0 11:54:39 T:2942303088 M:1951326208 INFO: CPCMRemap: I channel map: FL,FR 11:54:39 T:2942303088 M:1951326208 INFO: CPCMRemap: O channel map: FL,FR 11:54:39 T:2942303088 M:1951326208 DEBUG: CPCMRemap: Downmix normalization is disabled 11:54:39 T:2942303088 M:1951326208 DEBUG: CPCMRemap: FL = FL(1.000000*) 11:54:39 T:2942303088 M:1951326208 DEBUG: CPCMRemap: FR = FR(1.000000*) 11:54:39 T:2942303088 M:1951326208 DEBUG: RemoveActiveDevice - Removing device 1 11:54:39 T:2942303088 M:1951326208 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2 11:54:39 T:2942303088 M:1951326208 DEBUG: RemoveActiveDevice - Removing device 0 11:54:39 T:2924432240 M:1951326208 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 11:54:39 T:2924432240 M:1951326208 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 787, dheight: 576 11:54:39 T:2924432240 M:1951326208 DEBUG: OutputPicture - change configuration. 720x576. framerate: 25.00. format: YV12 11:54:39 T:2924432240 M:1951326208 NOTICE: Display resolution ADJUST : 1920x1080 @ 50.00 - Full Screen (12) 11:54:39 T:3001826160 M:1951453184 DEBUG: CDVDPlayer::HandleMessages - player started 2 11:54:39 T:3078719360 M:1951252480 DEBUG: Activating window ID: 12005 11:54:39 T:3078719360 M:1951252480 DEBUG: Checking if window ID 12005 is locked. 11:54:39 T:3078719360 M:1951252480 DEBUG: ------ Window Deinit (MyVideo.xml) ------ 11:54:39 T:3078719360 M:1951125504 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 11:54:39 T:3078719360 M:1951125504 INFO: Loading skin file: VideoFullScreen.xml 11:54:39 T:3078719360 M:1951223808 DEBUG: Load VideoFullScreen.xml: 32.80ms 11:54:40 T:2942303088 M:1950588928 DEBUG: PulseAudio: Context failed 11:54:40 T:2942303088 M:1950588928 ERROR: PulseAudio: Waited for the Context but it failed 11:54:40 T:2942303088 M:1950588928 ERROR: PulseAudio: Failed to create context 11:54:40 T:2942303088 M:1950588928 DEBUG: SetActiveDevice - SetActiveDevice from 2 to 1 11:54:40 T:2942303088 M:1950588928 DEBUG: RemoveActiveDevice - Removing device 2 11:54:40 T:2942303088 M:1950588928 DEBUG: CGUIAudioManager::Initialize 11:54:40 T:3078719360 M:1950568448 DEBUG: Alloc resources: 268.67ms (33.12 ms skin load) 11:54:40 T:3078719360 M:1950568448 INFO: Loading skin file: VideoOSD.xml 11:54:40 T:3078719360 M:1950543872 DEBUG: Load VideoOSD.xml: 22.95ms 11:54:40 T:3078719360 M:1950310400 DEBUG: Alloc resources: 73.05ms (0.00 ms skin load) 11:54:40 T:3078719360 M:1950310400 INFO: Loading skin file: VideoOSDSettings.xml 11:54:40 T:3078719360 M:1950310400 DEBUG: Load VideoOSDSettings.xml: 3.54ms 11:54:40 T:2942303088 M:1950281728 INFO: CPCMRemap: Configured speaker layout: 2.0 11:54:40 T:2942303088 M:1950281728 INFO: CPCMRemap: I channel map: FL,FR 11:54:40 T:2942303088 M:1950281728 INFO: CPCMRemap: O channel map: FL,FR 11:54:40 T:2942303088 M:1950281728 DEBUG: CPCMRemap: Downmix normalization is disabled 11:54:40 T:2942303088 M:1950281728 DEBUG: CPCMRemap: FL = FL(1.000000*) 11:54:40 T:2942303088 M:1950281728 DEBUG: CPCMRemap: FR = FR(1.000000*) 11:54:40 T:2942303088 M:1950281728 DEBUG: RemoveActiveDevice - Removing device 1 11:54:40 T:2942303088 M:1950281728 DEBUG: CGUIAudioManager::DeInitialize 11:54:40 T:3078719360 M:1949106176 DEBUG: Alloc resources: 71.64ms (0.00 ms skin load) 11:54:40 T:3078719360 M:1949106176 INFO: Loading skin file: VideoOSDSettings.xml 11:54:40 T:3078719360 M:1949106176 DEBUG: Load VideoOSDSettings.xml: 2.54ms 11:54:40 T:3078719360 M:1949106176 DEBUG: Alloc resources: 0.16ms (0.00 ms skin load) 11:54:40 T:3078719360 M:1949106176 INFO: Loading skin file: DialogFullScreenInfo.xml 11:54:40 T:3078719360 M:1949233152 DEBUG: Load DialogFullScreenInfo.xml: 17.42ms 11:54:40 T:3078719360 M:1949097984 DEBUG: Alloc resources: 17.36ms (0.00 ms skin load) 11:54:40 T:3078719360 M:1948934144 NOTICE: Using GL_TEXTURE_2D 11:54:40 T:3078719360 M:1948909568 DEBUG: GL: Requested render method: 0 11:54:40 T:2942303088 M:1948909568 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2 11:54:40 T:2942303088 M:1948909568 DEBUG: RemoveActiveDevice - Removing device 0 11:54:40 T:2942303088 M:1948909568 DEBUG: Initialize - using alsa device default 11:54:40 T:3078719360 M:1948909568 NOTICE: GL: Selecting Single Pass YUV 2 RGB shader 11:54:40 T:2942303088 M:1948909568 DEBUG: CALSADirectSound::Initialize - packet size:2048, packet count:16, buffer size:8192 11:54:40 T:3078719360 M:1948909568 DEBUG: GL: Vertex Shader compilation log: 11:54:40 T:3078719360 M:1948909568 DEBUG: GL: Vertex Shader compiled successfully 11:54:40 T:3078719360 M:1948909568 DEBUG: GL: Pixel Shader compilation log: 11:54:40 T:3078719360 M:1948909568 DEBUG: GL: Fragment Shader compiled successfully 11:54:40 T:3078719360 M:1948909568 NOTICE: GL: NPOT texture support detected 11:54:40 T:3078719360 M:1948909568 NOTICE: GL: Using GL_ARB_pixel_buffer_object 11:54:40 T:2942303088 M:1948876800 DEBUG: CALSADirectSound::Initialize - Channels: 2 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough false - audioDevice: default 11:54:40 T:2942303088 M:1948880896 DEBUG: CDVDPlayerAudio:: synctype set to 2: resample 11:54:40 T:2942303088 M:1948753920 DEBUG: CDVDPlayerResampler: resized buffers to hold 15360 frames 11:54:40 T:3001826160 M:1951522816 DEBUG: CDVDPlayer::HandleMessages - player started 1 11:54:40 T:3001826160 M:1951522816 DEBUG: CDVDPlayer::SetCaching - caching state 3 11:54:40 T:2942303088 M:1951522816 DEBUG: CDVDPlayerAudio:: Discontinuity - was:0.000000, should be:0.000000, error:0.000000 11:54:40 T:3001826160 M:1951522816 DEBUG: CDVDPlayer::SetCaching - caching state 0 11:54:42 T:2924432240 M:1952030720 DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00 11:54:44 T:3001826160 M:1951969280 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:54:44 T:3001826160 M:1951940608 INFO: msg: libdvdnav: Menu Languages available: 11:54:44 T:3001826160 M:1951911936 INFO: msg: en 11:54:44 T:3001826160 M:1951911936 INFO: msg: 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Menu Languages available: 11:54:44 T:3001826160 M:1951911936 INFO: msg: en 11:54:44 T:3001826160 M:1951911936 INFO: msg: 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Menu Languages available: 11:54:44 T:3001826160 M:1951911936 INFO: msg: en 11:54:44 T:3001826160 M:1951911936 INFO: msg: 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Menu Languages available: 11:54:44 T:3001826160 M:1951911936 INFO: msg: en 11:54:44 T:3001826160 M:1951911936 INFO: msg: 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:54:44 T:3001826160 M:1951911936 INFO: msg: libdvdnav: Menu Languages available: 11:54:44 T:3001826160 M:1951911936 INFO: msg: en 11:54:44 T:3001826160 M:1951911936 INFO: msg: 11:54:44 T:3001826160 M:1951911936 DEBUG: - DVDNAV_VTS_CHANGE (HOLDING) 11:54:44 T:3001826160 M:1951911936 DEBUG: DVDNAV_VTS_CHANGE 11:54:44 T:3001826160 M:1951911936 INFO: GetVideoAspectRatio - Aspect wanted: 0, Scale permissions: 3 11:54:44 T:3001826160 M:1951916032 DEBUG: dvdnav: Cannot get current position 11:54:44 T:3001826160 M:1951760384 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:54:44 T:3001826160 M:1951760384 INFO: msg: libdvdnav: Menu Languages available: 11:54:44 T:3001826160 M:1951760384 INFO: msg: en 11:54:44 T:3001826160 M:1951760384 INFO: msg: 11:54:44 T:3001826160 M:1951760384 DEBUG: ProcessBlock - Cell change: Title 0, Chapter 0 11:54:44 T:3001826160 M:1951760384 DEBUG: ProcessBlock - At position 0% inside the feature 11:54:44 T:3001826160 M:1951760384 DEBUG: DVDNAV_CELL_CHANGE 11:54:44 T:3001826160 M:1951760384 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:11800000 TO:280000 DIFF:-11520000 11:54:44 T:3001826160 M:1951887360 DEBUG: Open - av_find_stream_info starting 11:54:44 T:3001826160 M:1949675520 DEBUG: ffmpeg[B2EC3B70]: [mpeg] max_analyze_duration reached 11:54:44 T:3001826160 M:1949675520 DEBUG: ffmpeg[B2EC3B70]: [mpeg] Estimating duration from bitrate, this may be inaccurate 11:54:44 T:3001826160 M:1949802496 DEBUG: Open - av_find_stream_info finished 11:54:44 T:3001826160 M:1949802496 INFO: ffmpeg[B2EC3B70]: Input #0, mpeg, from '/media/sda4/filme2/doku/Kaminfeuer/VIDEO_TS/VIDEO_TS.IFO': 11:54:44 T:3001826160 M:1949802496 INFO: ffmpeg[B2EC3B70]: Duration: N/A, start: 0.280000, bitrate: 5192 kb/s 11:54:44 T:3001826160 M:1949802496 INFO: ffmpeg[B2EC3B70]: Stream #0.0[0x1e0]: Video: mpeg2video, yuv420p, 720x576 [PAR 16:15 DAR 4:3], 5000 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc 11:54:44 T:3001826160 M:1949802496 INFO: ffmpeg[B2EC3B70]: Stream #0.1[0x20]: Subtitle: dvdsub 11:54:44 T:3001826160 M:1949802496 INFO: ffmpeg[B2EC3B70]: Stream #0.2[0x80]: Audio: ac3, 48000 Hz, stereo, s16, 192 kb/s 11:54:44 T:3001826160 M:1949802496 NOTICE: Opening Subtitle stream: 1 source: 256 11:54:44 T:3001826160 M:1949810688 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet 11:54:44 T:3001826160 M:1949810688 NOTICE: Opening video stream: 0 source: 256 11:54:44 T:3001826160 M:1949810688 INFO: GetVideoAspectRatio - Aspect wanted: 0, Scale permissions: 3 11:54:44 T:3001826160 M:1949810688 DEBUG: - codecs hints have changed, must close previous stream 11:54:44 T:3001826160 M:1949810688 NOTICE: Closing video stream 11:54:44 T:3001826160 M:1949810688 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 11:54:51 T:2942303088 M:1949716480 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 11:54:52 T:2924432240 M:1949716480 DEBUG: CDVDPlayerVideo - CDVDMsg::VIDEO_SET_ASPECT 11:54:52 T:2924432240 M:1949716480 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 11:54:52 T:2924432240 M:1949716480 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 11:54:52 T:3001826160 M:1949716480 NOTICE: waiting for video thread to exit 11:54:52 T:2924432240 M:1949716480 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 11:54:52 T:2924432240 M:1949716480 NOTICE: thread end: video_thread 11:54:52 T:2924432240 M:1949716480 DEBUG: Thread 2924432240 terminating 11:54:52 T:3001826160 M:1949716480 NOTICE: deleting video codec 11:54:52 T:3001826160 M:1949716480 NOTICE: Creating video codec with codec id: 2 11:54:52 T:3001826160 M:1949716480 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no OpenMax:no VDPAU:yes VAAPI:no 11:54:52 T:3001826160 M:1949716480 DEBUG: FactoryCodec - Video: libmpeg2 - Opening 11:54:52 T:3001826160 M:1949716480 DEBUG: DllLibMpeg2: Using libmpeg2 system library 11:54:52 T:3001826160 M:1949716480 DEBUG: FactoryCodec - Video: libmpeg2 - Opened 11:54:52 T:3001826160 M:1949716480 NOTICE: Creating video thread 11:54:52 T:2924432240 M:1949716480 DEBUG: thread start, auto delete: 0 11:54:52 T:2924432240 M:1949716480 NOTICE: running thread: video_thread 11:54:52 T:2924432240 M:1949716480 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(11480000.000000, 0) 11:54:52 T:3001826160 M:1949683712 NOTICE: Opening audio stream: 2 source: 256 11:54:52 T:2942303088 M:1949687808 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 11:54:52 T:2942303088 M:1949687808 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 11:54:52 T:3001826160 M:1949687808 DEBUG: CDVDPlayer::HandleMessages - player started 1 11:54:52 T:2924432240 M:1949057024 DEBUG: CPullupCorrection: pattern lost 11:54:52 T:2942303088 M:1948008448 DEBUG: CDVDPlayerAudio:: synctype set to 2: resample 11:54:52 T:3001826160 M:1948008448 DEBUG: CDVDPlayer::HandleMessages - player started 2 11:54:52 T:2942303088 M:1948336128 DEBUG: CDVDPlayerAudio:: Discontinuity - was:11740000.000000, should be:11478333.334764, error:-261666.665236 11:54:52 T:2942303088 M:1948590080 DEBUG: CDVDPlayerAudio:: Discontinuity - was:11518333.334764, should be:11810145.833453, error:291812.498689 11:54:54 T:2924432240 M:1945726976 DEBUG: CPullupCorrection: detected pattern of length 1: 40000.00 11:55:07 T:3078719360 M:1944023040 DEBUG: SECTION:UnloadDelayed(SECTION: LCODE) 11:55:08 T:3017038704 M:1944047616 DEBUG: Thread 3017038704 terminating (autodelete) 11:55:14 T:3001826160 M:1944223744 DEBUG: - DVDNAV_WAIT (HOLDING) 11:55:14 T:3001826160 M:1944223744 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:55:14 T:3001826160 M:1944223744 INFO: msg: libdvdnav: Menu Languages available: 11:55:14 T:3001826160 M:1944223744 INFO: msg: en 11:55:14 T:3001826160 M:1944223744 INFO: msg: 11:55:14 T:3001826160 M:1944223744 DEBUG: ProcessBlock - Cell change: Title 0, Chapter 0 11:55:14 T:3001826160 M:1944223744 DEBUG: ProcessBlock - At position 0% inside the feature 11:55:14 T:3001826160 M:1944223744 DEBUG: DVDNAV_CELL_CHANGE 11:55:14 T:3001826160 M:1944223744 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:30280000 TO:280000 DIFF:-30000000 11:55:14 T:3001826160 M:1944223744 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet 11:55:44 T:3001826160 M:1943506944 DEBUG: - DVDNAV_WAIT (HOLDING) 11:55:44 T:3001826160 M:1943379968 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:55:44 T:3001826160 M:1943379968 INFO: msg: libdvdnav: Menu Languages available: 11:55:44 T:3001826160 M:1943379968 INFO: msg: en 11:55:44 T:3001826160 M:1943379968 INFO: msg: 11:55:44 T:3001826160 M:1943379968 DEBUG: ProcessBlock - Cell change: Title 0, Chapter 0 11:55:44 T:3001826160 M:1943379968 DEBUG: ProcessBlock - At position 0% inside the feature 11:55:44 T:3001826160 M:1943379968 DEBUG: DVDNAV_CELL_CHANGE 11:55:44 T:3001826160 M:1943379968 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:30280000 TO:280000 DIFF:-30000000 11:55:44 T:3001826160 M:1943379968 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet 11:56:14 T:3001826160 M:1946058752 DEBUG: - DVDNAV_WAIT (HOLDING) 11:56:14 T:3001826160 M:1946058752 INFO: msg: libdvdnav: Language 'de' not found, using 'en' instead 11:56:14 T:3001826160 M:1946058752 INFO: msg: libdvdnav: Menu Languages available: 11:56:14 T:3001826160 M:1946058752 INFO: msg: en 11:56:14 T:3001826160 M:1946058752 INFO: msg: 11:56:14 T:3001826160 M:1946058752 DEBUG: ProcessBlock - Cell change: Title 0, Chapter 0 11:56:14 T:3001826160 M:1946058752 DEBUG: ProcessBlock - At position 0% inside the feature 11:56:14 T:3001826160 M:1946058752 DEBUG: DVDNAV_CELL_CHANGE 11:56:14 T:3001826160 M:1946058752 DEBUG: DVDNAV_NAV_PACKET - DISCONTINUITY FROM:30280000 TO:280000 DIFF:-30000000 11:56:14 T:3001826160 M:1946058752 DEBUG: CDVDPlayer::ProcessSubData: Got complete SPU packet