09:03:13 T:139644619995184 M:640991232 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers(/var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts) 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 09:03:13 T:139644619995184 M:640991232 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 09:03:13 T:139644619995184 M:640991232 NOTICE: DVDPlayer: Opening: /var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:13 T:139644619995184 M:640991232 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 09:03:13 T:139644083632400 M:640991232 DEBUG: thread start, auto delete: 0 09:03:13 T:139644083632400 M:640991232 NOTICE: Creating InputStream 09:03:13 T:139644083632400 M:640991232 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles 09:03:13 T:139644083632400 M:640991232 DEBUG: CacheSubtitles: START 09:03:13 T:139644083632400 M:640991232 DEBUG: CacheSubtitles: Checking for common subdirs... 09:03:13 T:139644083632400 M:640991232 DEBUG: CacheSubtitles: Done (time: 1 ms) 09:03:13 T:139644083632400 M:640991232 DEBUG: CacheSubtitles: Searching for subtitles... 09:03:13 T:139644083632400 M:640991232 DEBUG: CacheSubtitles: Done (time: 0 ms) 09:03:13 T:139644083632400 M:640991232 DEBUG: CacheSubtitles: END (total time: 2 ms) 09:03:13 T:139644083632400 M:640991232 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done 09:03:13 T:139644083632400 M:640991232 NOTICE: Creating Demuxer 09:03:13 T:139644083632400 M:640991232 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/dvdplayer/avutil-50-x86_64-linux.so) 09:03:13 T:139644083632400 M:640991232 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/avutil-50-x86_64-linux.so 09:03:13 T:139644083632400 M:640991232 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/dvdplayer/avcodec-52-x86_64-linux.so) 09:03:13 T:139644083632400 M:640991232 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/avcodec-52-x86_64-linux.so 09:03:13 T:139644083632400 M:640991232 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/dvdplayer/avformat-52-x86_64-linux.so) 09:03:13 T:139644083632400 M:640991232 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/avformat-52-x86_64-linux.so 09:03:13 T:139644619995184 M:641118208 DEBUG: ------ Window Init (DialogBusy.xml) ------ 09:03:13 T:139644619995184 M:640991232 INFO: Loading skin file: DialogBusy.xml 09:03:13 T:139644619995184 M:640991232 DEBUG: Load DialogBusy.xml: 11.20ms 09:03:13 T:139644619995184 M:640991232 DEBUG: Alloc resources: 11.35ms (11.35 ms skin load) 09:03:13 T:139644083632400 M:640991232 DEBUG: Open - probing detected format [mpegts] 09:03:13 T:139644083632400 M:640864256 DEBUG: Open - av_find_stream_info starting 09:03:13 T:139644083632400 M:639840256 DEBUG: Open - av_find_stream_info finished 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Input #0, mpegts, from '/var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts': 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Duration: 00:25:54.71, start: 94850.075000, bitrate: 6912 kb/s 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Program 132 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Stream #0.0[0x65]: Video: mpeg2video, yuv420p, 720x576 [PAR 64:45 DAR 16:9], 15000 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Stream #0.1[0x66](deu): Audio: mp2, 48000 Hz, 2 channels, s16, 256 kb/s 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Stream #0.2[0x67](2ch): Audio: mp2, 48000 Hz, 2 channels, s16, 192 kb/s 09:03:13 T:139644083632400 M:639840256 INFO: ffmpeg[6BFFF910]: Stream #0.3[0x6a](deu): Audio: ac3, 48000 Hz, stereo, s16, 448 kb/s 09:03:13 T:139644083632400 M:639840256 NOTICE: Opening video stream: 0 source: 256 09:03:13 T:139644083632400 M:639840256 NOTICE: Creating video codec with codec id: 2 09:03:13 T:139644083632400 M:639840256 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no VDPAU:yes VAAPI:no 09:03:13 T:139644083632400 M:639840256 DEBUG: FactoryCodec - Video: - Opening 09:03:13 T:139644083632400 M:639840256 DEBUG: SECTION:LoadDLL(special://xbmc/system/players/dvdplayer/swscale-0.6.1-x86_64-linux.so) 09:03:13 T:139644083632400 M:639840256 DEBUG: Loading: /usr/local/share/xbmc/system/players/dvdplayer/swscale-0.6.1-x86_64-linux.so 09:03:13 T:139644083632400 M:639840256 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(720x576, 2) 09:03:13 T:139644083632400 M:638300160 NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000 09:03:13 T:139644083632400 M:638300160 NOTICE: VDPAU Decoder capabilities: 09:03:13 T:139644083632400 M:638300160 NOTICE: name level macbs width height 09:03:13 T:139644083632400 M:638300160 NOTICE: ------------------------------------ 09:03:13 T:139644083632400 M:638300160 NOTICE: MPEG1 0 8192 2048 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: MPEG2_MAIN 3 8192 2048 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: H264_MAIN 41 8190 2032 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: H264_HIGH 41 8190 2032 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: VC1_SIMPLE 1 8190 2048 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: VC1_MAIN 2 8190 2048 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: VC1_ADVANCED 4 8190 2048 2048 09:03:13 T:139644083632400 M:638300160 NOTICE: ------------------------------------ 09:03:13 T:139644083632400 M:638300160 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION 09:03:13 T:139644083632400 M:638300160 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS 09:03:13 T:139644083632400 M:638300160 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL 09:03:13 T:139644083632400 M:638300160 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL 09:03:13 T:139644083632400 M:638300160 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE 09:03:13 T:139644083632400 M:638300160 NOTICE: Creating 720x576 pixmap 09:03:13 T:139644083632400 M:638300160 DEBUG: Found 6 fbconfigs. 09:03:13 T:139644083632400 M:638300160 DEBUG: Using fbconfig index 0. 09:03:13 T:139644083632400 M:638300160 INFO: GLX: Creating Pixmap context 09:03:13 T:139644083632400 M:635920384 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-1/2 video (VDPAU acceleration) 09:03:13 T:139644083632400 M:635920384 DEBUG: FactoryCodec - Video: ff-mpegvideo_vdpau-vdpau - Opened 09:03:13 T:139643862534416 M:635830272 DEBUG: thread start, auto delete: 0 09:03:13 T:139643862534416 M:635830272 DEBUG: CVideoReferenceClock: Setting up GLX 09:03:14 T:139643862534416 M:632168448 DEBUG: CVideoReferenceClock: output of nvidia-settings -nt -q RefreshRate 2>&1: 50,00 Hz 09:03:14 T:139643862534416 M:632168448 DEBUG: CVideoReferenceClock: Detected refreshrate by nvidia-settings: 50.000000 hertz, rounding to 50 hertz 09:03:14 T:139644083632400 M:632168448 NOTICE: Creating video thread 09:03:14 T:139644083632400 M:632168448 NOTICE: Opening audio stream: 1 source: 256 09:03:14 T:139643854141712 M:632168448 DEBUG: thread start, auto delete: 0 09:03:14 T:139644083632400 M:632168448 NOTICE: Finding audio codec for: 86016 09:03:14 T:139644083632400 M:632168448 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening 09:03:14 T:139644083632400 M:632168448 INFO: CDVDAudioCodecPassthroughFFmpeg::Open - disabled passthrough due to video OTAS 09:03:14 T:139644083632400 M:632168448 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Failed 09:03:14 T:139644083632400 M:632168448 DEBUG: FactoryCodec - Audio: libmad - Opening 09:03:14 T:139644083632400 M:632168448 DEBUG: SECTION:LoadDLL(libmad.so.0) 09:03:14 T:139644083632400 M:632168448 DEBUG: Loading: libmad.so.0 09:03:14 T:139644083632400 M:632168448 DEBUG: FactoryCodec - Audio: libmad - Opened 09:03:14 T:139644083632400 M:632168448 NOTICE: Creating audio thread 09:03:14 T:139643845749008 M:632168448 DEBUG: thread start, auto delete: 0 09:03:14 T:139643845749008 M:632168448 NOTICE: running thread: CDVDPlayerAudio::Process() 09:03:14 T:139644083632400 M:632168448 DEBUG: ReadEditDecisionLists - Setting frames per second to 25.0 assuming PAL (interlaced) 09:03:14 T:139644083632400 M:632168448 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:14 T:139644083632400 M:632168448 DEBUG: CDVDPlayer::SetCaching - caching state 2 09:03:14 T:139643845749008 M:632168448 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(50977.777777, 0) 09:03:14 T:139643845749008 M:632168448 NOTICE: Creating audio device with codec id: 86016, channels: 2, sample rate: 48000, no pass-through 09:03:14 T:139643845749008 M:632168448 INFO: CPCMRemap: Channel Layout: 5.1 09:03:14 T:139643845749008 M:632168448 INFO: CPCMRemap: I channel map: FL,FR 09:03:14 T:139643845749008 M:632168448 INFO: CPCMRemap: O channel map: FL,FR,BL,BR,CE,LFE 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: Downmix normalization is disabled 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: FL = FL(1.000000*) 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: FR = FR(1.000000*) 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: BL = 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: BR = 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: CE = 09:03:14 T:139643845749008 M:632168448 DEBUG: CPCMRemap: LFE = 09:03:14 T:139643845749008 M:632168448 DEBUG: CALSADirectSound::CALSADirectSound - Requested channels changed from 2 to 6 09:03:14 T:139643845749008 M:632168448 DEBUG: CALSADirectSound::CALSADirectSound - Channels: 6 - SampleRate: 48000 - SampleBit: 16 - Resample false - Codec PCM - IsMusic false - IsPassthrough false - audioDevice: xbmc 09:03:14 T:139643845749008 M:632168448 DEBUG: RemoveActiveDevice - Removing device 1 09:03:14 T:139643845749008 M:632168448 DEBUG: CGUIAudioManager::DeInitialize 09:03:14 T:139643854141712 M:632041472 DEBUG: LinuxRendererGL: Cleaning up GL resources 09:03:14 T:139643854141712 M:632041472 NOTICE: running thread: video_thread 09:03:14 T:139643854141712 M:632041472 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:14 T:139643854141712 M:632041472 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(117266.666668, 1) 09:03:14 T:139643854141712 M:631533568 NOTICE: (VDPAU) screenWidth:720 vidWidth:720 09:03:14 T:139643854141712 M:631533568 NOTICE: (VDPAU) screenHeight:576 vidHeight:576 09:03:14 T:139643845749008 M:624263168 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2 09:03:14 T:139643845749008 M:624136192 DEBUG: RemoveActiveDevice - Removing device 0 09:03:14 T:139644619995184 M:624136192 DEBUG: CAnnouncementManager - Announcement: PlaybackStarted from xbmc 09:03:14 T:139644619995184 M:624136192 DEBUG: OnPlayBackStarted - Playback has started 09:03:14 T:139643845749008 M:624136192 DEBUG: Initialize - using alsa device xbmc 09:03:14 T:139643854141712 M:617062400 NOTICE: (VDPAU) Total Output Surfaces Available: 4 of a max (tmp: 4 const: 4) 09:03:14 T:139643845749008 M:616808448 DEBUG: CALSADirectSound::Initialize - packet size:6144, packet count:16, buffer size:8192 09:03:14 T:139643854141712 M:615792640 NOTICE: (VDPAU) Creating the video mixer 09:03:14 T:139643845749008 M:611188736 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 09:03:14 T:139644083632400 M:609665024 DEBUG: CDVDPlayer::HandleMessages - player started 1 09:03:14 T:139643854141712 M:606744576 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 405 09:03:14 T:139643854141712 M:606744576 DEBUG: OutputPicture - change configuration. 720x576. framerate: 25.00 09:03:14 T:139643854141712 M:606617600 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (12) 09:03:14 T:139643854141712 M:606617600 WARNING: Upscale: possible given resolution increase. 09:03:14 T:139643854141712 M:606617600 WARNING: Upscale: selected algorithm 8 09:03:14 T:139644083632400 M:606490624 DEBUG: CDVDPlayer::HandleMessages - player started 2 09:03:14 T:139644083632400 M:606490624 DEBUG: CDVDPlayer::SetCaching - caching state 3 09:03:14 T:139644083632400 M:606490624 DEBUG: CDVDPlayer::SetCaching - caching state 0 09:03:14 T:139643845749008 M:606236672 DEBUG: CDVDPlayerAudio:: Discontinuity - was:97266.666668, should be:50977.777777, error:-46288.888891 09:03:14 T:139644619995184 M:600395776 NOTICE: Using GL_TEXTURE_2D 09:03:14 T:139644619995184 M:600395776 DEBUG: GL: Requested render method: 0 09:03:14 T:139644619995184 M:600395776 NOTICE: GL: Using VDPAU render method 09:03:14 T:139644619995184 M:600395776 NOTICE: GL: NPOT texture support detected 09:03:14 T:139644619995184 M:600395776 NOTICE: GL: Using GL_ARB_pixel_buffer_object 09:03:14 T:139644619995184 M:600141824 DEBUG: CGUIInfoManager::SetCurrentMovie(stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts) 09:03:14 T:139644619995184 M:600141824 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:14 T:139644619995184 M:600014848 DEBUG: GetMovieId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idMovie from movie where idFile=24 09:03:14 T:139644619995184 M:600141824 DEBUG: GetEpisodeId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idEpisode from episode where idFile=24 09:03:14 T:139644619995184 M:600141824 DEBUG: GetMusicVideoId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idMVideo from musicvideo where idFile=24 09:03:14 T:139644619995184 M:600141824 DEBUG: Activating window ID: 12005 09:03:14 T:139644619995184 M:600141824 DEBUG: Checking if window ID 12005 is locked. 09:03:14 T:139644619995184 M:600141824 DEBUG: ------ Window Deinit (MyTV.xml) ------ 09:03:14 T:139644619995184 M:600014848 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 09:03:14 T:139644619995184 M:600014848 INFO: Loading skin file: VideoFullScreen.xml 09:03:14 T:139644619995184 M:600014848 DEBUG: Load VideoFullScreen.xml: 19.59ms 09:03:14 T:139644619995184 M:600014848 DEBUG: Alloc resources: 20.10ms (19.90 ms skin load) 09:03:14 T:139644619995184 M:600014848 INFO: Loading skin file: VideoOSD.xml 09:03:14 T:139644619995184 M:600014848 DEBUG: Load VideoOSD.xml: 10.84ms 09:03:15 T:139644619995184 M:599506944 DEBUG: Alloc resources: 31.01ms (0.01 ms skin load) 09:03:15 T:139644619995184 M:599506944 INFO: Loading skin file: VideoOSDSettings.xml 09:03:15 T:139644619995184 M:599506944 DEBUG: Load VideoOSDSettings.xml: 2.77ms 09:03:15 T:139644619995184 M:598491136 DEBUG: Alloc resources: 3.67ms (0.00 ms skin load) 09:03:15 T:139644619995184 M:598491136 INFO: Loading skin file: VideoOSDSettings.xml 09:03:15 T:139644619995184 M:598491136 DEBUG: Load VideoOSDSettings.xml: 2.57ms 09:03:15 T:139644619995184 M:598491136 DEBUG: Alloc resources: 0.14ms (0.00 ms skin load) 09:03:15 T:139644619995184 M:598491136 INFO: Loading skin file: DialogFullScreenInfo.xml 09:03:15 T:139644619995184 M:598491136 DEBUG: Load DialogFullScreenInfo.xml: 19.71ms 09:03:15 T:139644619995184 M:598618112 DEBUG: Alloc resources: 1.08ms (0.00 ms skin load) 09:03:15 T:139644619995184 M:598491136 DEBUG: Building didl for object 'stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts' 09:03:15 T:139644619995184 M:598491136 NOTICE: Created m_glPixmapTexture (66) 09:03:15 T:139644619995184 M:598491136 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 09:03:15 T:139644619995184 M:597860352 DEBUG: SDLKeyboard: scancode: 114, sym: 275, unicode: 0, modifier: 0 09:03:15 T:139644619995184 M:597860352 DEBUG: OnKey: 61479 pressed, action is StepForward 09:03:15 T:139644083632400 M:597860352 DEBUG: CDVDPlayer::SetCaching - caching state 2 09:03:15 T:139644083632400 M:597860352 DEBUG: demuxer seek to: 30931 09:03:15 T:139644083632400 M:597860352 DEBUG: SeekTime - seek ended up on time 9077 09:03:15 T:139644083632400 M:597860352 DEBUG: demuxer seek to: 30931, success 09:03:15 T:139644083632400 M:608288768 WARNING: CDVDMessageQueue(teletext)::Put MSGQ_NOT_INITIALIZED 09:03:15 T:139643845749008 M:608288768 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1050977.777777, should be:1061322.395348, error:10344.617571 09:03:15 T:139644619995184 M:608415744 DEBUG: CAnnouncementManager - Announcement: PlaybackSeek from xbmc 09:03:15 T:139644619995184 M:608415744 DEBUG: OnPlayBackSeek - Playback skip 09:03:15 T:139644619995184 M:608415744 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 09:03:15 T:139644619995184 M:608415744 DEBUG: Alloc resources: 0.02ms (0.00 ms skin load) 09:03:16 T:139643854141712 M:608923648 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:16 T:139644083632400 M:608923648 DEBUG: CDVDPlayer::HandleMessages - player started 1 09:03:16 T:139644083632400 M:608923648 DEBUG: CDVDPlayer::HandleMessages - player started 2 09:03:16 T:139644083632400 M:608923648 DEBUG: CDVDPlayer::SetCaching - caching state 3 09:03:16 T:139644083632400 M:609050624 DEBUG: CDVDPlayer::SetCaching - caching state 0 09:03:16 T:139644083632400 M:609050624 NOTICE: CDVDPlayer::OnExit() 09:03:16 T:139644083632400 M:609050624 NOTICE: DVDPlayer: eof, waiting for queues to empty 09:03:16 T:139644083632400 M:609050624 NOTICE: DVDPlayer: closing audio stream 09:03:16 T:139644083632400 M:609050624 NOTICE: Closing audio stream 09:03:16 T:139644083632400 M:609050624 NOTICE: Waiting for audio thread to exit 09:03:16 T:139643845749008 M:609050624 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:16 T:139643845749008 M:609050624 NOTICE: thread end: CDVDPlayerAudio::OnExit() 09:03:16 T:139643845749008 M:609050624 DEBUG: Thread 139643845749008 terminating 09:03:16 T:139644083632400 M:609050624 NOTICE: Closing audio device 09:03:16 T:139644083632400 M:609050624 DEBUG: SetActiveDevice - SetActiveDevice from 2 to 1 09:03:16 T:139644083632400 M:609050624 DEBUG: RemoveActiveDevice - Removing device 2 09:03:16 T:139644083632400 M:609050624 DEBUG: CGUIAudioManager::Initialize 09:03:16 T:139644083632400 M:609050624 NOTICE: Deleting audio codec 09:03:16 T:139644083632400 M:609050624 NOTICE: DVDPlayer: closing video stream 09:03:16 T:139644083632400 M:609050624 NOTICE: Closing video stream 09:03:16 T:139644083632400 M:609050624 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 09:03:16 T:139643854141712 M:609050624 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:16 T:139644083632400 M:609050624 NOTICE: waiting for video thread to exit 09:03:16 T:139643854141712 M:609050624 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 09:03:16 T:139643854141712 M:609050624 NOTICE: thread end: video_thread 09:03:16 T:139643854141712 M:609050624 DEBUG: Thread 139643854141712 terminating 09:03:16 T:139644083632400 M:609050624 NOTICE: deleting video codec 09:03:16 T:139644083632400 M:609050624 NOTICE: CDVDPlayer::OnExit() deleting demuxer 09:03:16 T:139644083632400 M:609050624 NOTICE: CDVDPlayer::OnExit() deleting input stream 09:03:16 T:139644083632400 M:609050624 DEBUG: CAnnouncementManager - Announcement: PlaybackEnded from xbmc 09:03:16 T:139644083632400 M:609050624 DEBUG: OnPlayBackEnded - Playback has finished 09:03:16 T:139644083632400 M:609050624 DEBUG: Thread 139644083632400 terminating 09:03:16 T:139644619995184 M:610082816 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 09:03:16 T:139644619995184 M:610082816 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 09:03:16 T:139644619995184 M:610082816 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 09:03:16 T:139644619995184 M:610082816 DEBUG: ------ Window Init (MyTV.xml) ------ 09:03:16 T:139644619995184 M:610082816 INFO: Loading skin file: MyTV.xml 09:03:16 T:139644619995184 M:610082816 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:610082816 DEBUG: Load MyTV.xml: 37.38ms 09:03:16 T:139644619995184 M:610082816 DEBUG: Alloc resources: 41.24ms (39.62 ms skin load) 09:03:16 T:139644619995184 M:610082816 DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/) 09:03:16 T:139644619995184 M:610082816 DEBUG: ParentPath = [pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/] 09:03:16 T:139643968293136 M:610082816 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ 09:03:16 T:139643968293136 M:610082816 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe) 09:03:16 T:139643968293136 M:610082816 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ succeeded 09:03:16 T:139643968293136 M:610082816 DEBUG: CGetDirectory::OnJobComplete called 09:03:16 T:139644619995184 M:610082816 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:610082816 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:610082816 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:610082816 DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/) 09:03:16 T:139644619995184 M:610082816 DEBUG: ParentPath = [pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/] 09:03:16 T:139643976685840 M:610082816 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ 09:03:16 T:139643976685840 M:610082816 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe) 09:03:16 T:139643976685840 M:610082816 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ succeeded 09:03:16 T:139643976685840 M:609955840 DEBUG: CGetDirectory::OnJobComplete called 09:03:16 T:139644619995184 M:609955840 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:609955840 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:609955840 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:16 T:139644619995184 M:609955840 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 09:03:16 T:139644619995184 M:609955840 NOTICE: CDVDPlayer::CloseFile() 09:03:16 T:139644619995184 M:609955840 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 09:03:16 T:139644619995184 M:609955840 NOTICE: DVDPlayer: waiting for threads to exit 09:03:16 T:139644619995184 M:609955840 NOTICE: DVDPlayer: finished waiting 09:03:16 T:139644619995184 M:609955840 DEBUG: LinuxRendererGL: Cleaning up GL resources 09:03:16 T:139644619995184 M:609955840 NOTICE: (VDPAU) Close 09:03:16 T:139644619995184 M:609955840 NOTICE: (VDPAU) FiniVDPAUOutput 09:03:16 T:139644619995184 M:626364416 INFO: GLX: Destroying glPixmap 09:03:16 T:139644619995184 M:626364416 INFO: GLX: Destroying XPixmap 09:03:16 T:139644619995184 M:626364416 INFO: GLX: Destroying glContext 09:03:16 T:139643862534416 M:626745344 DEBUG: CVideoReferenceClock: Cleaning up GLX 09:03:16 T:139643862534416 M:627269632 DEBUG: Thread 139643862534416 terminating 09:03:16 T:139644619995184 M:629731328 DEBUG: SaveFileState - Saving file state for video item stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:16 T:139644619995184 M:629731328 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:17 T:139644619995184 M:629743616 INFO: CheckIdle - Closing session to http://feeds.feedburner.com (easy=0x3ad06d0, multi=0x3769d10) 09:03:17 T:139644619995184 M:629997568 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 0 09:03:17 T:139644619995184 M:629997568 DEBUG: OnKey: 61453 pressed, action is Select 09:03:17 T:139644619995184 M:629997568 DEBUG: new file set audiostream:0 09:03:17 T:139644619995184 M:629997568 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers(/var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts) 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 09:03:17 T:139644619995184 M:629997568 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 09:03:17 T:139644619995184 M:629997568 NOTICE: DVDPlayer: Opening: /var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:17 T:139644619995184 M:629997568 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 09:03:17 T:139643862534416 M:629997568 DEBUG: thread start, auto delete: 0 09:03:17 T:139643862534416 M:629997568 NOTICE: Creating InputStream 09:03:17 T:139643862534416 M:629997568 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles 09:03:17 T:139643862534416 M:629997568 DEBUG: CacheSubtitles: START 09:03:17 T:139643862534416 M:629997568 DEBUG: CacheSubtitles: Checking for common subdirs... 09:03:17 T:139643862534416 M:629997568 DEBUG: CacheSubtitles: Done (time: 0 ms) 09:03:17 T:139643862534416 M:629997568 DEBUG: CacheSubtitles: Searching for subtitles... 09:03:17 T:139643862534416 M:629997568 DEBUG: CacheSubtitles: Done (time: 1 ms) 09:03:17 T:139643862534416 M:629997568 DEBUG: CacheSubtitles: END (total time: 2 ms) 09:03:17 T:139643862534416 M:629997568 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done 09:03:17 T:139643862534416 M:629997568 NOTICE: Creating Demuxer 09:03:17 T:139643862534416 M:629997568 DEBUG: Open - probing detected format [mpegts] 09:03:17 T:139643862534416 M:629997568 DEBUG: Open - av_find_stream_info starting 09:03:17 T:139643862534416 M:629997568 DEBUG: Open - av_find_stream_info finished 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Input #0, mpegts, from '/var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts': 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Duration: 00:25:54.71, start: 94850.075000, bitrate: 6912 kb/s 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Program 132 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Stream #0.0[0x65]: Video: mpeg2video, yuv420p, 720x576 [PAR 64:45 DAR 16:9], 15000 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Stream #0.1[0x66](deu): Audio: mp2, 48000 Hz, 2 channels, s16, 256 kb/s 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Stream #0.2[0x67](2ch): Audio: mp2, 48000 Hz, 2 channels, s16, 192 kb/s 09:03:17 T:139643862534416 M:629997568 INFO: ffmpeg[5ED24910]: Stream #0.3[0x6a](deu): Audio: ac3, 48000 Hz, stereo, s16, 448 kb/s 09:03:17 T:139643862534416 M:629997568 NOTICE: Opening video stream: 0 source: 256 09:03:17 T:139643862534416 M:629997568 NOTICE: Creating video codec with codec id: 2 09:03:17 T:139643862534416 M:629997568 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no VDPAU:yes VAAPI:no 09:03:17 T:139643862534416 M:629997568 DEBUG: FactoryCodec - Video: - Opening 09:03:17 T:139643862534416 M:629997568 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(720x576, 2) 09:03:18 T:139643862534416 M:629735424 NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000 09:03:18 T:139643862534416 M:629735424 NOTICE: VDPAU Decoder capabilities: 09:03:18 T:139643862534416 M:629735424 NOTICE: name level macbs width height 09:03:18 T:139643862534416 M:629735424 NOTICE: ------------------------------------ 09:03:18 T:139643862534416 M:629735424 NOTICE: MPEG1 0 8192 2048 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: MPEG2_MAIN 3 8192 2048 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: H264_MAIN 41 8190 2032 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: H264_HIGH 41 8190 2032 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: VC1_SIMPLE 1 8190 2048 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: VC1_MAIN 2 8190 2048 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: VC1_ADVANCED 4 8190 2048 2048 09:03:18 T:139643862534416 M:629735424 NOTICE: ------------------------------------ 09:03:18 T:139643862534416 M:629735424 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION 09:03:18 T:139643862534416 M:629735424 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS 09:03:18 T:139643862534416 M:629735424 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL 09:03:18 T:139643862534416 M:629735424 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL 09:03:18 T:139643862534416 M:629735424 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE 09:03:18 T:139643862534416 M:629735424 NOTICE: Creating 720x576 pixmap 09:03:18 T:139643862534416 M:629735424 DEBUG: Found 6 fbconfigs. 09:03:18 T:139643862534416 M:629735424 DEBUG: Using fbconfig index 0. 09:03:18 T:139643862534416 M:629735424 INFO: GLX: Creating Pixmap context 09:03:18 T:139643862534416 M:627765248 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-1/2 video (VDPAU acceleration) 09:03:18 T:139643862534416 M:627765248 DEBUG: FactoryCodec - Video: ff-mpegvideo_vdpau-vdpau - Opened 09:03:18 T:139644083632400 M:627765248 DEBUG: thread start, auto delete: 0 09:03:18 T:139644083632400 M:627765248 DEBUG: CVideoReferenceClock: Setting up GLX 09:03:18 T:139644619995184 M:627318784 DEBUG: ------ Window Init (DialogBusy.xml) ------ 09:03:18 T:139644619995184 M:627318784 DEBUG: Alloc resources: 0.01ms (0.00 ms skin load) 09:03:18 T:139644619995184 M:627318784 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 09:03:18 T:139644619995184 M:627318784 DEBUG: Alloc resources: 0.12ms (0.00 ms skin load) 09:03:18 T:139644083632400 M:625762304 DEBUG: CVideoReferenceClock: output of nvidia-settings -nt -q RefreshRate 2>&1: 50,00 Hz 09:03:18 T:139644083632400 M:625762304 DEBUG: CVideoReferenceClock: Detected refreshrate by nvidia-settings: 50.000000 hertz, rounding to 50 hertz 09:03:18 T:139643862534416 M:625762304 NOTICE: Creating video thread 09:03:18 T:139643862534416 M:625762304 NOTICE: Opening audio stream: 1 source: 256 09:03:18 T:139643854141712 M:625762304 DEBUG: thread start, auto delete: 0 09:03:18 T:139643862534416 M:625737728 NOTICE: Finding audio codec for: 86016 09:03:18 T:139643862534416 M:625737728 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening 09:03:18 T:139643862534416 M:625737728 ERROR: CDVDAudioCodecPassthroughFFmpeg::Open - FFmpeg SPDIF muxer does not support this codec 09:03:18 T:139643862534416 M:625737728 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Failed 09:03:18 T:139643862534416 M:625737728 DEBUG: FactoryCodec - Audio: libmad - Opening 09:03:18 T:139643862534416 M:625737728 DEBUG: FactoryCodec - Audio: libmad - Opened 09:03:18 T:139643862534416 M:625737728 NOTICE: Creating audio thread 09:03:18 T:139644217850128 M:625737728 DEBUG: thread start, auto delete: 0 09:03:18 T:139644217850128 M:625737728 NOTICE: running thread: CDVDPlayerAudio::Process() 09:03:18 T:139643862534416 M:625737728 DEBUG: ReadEditDecisionLists - Setting frames per second to 25.0 assuming PAL (interlaced) 09:03:18 T:139643862534416 M:625737728 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:18 T:139643862534416 M:625737728 DEBUG: CDVDPlayer::SetCaching - caching state 2 09:03:18 T:139644217850128 M:625737728 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(50977.777777, 0) 09:03:18 T:139644217850128 M:625737728 NOTICE: Creating audio device with codec id: 86016, channels: 2, sample rate: 48000, no pass-through 09:03:18 T:139644217850128 M:625737728 INFO: CPCMRemap: Channel Layout: 5.1 09:03:18 T:139644217850128 M:625737728 INFO: CPCMRemap: I channel map: FL,FR 09:03:18 T:139644217850128 M:625737728 INFO: CPCMRemap: O channel map: FL,FR,BL,BR,CE,LFE 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: Downmix normalization is disabled 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: FL = FL(1.000000*) 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: FR = FR(1.000000*) 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: BL = 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: BR = 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: CE = 09:03:18 T:139644217850128 M:625737728 DEBUG: CPCMRemap: LFE = 09:03:18 T:139644217850128 M:625737728 DEBUG: CALSADirectSound::CALSADirectSound - Requested channels changed from 2 to 6 09:03:18 T:139644217850128 M:625737728 DEBUG: CALSADirectSound::CALSADirectSound - Channels: 6 - SampleRate: 48000 - SampleBit: 16 - Resample false - Codec PCM - IsMusic false - IsPassthrough false - audioDevice: xbmc 09:03:18 T:139644217850128 M:625737728 DEBUG: RemoveActiveDevice - Removing device 1 09:03:18 T:139644217850128 M:625737728 DEBUG: CGUIAudioManager::DeInitialize 09:03:18 T:139643854141712 M:625737728 DEBUG: LinuxRendererGL: Cleaning up GL resources 09:03:18 T:139643854141712 M:625737728 NOTICE: running thread: video_thread 09:03:18 T:139643854141712 M:625737728 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:18 T:139643854141712 M:625737728 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(117266.666668, 1) 09:03:18 T:139643854141712 M:624984064 NOTICE: (VDPAU) screenWidth:720 vidWidth:720 09:03:18 T:139643854141712 M:624984064 NOTICE: (VDPAU) screenHeight:576 vidHeight:576 09:03:18 T:139644217850128 M:618127360 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2 09:03:18 T:139644217850128 M:618127360 DEBUG: RemoveActiveDevice - Removing device 0 09:03:18 T:139644217850128 M:618127360 DEBUG: Initialize - using alsa device xbmc 09:03:18 T:139644619995184 M:617873408 DEBUG: CAnnouncementManager - Announcement: PlaybackStarted from xbmc 09:03:18 T:139644619995184 M:617873408 DEBUG: OnPlayBackStarted - Playback has started 09:03:18 T:139644217850128 M:611713024 DEBUG: CALSADirectSound::Initialize - packet size:6144, packet count:16, buffer size:8192 09:03:18 T:139643854141712 M:611332096 NOTICE: (VDPAU) Total Output Surfaces Available: 4 of a max (tmp: 4 const: 4) 09:03:18 T:139643854141712 M:610418688 NOTICE: (VDPAU) Creating the video mixer 09:03:18 T:139644217850128 M:606355456 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 09:03:18 T:139643854141712 M:605593600 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 405 09:03:18 T:139643854141712 M:605593600 DEBUG: OutputPicture - change configuration. 720x576. framerate: 25.00 09:03:18 T:139643854141712 M:605593600 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (12) 09:03:18 T:139643854141712 M:605593600 WARNING: Upscale: possible given resolution increase. 09:03:18 T:139643854141712 M:605593600 WARNING: Upscale: selected algorithm 8 09:03:18 T:139643862534416 M:605466624 DEBUG: CDVDPlayer::HandleMessages - player started 1 09:03:18 T:139643862534416 M:605466624 DEBUG: CDVDPlayer::HandleMessages - player started 2 09:03:18 T:139643862534416 M:605466624 DEBUG: CDVDPlayer::SetCaching - caching state 3 09:03:18 T:139643862534416 M:605466624 DEBUG: CDVDPlayer::SetCaching - caching state 0 09:03:18 T:139644217850128 M:605339648 DEBUG: CDVDPlayerAudio:: Discontinuity - was:97266.666668, should be:50977.777777, error:-46288.888891 09:03:18 T:139644619995184 M:604069888 NOTICE: Using GL_TEXTURE_2D 09:03:18 T:139644619995184 M:604069888 DEBUG: GL: Requested render method: 0 09:03:18 T:139644619995184 M:604069888 NOTICE: GL: Using VDPAU render method 09:03:18 T:139644619995184 M:604069888 NOTICE: GL: NPOT texture support detected 09:03:18 T:139644619995184 M:604069888 NOTICE: GL: Using GL_ARB_pixel_buffer_object 09:03:18 T:139644619995184 M:603942912 DEBUG: CGUIInfoManager::SetCurrentMovie(stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts) 09:03:18 T:139644619995184 M:603942912 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:18 T:139644619995184 M:603942912 DEBUG: GetMovieId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idMovie from movie where idFile=24 09:03:18 T:139644619995184 M:603942912 DEBUG: GetEpisodeId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idEpisode from episode where idFile=24 09:03:18 T:139644619995184 M:603942912 DEBUG: GetMusicVideoId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idMVideo from musicvideo where idFile=24 09:03:18 T:139644619995184 M:603942912 DEBUG: Activating window ID: 12005 09:03:18 T:139644619995184 M:603942912 DEBUG: Checking if window ID 12005 is locked. 09:03:18 T:139644619995184 M:603942912 DEBUG: ------ Window Deinit (MyTV.xml) ------ 09:03:18 T:139644619995184 M:603942912 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 09:03:18 T:139644619995184 M:603942912 INFO: Loading skin file: VideoFullScreen.xml 09:03:18 T:139644619995184 M:603942912 DEBUG: Load VideoFullScreen.xml: 4.09ms 09:03:18 T:139644619995184 M:603942912 DEBUG: Alloc resources: 4.66ms (4.36 ms skin load) 09:03:18 T:139644619995184 M:603942912 INFO: Loading skin file: VideoOSD.xml 09:03:18 T:139644619995184 M:603942912 DEBUG: Load VideoOSD.xml: 9.18ms 09:03:18 T:139644619995184 M:603815936 DEBUG: Alloc resources: 3.77ms (0.01 ms skin load) 09:03:18 T:139644619995184 M:603815936 INFO: Loading skin file: VideoOSDSettings.xml 09:03:18 T:139644619995184 M:603815936 DEBUG: Load VideoOSDSettings.xml: 2.50ms 09:03:18 T:139644619995184 M:602800128 DEBUG: Alloc resources: 3.63ms (0.00 ms skin load) 09:03:18 T:139644619995184 M:602800128 INFO: Loading skin file: VideoOSDSettings.xml 09:03:18 T:139644619995184 M:602800128 DEBUG: Load VideoOSDSettings.xml: 2.45ms 09:03:18 T:139644619995184 M:602800128 DEBUG: Alloc resources: 0.16ms (0.00 ms skin load) 09:03:18 T:139644619995184 M:602800128 INFO: Loading skin file: DialogFullScreenInfo.xml 09:03:18 T:139644619995184 M:602800128 DEBUG: Load DialogFullScreenInfo.xml: 4.81ms 09:03:18 T:139644619995184 M:602800128 DEBUG: Alloc resources: 0.38ms (0.00 ms skin load) 09:03:18 T:139644619995184 M:602800128 NOTICE: Created m_glPixmapTexture (11) 09:03:18 T:139644619995184 M:602800128 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 09:03:18 T:139644619995184 M:602800128 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 09:03:19 T:139644619995184 M:602652672 DEBUG: SDLKeyboard: scancode: 41, sym: 102, unicode: 102, modifier: 0 09:03:19 T:139644619995184 M:602652672 DEBUG: OnKey: 61510 pressed, action is FastForward 09:03:19 T:139644619995184 M:602652672 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 09:03:19 T:139644619995184 M:602652672 DEBUG: Alloc resources: 0.11ms (0.00 ms skin load) 09:03:20 T:139644619995184 M:602476544 INFO: CheckIdle - Closing session to http://xoap.weather.com (easy=0x3af71e0, multi=0x3a4c9c0) 09:03:20 T:139644217850128 M:602476544 ERROR: GetDelay - snd_pcm_delay, alsa error: -32 - Datenübergabe unterbrochen (broken pipe) 09:03:20 T:139644619995184 M:602443776 DEBUG: SDLKeyboard: scancode: 41, sym: 102, unicode: 102, modifier: 0 09:03:20 T:139644619995184 M:602443776 DEBUG: OnKey: 61510 pressed, action is FastForward 09:03:21 T:139644619995184 M:601985024 DEBUG: SDLKeyboard: scancode: 41, sym: 102, unicode: 102, modifier: 0 09:03:21 T:139644619995184 M:601985024 DEBUG: OnKey: 61510 pressed, action is FastForward 09:03:21 T:139643862534416 M:600633344 DEBUG: CDVDPlayer::Process - Seeking to catch up 09:03:21 T:139643862534416 M:600633344 DEBUG: CDVDPlayer::SetCaching - caching state 2 09:03:21 T:139643862534416 M:600633344 DEBUG: demuxer seek to: 12190 09:03:21 T:139644217850128 M:600633344 ERROR: Pause - pcm_pause, alsa error: -77 - Die Dateizugriffsnummer ist in schlechter Verfassung 09:03:21 T:139644217850128 M:600633344 WARNING: CALSADirectSound::CALSADirectSound - device is not able to pause playback, will flush and prefix with 0 frames 09:03:21 T:139643862534416 M:600633344 DEBUG: SeekTime - seek ended up on time 14917 09:03:21 T:139643862534416 M:600633344 DEBUG: demuxer seek to: 12190, success 09:03:21 T:139643862534416 M:602411008 WARNING: CDVDMessageQueue(teletext)::Put MSGQ_NOT_INITIALIZED 09:03:21 T:139644217850128 M:602411008 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:21 T:139643862534416 M:602411008 DEBUG: CDVDPlayer::HandleMessages - player started 2 09:03:21 T:139643862534416 M:602411008 DEBUG: CDVDPlayer::HandleMessages - player started 1 09:03:21 T:139643862534416 M:602411008 DEBUG: CDVDPlayer::SetCaching - caching state 3 09:03:21 T:139643862534416 M:602411008 DEBUG: CDVDPlayer::SetCaching - caching state 0 09:03:21 T:139643862534416 M:602411008 NOTICE: CDVDPlayer::OnExit() 09:03:21 T:139643862534416 M:602411008 NOTICE: DVDPlayer: eof, waiting for queues to empty 09:03:21 T:139643862534416 M:602411008 NOTICE: DVDPlayer: closing audio stream 09:03:21 T:139643862534416 M:602411008 NOTICE: Closing audio stream 09:03:21 T:139643862534416 M:602411008 NOTICE: Waiting for audio thread to exit 09:03:21 T:139644217850128 M:602411008 DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread 09:03:21 T:139644217850128 M:602411008 NOTICE: thread end: CDVDPlayerAudio::OnExit() 09:03:21 T:139644217850128 M:602411008 DEBUG: Thread 139644217850128 terminating 09:03:21 T:139643862534416 M:602411008 NOTICE: Closing audio device 09:03:21 T:139643854141712 M:602411008 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:21 T:139643862534416 M:602411008 DEBUG: SetActiveDevice - SetActiveDevice from 2 to 1 09:03:21 T:139643862534416 M:602411008 DEBUG: RemoveActiveDevice - Removing device 2 09:03:21 T:139643862534416 M:602411008 DEBUG: CGUIAudioManager::Initialize 09:03:21 T:139643862534416 M:602411008 NOTICE: Deleting audio codec 09:03:21 T:139643862534416 M:602411008 NOTICE: DVDPlayer: closing video stream 09:03:21 T:139643862534416 M:602411008 NOTICE: Closing video stream 09:03:21 T:139643862534416 M:602411008 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 09:03:21 T:139643862534416 M:602411008 NOTICE: waiting for video thread to exit 09:03:21 T:139643854141712 M:602411008 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:21 T:139643854141712 M:602411008 NOTICE: thread end: video_thread 09:03:21 T:139643854141712 M:602411008 DEBUG: Thread 139643854141712 terminating 09:03:21 T:139643862534416 M:602411008 NOTICE: deleting video codec 09:03:21 T:139643862534416 M:602411008 NOTICE: CDVDPlayer::OnExit() deleting demuxer 09:03:21 T:139643862534416 M:602411008 NOTICE: CDVDPlayer::OnExit() deleting input stream 09:03:21 T:139643862534416 M:602411008 DEBUG: CAnnouncementManager - Announcement: PlaybackEnded from xbmc 09:03:21 T:139643862534416 M:602411008 DEBUG: OnPlayBackEnded - Playback has finished 09:03:21 T:139643862534416 M:602411008 DEBUG: Thread 139643862534416 terminating 09:03:21 T:139644619995184 M:603467776 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 09:03:21 T:139644619995184 M:603467776 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 09:03:21 T:139644619995184 M:603275264 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 09:03:21 T:139644619995184 M:603275264 DEBUG: ------ Window Init (MyTV.xml) ------ 09:03:21 T:139644619995184 M:603275264 INFO: Loading skin file: MyTV.xml 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:603279360 DEBUG: Load MyTV.xml: 37.79ms 09:03:21 T:139644619995184 M:603279360 DEBUG: Alloc resources: 41.70ms (40.09 ms skin load) 09:03:21 T:139644619995184 M:603279360 DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/) 09:03:21 T:139644619995184 M:603279360 DEBUG: ParentPath = [pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/] 09:03:21 T:139643987847440 M:603279360 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ 09:03:21 T:139643987847440 M:603279360 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe) 09:03:21 T:139643987847440 M:603279360 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ succeeded 09:03:21 T:139643987847440 M:603279360 DEBUG: CGetDirectory::OnJobComplete called 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:603279360 DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/) 09:03:21 T:139644619995184 M:603279360 DEBUG: ParentPath = [pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/] 09:03:21 T:139643968293136 M:603279360 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ 09:03:21 T:139643968293136 M:603279360 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe) 09:03:21 T:139643968293136 M:603279360 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ succeeded 09:03:21 T:139643968293136 M:603279360 DEBUG: CGetDirectory::OnJobComplete called 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:603279360 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:21 T:139644619995184 M:602263552 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 09:03:21 T:139644619995184 M:602263552 NOTICE: CDVDPlayer::CloseFile() 09:03:21 T:139644619995184 M:602263552 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 09:03:21 T:139644619995184 M:602263552 NOTICE: DVDPlayer: waiting for threads to exit 09:03:21 T:139644619995184 M:602263552 NOTICE: DVDPlayer: finished waiting 09:03:21 T:139644619995184 M:602263552 DEBUG: LinuxRendererGL: Cleaning up GL resources 09:03:21 T:139644619995184 M:602263552 NOTICE: (VDPAU) Close 09:03:21 T:139644619995184 M:602263552 NOTICE: (VDPAU) FiniVDPAUOutput 09:03:21 T:139644619995184 M:617349120 INFO: GLX: Destroying glPixmap 09:03:21 T:139644619995184 M:617349120 INFO: GLX: Destroying XPixmap 09:03:21 T:139644619995184 M:617349120 INFO: GLX: Destroying glContext 09:03:21 T:139644083632400 M:617254912 DEBUG: CVideoReferenceClock: Cleaning up GLX 09:03:21 T:139644083632400 M:617381888 DEBUG: Thread 139644083632400 terminating 09:03:21 T:139643976685840 M:615256064 DEBUG: DoWork - took 118 ms to load special://skin/backgrounds/tv.jpg 09:03:22 T:139644619995184 M:621740032 DEBUG: SaveFileState - Saving file state for video item stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:22 T:139644619995184 M:621740032 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:23 T:139644619995184 M:622063616 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 0 09:03:23 T:139644619995184 M:622063616 DEBUG: OnKey: 61453 pressed, action is Select 09:03:23 T:139644619995184 M:622063616 DEBUG: new file set audiostream:0 09:03:23 T:139644619995184 M:622063616 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers(/var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts) 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 09:03:23 T:139644619995184 M:622063616 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 09:03:23 T:139644619995184 M:622063616 NOTICE: DVDPlayer: Opening: /var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:23 T:139644619995184 M:622063616 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 09:03:23 T:139644083632400 M:622063616 DEBUG: thread start, auto delete: 0 09:03:23 T:139644083632400 M:622063616 NOTICE: Creating InputStream 09:03:23 T:139644083632400 M:622063616 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles 09:03:23 T:139644083632400 M:622063616 DEBUG: CacheSubtitles: START 09:03:23 T:139644083632400 M:622063616 DEBUG: CacheSubtitles: Checking for common subdirs... 09:03:23 T:139644083632400 M:622063616 DEBUG: CacheSubtitles: Done (time: 1 ms) 09:03:23 T:139644083632400 M:622063616 DEBUG: CacheSubtitles: Searching for subtitles... 09:03:23 T:139644083632400 M:622063616 DEBUG: CacheSubtitles: Done (time: 0 ms) 09:03:23 T:139644083632400 M:622063616 DEBUG: CacheSubtitles: END (total time: 2 ms) 09:03:23 T:139644083632400 M:622063616 INFO: CDVDFactorySubtitle::GetSubtitles, searching subtitles done 09:03:23 T:139644083632400 M:622063616 NOTICE: Creating Demuxer 09:03:23 T:139644083632400 M:622063616 DEBUG: Open - probing detected format [mpegts] 09:03:23 T:139644083632400 M:622063616 DEBUG: Open - av_find_stream_info starting 09:03:23 T:139644083632400 M:622063616 DEBUG: Open - av_find_stream_info finished 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Input #0, mpegts, from '/var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts': 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Duration: 00:25:54.71, start: 94850.075000, bitrate: 6912 kb/s 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Program 132 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Stream #0.0[0x65]: Video: mpeg2video, yuv420p, 720x576 [PAR 64:45 DAR 16:9], 15000 kb/s, 25 fps, 25 tbr, 90k tbn, 50 tbc 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Stream #0.1[0x66](deu): Audio: mp2, 48000 Hz, 2 channels, s16, 256 kb/s 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Stream #0.2[0x67](2ch): Audio: mp2, 48000 Hz, 2 channels, s16, 192 kb/s 09:03:23 T:139644083632400 M:622063616 INFO: ffmpeg[6BFFF910]: Stream #0.3[0x6a](deu): Audio: ac3, 48000 Hz, stereo, s16, 448 kb/s 09:03:23 T:139644083632400 M:622063616 NOTICE: Opening video stream: 0 source: 256 09:03:23 T:139644083632400 M:622063616 NOTICE: Creating video codec with codec id: 2 09:03:23 T:139644083632400 M:622063616 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no VDPAU:yes VAAPI:no 09:03:23 T:139644083632400 M:622063616 DEBUG: FactoryCodec - Video: - Opening 09:03:23 T:139644083632400 M:622063616 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(720x576, 2) 09:03:23 T:139644083632400 M:621481984 NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000 09:03:23 T:139644083632400 M:621481984 NOTICE: VDPAU Decoder capabilities: 09:03:23 T:139644083632400 M:621481984 NOTICE: name level macbs width height 09:03:23 T:139644083632400 M:621481984 NOTICE: ------------------------------------ 09:03:23 T:139644083632400 M:621481984 NOTICE: MPEG1 0 8192 2048 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: MPEG2_MAIN 3 8192 2048 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: H264_MAIN 41 8190 2032 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: H264_HIGH 41 8190 2032 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: VC1_SIMPLE 1 8190 2048 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: VC1_MAIN 2 8190 2048 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: VC1_ADVANCED 4 8190 2048 2048 09:03:23 T:139644083632400 M:621481984 NOTICE: ------------------------------------ 09:03:23 T:139644083632400 M:621481984 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION 09:03:23 T:139644083632400 M:621481984 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS 09:03:23 T:139644083632400 M:621481984 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL 09:03:23 T:139644083632400 M:621481984 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL 09:03:23 T:139644083632400 M:621481984 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE 09:03:23 T:139644083632400 M:621481984 NOTICE: Creating 720x576 pixmap 09:03:23 T:139644083632400 M:621481984 DEBUG: Found 6 fbconfigs. 09:03:23 T:139644083632400 M:621481984 DEBUG: Using fbconfig index 0. 09:03:23 T:139644083632400 M:621481984 INFO: GLX: Creating Pixmap context 09:03:23 T:139644083632400 M:620101632 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-1/2 video (VDPAU acceleration) 09:03:23 T:139644083632400 M:620101632 DEBUG: FactoryCodec - Video: ff-mpegvideo_vdpau-vdpau - Opened 09:03:23 T:139643862534416 M:620101632 DEBUG: thread start, auto delete: 0 09:03:23 T:139643862534416 M:620101632 DEBUG: CVideoReferenceClock: Setting up GLX 09:03:23 T:139644619995184 M:620101632 DEBUG: ------ Window Init (DialogBusy.xml) ------ 09:03:23 T:139644619995184 M:620101632 DEBUG: Alloc resources: 0.01ms (0.00 ms skin load) 09:03:23 T:139644619995184 M:620101632 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 09:03:23 T:139644619995184 M:620101632 DEBUG: Alloc resources: 0.11ms (0.00 ms skin load) 09:03:23 T:139643862534416 M:617639936 DEBUG: CVideoReferenceClock: output of nvidia-settings -nt -q RefreshRate 2>&1: 50,00 Hz 09:03:23 T:139643862534416 M:617639936 DEBUG: CVideoReferenceClock: Detected refreshrate by nvidia-settings: 50.000000 hertz, rounding to 50 hertz 09:03:23 T:139644083632400 M:617639936 NOTICE: Creating video thread 09:03:23 T:139644083632400 M:617639936 NOTICE: Opening audio stream: 1 source: 256 09:03:23 T:139643854141712 M:617639936 DEBUG: thread start, auto delete: 0 09:03:23 T:139644083632400 M:617639936 NOTICE: Finding audio codec for: 86016 09:03:23 T:139644083632400 M:617639936 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening 09:03:23 T:139644083632400 M:617639936 ERROR: CDVDAudioCodecPassthroughFFmpeg::Open - FFmpeg SPDIF muxer does not support this codec 09:03:23 T:139644083632400 M:617639936 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Failed 09:03:23 T:139644083632400 M:617639936 DEBUG: FactoryCodec - Audio: libmad - Opening 09:03:23 T:139644083632400 M:617639936 DEBUG: FactoryCodec - Audio: libmad - Opened 09:03:23 T:139644083632400 M:617639936 NOTICE: Creating audio thread 09:03:23 T:139643845749008 M:617639936 DEBUG: thread start, auto delete: 0 09:03:23 T:139643845749008 M:617639936 NOTICE: running thread: CDVDPlayerAudio::Process() 09:03:23 T:139644083632400 M:617639936 DEBUG: ReadEditDecisionLists - Setting frames per second to 25.0 assuming PAL (interlaced) 09:03:23 T:139644083632400 M:617639936 DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: /var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:23 T:139644083632400 M:617639936 DEBUG: CDVDPlayer::SetCaching - caching state 2 09:03:23 T:139643845749008 M:617639936 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(50977.777777, 0) 09:03:23 T:139643845749008 M:617639936 NOTICE: Creating audio device with codec id: 86016, channels: 2, sample rate: 48000, no pass-through 09:03:23 T:139643845749008 M:617639936 INFO: CPCMRemap: Channel Layout: 5.1 09:03:23 T:139643845749008 M:617639936 INFO: CPCMRemap: I channel map: FL,FR 09:03:23 T:139643845749008 M:617639936 INFO: CPCMRemap: O channel map: FL,FR,BL,BR,CE,LFE 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: Downmix normalization is disabled 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: FL = FL(1.000000*) 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: FR = FR(1.000000*) 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: BL = 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: BR = 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: CE = 09:03:23 T:139643845749008 M:617639936 DEBUG: CPCMRemap: LFE = 09:03:23 T:139643845749008 M:617639936 DEBUG: CALSADirectSound::CALSADirectSound - Requested channels changed from 2 to 6 09:03:23 T:139643845749008 M:617639936 DEBUG: CALSADirectSound::CALSADirectSound - Channels: 6 - SampleRate: 48000 - SampleBit: 16 - Resample false - Codec PCM - IsMusic false - IsPassthrough false - audioDevice: xbmc 09:03:23 T:139643845749008 M:617639936 DEBUG: RemoveActiveDevice - Removing device 1 09:03:23 T:139643845749008 M:617639936 DEBUG: CGUIAudioManager::DeInitialize 09:03:23 T:139643854141712 M:617639936 DEBUG: LinuxRendererGL: Cleaning up GL resources 09:03:23 T:139643854141712 M:617639936 NOTICE: running thread: video_thread 09:03:23 T:139643854141712 M:617639936 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:23 T:139643854141712 M:617639936 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(117266.666668, 1) 09:03:23 T:139643854141712 M:617226240 NOTICE: (VDPAU) screenWidth:720 vidWidth:720 09:03:23 T:139643854141712 M:617226240 NOTICE: (VDPAU) screenHeight:576 vidHeight:576 09:03:23 T:139643845749008 M:608464896 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2 09:03:23 T:139643845749008 M:608464896 DEBUG: RemoveActiveDevice - Removing device 0 09:03:23 T:139643845749008 M:608464896 DEBUG: Initialize - using alsa device xbmc 09:03:23 T:139644619995184 M:608464896 DEBUG: CAnnouncementManager - Announcement: PlaybackStarted from xbmc 09:03:23 T:139644619995184 M:608464896 DEBUG: OnPlayBackStarted - Playback has started 09:03:23 T:139643854141712 M:608464896 NOTICE: (VDPAU) Total Output Surfaces Available: 4 of a max (tmp: 4 const: 4) 09:03:23 T:139643854141712 M:607813632 NOTICE: (VDPAU) Creating the video mixer 09:03:23 T:139643854141712 M:603262976 NOTICE: fps: 25.000000, pwidth: 720, pheight: 576, dwidth: 720, dheight: 405 09:03:23 T:139643854141712 M:603262976 DEBUG: OutputPicture - change configuration. 720x576. framerate: 25.00 09:03:23 T:139643854141712 M:603262976 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (12) 09:03:23 T:139643854141712 M:603262976 WARNING: Upscale: possible given resolution increase. 09:03:23 T:139643854141712 M:603262976 WARNING: Upscale: selected algorithm 8 09:03:23 T:139643845749008 M:603262976 DEBUG: CALSADirectSound::Initialize - packet size:6144, packet count:16, buffer size:8192 09:03:23 T:139644083632400 M:603262976 DEBUG: CDVDPlayer::HandleMessages - player started 2 09:03:23 T:139643845749008 M:603262976 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 09:03:23 T:139644619995184 M:603262976 NOTICE: Using GL_TEXTURE_2D 09:03:23 T:139644619995184 M:603262976 DEBUG: GL: Requested render method: 0 09:03:23 T:139644619995184 M:603262976 NOTICE: GL: Using VDPAU render method 09:03:23 T:139644619995184 M:603262976 NOTICE: GL: NPOT texture support detected 09:03:23 T:139644619995184 M:603262976 NOTICE: GL: Using GL_ARB_pixel_buffer_object 09:03:23 T:139644083632400 M:603136000 DEBUG: CDVDPlayer::HandleMessages - player started 1 09:03:23 T:139644083632400 M:603136000 DEBUG: CDVDPlayer::SetCaching - caching state 3 09:03:23 T:139644083632400 M:603136000 DEBUG: CDVDPlayer::SetCaching - caching state 0 09:03:23 T:139643845749008 M:603136000 DEBUG: CDVDPlayerAudio:: Discontinuity - was:97266.666668, should be:50977.777777, error:-46288.888891 09:03:23 T:139644619995184 M:603136000 DEBUG: CGUIInfoManager::SetCurrentMovie(stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts) 09:03:23 T:139644619995184 M:603136000 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:23 T:139644619995184 M:603136000 DEBUG: GetMovieId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idMovie from movie where idFile=24 09:03:23 T:139644619995184 M:603136000 DEBUG: GetEpisodeId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idEpisode from episode where idFile=24 09:03:23 T:139644619995184 M:603009024 DEBUG: GetMusicVideoId (stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts), query = select idMVideo from musicvideo where idFile=24 09:03:23 T:139644619995184 M:602501120 DEBUG: Activating window ID: 12005 09:03:23 T:139644619995184 M:602374144 DEBUG: Checking if window ID 12005 is locked. 09:03:23 T:139644619995184 M:602374144 DEBUG: ------ Window Deinit (MyTV.xml) ------ 09:03:23 T:139644619995184 M:602374144 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 09:03:23 T:139644619995184 M:602374144 INFO: Loading skin file: VideoFullScreen.xml 09:03:23 T:139644619995184 M:602374144 DEBUG: Load VideoFullScreen.xml: 4.52ms 09:03:23 T:139644619995184 M:602374144 DEBUG: Alloc resources: 5.11ms (4.85 ms skin load) 09:03:23 T:139644619995184 M:602374144 INFO: Loading skin file: VideoOSD.xml 09:03:23 T:139644619995184 M:602374144 DEBUG: Load VideoOSD.xml: 8.67ms 09:03:23 T:139644619995184 M:601993216 DEBUG: Alloc resources: 3.39ms (0.01 ms skin load) 09:03:23 T:139644619995184 M:601993216 INFO: Loading skin file: VideoOSDSettings.xml 09:03:23 T:139644619995184 M:601993216 DEBUG: Load VideoOSDSettings.xml: 3.09ms 09:03:23 T:139644619995184 M:600977408 DEBUG: Alloc resources: 3.58ms (0.00 ms skin load) 09:03:23 T:139644619995184 M:600977408 INFO: Loading skin file: VideoOSDSettings.xml 09:03:23 T:139644619995184 M:600977408 DEBUG: Load VideoOSDSettings.xml: 2.92ms 09:03:23 T:139644619995184 M:600977408 DEBUG: Alloc resources: 0.14ms (0.00 ms skin load) 09:03:23 T:139644619995184 M:600977408 INFO: Loading skin file: DialogFullScreenInfo.xml 09:03:23 T:139644619995184 M:600977408 DEBUG: Load DialogFullScreenInfo.xml: 4.38ms 09:03:23 T:139644619995184 M:600977408 DEBUG: Alloc resources: 0.41ms (0.00 ms skin load) 09:03:23 T:139644619995184 M:600977408 NOTICE: Created m_glPixmapTexture (18) 09:03:23 T:139644619995184 M:600977408 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 09:03:23 T:139644619995184 M:600977408 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 09:03:24 T:139643845749008 M:601116672 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1070977.777777, should be:1081656.597226, error:10678.819449 09:03:25 T:139644619995184 M:601116672 DEBUG: SDLKeyboard: scancode: 19, sym: 48, unicode: 48, modifier: 0 09:03:25 T:139644619995184 M:601116672 DEBUG: OnKey: 61536 pressed, action is Number0 09:03:25 T:139644619995184 M:601116672 DEBUG: SDLKeyboard: scancode: 19, sym: 48, unicode: 48, modifier: 0 09:03:25 T:139644619995184 M:601116672 DEBUG: OnKey: 61536 pressed, action is Number0 09:03:25 T:139643854141712 M:601120768 DEBUG: CPullupCorrection: detected pattern of length 1: 20000.00 09:03:25 T:139644619995184 M:601120768 DEBUG: SDLKeyboard: scancode: 10, sym: 49, unicode: 49, modifier: 0 09:03:25 T:139644619995184 M:601120768 DEBUG: OnKey: 61537 pressed, action is Number1 09:03:26 T:139644619995184 M:601120768 DEBUG: SDLKeyboard: scancode: 19, sym: 48, unicode: 48, modifier: 0 09:03:26 T:139644619995184 M:601120768 DEBUG: OnKey: 61536 pressed, action is Number0 09:03:26 T:139644083632400 M:601120768 DEBUG: CDVDPlayer::SetCaching - caching state 2 09:03:26 T:139644083632400 M:601120768 DEBUG: demuxer seek to: 600000 09:03:26 T:139644083632400 M:601120768 DEBUG: SeekTime - seek ended up on time 10637 09:03:26 T:139644083632400 M:601120768 DEBUG: demuxer seek to: 600000, success 09:03:26 T:139644083632400 M:601120768 WARNING: CDVDMessageQueue(teletext)::Put MSGQ_NOT_INITIALIZED 09:03:26 T:139644619995184 M:601120768 DEBUG: CAnnouncementManager - Announcement: PlaybackSeek from xbmc 09:03:26 T:139644619995184 M:601120768 DEBUG: OnPlayBackSeek - Playback skip 09:03:26 T:139644619995184 M:601120768 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 09:03:26 T:139644619995184 M:601120768 DEBUG: Alloc resources: 0.11ms (0.00 ms skin load) 09:03:26 T:139643854141712 M:601120768 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:26 T:139644083632400 M:601120768 DEBUG: CDVDPlayer::HandleMessages - player started 1 09:03:26 T:139644083632400 M:601120768 DEBUG: CDVDPlayer::HandleMessages - player started 2 09:03:26 T:139644083632400 M:601120768 DEBUG: CDVDPlayer::SetCaching - caching state 3 09:03:26 T:139643845749008 M:601120768 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:26 T:139644083632400 M:601120768 DEBUG: CDVDPlayer::SetCaching - caching state 0 09:03:26 T:139644083632400 M:601120768 NOTICE: CDVDPlayer::OnExit() 09:03:26 T:139644083632400 M:601120768 NOTICE: DVDPlayer: eof, waiting for queues to empty 09:03:26 T:139644083632400 M:601120768 NOTICE: DVDPlayer: closing audio stream 09:03:26 T:139644083632400 M:601120768 NOTICE: Closing audio stream 09:03:26 T:139644083632400 M:601120768 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 09:03:26 T:139643845749008 M:601120768 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:26 T:139644083632400 M:601120768 NOTICE: Waiting for audio thread to exit 09:03:26 T:139643845749008 M:601120768 DEBUG: CDVDPlayerAudio::Process - Abort received, exiting thread 09:03:26 T:139643845749008 M:601120768 NOTICE: thread end: CDVDPlayerAudio::OnExit() 09:03:26 T:139643845749008 M:601120768 DEBUG: Thread 139643845749008 terminating 09:03:26 T:139644083632400 M:601120768 NOTICE: Closing audio device 09:03:26 T:139644083632400 M:601120768 DEBUG: SetActiveDevice - SetActiveDevice from 2 to 1 09:03:26 T:139644083632400 M:601120768 DEBUG: RemoveActiveDevice - Removing device 2 09:03:26 T:139644083632400 M:601120768 DEBUG: CGUIAudioManager::Initialize 09:03:26 T:139644083632400 M:601133056 NOTICE: Deleting audio codec 09:03:26 T:139644083632400 M:601133056 NOTICE: DVDPlayer: closing video stream 09:03:26 T:139644083632400 M:601133056 NOTICE: Closing video stream 09:03:26 T:139644083632400 M:601133056 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 09:03:26 T:139643854141712 M:601133056 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 09:03:26 T:139644083632400 M:601133056 NOTICE: waiting for video thread to exit 09:03:26 T:139643854141712 M:601133056 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 09:03:26 T:139643854141712 M:601133056 NOTICE: thread end: video_thread 09:03:26 T:139643854141712 M:601133056 DEBUG: Thread 139643854141712 terminating 09:03:26 T:139644083632400 M:601133056 NOTICE: deleting video codec 09:03:26 T:139644083632400 M:601133056 NOTICE: CDVDPlayer::OnExit() deleting demuxer 09:03:26 T:139644083632400 M:601133056 NOTICE: CDVDPlayer::OnExit() deleting input stream 09:03:26 T:139644083632400 M:601133056 DEBUG: CAnnouncementManager - Announcement: PlaybackEnded from xbmc 09:03:26 T:139644083632400 M:601133056 DEBUG: OnPlayBackEnded - Playback has finished 09:03:26 T:139644083632400 M:601133056 DEBUG: Thread 139644083632400 terminating 09:03:26 T:139644619995184 M:602140672 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 09:03:26 T:139644619995184 M:602140672 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 09:03:26 T:139644619995184 M:602030080 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 09:03:26 T:139644619995184 M:602030080 DEBUG: ------ Window Init (MyTV.xml) ------ 09:03:26 T:139644619995184 M:602030080 INFO: Loading skin file: MyTV.xml 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:602030080 DEBUG: Load MyTV.xml: 38.01ms 09:03:26 T:139644619995184 M:602030080 DEBUG: Alloc resources: 41.94ms (40.27 ms skin load) 09:03:26 T:139644619995184 M:602030080 DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/) 09:03:26 T:139644619995184 M:602030080 DEBUG: ParentPath = [pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/] 09:03:26 T:139643987847440 M:602030080 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ 09:03:26 T:139643987847440 M:602030080 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe) 09:03:26 T:139643987847440 M:602030080 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ succeeded 09:03:26 T:139643987847440 M:602030080 DEBUG: CGetDirectory::OnJobComplete called 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:602030080 DEBUG: CGUIMediaWindow::GetDirectory (pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/) 09:03:26 T:139644619995184 M:602030080 DEBUG: ParentPath = [pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/] 09:03:26 T:139643968293136 M:602030080 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ 09:03:26 T:139643968293136 M:602030080 DEBUG: CPVRDirectory::GetDirectory(pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe) 09:03:26 T:139643968293136 M:602030080 DEBUG: CGetDirectory::DoWork retrieving pvr://recordings/client_0001/Verbotene_Liebe/Verbotene_Liebe/ succeeded 09:03:26 T:139643968293136 M:602030080 DEBUG: CGetDirectory::OnJobComplete called 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:602030080 DEBUG: CDatabase: Connecting to database ViewModes at /home/myuser/.xbmc/userdata/Database: 09:03:26 T:139644619995184 M:599236608 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 09:03:26 T:139644619995184 M:600633344 NOTICE: CDVDPlayer::CloseFile() 09:03:26 T:139644619995184 M:600633344 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 09:03:26 T:139644619995184 M:600633344 NOTICE: DVDPlayer: waiting for threads to exit 09:03:26 T:139644619995184 M:600633344 NOTICE: DVDPlayer: finished waiting 09:03:26 T:139644619995184 M:600633344 DEBUG: LinuxRendererGL: Cleaning up GL resources 09:03:26 T:139644619995184 M:600633344 NOTICE: (VDPAU) Close 09:03:26 T:139644619995184 M:600633344 NOTICE: (VDPAU) FiniVDPAUOutput 09:03:26 T:139644619995184 M:615669760 INFO: GLX: Destroying glPixmap 09:03:26 T:139644619995184 M:615669760 INFO: GLX: Destroying XPixmap 09:03:26 T:139644619995184 M:615669760 INFO: GLX: Destroying glContext 09:03:26 T:139643862534416 M:615718912 DEBUG: CVideoReferenceClock: Cleaning up GLX 09:03:26 T:139643862534416 M:616099840 DEBUG: Thread 139643862534416 terminating 09:03:26 T:139643976685840 M:613855232 DEBUG: DoWork - took 111 ms to load special://skin/backgrounds/tv.jpg 09:03:26 T:139644619995184 M:620339200 DEBUG: SaveFileState - Saving file state for video item stack:///var/lib/video.00/Verbotene_Liebe/Verbotene_Liebe/Mon_31.05.2010-18#3A00/2010-05-31.17.58.1-0.rec/00001.ts 09:03:26 T:139644619995184 M:620339200 DEBUG: CDatabase: Connecting to database MyVideos34.db at /home/myuser/.xbmc/userdata/Database: 09:03:28 T:139644619995184 M:620498944 DEBUG: SDLKeyboard: scancode: 9, sym: 27, unicode: 27, modifier: 0 09:03:28 T:139644619995184 M:620498944 DEBUG: OnKey: 61467 pressed, action is PreviousMenu 09:03:28 T:139644619995184 M:620498944 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 09:03:28 T:139644619995184 M:620498944 DEBUG: ------ Window Deinit (MyTV.xml) ------ 09:03:29 T:139644619995184 M:620498944 DEBUG: CGUIWindowManager::PreviousWindow: Activate new