2011-03-06 10:37:03.985 MythFrontend version: fixes/0.24 [v0.24-198-g0d3d3a4-dirty] www.mythtv.org ... 2011-03-06 10:37:24.698 TV: StartTV() -- begin 2011-03-06 10:37:24.698 TV: ctor -- begin 2011-03-06 10:37:24.706 TV: ctor -- end 2011-03-06 10:37:24.706 TV: Init -- begin 2011-03-06 10:37:24.729 TV: DrawUnusedRects() -- begin 2011-03-06 10:37:24.729 TV: DrawUnusedRects() -- end 2011-03-06 10:37:24.752 TV: Init -- end 2011-03-06 10:37:24.753 TV: tv->Playback() -- begin 2011-03-06 10:37:24.775 TV: HandleStateChange(0) -- begin 2011-03-06 10:37:24.775 TV: Attempting to change from None to WatchingPreRecorded 2011-03-06 10:37:24.791 RingBuf(myth://192.168.1.50:6543/2051_20110306055900.mpg): OpenFile(myth://192.168.1.50:6543/2051_20110306055900.mpg, 2000 ms) 2011-03-06 10:37:24.872 TV: StartPlayer(0, WatchingPreRecorded, main) -- begin 2011-03-06 10:37:24.872 TV: Elapsed time since TV constructor was called: 175 ms 2011-03-06 10:37:25.027 CoreAudioData::CoreAudioData - default device ID = 260 2011-03-06 10:37:25.027 AO: Sample rate 44100 is supported 2011-03-06 10:37:25.027 AO: Sample rate 48000 is supported 2011-03-06 10:37:25.027 AO: Sample rate 96000 is supported 2011-03-06 10:37:25.027 AudioOutputCA::Support 2 channels 2011-03-06 10:37:25.027 AO: 2 channel(s) are supported 2011-03-06 10:37:25.027 AO: AC3 or DTS capable 2011-03-06 10:37:25.027 AO: 6 channel(s) are supported 2011-03-06 10:37:25.038 AO: Killing AudioOutputDSP 2011-03-06 10:37:25.095 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.096 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.097 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.098 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.115 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.115 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.133 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.150 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.151 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.168 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.169 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.186 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.186 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.204 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure 2011-03-06 10:37:25.676 [mpegts @ 0x8aa81240]Estimating duration from bitrate, this may be inaccurate 2011-03-06 10:37:25.677 [NULL @ 0x8a45a640]start time is not set in av_estimate_timings_from_pts 2011-03-06 10:37:25.936 AFD: Stream #0, has id 0x840 codec id MPEG2VIDEO, type Video, bitrate 20000000 at 0x15e3dac0 2011-03-06 10:37:25.970 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl)) 2011-03-06 10:37:25.970 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl)) 2011-03-06 10:37:25.971 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt() 2011-03-06 10:37:25.971 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt() 2011-03-06 10:37:25.971 VDP: LoadBestPreferences(2048x2048, 0) 2011-03-06 10:37:25.971 VDP: LoadBestPreferences(2048x2048, 60) 2011-03-06 10:37:25.971 VDP: LoadBestPreferences(1920x1080, 60) 2011-03-06 10:37:25.972 AFD: Using 1 CPUs for decoding 2011-03-06 10:37:25.972 AFD: InitVideoCodec() 0xb62200 id(MPEG2VIDEO) type (Video). 2011-03-06 10:37:25.972 AFD: Selected FPS is 29.97 (avg 34.3559 stream 29.97 container 90000 estimated 29.97) 2011-03-06 10:37:25.972 Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan 2011-03-06 10:37:25.973 AFD: EIA-708 caption service #1 is in the English language. 2011-03-06 10:37:25.973 AFD: Using ffmpeg for video decoding 2011-03-06 10:37:25.973 AFD: Looking for decoder for MPEG2VIDEO 2011-03-06 10:37:25.973 AFD: Opened codec 0xb62200, id(MPEG2VIDEO) type(Video) 2011-03-06 10:37:25.973 AFD: Stream #1, has id 0x841 codec id AC3, type Audio, bitrate 384000 at 0x22388950 2011-03-06 10:37:25.973 AFD: codec AC3 has 6 channels 2011-03-06 10:37:25.973 AFD: Looking for decoder for AC3 2011-03-06 10:37:25.973 AFD: Opened codec 0xa46800, id(AC3) type(Audio) 2011-03-06 10:37:25.973 AFD: Audio Track #1 is A/V stream #1 and has 6 channels in the English language(6647399). 2011-03-06 10:37:25.973 AFD: Stream #2, has id 0x842 codec id AC3, type Audio, bitrate 192000 at 0x22388b20 2011-03-06 10:37:25.973 AFD: codec AC3 has 1 channels 2011-03-06 10:37:25.973 AFD: Looking for decoder for AC3 2011-03-06 10:37:25.974 AFD: Opened codec 0xa42e00, id(AC3) type(Audio) 2011-03-06 10:37:25.974 AFD: Audio Track #2 is A/V stream #2 and has 1 channels in the English language(6647399). 2011-03-06 10:37:25.974 AFD: Stream #3, has id 0x843 codec id DVB_VBI, type Data, bitrate 0 at 0x2237fe90 2011-03-06 10:37:25.974 AFD: data codec (Data) 2011-03-06 10:37:26.000 AFD: Trying to select audio track (w/lang) 2011-03-06 10:37:26.003 AFD: Selected track 1: English AC3 5.1ch (A/V Stream #1) 2011-03-06 10:37:26.003 AFD: Initializing audio parms from audio track #1 2011-03-06 10:37:26.003 AFD: Audio format changed from id(NONE) -1Hz -1ch -1bps to id( AC3) 48000Hz 6ch 16bps 2011-03-06 10:37:26.004 AO: Killing AudioOutputDSP 2011-03-06 10:37:26.121 CoreAudioData::CoreAudioData - default device ID = 260 2011-03-06 10:37:26.122 AO: Sample rate 44100 is supported 2011-03-06 10:37:26.122 AO: Sample rate 48000 is supported 2011-03-06 10:37:26.122 AO: Sample rate 96000 is supported 2011-03-06 10:37:26.122 AudioOutputCA::Support 2 channels 2011-03-06 10:37:26.122 AO: 2 channel(s) are supported 2011-03-06 10:37:26.122 AO: AC3 or DTS capable 2011-03-06 10:37:26.122 AO: 6 channel(s) are supported 2011-03-06 10:37:26.122 AO: Killing AudioOutputDSP 2011-03-06 10:37:26.122 AO: Original codec was AC3, signed 16 bit, 48 kHz, 6 channels 2011-03-06 10:37:26.123 AO: enc(1), passthru(0), canAC3(1), canDTS(1), canLPCM(0), configured_channels(6), 6 channels supported(1) 2011-03-06 10:37:26.123 AO: Reencoding decoded AC-3/DTS to AC-3 2011-03-06 10:37:26.123 AO: Creating AC-3 Encoder with sr = 48000, ch = 6 2011-03-06 10:37:26.123 DEnc: Init codecid=AC3, br=448000, sr=48000, ch=6 2011-03-06 10:37:26.123 [ac3 @ 0x8a45a640]No channel layout specified. The encoder will guess the layout, but it might be incorrect. 2011-03-06 10:37:26.124 DigitalEncoder::Init fs=1536, bpf=12 ofb=18432 2011-03-06 10:37:26.124 AO: Audio processing enabled 2011-03-06 10:37:26.124 AO: Opening audio device 'CoreAudio:' ch 2(6) sr 48000 sf signed 16 bit reenc 1 2011-03-06 10:37:26.124 CoreAudioData::FindAC3Stream - found digital format 2011-03-06 10:37:26.124 AudioOutputCA::OpenDevice() Trying Digital. 2011-03-06 10:37:26.129 CoreAudioData::OpenSPDIF - found digital format 2011-03-06 10:37:26.129 CoreAudioData::AudioStreamChangeFormat(261) 2011-03-06 10:37:26.453 AO: Software volume enabled 2011-03-06 10:37:26.462 AO: Audio fragment size: 0 2011-03-06 10:37:26.462 AO: Audio Stretch Factor: 1 2011-03-06 10:37:26.462 AO: Ending Reconfigure() 2011-03-06 10:37:26.462 AudioPlayer: Enabling Audio 2011-03-06 10:37:26.462 AO: Reconfigure(): No change -> exiting 2011-03-06 10:37:26.462 Dec: Selected track #1 in the Unknown language(0) 2011-03-06 10:37:26.462 Dec: Selected track #1 in the English language(6647399) 2011-03-06 10:37:26.462 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2011-03-06 10:37:26.519 Dec: Position map filled from DB to: 163545 2011-03-06 10:37:26.521 Dec: SyncPositionMap prerecorded, from DB: 10904 entries 2011-03-06 10:37:26.521 Dec: SyncPositionMap, new totframes: 163545, new length: 5456, posMap size: 10904 2011-03-06 10:37:26.522 AFD: Position map found 2011-03-06 10:37:26.522 AFD: Successfully opened decoder for file: "myth://192.168.1.50:6543/2051_20110306055900.mpg". novideo(0) 2011-03-06 10:37:26.535 VideoOutput: Allowed renderers: quartz-blit,opengl 2011-03-06 10:37:26.535 VideoOutput: Allowed renderers (filt: ffmpeg): quartz-blit,opengl 2011-03-06 10:37:26.542 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl)) 2011-03-06 10:37:26.542 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl)) 2011-03-06 10:37:26.543 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt() 2011-03-06 10:37:26.543 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt() 2011-03-06 10:37:26.543 VDP: LoadBestPreferences(2048x2048, 0) 2011-03-06 10:37:26.543 VDP: LoadBestPreferences(2048x2048, 60) 2011-03-06 10:37:26.543 VDP: LoadBestPreferences(1920x1080, 60) 2011-03-06 10:37:26.543 VideoOutput: Preferred renderer: quartz-blit 2011-03-06 10:37:26.543 VideoOutput: Trying video renderer: 'quartz-blit' 2011-03-06 10:37:26.603 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl)) 2011-03-06 10:37:26.604 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl)) 2011-03-06 10:37:26.604 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt() 2011-03-06 10:37:26.604 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt() 2011-03-06 10:37:26.604 VDP: LoadBestPreferences(2048x2048, 0) 2011-03-06 10:37:26.604 VDP: LoadBestPreferences(2048x2048, 60) 2011-03-06 10:37:26.604 VideoOutWindow::SetPIPState. pip_state: 0] 2011-03-06 10:37:26.604 SetVideoFrameRate(29.97) - unimplemented? 2011-03-06 10:37:26.605 VideoOutputQuartz::Init(WxH 1920x1080, aspect=1.77778, winid=5556144 win_bounds(x 0, y0, WxH 1360x768), WId embedid=0) 2011-03-06 10:37:26.605 Display Rect left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333 2011-03-06 10:37:26.605 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2011-03-06 10:37:26.605 VDP: LoadBestPreferences(1920x1088, 60) 2011-03-06 10:37:26.605 VideoOutputQuartz::VideoAspectRatioChanged(aspect=1.77778) [was 1.3333] 2011-03-06 10:37:26.605 Display Rect left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333 2011-03-06 10:37:26.605 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2011-03-06 10:37:26.622 Screen size is 1100 x 620 (mm), aspect 1.77419 2011-03-06 10:37:26.629 Main window is 1100 x 620 (mm), aspect 1.77419 2011-03-06 10:37:26.629 VideoOutputQuartz::CreateQuartzBuffers() render: quartz-blit, allowed: quartz-blit 2011-03-06 10:37:26.629 VDP: SetVideoRenderer(quartz-blit) 2011-03-06 10:37:26.629 VDP: SetVideoRender(quartz-blit) == GetVideoRenderer() 2011-03-06 10:37:26.629 VideoOutputQuartz::VProf: rend(quartz-blit) osd(softblend) deint(linearblend,linearblend) filt() 2011-03-06 10:37:26.762 Main window: Viewport currently 0,0 -> 1360,768 2011-03-06 10:37:26.770 Main window: Viewport is 1360 x 768 2011-03-06 10:37:26.770 Main window: Image is 1920 x 1088 2011-03-06 10:37:26.770 Main window: Scaling to 0.708333 x 0.705882 of original 2011-03-06 10:37:26.770 Display Rect left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778 2011-03-06 10:37:26.770 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2011-03-06 10:37:26.770 Main window: Viewport is 1360 x 768 2011-03-06 10:37:26.770 Main window: Image is 1920 x 1088 2011-03-06 10:37:26.770 Main window: Scaling to 0.708333 x 0.705882 of original 2011-03-06 10:37:26.776 Over/underscan. V: 0, H: 0 2011-03-06 10:37:26.776 Display Rect left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778 2011-03-06 10:37:26.776 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2011-03-06 10:37:26.776 Player(0): LoadFilters(''..) -> 0x0 2011-03-06 10:37:26.781 Player(0): Decoder thread starting. 2011-03-06 10:37:26.781 AFD: DoFastForward(11293 (0), do discard frames) 2011-03-06 10:37:26.781 Dec: DoFastForward(11293 (0), do discard frames) 2011-03-06 10:37:26.782 Dec: FindPosition(11293, search not adjusted) --> [752:11280(714764532),753:11295(715830868)] 2011-03-06 10:37:26.783 AFD: SeekReset(11295, 0, do flush, do discard) 2011-03-06 10:37:26.783 AFD: SeekReset() flushing 2011-03-06 10:37:26.783 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2011-03-06 10:37:26.783 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2011-03-06 10:37:26.783 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2011-03-06 10:37:26.784 Player(0): ClearAfterSeek(0) 2011-03-06 10:37:26.810 OSD: Base theme size: 1920x1080 2011-03-06 10:37:26.810 OSD: Scaling factors: 1x1 2011-03-06 10:37:26.819 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 132 Name: 'basenormal' Type: 'fontdef' 2011-03-06 10:37:26.822 OSD: Loaded window osd_message 2011-03-06 10:37:26.831 OSD: Loaded window osd_input 2011-03-06 10:37:26.841 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 196 Name: 'basesmall' Type: 'fontdef' 2011-03-06 10:37:26.844 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 229 Name: 'basesmalllightblue' Type: 'fontdef' 2011-03-06 10:37:26.850 [mpeg2video @ 0x8a45a640]warning: first frame is no keyframe 2011-03-06 10:37:26.861 Detect Letterbox: YV12 frame format detected 2011-03-06 10:37:26.861 Detect Letterbox: The source is already in widescreen (aspect: 1.77778) 2011-03-06 10:37:26.902 OSD: Loaded window program_info 2011-03-06 10:37:26.908 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 567 Name: 'basesmall' Type: 'fontdef' 2011-03-06 10:37:26.908 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 600 Name: 'basesmalllightblue' Type: 'fontdef' 2011-03-06 10:37:26.943 OSD: Loaded window browse_info 2011-03-06 10:37:26.949 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 685 Name: 'basenormal' Type: 'fontdef' 2011-03-06 10:37:26.952 OSD: Loaded window osd_status 2011-03-06 10:37:26.958 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 901 Name: 'basenormal' Type: 'fontdef' 2011-03-06 10:37:26.964 OSD: Loaded window osd_program_editor 2011-03-06 10:37:26.964 OSD: Loaded OSD: size 1920x1080 offset 0+0 2011-03-06 10:37:26.964 OSD: Base theme size: 1920x1080 2011-03-06 10:37:26.964 OSD: Scaling factors: 1x1 2011-03-06 10:37:27.018 Player(0): ClearAfterSeek(0) 2011-03-06 10:37:27.026 VDP: GetFilteredDeint() : quartz-blit -> 'linearblend' 2011-03-06 10:37:27.030 FilterManager: GetFilterInfo(convert) returning: 0x0 2011-03-06 10:37:27.030 FilterManager: GetFilterInfo(linearblend) returning: 0x224118d0 2011-03-06 10:37:27.030 VideoOutput: Using deinterlace method linearblend 2011-03-06 10:37:27.030 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory 2011-03-06 10:37:27.036 AFD: EIA-708 caption service #1 is in the English language. 2011-03-06 10:37:27.036 AFD: EIA-708 caption service #2 is in the Undetermined language. 2011-03-06 10:37:27.039 Player(0): Video timing method: USleep with busy wait 2011-03-06 10:37:27.039 Player(0): Display Refresh Rate: 60.002 Video Frame Rate: 29.971 2011-03-06 10:37:27.039 playCtx: StartPlaying(): took 0 ms to start player. 2011-03-06 10:37:27.039 TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok 2011-03-06 10:37:27.044 TV: Changing from None to WatchingPreRecorded 2011-03-06 10:37:27.058 TV: DrawUnusedRects() -- begin 2011-03-06 10:37:27.058 TV: DrawUnusedRects() -- end 2011-03-06 10:37:27.058 TV: HandleStateChange(0) -- end 2011-03-06 10:37:27.058 TV: tv->Playback() -- end 2011-03-06 10:37:27.058 TV: StartTV -- process events begin 2011-03-06 10:37:27.060 Player(0): Waiting for video buffers... 2011-03-06 10:37:27.060 AO: Pause 1 2011-03-06 10:37:27.148 PreviewQueue: Requesting preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.148 PreviewQueue: Requested preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.162 AFD: EIA-708 caption service #1 is in the English language. 2011-03-06 10:37:27.162 AFD: EIA-608 caption service #3 is in the Undetermined language. 2011-03-06 10:37:27.162 AFD: EIA-708 caption service #2 is in the Undetermined language. 2011-03-06 10:37:27.163 Dec: Selected track #1 in the Undetermined language(7695972) 2011-03-06 10:37:27.189 AFD: EIA-708 caption service #1 is in the English language. 2011-03-06 10:37:27.189 AFD: EIA-608 caption service #1 is in the Undetermined language. 2011-03-06 10:37:27.189 AFD: EIA-608 caption service #3 is in the Undetermined language. 2011-03-06 10:37:27.189 AFD: EIA-708 caption service #2 is in the Undetermined language. 2011-03-06 10:37:27.190 PreviewQueue: Requesting preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.190 PreviewQueue: Requested preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.199 AO: Pause 0 2011-03-06 10:37:27.199 Player(0): progressive frame seen after 2 interlaced frames 2011-03-06 10:37:27.201 PreviewQueue: Requesting preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.201 PreviewQueue: Requested preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.259 VideoOutput: Created YV12 OSD. 2011-03-06 10:37:27.380 Player(0): interlaced frame seen after 1 progressive frames 2011-03-06 10:37:27.380 Player(0): Locking scan to Interlaced. 2011-03-06 10:37:27.380 Player(0): Enabled deinterlacing 2011-03-06 10:37:27.385 Player(0): Video is 3.22934 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.389 Player(0): Video is 6.31068 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.394 Player(0): Video is 8.37442 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.451 Player(0): Video is 9.67497 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.455 Player(0): Video is 10.4781 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.459 Player(0): Video is 10.8331 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.463 Player(0): Video is 10.8447 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.467 Player(0): Video is 10.8458 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.472 Player(0): Video is 10.5994 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.476 Player(0): Video is 10.1599 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.480 Player(0): Video is 9.58299 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.484 Player(0): Video is 8.90304 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.488 Player(0): Video is 8.13834 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.492 Player(0): Video is 7.31757 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.495 Player(0): Video is 6.45471 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.499 Player(0): Video is 5.7926 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.503 Player(0): Video is 5.04876 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.508 Player(0): Video is 4.23611 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.512 Player(0): Video is 3.37937 frames behind audio (too slow), dropping frame to catch up. 2011-03-06 10:37:27.604 PreviewQueue: Requesting preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:27.604 PreviewQueue: Requested preview for '2051_20110306055900.mpg_0x0_-1s' 'video_output' mean = '28361.84', std. dev. = '13209.65', fps = '35.26' 2011-03-06 10:37:32.563 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2011-03-06 10:37:32.563 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2011-03-06 10:37:32.619 TV: HandleStateChange(0) -- begin 2011-03-06 10:37:32.619 TV: Attempting to change from WatchingPreRecorded to None 2011-03-06 10:37:32.619 TV: StopStuff() for player ctx 0 -- begin 2011-03-06 10:37:32.620 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2011-03-06 10:37:32.620 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2011-03-06 10:37:32.620 Player(0): StopPlaying - begin 2011-03-06 10:37:32.630 Player(0): Decoder thread exiting. 2011-03-06 10:37:32.630 Player(0): Exited decoder loop. 2011-03-06 10:37:32.716 AO: Killing AudioOutputDSP 2011-03-06 10:37:32.717 CoreAudioData::AudioStreamChangeFormat(261) 2011-03-06 10:37:33.029 Player(0): StopPlaying - end 2011-03-06 10:37:33.029 TV: StopStuff(): stopping ring buffer 2011-03-06 10:37:33.029 TV: StopStuff(): stopping player 2011-03-06 10:37:33.029 TV: StopStuff() -- end 2011-03-06 10:37:33.029 TV: Changing from WatchingPreRecorded to None 2011-03-06 10:37:33.029 TV: HandleStateChange(0) -- end 2011-03-06 10:37:33.029 TV: StartTV -- process events end 2011-03-06 10:37:33.030 TV: StartTV -- process events 2 begin 2011-03-06 10:37:33.048 TV: StartTV -- process events 2 end 2011-03-06 10:37:33.048 TV::~TV() -- begin 2011-03-06 10:37:33.048 TV::~TV() -- lock 2011-03-06 10:37:33.049 Player(0): StopPlaying - begin 2011-03-06 10:37:33.049 Player(0): Exited decoder loop. 2011-03-06 10:37:33.049 Player(0): StopPlaying - end 2011-03-06 10:37:33.049 PreviewQueue: Requesting preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:33.049 PreviewQueue: Requested preview for '2051_20110306055900.mpg_0x0_-1s' 2011-03-06 10:37:33.059 TV::~TV() -- end 2011-03-06 10:37:33.060 TV: StartTV -- end 2