2009-11-17 20:38:29.299 TV: StartTV() -- begin 2009-11-17 20:38:29.299 TV: ctor 2009-11-17 20:38:29.430 TV: DrawUnusedRects() -- begin 2009-11-17 20:38:29.430 TV: DrawUnusedRects() -- end 2009-11-17 20:38:29.447 TV: DrawUnusedRects() -- begin 2009-11-17 20:38:29.447 TV: DrawUnusedRects() -- end 2009-11-17 20:38:29.511 TV: tv->Playback() -- begin 2009-11-17 20:38:29.530 TV: tv->Playback() -- end 2009-11-17 20:38:29.530 TV: StartTV -- process events begin 2009-11-17 20:38:29.571 TV: HandleStateChange(0) -- begin 2009-11-17 20:38:29.571 TV: Attempting to change from None to Watching WatchingPreRecorded 2009-11-17 20:38:29.586 RingBuf(myth://192.168.1.50:6543/2091_20091117150000.mpg): OpenFile(myth://192.168.1.50:6543/2091_20091117150000.mpg, 12) 2009-11-17 20:38:29.626 RingBuf(myth://192.168.1.50:6543/2091_20091117150000.mpg): CalcReadAheadThresh(0 KB) -> threshhold(64 KB) min read(0 KB) blk size(32 KB) 2009-11-17 20:38:29.676 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- begin 2009-11-17 20:38:30.427 AFD: Stream #0, has id 0x800 codec id MPEG2VIDEO, type Video, bitrate 38810400 at 0x14fd71e0 2009-11-17 20:38:30.432 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:30.432 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:30.432 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(onefield,onefield) filt() 2009-11-17 20:38:30.432 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt() 2009-11-17 20:38:30.433 VDP: LoadBestPreferences(2048x2048, 0) 2009-11-17 20:38:30.433 VDP: LoadBestPreferences(2048x2048, 60) 2009-11-17 20:38:30.433 VDP: LoadBestPreferences(1920x1080, 60) 2009-11-17 20:38:30.433 Using 2 CPUs for decoding 2009-11-17 20:38:30.433 AFD: InitVideoCodec() 0x901800 id(MPEG2VIDEO) type (Video). 2009-11-17 20:38:30.433 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan 2009-11-17 20:38:30.433 AFD: Using ffmpeg for video decoding 2009-11-17 20:38:30.433 AFD: Looking for decoder for MPEG2VIDEO 2009-11-17 20:38:30.433 AFD: Opened codec 0x901800, id(MPEG2VIDEO) type(Video) 2009-11-17 20:38:30.433 AFD: Stream #1, has id 0x801 codec id AC3, type Audio, bitrate 384000 at 0x165621c0 2009-11-17 20:38:30.433 AFD: codec AC3 has 6 channels 2009-11-17 20:38:30.433 AFD: Looking for decoder for AC3 2009-11-17 20:38:30.434 AFD: Opened codec 0x906a00, id(AC3) type(Audio) 2009-11-17 20:38:30.434 AFD: Audio Track #1 is A/V stream #1 and has 6 channels in the English language(6647399). 2009-11-17 20:38:30.434 AFD: Stream #2, has id 0x802 codec id AC3, type Audio, bitrate 192000 at 0x165660c0 2009-11-17 20:38:30.434 AFD: codec AC3 has 2 channels 2009-11-17 20:38:30.434 AFD: Looking for decoder for AC3 2009-11-17 20:38:30.435 AFD: Opened codec 0x906e00, id(AC3) type(Audio) 2009-11-17 20:38:30.435 AFD: Audio Track #2 is A/V stream #2 and has 2 channels in the French language(6713957). 2009-11-17 20:38:30.435 AFD: Stream #3, has id 0x803 codec id AC3, type Audio, bitrate 192000 at 0x16566280 2009-11-17 20:38:30.435 AFD: codec AC3 has 2 channels 2009-11-17 20:38:30.435 AFD: Looking for decoder for AC3 2009-11-17 20:38:30.435 AFD: Opened codec 0x902c00, id(AC3) type(Audio) 2009-11-17 20:38:30.435 AFD: Audio Track #3 is A/V stream #3 and has 2 channels in the Unknown language(6648684). 2009-11-17 20:38:30.435 RingBuf(myth://192.168.1.50:6543/2091_20091117150000.mpg): CalcReadAheadThresh(0 KB) -> threshhold(64 KB) min read(0 KB) blk size(32 KB) 2009-11-17 20:38:30.436 AFD: Trying to select audio track (w/lang) 2009-11-17 20:38:30.436 AFD: Trying to select audio track (wo/lang) 2009-11-17 20:38:30.436 AFD: Selected track 1: English AC3 5.1ch (A/V Stream #1) 2009-11-17 20:38:30.436 AFD: Initializing audio parms from audio track #1 2009-11-17 20:38:30.436 AFD: Audio format changed digital passthrough id( AC3) 48000Hz 2ch 16bps pt from id(NONE) -1Hz -1ch 0bps ; id(NONE) -1Hz -1ch 0bps to id( AC3) 48000Hz 6ch 16bps pt ; id( AC3) 48000Hz 2ch 16bps pt 2009-11-17 20:38:30.441 CoreAudioData::CoreAudioData - default device ID = 260 2009-11-17 20:38:30.442 AO: Killing AudioOutputDSP 2009-11-17 20:38:30.442 Opening audio device 'CoreAudio:'. ch 2(2) sr 48000 2009-11-17 20:38:30.442 CoreAudioData::FindAC3Stream - found digital format 2009-11-17 20:38:30.442 AudioOutputCA::OpenDevice() Trying Digital. 2009-11-17 20:38:30.447 CoreAudioData::OpenSPDIF - found digital format 2009-11-17 20:38:30.448 CoreAudioData::AudioStreamChangeFormat(261) 2009-11-17 20:38:30.791 AO: Audio fragment size: 0 2009-11-17 20:38:30.792 AO: Audio Stretch Factor: 1 2009-11-17 20:38:30.792 Audio Codec Used: not set 2009-11-17 20:38:30.793 AO: Ending reconfigure 2009-11-17 20:38:30.793 AO: Killing AudioOutputDSP 2009-11-17 20:38:30.793 CoreAudioData::AudioStreamChangeFormat(261) 2009-11-17 20:38:31.118 Opening audio device 'CoreAudio:'. ch 2(2) sr 48000 2009-11-17 20:38:31.118 CoreAudioData::FindAC3Stream - found digital format 2009-11-17 20:38:31.118 AudioOutputCA::OpenDevice() Trying Digital. 2009-11-17 20:38:31.123 CoreAudioData::AudioStreamChangeFormat(261) 2009-11-17 20:38:31.448 AO: Audio fragment size: 0 2009-11-17 20:38:31.457 AO: Audio Stretch Factor: 1 2009-11-17 20:38:31.457 Audio Codec Used: AC3 2009-11-17 20:38:31.458 AO: Ending reconfigure 2009-11-17 20:38:31.458 Dec: Trying to select track (w/lang) 2009-11-17 20:38:31.458 Dec: Selecting first track 2009-11-17 20:38:31.458 Dec: Selected track #1 in the Unknown language(0) 2009-11-17 20:38:31.458 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0) 2009-11-17 20:38:31.669 Position map filled from DB to: 107670 2009-11-17 20:38:31.671 Dec: SyncPositionMap prerecorded, from DB: 7179 entries 2009-11-17 20:38:31.671 Dec: SyncPositionMap, new totframes: 107670, new length: 3592, posMap size: 7179 2009-11-17 20:38:31.671 AFD: Position map found 2009-11-17 20:38:31.671 AFD: Successfully opened decoder for file: "myth://192.168.1.50:6543/2091_20091117150000.mpg". novideo(0) 2009-11-17 20:38:31.691 AO: no change exiting 2009-11-17 20:38:31.692 AO: Pause 1 2009-11-17 20:38:31.692 VideoOutput: Allowed renderers: quartz-blit,opengl 2009-11-17 20:38:31.692 VideoOutput: Allowed renderers (filt: ffmpeg): quartz-blit,opengl 2009-11-17 20:38:31.697 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:31.697 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:31.697 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(onefield,onefield) filt() 2009-11-17 20:38:31.697 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt() 2009-11-17 20:38:31.697 VDP: LoadBestPreferences(2048x2048, 0) 2009-11-17 20:38:31.697 VDP: LoadBestPreferences(2048x2048, 60) 2009-11-17 20:38:31.697 VDP: LoadBestPreferences(1920x1080, 60) 2009-11-17 20:38:31.697 VideoOutput: Preferred renderer: quartz-blit 2009-11-17 20:38:31.697 VideoOutput: Trying video renderer: 'quartz-blit' 2009-11-17 20:38:31.732 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(2) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:31.732 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(2) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:31.732 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(onefield,onefield) filt() 2009-11-17 20:38:31.732 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt() 2009-11-17 20:38:31.732 VDP: LoadBestPreferences(2048x2048, 0) 2009-11-17 20:38:31.732 VDP: LoadBestPreferences(2048x2048, 60) 2009-11-17 20:38:31.755 VDP: SetVideoRenderer(quartz-blit) 2009-11-17 20:38:31.755 VDP: SetVideoRender(quartz-blit) == GetVideoRenderer() 2009-11-17 20:38:31.755 VideoOutWindow::SetPIPState. pip_state: 0] 2009-11-17 20:38:31.755 VideoOutputQuartz::Init(WxH 1920x1080, aspect=1.77778, winid=6768720 win_bounds(x 0, y0, WxH 1360x768), WId embedid=0) 2009-11-17 20:38:31.755 Display Rect left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333 2009-11-17 20:38:31.755 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-11-17 20:38:31.755 VDP: LoadBestPreferences(1920x1088, 60) 2009-11-17 20:38:31.755 VideoOutputQuartz::VideoAspectRatioChanged(aspect=1.77778) [was 1.3333] 2009-11-17 20:38:31.755 Display Rect left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333 2009-11-17 20:38:31.755 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-11-17 20:38:31.758 Screen size is 1100 x 620 (mm), aspect 1.77419 2009-11-17 20:38:31.777 Main window is 1100 x 620 (mm), aspect 1.77419 2009-11-17 20:38:31.777 VideoOutputQuartz::CreateQuartzBuffers() render: quartz-blit, allowed: quartz-blit 2009-11-17 20:38:31.777 VDP: SetVideoRenderer(quartz-blit) 2009-11-17 20:38:31.777 VDP: SetVideoRender(quartz-blit) == GetVideoRenderer() 2009-11-17 20:38:31.777 VideoOutputQuartz::VProf: rend(quartz-blit) osd(softblend) deint(kerneldeint,linearblend) filt() 2009-11-17 20:38:31.951 Main window: Viewport currently 0,0 -> 1360,768 2009-11-17 20:38:31.952 Main window: Viewport is 1360 x 768 2009-11-17 20:38:31.952 Main window: Image is 1920 x 1088 2009-11-17 20:38:31.952 Main window: Scaling to 0.708333 x 0.705882 of original 2009-11-17 20:38:31.952 Display Rect left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778 2009-11-17 20:38:31.952 Video Rect left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778 2009-11-17 20:38:31.952 Main window: Viewport is 1360 x 768 2009-11-17 20:38:31.952 Main window: Image is 1920 x 1088 2009-11-17 20:38:31.952 Main window: Scaling to 0.708333 x 0.705882 of original 2009-11-17 20:38:31.955 Over/underscan. V: 0.01, H: 0.01 2009-11-17 20:38:31.955 Display Rect left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778 2009-11-17 20:38:31.955 Video Rect left: 19, top: 11, width: 1882, height: 1058, aspect: 1.77778 2009-11-17 20:38:31.955 SetVideoFrameRate(29.97) 2009-11-17 20:38:31.956 NVP(1): LoadFilters(''..) -> 0x0 2009-11-17 20:38:31.958 OSD Theme Dimensions W: 1280 H: 720 2009-11-17 20:38:33.849 playCtx: StartDecoderThread(): took 2157 ms to start player. 2009-11-17 20:38:33.849 NVP(1): ClearAfterSeek(1) 2009-11-17 20:38:33.849 AO: Pause 1 2009-11-17 20:38:33.849 TV: StartPlayer(0, Watching WatchingPreRecorded, main) -- end ok 2009-11-17 20:38:33.851 VideoOutputQuartz::GetDisplayInfo() [returning 60] 2009-11-17 20:38:33.851 VDP: GetFilteredDeint() : quartz-blit -> 'kerneldeint' 2009-11-17 20:38:33.856 FilterManager: GetFilterInfo(convert) returning: 0x0 2009-11-17 20:38:33.856 FilterManager: GetFilterInfo(kerneldeint) returning: 0x2657c5a0 2009-11-17 20:38:33.861 TV: Changing from None to Watching WatchingPreRecorded 2009-11-17 20:38:33.864 TV: HandleStateChange(0) -- end 2009-11-17 20:38:33.086 KernelDeint: Created threads. 2009-11-17 20:38:33.864 Using deinterlace method kerneldeint 2009-11-17 20:38:33.870 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory 2009-11-17 20:38:33.871 OpenGLVideoSync() 2009-11-17 20:38:33.871 ~OpenGLVideoSync() -- closing opengl vsync 2009-11-17 20:38:33.871 VideoOutputQuartz::GetDisplayInfo() [returning 60] 2009-11-17 20:38:33.871 Using audio as timebase 2009-11-17 20:38:33.871 Video timing method: USleep with busy wait 2009-11-17 20:38:33.871 Refresh rate: 16666, frame interval: 33366 2009-11-17 20:38:33.871 NVP(1): Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAALL 2009-11-17 20:38:33.881 AFD: DoFastForward(1160 (1), do discard frames) 2009-11-17 20:38:33.881 Dec: DoFastForward(1160 (1), do discard frames) 2009-11-17 20:38:33.881 Dec: FindPosition(1160, search not adjusted) --> [77:1155(65018296),78:1170(65871064)] 2009-11-17 20:38:33.887 AFD: SeekReset(1170, 0, do flush, do discard) 2009-11-17 20:38:33.887 AFD: SeekReset() flushing 2009-11-17 20:38:33.887 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAUA 2009-11-17 20:38:33.887 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done() 2009-11-17 20:38:33.887 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done 2009-11-17 20:38:33.888 NVP(1): ClearAfterSeek(0) 2009-11-17 20:38:34.004 NVP(1): Waiting for prebuffer.. 1 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-11-17 20:38:34.137 NVP(1): Waiting for prebuffer.. 2 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA 2009-11-17 20:38:34.275 AO: Pause 0 'video_output' mean = '32736.95', std. dev. = '3083.87', fps = '30.55' 'video_output' mean = '33364.46', std. dev. = '127.19', fps = '29.97' 2009-11-17 20:38:43.831 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2009-11-17 20:38:43.831 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2009-11-17 20:38:43.954 TV: HandleStateChange(0) -- begin 2009-11-17 20:38:43.955 TV: Attempting to change from Watching WatchingPreRecorded to None 2009-11-17 20:38:43.955 TV: StopStuff() for player ctx 0 -- begin 2009-11-17 20:38:43.955 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin 2009-11-17 20:38:43.955 TV: SetActive(0,w/o OSD) 0 -> 0 -- end 2009-11-17 20:38:43.955 TV: StopStuff(): stopping ring buffer 2009-11-17 20:38:43.958 NVP(1): Exited decoder loop. 2009-11-17 20:38:43.980 TV: StopStuff(): stopping player 2009-11-17 20:38:43.981 TV: StopStuff() -- end 2009-11-17 20:38:43.981 TV: Changing from Watching WatchingPreRecorded to None