2012-01-08 17:30:13.424 TV: StartTV() -- begin 2012-01-08 17:30:13.424 TV: ctor -- begin 2012-01-08 17:30:13.433 TV: ctor -- end 2012-01-08 17:30:13.433 TV: Init -- begin 2012-01-08 17:30:13.448 TV: DrawUnusedRects() -- begin 2012-01-08 17:30:13.448 TV: DrawUnusedRects() -- end 2012-01-08 17:30:13.475 TV: Init -- end 2012-01-08 17:30:13.476 SendReceiveStringList(MESSAGE,SYSTEM_EVENT PLAY_STARTED HOSTNAME mc1 CHANID 0 STARTTIME 2012-01-08T17:29:13 SENDER mc1) called from UI thread 2012-01-08 17:30:13.477 TV: tv->Playback() -- begin 2012-01-08 17:30:13.485 TV: HandleStateChange(0) -- begin 2012-01-08 17:30:13.485 TV: Attempting to change from None to WatchingVideo 2012-01-08 17:30:13.485 RingBuf(myth://Videos@10.10.10.50:6543/Samples/dyreboern.mpg): OpenFile(myth://Videos@10.10.10.50:6543/Samples/dyreboern.mpg, 2000 ms) 2012-01-08 17:30:13.485 SendReceiveStringList(QUERY_FILE_EXISTS,Samples/dyreboern.mpg...) called from UI thread 2012-01-08 17:30:13.496 TV: StartPlayer(0, WatchingVideo, main) -- begin 2012-01-08 17:30:13.496 TV: Elapsed time since TV constructor was called: 72 ms 2012-01-08 17:30:13.502 FilterManager: filters[adjust] = 0x7f11e40869d0 2012-01-08 17:30:13.503 FilterManager: filters[bobdeint] = 0x7f11e40858e0 2012-01-08 17:30:13.506 FilterManager: filters[crop] = 0x7f11e49b0110 2012-01-08 17:30:13.508 FilterManager: filters[denoise3d] = 0x7f11e49b0ac0 2012-01-08 17:30:13.510 FilterManager: filters[fieldorderdoubleprocessdeint] = 0x7f11e49b1510 2012-01-08 17:30:13.511 FilterManager: filters[forceyv12] = 0x7f11e40994e0 2012-01-08 17:30:13.511 FilterManager: filters[forceyuv422p] = 0x7f11e410fc00 2012-01-08 17:30:13.511 FilterManager: filters[forcergb24] = 0x7f11e40aa8d0 2012-01-08 17:30:13.512 FilterManager: filters[forceargb32] = 0x7f11e40091a0 2012-01-08 17:30:13.514 FilterManager: filters[greedyhdeint] = 0x7f11e49b25b0 2012-01-08 17:30:13.514 FilterManager: filters[greedyhdoubleprocessdeint] = 0x7f11e49b26a0 2012-01-08 17:30:13.515 FilterManager: filters[invert] = 0x7f11e4005e00 2012-01-08 17:30:13.517 FilterManager: filters[ivtc] = 0x7f11e49b34e0 2012-01-08 17:30:13.522 FilterManager: filters[kerneldeint] = 0x7f11e49b3610 2012-01-08 17:30:13.522 FilterManager: filters[kerneldoubleprocessdeint] = 0x7f11e49b1c90 2012-01-08 17:30:13.525 FilterManager: filters[linearblend] = 0x7f11e4085f20 2012-01-08 17:30:13.526 FilterManager: filters[onefield] = 0x7f11e49b44c0 2012-01-08 17:30:13.528 FilterManager: filters[postprocess] = 0x7f11e49b6690 2012-01-08 17:30:13.531 FilterManager: filters[quickdnr] = 0x7f11e49b55f0 2012-01-08 17:30:13.533 FilterManager: filters[yadifdeint] = 0x7f11e49b5580 2012-01-08 17:30:13.533 FilterManager: filters[yadifdoubleprocessdeint] = 0x7f11e49b9030 2012-01-08 17:30:13.590 Launching: ps -ae | grep pulseaudio > /dev/null 2012-01-08 17:30:13.599 PID 5123: launched 2012-01-08 17:30:13.683 PID 5123: exited: status=256, result=1 2012-01-08 17:30:13.797 [mpeg2video @ 0x7f1210b9e6e0]mpeg_decode_postinit() failure 2012-01-08 17:30:13.799 [mpeg2video @ 0x7f1210b9e6e0]mpeg_decode_postinit() failure 2012-01-08 17:30:13.800 [mpeg2video @ 0x7f1210b9e6e0]mpeg_decode_postinit() failure 2012-01-08 17:30:13.801 [mpeg2video @ 0x7f1210b9e6e0]mpeg_decode_postinit() failure 2012-01-08 17:30:13.802 [mpeg2video @ 0x7f1210b9e6e0]mpeg_decode_postinit() failure 2012-01-08 17:30:13.804 [mpeg2video @ 0x7f1210b9e6e0]mpeg_decode_postinit() failure 2012-01-08 17:30:14.079 AFD: Stream #0, has id 0xb54 codec id MPEG2VIDEO, type Video, bitrate 15000000 at 0x7f11e49c7c40 2012-01-08 17:30:14.087 VDP: Accepting: cmp(>= 0 720) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt() 2012-01-08 17:30:14.087 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt() 2012-01-08 17:30:14.087 VDP: LoadBestPreferences(2048x2048, 0) 2012-01-08 17:30:14.087 VDP: LoadBestPreferences(2048x2048, 60) 2012-01-08 17:30:14.088 VDP: LoadBestPreferences(720x576, 60) 2012-01-08 17:30:14.093 VDP: Accepting: cmp(>= 0 720) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt() 2012-01-08 17:30:14.093 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt() 2012-01-08 17:30:14.093 VDP: LoadBestPreferences(2048x2048, 0) 2012-01-08 17:30:14.093 VDP: LoadBestPreferences(2048x2048, 60) 2012-01-08 17:30:14.093 VDP: LoadBestPreferences(720x576, 60) 2012-01-08 17:30:14.094 AFD: Using 1 CPUs for decoding 2012-01-08 17:30:14.094 AFD: InitVideoCodec() 0x7f11e4979220 id(MPEG2VIDEO) type (Video). 2012-01-08 17:30:14.094 AFD: Selected FPS is 25 (avg 31.6667 stream 25 container 90000 estimated 25) 2012-01-08 17:30:14.094 Player(0): detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan 2012-01-08 17:30:14.096 AFD: Using vdpau for video decoding 2012-01-08 17:30:14.097 AFD: Looking for decoder for MPEG2VIDEO 2012-01-08 17:30:14.097 AFD: Opened codec 0x7f11e4979220, id(MPEG2VIDEO) type(Video) 2012-01-08 17:30:14.097 AFD: Stream #1, has id 0xb55 codec id MP2, type Audio, bitrate 192000 at 0x7f11e4979840 2012-01-08 17:30:14.098 AFD: codec MP2 has 2 channels 2012-01-08 17:30:14.098 AFD: Looking for decoder for MP2 2012-01-08 17:30:14.098 AFD: Opened codec 0x7f11e4979a60, id(MP2) type(Audio) 2012-01-08 17:30:14.098 AFD: Stream #2, has id 0xb5d codec id DVB_VBI, type Data, bitrate 0 at 0x7f11e49c8f70 2012-01-08 17:30:14.098 AFD: Teletext stream #0 (Menu) is in the Danish language on page 1 0. 2012-01-08 17:30:14.098 AFD: data codec (Data) 2012-01-08 17:30:14.133 Launching: ps -ae | grep pulseaudio > /dev/null 2012-01-08 17:30:14.142 PID 5127: launched 2012-01-08 17:30:14.284 PID 5127: exited: status=256, result=1 2012-01-08 17:30:14.326 AO: Opening audio device 'front:CARD=NVidia,DEV=0' ch 2(2) sr 48000 sf signed 16 bit reenc 0 2012-01-08 17:30:14.335 AudioPlayer: Enabling Audio 2012-01-08 17:30:14.336 Dec: Selected track #1 in the Unknown language(0) 2012-01-08 17:30:14.336 Dec: Selected track #1 in the Danish language(6578542) 2012-01-08 17:30:14.336 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2012-01-08 17:30:14.341 Dec: SyncPositionMap prerecorded, from DB: 0 entries 2012-01-08 17:30:14.341 AFD: Recording has no position -- using libavformat seeking. 2012-01-08 17:30:14.341 AFD: Successfully opened decoder for file: "myth://Videos@10.10.10.50:6543/Samples/dyreboern.mpg". novideo(0) 2012-01-08 17:30:14.347 VideoOutput: Allowed renderers: vdpau 2012-01-08 17:30:14.347 VideoOutput: Allowed renderers (filt: vdpau): vdpau 2012-01-08 17:30:14.352 VDP: Accepting: cmp(>= 0 720) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt() 2012-01-08 17:30:14.352 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt() 2012-01-08 17:30:14.353 VDP: LoadBestPreferences(2048x2048, 0) 2012-01-08 17:30:14.353 VDP: LoadBestPreferences(2048x2048, 60) 2012-01-08 17:30:14.353 VDP: LoadBestPreferences(720x576, 60) 2012-01-08 17:30:14.353 VideoOutput: Preferred renderer: vdpau 2012-01-08 17:30:14.353 VideoOutput: Trying video renderer: 'vdpau' 2012-01-08 17:30:14.383 VDP: Accepting: cmp(>= 0 720) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt() 2012-01-08 17:30:14.383 VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt() 2012-01-08 17:30:14.383 VDP: LoadBestPreferences(2048x2048, 0) 2012-01-08 17:30:14.383 VDP: LoadBestPreferences(2048x2048, 60) 2012-01-08 17:30:14.384 VideoOutWindow::SetPIPState. pip_state: 0] 2012-01-08 17:30:14.384 VDP: LoadBestPreferences(2048x2048, 25) 2012-01-08 17:30:14.384 Clearing OpenGL painter cache. 2012-01-08 17:30:14.392 Display Rect left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333 2012-01-08 17:30:14.392 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.77778 2012-01-08 17:30:14.392 VDP: LoadBestPreferences(720x576, 25) 2012-01-08 17:30:14.392 Display Rect left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333 2012-01-08 17:30:14.393 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.77778 2012-01-08 17:30:14.393 VDP: SetVideoRenderer(vdpau) 2012-01-08 17:30:14.393 VDP: SetVideoRender(vdpau) == GetVideoRenderer() 2012-01-08 17:30:14.395 Trying to match best refresh rate 25.000Hz 2012-01-08 17:30:14.396 Trying 1920x1080 50.000 Hz 2012-01-08 17:30:14.398 Dynamic TwinView rate found, set 50Hz as XRandR 51 2012-01-08 17:30:14.612 SwitchToVideo: Video size 720 x 576: Switched to displaying resolution 1920 x 1080, 487mm x 274mm 2012-01-08 17:30:14.617 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2012-01-08 17:30:14.617 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.77778 2012-01-08 17:30:14.617 VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080 2012-01-08 17:30:14.617 VideoOutput: Actual display dimensions: 487x274 mm Aspect: 1.77737 2012-01-08 17:30:14.617 VideoOutput: Estimated window dimensions: 487x274 mm Aspect: 1.77737 2012-01-08 17:30:14.688 VDPAU: Created 2 output surfaces. 2012-01-08 17:30:14.688 VDPAU: Set colorkey to 0x20202 2012-01-08 17:30:14.688 VDPAU: Version 1 2012-01-08 17:30:14.688 VDPAU: Information NVIDIA VDPAU Driver Shared Library 270.41.06 Mon Apr 18 15:13:22 PDT 2011 2012-01-08 17:30:14.688 VDPAU: HQ Scaling not supported. 2012-01-08 17:30:14.688 VDPAU: MPEG4 hardware acceleration not supported. 2012-01-08 17:30:14.688 VDPAU: Created VDPAU render device 1920x1080 2012-01-08 17:30:14.689 VidOutVDPAU: Created VDPAU osd (1920x1080) 2012-01-08 17:30:14.802 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2012-01-08 17:30:14.802 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.77778 2012-01-08 17:30:14.802 VidOutVDPAU: Created VDPAU context (GPU decode) 2012-01-08 17:30:14.808 Over/underscan. V: 0, H: 0 2012-01-08 17:30:14.809 Display Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2012-01-08 17:30:14.809 Video Rect left: 0, top: 0, width: 720, height: 576, aspect: 1.77778 2012-01-08 17:30:14.809 Player(0): Forcing decode extra audio option on (Video method requires it). 2012-01-08 17:30:14.809 Player(0): InitFilters() vo '' prog '' over '' 2012-01-08 17:30:14.809 Player(0): LoadFilters(''..) -> 0x0 2012-01-08 17:30:14.813 Player(0): Decoder thread starting. 2012-01-08 17:30:14.830 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 132 Name: 'basenormal' Type: 'fontdef' 2012-01-08 17:30:14.834 OSD: Loaded window osd_message 2012-01-08 17:30:14.856 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 164 Name: 'basegothicmedium' Type: 'fontdef' 2012-01-08 17:30:14.861 OSD: Loaded window osd_input 2012-01-08 17:30:14.878 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 196 Name: 'basesmall' Type: 'fontdef' 2012-01-08 17:30:14.879 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 201 Name: 'basegothicmedium' Type: 'fontdef' 2012-01-08 17:30:14.879 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 206 Name: 'basegothicsmall' Type: 'fontdef' 2012-01-08 17:30:14.880 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 211 Name: 'basegothicsmalllightblue' Type: 'fontdef' 2012-01-08 17:30:14.884 VidOutVDPAU: Created VDPAU decoder (2 ref frames) 2012-01-08 17:30:14.887 Detect Letterbox: The source is not a supported frame format (was 11) 2012-01-08 17:30:14.891 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 215 Name: 'basegothicmid' Type: 'fontdef' 2012-01-08 17:30:14.891 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 219 Name: 'basegothicmidblue' Type: 'fontdef' 2012-01-08 17:30:14.892 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 224 Name: 'basegothicmidwhite' Type: 'fontdef' 2012-01-08 17:30:14.893 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 229 Name: 'basesmalllightblue' Type: 'fontdef' 2012-01-08 17:30:14.943 OSD: Loaded window program_info 2012-01-08 17:30:14.973 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 567 Name: 'basesmall' Type: 'fontdef' 2012-01-08 17:30:14.974 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 572 Name: 'basegothicmedium' Type: 'fontdef' 2012-01-08 17:30:14.974 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 577 Name: 'basegothicsmall' Type: 'fontdef' 2012-01-08 17:30:14.975 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 582 Name: 'basegothicsmalllightblue' Type: 'fontdef' 2012-01-08 17:30:14.975 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 586 Name: 'basegothicmid' Type: 'fontdef' 2012-01-08 17:30:14.976 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 590 Name: 'basegothicmidblue' Type: 'fontdef' 2012-01-08 17:30:14.976 MythFontProperties: loaded 'League Gothic' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 595 Name: 'basegothicmidwhite' Type: 'fontdef' 2012-01-08 17:30:14.977 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 600 Name: 'basesmalllightblue' Type: 'fontdef' 2012-01-08 17:30:14.985 OSD: Loaded window browse_info 2012-01-08 17:30:14.996 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 685 Name: 'basenormal' Type: 'fontdef' 2012-01-08 17:30:15.002 OSD: Loaded window osd_status 2012-01-08 17:30:15.018 MythFontProperties: loaded 'CartoGothic Std' Location: /home/kenni/.mythtv/themes/Arclight/osd.xml @ 901 Name: 'basenormal' Type: 'fontdef' 2012-01-08 17:30:15.026 OSD: Loaded window osd_program_editor 2012-01-08 17:30:15.027 OSD: Loaded OSD: size 1920x1080 offset 0+0 2012-01-08 17:30:15.029 OSD: Created window aa_OSD_SUBTITLES 2012-01-08 17:30:15.031 Player(0): ClearAfterSeek(0) 2012-01-08 17:30:15.034 VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate' 2012-01-08 17:30:15.049 VidOutVDPAU: Enabled deinterlacing. 2012-01-08 17:30:15.049 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory 2012-01-08 17:30:15.049 VSYNC: RTCVideoSync: Could not open /dev/rtc, Permission denied. 2012-01-08 17:30:15.052 Player(0): Video timing method: USleep with busy wait 2012-01-08 17:30:15.052 Player(0): Display Refresh Rate: 50.000 Video Frame Rate: 25.000 2012-01-08 17:30:15.052 playCtx: StartPlaying(): took 0 ms to start player. 2012-01-08 17:30:15.052 TV: StartPlayer(0, WatchingVideo, main) -- end ok 2012-01-08 17:30:15.053 TV: Changing from None to WatchingVideo 2012-01-08 17:30:15.160 TV: DrawUnusedRects() -- begin 2012-01-08 17:30:15.161 TV: DrawUnusedRects() -- end 2012-01-08 17:30:15.161 TV: HandleStateChange(0) -- end 2012-01-08 17:30:15.162 TV: tv->Playback() -- end 2012-01-08 17:30:15.162 TV: StartTV -- process events begin 2012-01-08 17:30:15.168 ScreenSaverX11Private: ResetTimer -- begin 2012-01-08 17:30:15.168 ScreenSaverX11Private: StopTimer 2012-01-08 17:30:15.170 ScreenSaverX11Private: StartTimer 2012-01-08 17:30:15.170 ScreenSaverX11Private: ResetTimer -- end 2012-01-08 17:30:15.172 Player(0): Enabled deinterlacing 2012-01-08 17:30:15.179 VDPAU: Added 2 output surfaces (total 4, max 4) 2012-01-08 17:30:15.317 Player(0): Video is 3.2125 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.318 Player(0): Video is 3.99062 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.318 Player(0): Video is 4.3242 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.318 Player(0): Video is 4.3244 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.318 Player(0): Video is 4.07455 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.319 Player(0): Video is 3.6434 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.319 Player(0): Video is 3.07005 frames behind audio (too slow), dropping frame to catch up. 2012-01-08 17:30:15.326 AFD: HandleGopStart: gopset not set, syncing positionMap 2012-01-08 17:30:15.326 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2012-01-08 17:30:15.326 AFD: HandleGopStart: Initial key frame distance: 15. 'video_output' mean = '36876.06', std. dev. = '10458.05', fps = '27.12' 2012-01-08 17:30:20.337 AFD: HandleGopStart: Key frame distance changed from 24 to 9. 2012-01-08 17:30:21.297 AFD: HandleGopStart: Key frame distance changed from 9 to 24. 2012-01-08 17:30:22.217 AFD: HandleGopStart: Key frame distance changed from 24 to 23. 'video_output' mean = '39997.67', std. dev. = '26.19', fps = '25.00' 2012-01-08 17:30:23.218 AFD: HandleGopStart: Key frame distance changed from 23 to 25. 2012-01-08 17:30:24.177 AFD: HandleGopStart: Key frame distance changed from 25 to 24. 2012-01-08 17:30:24.618 AFD: HandleGopStart: Key frame distance changed from 24 to 11. 2012-01-08 17:30:25.618 AFD: HandleGopStart: Key frame distance changed from 11 to 25. 2012-01-08 17:30:26.577 AFD: HandleGopStart: Key frame distance changed from 25 to 24. 'video_output' mean = '39998.26', std. dev. = '27.43', fps = '25.00' 2012-01-08 17:30:30.717 Player(0): 400 interlaced frames seen. 'video_output' mean = '39998.19', std. dev. = '18.64', fps = '25.00' 2012-01-08 17:30:33.058 [mp2 @ 0x7f1210b9e6e0]incomplete frame 2012-01-08 17:30:33.058 AFD Error: Unknown audio decoding error 2012-01-08 17:30:33.238 TV: HandleStateChange(0) -- begin 2012-01-08 17:30:33.238 TV: Attempting to change from WatchingVideo to None 2012-01-08 17:30:33.238 TV: StopStuff() for player ctx 0 -- begin 2012-01-08 17:30:33.239 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2012-01-08 17:30:33.239 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2012-01-08 17:30:33.239 Player(0): StopPlaying - begin 2012-01-08 17:30:33.240 Player(0): Decoder thread exiting. 2012-01-08 17:30:33.240 Player(0): Exited decoder loop. 2012-01-08 17:30:33.253 VidOutVDPAU: DiscardFrames(1) 2012-01-08 17:30:33.253 VideoBuffers::DiscardFrames(1): AAAAAUUUUUuUuDDDL 2012-01-08 17:30:33.253 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAADDDA -- done() 2012-01-08 17:30:33.253 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAADDDA -- done 2012-01-08 17:30:33.253 VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAADDDA -- done() 2012-01-08 17:30:33.303 VDPAU Painter: Clearing VDPAU painter cache. 2012-01-08 17:30:33.303 MythPainter: 43 images not yet de-allocated. 2012-01-08 17:30:33.394 Trying 1920x1080 0.000 Hz 2012-01-08 17:30:33.394 SwitchToGUI: Switched to 1920x1080 0.000 Hz 2012-01-08 17:30:33.401 Player(0): StopPlaying - end 2012-01-08 17:30:33.402 TV: StopStuff(): stopping ring buffer 2012-01-08 17:30:33.407 TV: StopStuff(): stopping player 2012-01-08 17:30:33.407 TV: StopStuff() -- end 2012-01-08 17:30:33.407 TV: Changing from WatchingVideo to None 2012-01-08 17:30:33.407 TV: HandleStateChange(0) -- end 2012-01-08 17:30:33.408 ScreenSaverX11Private: StopTimer 2012-01-08 17:30:33.408 TV: HandleStateChange(0) -- begin 2012-01-08 17:30:33.409 TV: Attempting to change from None to None 2012-01-08 17:30:33.409 TV: HandleStateChange(0) -- end 2012-01-08 17:30:33.409 TV: StartTV -- process events end 2012-01-08 17:30:33.409 TV: StartTV -- process events 2 begin 2012-01-08 17:30:33.409 TV: StartTV -- process events 2 end 2012-01-08 17:30:33.409 TV::~TV() -- begin 2012-01-08 17:30:33.409 TV: DrawUnusedRects() -- begin 2012-01-08 17:30:33.410 TV: DrawUnusedRects() -- end 2012-01-08 17:30:33.410 TV: DrawUnusedRects() -- begin 2012-01-08 17:30:33.410 TV: DrawUnusedRects() -- end 2012-01-08 17:30:33.421 TV::~TV() -- lock 2012-01-08 17:30:33.421 Player(0): StopPlaying - begin 2012-01-08 17:30:33.421 Player(0): Exited decoder loop. 2012-01-08 17:30:33.421 Player(0): StopPlaying - end 2012-01-08 17:30:33.427 TV::~TV() -- end 2012-01-08 17:30:33.427 SendReceiveStringList(MESSAGE,SYSTEM_EVENT PLAY_STOPPED HOSTNAME mc1 CHANID 0 STARTTIME 2012-01-08T17:29:13 SENDER mc1) called from UI thread 2012-01-08 17:30:33.428 TV: StartTV -- end