Ticket #5552: normal_playback_timestamp.txt

2011-03-07 18:53:37.531 TV: StartTV() -- begin
2011-03-07 18:53:37.532 TV: ctor -- begin
2011-03-07 18:53:37.540 TV: ctor -- end
2011-03-07 18:53:37.540 TV: Init -- begin
2011-03-07 18:53:37.561 TV: DrawUnusedRects() -- begin
2011-03-07 18:53:37.562 TV: DrawUnusedRects() -- end
2011-03-07 18:53:37.585 TV: Init -- end
2011-03-07 18:53:37.586 TV: tv->Playback() -- begin
2011-03-07 18:53:37.608 TV: HandleStateChange(0) -- begin
2011-03-07 18:53:37.608 TV: Attempting to change from None to WatchingPreRecorded
2011-03-07 18:53:37.625 RingBuf(myth://192.168.1.50:6543/2051_20110303200000.mpg): OpenFile(myth://192.168.1.50:6543/2051_20110303200000.mpg, 2000 ms)
2011-03-07 18:53:37.785 TV: StartPlayer(0, WatchingPreRecorded, main) -- begin
2011-03-07 18:53:37.785 TV: Elapsed time since TV constructor was called: 253 ms
2011-03-07 18:53:37.898 CoreAudioData::CoreAudioData - default device ID = 261
2011-03-07 18:53:37.898 AO: Sample rate 44100 is supported
2011-03-07 18:53:37.898 AO: Sample rate 48000 is supported
2011-03-07 18:53:37.898 AO: Sample rate 96000 is supported
2011-03-07 18:53:37.898 AudioOutputCA::Support 2 channels
2011-03-07 18:53:37.899 AO: 2 channel(s) are supported
2011-03-07 18:53:37.899 AO: AC3 or DTS capable
2011-03-07 18:53:37.899 AO: 6 channel(s) are supported
2011-03-07 18:53:37.910 AO: Killing AudioOutputDSP
2011-03-07 18:53:37.966 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.966 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.966 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.967 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.967 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.967 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.968 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.968 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.968 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.968 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.968 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.968 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.969 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:37.969 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
2011-03-07 18:53:38.855 AFD: Stream #0, has id 0x840 codec id MPEG2VIDEO, type Video, bitrate 20000000 at 0x1fdbd1d0
2011-03-07 18:53:38.884 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
2011-03-07 18:53:38.884 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
2011-03-07 18:53:38.884 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt()
2011-03-07 18:53:38.906 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2011-03-07 18:53:38.906 VDP: LoadBestPreferences(2048x2048, 0)
2011-03-07 18:53:38.907 VDP: LoadBestPreferences(2048x2048, 60)
2011-03-07 18:53:38.907 VDP: LoadBestPreferences(1920x1080, 60)
2011-03-07 18:53:38.907 AFD: Using 1 CPUs for decoding
2011-03-07 18:53:38.907 AFD: InitVideoCodec() 0xbdf800 id(MPEG2VIDEO) type (Video).
2011-03-07 18:53:38.907 AFD: Selected FPS is 29.97 (avg 34.2011 stream 29.97 container 90000 estimated 29.97)
2011-03-07 18:53:38.907 Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
2011-03-07 18:53:38.908 AFD: EIA-708 caption service #1 is in the English language.
2011-03-07 18:53:38.908 AFD: Using ffmpeg for video decoding
2011-03-07 18:53:38.908 AFD: Looking for decoder for MPEG2VIDEO
2011-03-07 18:53:38.908 AFD: Opened codec 0xbdf800, id(MPEG2VIDEO) type(Video)
2011-03-07 18:53:38.908 AFD: Stream #1, has id 0x841 codec id AC3, type Audio, bitrate 384000 at 0x1fdbd3a0
2011-03-07 18:53:38.908 AFD: codec AC3 has 6 channels
2011-03-07 18:53:38.908 AFD: Looking for decoder for AC3
2011-03-07 18:53:38.908 AFD: Opened codec 0xbdfc00, id(AC3) type(Audio)
2011-03-07 18:53:38.908 AFD: Audio Track #1 is A/V stream #1 and has 6 channels in the English language(6647399).
2011-03-07 18:53:38.908 AFD: Stream #2, has id 0x842 codec id AC3, type Audio, bitrate 192000 at 0x1fdbd6d0
2011-03-07 18:53:38.908 AFD: codec AC3 has 1 channels
2011-03-07 18:53:38.908 AFD: Looking for decoder for AC3
2011-03-07 18:53:38.909 AFD: Opened codec 0xa68e00, id(AC3) type(Audio)
2011-03-07 18:53:38.909 AFD: Audio Track #2 is A/V stream #2 and has 1 channels in the English language(6647399).
2011-03-07 18:53:38.909 AFD: Stream #3, has id 0x843 codec id DVB_VBI, type Data, bitrate 0 at 0x1fdbda00
2011-03-07 18:53:38.918 AFD: data codec (Data)
2011-03-07 18:53:38.920 AFD: Trying to select audio track (w/lang)
2011-03-07 18:53:38.923 AFD: Selected track 1: English AC3 5.1ch (A/V Stream #1)
2011-03-07 18:53:38.923 AFD: Initializing audio parms from audio track #1
2011-03-07 18:53:38.923 AFD: Audio format changed 
                        from id(NONE)     -1Hz -1ch -1bps     to id( AC3)  48000Hz  6ch 16bps    
2011-03-07 18:53:38.923 AO: Killing AudioOutputDSP
2011-03-07 18:53:38.993 CoreAudioData::CoreAudioData - default device ID = 261
2011-03-07 18:53:38.994 AO: Sample rate 44100 is supported
2011-03-07 18:53:38.994 AO: Sample rate 48000 is supported
2011-03-07 18:53:38.994 AO: Sample rate 96000 is supported
2011-03-07 18:53:38.995 AudioOutputCA::Support 2 channels
2011-03-07 18:53:38.995 AO: 2 channel(s) are supported
2011-03-07 18:53:38.995 AO: AC3 or DTS capable
2011-03-07 18:53:38.995 AO: 6 channel(s) are supported
2011-03-07 18:53:38.995 AO: Killing AudioOutputDSP
2011-03-07 18:53:38.995 AO: Original codec was AC3, signed 16 bit, 48 kHz, 6 channels
2011-03-07 18:53:39.003 AO: enc(1), passthru(0), canAC3(1), canDTS(1), canLPCM(0), configured_channels(6), 6 channels supported(1)
2011-03-07 18:53:39.003 AO: Reencoding decoded AC-3/DTS to AC-3
2011-03-07 18:53:39.003 AO: Creating AC-3 Encoder with sr = 48000, ch = 6
2011-03-07 18:53:39.004 DEnc: Init codecid=AC3, br=448000, sr=48000, ch=6
2011-03-07 18:53:39.004 DigitalEncoder::Init fs=1536, bpf=12 ofb=18432
2011-03-07 18:53:39.004 AO: Audio processing enabled
2011-03-07 18:53:39.005 AO: Opening audio device 'CoreAudio:' ch 2(6) sr 48000 sf signed 16 bit reenc 1
2011-03-07 18:53:39.005 CoreAudioData::FindAC3Stream - found digital format
2011-03-07 18:53:39.005 AudioOutputCA::OpenDevice() Trying Digital.
2011-03-07 18:53:39.031 CoreAudioData::OpenSPDIF - found digital format
2011-03-07 18:53:39.031 CoreAudioData::AudioStreamChangeFormat(262)
2011-03-07 18:53:39.861 AO: Software volume enabled
2011-03-07 18:53:39.868 AO: Audio fragment size: 0
2011-03-07 18:53:39.868 AO: Audio Stretch Factor: 1
2011-03-07 18:53:39.868 AO: Ending Reconfigure()
2011-03-07 18:53:39.868 AudioPlayer: Enabling Audio
2011-03-07 18:53:39.868 AO: Reconfigure(): No change -> exiting
2011-03-07 18:53:39.868 Dec: Selected track #1 in the Unknown language(0)
2011-03-07 18:53:39.868 Dec: Selected track #1 in the English language(6647399)
2011-03-07 18:53:39.869 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2011-03-07 18:53:39.955 Dec: Position map filled from DB to: 55605
2011-03-07 18:53:39.956 Dec: SyncPositionMap prerecorded, from DB: 3708 entries
2011-03-07 18:53:39.956 Dec: SyncPositionMap, new totframes: 55605, new length: 1855, posMap size: 3708
2011-03-07 18:53:39.956 AFD: Position map found
2011-03-07 18:53:39.956 AFD: Successfully opened decoder for file: "myth://192.168.1.50:6543/2051_20110303200000.mpg". novideo(0)
2011-03-07 18:53:40.015 VideoOutput: Allowed renderers: quartz-blit,opengl
2011-03-07 18:53:40.015 VideoOutput: Allowed renderers (filt: ffmpeg): quartz-blit,opengl
2011-03-07 18:53:40.052 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
2011-03-07 18:53:40.052 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
2011-03-07 18:53:40.053 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt()
2011-03-07 18:53:40.053 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2011-03-07 18:53:40.053 VDP: LoadBestPreferences(2048x2048, 0)
2011-03-07 18:53:40.053 VDP: LoadBestPreferences(2048x2048, 60)
2011-03-07 18:53:40.053 VDP: LoadBestPreferences(1920x1080, 60)
2011-03-07 18:53:40.053 VideoOutput: Preferred renderer: quartz-blit
2011-03-07 18:53:40.053 VideoOutput: Trying video renderer: 'quartz-blit'
2011-03-07 18:53:40.264 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
2011-03-07 18:53:40.264 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
2011-03-07 18:53:40.265 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt()
2011-03-07 18:53:40.265 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
2011-03-07 18:53:40.265 VDP: LoadBestPreferences(2048x2048, 0)
2011-03-07 18:53:40.265 VDP: LoadBestPreferences(2048x2048, 60)
2011-03-07 18:53:40.265 VideoOutWindow::SetPIPState. pip_state: 0]
2011-03-07 18:53:40.265 SetVideoFrameRate(29.97) - unimplemented?
2011-03-07 18:53:40.265 VideoOutputQuartz::Init(WxH 1920x1080, aspect=1.77778, winid=4402816
                        win_bounds(x 0, y0, WxH 1360x768), WId embedid=0)
2011-03-07 18:53:40.266 Display Rect  left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333
2011-03-07 18:53:40.266 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2011-03-07 18:53:40.266 VDP: LoadBestPreferences(1920x1088, 60)
2011-03-07 18:53:40.266 VideoOutputQuartz::VideoAspectRatioChanged(aspect=1.77778) [was 1.3333]
2011-03-07 18:53:40.266 Display Rect  left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333
2011-03-07 18:53:40.266 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2011-03-07 18:53:40.973 Screen size is 1100 x 620 (mm), aspect 1.77419
2011-03-07 18:53:40.980 Main window is 1100 x 620 (mm), aspect 1.77419
2011-03-07 18:53:40.981 VideoOutputQuartz::CreateQuartzBuffers() render: quartz-blit, allowed: quartz-blit
2011-03-07 18:53:40.981 VDP: SetVideoRenderer(quartz-blit)
2011-03-07 18:53:40.981 VDP: SetVideoRender(quartz-blit) == GetVideoRenderer()
2011-03-07 18:53:40.981 VideoOutputQuartz::VProf: rend(quartz-blit) osd(softblend) deint(linearblend,linearblend) filt()
2011-03-07 18:53:41.116 Main window: Viewport currently 0,0 -> 1360,768
2011-03-07 18:53:41.151 Main window: Viewport is 1360 x 768
2011-03-07 18:53:41.151 Main window: Image is 1920 x 1088
2011-03-07 18:53:41.151 Main window: Scaling to 0.708333 x 0.705882 of original
2011-03-07 18:53:41.151 Display Rect  left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778
2011-03-07 18:53:41.151 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2011-03-07 18:53:41.151 Main window: Viewport is 1360 x 768
2011-03-07 18:53:41.152 Main window: Image is 1920 x 1088
2011-03-07 18:53:41.152 Main window: Scaling to 0.708333 x 0.705882 of original
2011-03-07 18:53:41.157 Over/underscan. V: 0, H: 0
2011-03-07 18:53:41.157 Display Rect  left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778
2011-03-07 18:53:41.157 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2011-03-07 18:53:41.157 Player(0): LoadFilters(''..) -> 0x0
2011-03-07 18:53:41.162 Player(0): Decoder thread starting.
2011-03-07 18:53:41.162 AFD: DoFastForward(720 (0), do discard frames)
2011-03-07 18:53:41.174 Dec: DoFastForward(720 (0), do discard frames)
2011-03-07 18:53:41.174 Dec: FindPosition(720, search not adjusted) --> [48:720(40916696)]
2011-03-07 18:53:41.175 AFD: SeekReset(720, 0, do flush, do discard)
2011-03-07 18:53:41.175 AFD: SeekReset() flushing
2011-03-07 18:53:41.176 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2011-03-07 18:53:41.176 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2011-03-07 18:53:41.176 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2011-03-07 18:53:41.176 Player(0): ClearAfterSeek(0)
2011-03-07 18:53:41.184 OSD: Base theme size: 1920x1080
2011-03-07 18:53:41.184 OSD: Scaling factors: 1x1
2011-03-07 18:53:41.192 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-07 18:53:41.195 OSD: Loaded window osd_message
2011-03-07 18:53:41.204 OSD: Loaded window osd_input
2011-03-07 18:53:41.211 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-07 18:53:41.213 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-07 18:53:41.250 OSD: Loaded window program_info
2011-03-07 18:53:41.258 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-07 18:53:41.260 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-07 18:53:41.265 OSD: Loaded window browse_info
2011-03-07 18:53:41.271 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-07 18:53:41.274 [mpeg2video @ 0x8a45a640]warning: first frame is no keyframe
2011-03-07 18:53:41.283 AFD: video timecode 177447715 177447715 177438706 1971641 1971641 0 (reordered active)
2011-03-07 18:53:41.284 Detect Letterbox: YV12 frame format detected
2011-03-07 18:53:41.284 Detect Letterbox: The source is already in widescreen (aspect: 1.77778)
2011-03-07 18:53:41.288 OSD: Loaded window osd_status
2011-03-07 18:53:41.294 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-07 18:53:41.297 OSD: Loaded window osd_program_editor
2011-03-07 18:53:41.297 OSD: Loaded OSD: size 1920x1080 offset 0+0
2011-03-07 18:53:41.297 OSD: Base theme size: 1920x1080
2011-03-07 18:53:41.297 OSD: Scaling factors: 1x1
2011-03-07 18:53:41.324 Player(0): ClearAfterSeek(0)
2011-03-07 18:53:41.331 VDP: GetFilteredDeint() : quartz-blit -> 'linearblend'
2011-03-07 18:53:41.334 FilterManager: GetFilterInfo(convert) returning: 0x0
2011-03-07 18:53:41.335 FilterManager: GetFilterInfo(linearblend) returning: 0x1fdf1130
2011-03-07 18:53:41.335 VideoOutput: Using deinterlace method linearblend
2011-03-07 18:53:41.335 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2011-03-07 18:53:41.341 Player(0): Video timing method: USleep with busy wait
2011-03-07 18:53:41.341 Player(0): Display Refresh Rate: 60.002 Video Frame Rate: 29.971
2011-03-07 18:53:41.341 playCtx: StartPlaying(): took 0 ms to start player.
2011-03-07 18:53:41.342 TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok
2011-03-07 18:53:41.353 TV: Changing from None to WatchingPreRecorded
2011-03-07 18:53:41.371 TV: DrawUnusedRects() -- begin
2011-03-07 18:53:41.371 TV: DrawUnusedRects() -- end
2011-03-07 18:53:41.372 TV: HandleStateChange(0) -- end
2011-03-07 18:53:41.372 TV: tv->Playback() -- end
2011-03-07 18:53:41.372 TV: StartTV -- process events begin
2011-03-07 18:53:41.373 AFD: audio timecode 177450466 177450466 1971671 1971703
2011-03-07 18:53:41.374 Player(0): Waiting for video buffers...
2011-03-07 18:53:41.374 AO: Pause 1
2011-03-07 18:53:41.380 AO: AddFrames frames=1536, bytes=18432, used=1, free=3071999, timecode=1971671 needsupmix=0
2011-03-07 18:53:41.390 AO: SetAudiotime atc=1971671 tc=1971671 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.391 AFD: audio timecode 177453346 177453346 1971703 1971735
2011-03-07 18:53:41.391 AO: AddFrames frames=1536, bytes=18432, used=6145, free=3065855, timecode=1971703 needsupmix=0
2011-03-07 18:53:41.392 AO: SetAudiotime atc=1971703 tc=1971703 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.436 AFD: audio timecode 177456226 177456226 1971735 1971767
2011-03-07 18:53:41.436 AO: AddFrames frames=1536, bytes=18432, used=12289, free=3059711, timecode=1971735 needsupmix=0
2011-03-07 18:53:41.437 AO: SetAudiotime atc=1971735 tc=1971735 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.447 AFD: video timecode 177441709 177441709 177441709 1971574 1971574 1971641 (dts active)
2011-03-07 18:53:41.457 AFD: video timecode 177444712 177444712 177444712 1971607 1971607 1971574 (dts active)
2011-03-07 18:53:41.465 AFD: video timecode 177447715 177456724 177447715 1971641 1971641 1971607 (dts active)
2011-03-07 18:53:41.476 AFD: video timecode 177450718 177450718 177450718 1971674 1971674 1971641 (dts active)
2011-03-07 18:53:41.476 AFD: audio timecode 177459106 177459106 1971767 1971799
2011-03-07 18:53:41.476 AO: AddFrames frames=1536, bytes=18432, used=18433, free=3053567, timecode=1971767 needsupmix=0
2011-03-07 18:53:41.477 AO: SetAudiotime atc=1971767 tc=1971767 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.479 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:41.479 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:41.487 AFD: video timecode 177453721 177453721 177453721 1971708 1971708 1971674 (dts active)
2011-03-07 18:53:41.488 AFD: audio timecode 177461986 177461986 1971799 1971831
2011-03-07 18:53:41.488 AO: AddFrames frames=1536, bytes=18432, used=24577, free=3047423, timecode=1971799 needsupmix=0
2011-03-07 18:53:41.489 AO: SetAudiotime atc=1971799 tc=1971799 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.499 AFD: video timecode 177456724 177465733 177456724 1971741 1971741 1971708 (dts active)
2011-03-07 18:53:41.499 AFD: audio timecode 177464866 177464866 1971831 1971863
2011-03-07 18:53:41.500 AO: AddFrames frames=1536, bytes=18432, used=30721, free=3041279, timecode=1971831 needsupmix=0
2011-03-07 18:53:41.501 AO: SetAudiotime atc=1971831 tc=1971831 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.511 AFD: video timecode 177459727 177459727 177459727 1971774 1971774 1971741 (dts active)
2011-03-07 18:53:41.511 AFD: audio timecode 177467746 177467746 1971863 1971895
2011-03-07 18:53:41.511 AO: AddFrames frames=1536, bytes=18432, used=36865, free=3035135, timecode=1971863 needsupmix=0
2011-03-07 18:53:41.513 AO: SetAudiotime atc=1971863 tc=1971863 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.518 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:41.519 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:41.523 AFD: video timecode 177462730 177462730 177462730 1971808 1971808 1971774 (dts active)
2011-03-07 18:53:41.523 AFD: audio timecode 177470626 177470626 1971895 1971927
2011-03-07 18:53:41.524 AO: AddFrames frames=1536, bytes=18432, used=43009, free=3028991, timecode=1971895 needsupmix=0
2011-03-07 18:53:41.525 AO: SetAudiotime atc=1971895 tc=1971895 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.534 AFD: video timecode 177465733 177474742 177465733 1971841 1971841 1971808 (dts active)
2011-03-07 18:53:41.534 AFD: audio timecode 177473506 177473506 1971927 1971959
2011-03-07 18:53:41.534 AO: AddFrames frames=1536, bytes=18432, used=49153, free=3022847, timecode=1971927 needsupmix=0
2011-03-07 18:53:41.536 AO: SetAudiotime atc=1971927 tc=1971927 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.546 AFD: video timecode 177468736 177468736 177468736 1971874 1971874 1971841 (dts active)
2011-03-07 18:53:41.547 AFD: audio timecode 177476386 177476386 1971959 1971991
2011-03-07 18:53:41.547 AO: AddFrames frames=1536, bytes=18432, used=55297, free=3016703, timecode=1971959 needsupmix=0
2011-03-07 18:53:41.548 AO: SetAudiotime atc=1971959 tc=1971959 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.550 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:41.550 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:41.558 AFD: video timecode 177471739 177471739 177471739 1971908 1971908 1971874 (dts active)
2011-03-07 18:53:41.559 AFD: audio timecode 177479266 177479266 1971991 1972023
2011-03-07 18:53:41.559 AO: AddFrames frames=1536, bytes=18432, used=61441, free=3010559, timecode=1971991 needsupmix=0
2011-03-07 18:53:41.560 AO: SetAudiotime atc=1971991 tc=1971991 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.571 AFD: video timecode 177474742 177483751 177474742 1971941 1971941 1971908 (dts active)
2011-03-07 18:53:41.572 AFD: audio timecode 177482146 177482146 1972023 1972055
2011-03-07 18:53:41.572 AO: AddFrames frames=1536, bytes=18432, used=67585, free=3004415, timecode=1972023 needsupmix=0
2011-03-07 18:53:41.573 AO: SetAudiotime atc=1972023 tc=1972023 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.583 AFD: video timecode 177477745 177477745 177477745 1971974 1971974 1971941 (dts active)
2011-03-07 18:53:41.584 AFD: audio timecode 177485026 177485026 1972055 1972087
2011-03-07 18:53:41.584 AO: AddFrames frames=1536, bytes=18432, used=73729, free=2998271, timecode=1972055 needsupmix=0
2011-03-07 18:53:41.585 AO: SetAudiotime atc=1972055 tc=1972055 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.587 AO: Pause 0
2011-03-07 18:53:41.587 Player(0): progressive frame seen after 2 interlaced  frames
2011-03-07 18:53:41.597 AFD: video timecode 177480748 177480748 177480748 1972008 1972008 1971974 (dts active)
2011-03-07 18:53:41.598 AFD: audio timecode 177487906 177487906 1972087 1972119
2011-03-07 18:53:41.598 AO: AddFrames frames=1536, bytes=18432, used=79873, free=2992127, timecode=1972087 needsupmix=0
2011-03-07 18:53:41.599 AO: SetAudiotime atc=1972087 tc=1972087 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.609 AFD: video timecode 177483751 177492760 177483751 1972041 1972041 1972008 (dts active)
2011-03-07 18:53:41.611 AFD: audio timecode 177490786 177490786 1972119 1972151
2011-03-07 18:53:41.611 AO: AddFrames frames=1536, bytes=18432, used=86017, free=2985983, timecode=1972119 needsupmix=0
2011-03-07 18:53:41.612 AO: SetAudiotime atc=1972119 tc=1972119 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.623 AFD: video timecode 177486754 177486754 177486754 1972075 1972075 1972041 (dts active)
2011-03-07 18:53:41.623 AFD: audio timecode 177493666 177493666 1972151 1972183
2011-03-07 18:53:41.623 AO: AddFrames frames=1536, bytes=18432, used=92161, free=2979839, timecode=1972151 needsupmix=0
2011-03-07 18:53:41.624 AO: SetAudiotime atc=1972151 tc=1972151 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.634 AFD: video timecode 177489757 177489757 177489757 1972108 1972108 1972075 (dts active)
2011-03-07 18:53:41.636 AFD: audio timecode 177496546 177496546 1972183 1972215
2011-03-07 18:53:41.636 AO: AddFrames frames=1536, bytes=18432, used=98305, free=2973695, timecode=1972183 needsupmix=0
2011-03-07 18:53:41.637 AO: SetAudiotime atc=1972183 tc=1972183 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.647 AFD: EIA-708 caption service #1 is in the English language.
2011-03-07 18:53:41.647 AFD: EIA-608 caption service #1 is in the Undetermined language.
2011-03-07 18:53:41.647 AFD: video timecode 177492760 177501769 177492760 1972141 1972141 1972108 (dts active)
2011-03-07 18:53:41.647 AFD: audio timecode 177499426 177499426 1972215 1972247
2011-03-07 18:53:41.647 AO: AddFrames frames=1536, bytes=18432, used=104449, free=2967551, timecode=1972215 needsupmix=0
2011-03-07 18:53:41.649 AO: SetAudiotime atc=1972215 tc=1972215 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.649 Dec: Selected track #1 in the Undetermined language(7695972)
2011-03-07 18:53:41.650 VideoOutput: Created YV12 OSD.
2011-03-07 18:53:41.662 AFD: video timecode 177495763 177495763 177495763 1972175 1972175 1972141 (dts active)
2011-03-07 18:53:41.662 AFD: audio timecode 177502306 177502306 1972247 1972279
2011-03-07 18:53:41.662 AO: AddFrames frames=1536, bytes=18432, used=110593, free=2961407, timecode=1972247 needsupmix=0
2011-03-07 18:53:41.664 AO: SetAudiotime atc=1972247 tc=1972247 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.664 AVSync waitforframe 0 0
2011-03-07 18:53:41.664 AVSync show
2011-03-07 18:53:41.675 AFD: video timecode 177498766 177498766 177498766 1972208 1972208 1972175 (dts active)
2011-03-07 18:53:41.676 AFD: audio timecode 177505186 177505186 1972279 1972311
2011-03-07 18:53:41.676 AO: AddFrames frames=1536, bytes=18432, used=116737, free=2955263, timecode=1972279 needsupmix=0
2011-03-07 18:53:41.677 AO: SetAudiotime atc=1972279 tc=1972279 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.686 AFD: video timecode 177501769 177510778 177501769 1972241 1972241 1972208 (dts active)
2011-03-07 18:53:41.686 AFD: audio timecode 177508066 177508066 1972311 1972343
2011-03-07 18:53:41.686 AO: AddFrames frames=1536, bytes=18432, used=110593, free=2961407, timecode=1972311 needsupmix=0
2011-03-07 18:53:41.688 AO: SetAudiotime atc=1972311 tc=1972311 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.698 AFD: video timecode 177504772 177504772 177504772 1972275 1972275 1972241 (dts active)
2011-03-07 18:53:41.698 AFD: audio timecode 177510946 177510946 1972343 1972375
2011-03-07 18:53:41.698 AO: AddFrames frames=1536, bytes=18432, used=116737, free=2955263, timecode=1972343 needsupmix=0
2011-03-07 18:53:41.700 AO: SetAudiotime atc=1972343 tc=1972343 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.709 AFD: video timecode 177507775 177507775 177507775 1972308 1972308 1972275 (dts active)
2011-03-07 18:53:41.709 AFD: audio timecode 177513826 177513826 1972375 1972407
2011-03-07 18:53:41.710 AO: AddFrames frames=1536, bytes=18432, used=116737, free=2955263, timecode=1972375 needsupmix=0
2011-03-07 18:53:41.711 AO: SetAudiotime atc=1972375 tc=1972375 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.711 AFD: audio timecode 177516706 177516706 1972407 1972439
2011-03-07 18:53:41.711 AO: AddFrames frames=1536, bytes=18432, used=122881, free=2949119, timecode=1972407 needsupmix=0
2011-03-07 18:53:41.712 AO: SetAudiotime atc=1972407 tc=1972407 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.726 AFD: video timecode 177510778 177519787 177510778 1972341 1972341 1972308 (dts active)
2011-03-07 18:53:41.727 AFD: audio timecode 177519586 177519586 1972439 1972471
2011-03-07 18:53:41.727 AO: AddFrames frames=1536, bytes=18432, used=129025, free=2942975, timecode=1972439 needsupmix=0
2011-03-07 18:53:41.728 AO: SetAudiotime atc=1972439 tc=1972439 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.736 AFD: video timecode 177513781 177513781 177513781 1972375 1972375 1972341 (dts active)
2011-03-07 18:53:41.737 AFD: audio timecode 177522466 177522466 1972471 1972503
2011-03-07 18:53:41.737 AO: AddFrames frames=1536, bytes=18432, used=129025, free=2942975, timecode=1972471 needsupmix=0
2011-03-07 18:53:41.738 AO: SetAudiotime atc=1972471 tc=1972471 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.755 AFD: video timecode 177516784 177516784 177516784 1972408 1972408 1972375 (dts active)
2011-03-07 18:53:41.756 AFD: audio timecode 177525346 177525346 1972503 1972535
2011-03-07 18:53:41.756 AO: AddFrames frames=1536, bytes=18432, used=135169, free=2936831, timecode=1972503 needsupmix=0
2011-03-07 18:53:41.757 AO: SetAudiotime atc=1972503 tc=1972503 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.769 AFD: video timecode 177519787 177528796 177519787 1972442 1972442 1972408 (dts active)
2011-03-07 18:53:41.770 AFD: audio timecode 177528226 177528226 1972535 1972567
2011-03-07 18:53:41.770 AO: AddFrames frames=1536, bytes=18432, used=135169, free=2936831, timecode=1972535 needsupmix=0
2011-03-07 18:53:41.772 AO: SetAudiotime atc=1972535 tc=1972535 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.783 AFD: video timecode 177522790 177522790 177522790 1972475 1972475 1972442 (dts active)
2011-03-07 18:53:41.784 AFD: audio timecode 177531106 177531106 1972567 1972599
2011-03-07 18:53:41.784 AO: AddFrames frames=1536, bytes=18432, used=141313, free=2930687, timecode=1972567 needsupmix=0
2011-03-07 18:53:41.785 AO: SetAudiotime atc=1972567 tc=1972567 f=1536 pfu=0 pfs=0
2011-03-07 18:53:41.796 AFD: video timecode 177525793 177525793 177525793 1972508 1972508 1972475 (dts active)
2011-03-07 18:53:41.796 AFD: audio timecode 177533986 177533986 1972599 1972631
2011-03-07 18:53:41.796 AO: AddFrames frames=1536, bytes=18432, used=141313, free=2930687, timecode=1972599 needsupmix=0
2011-03-07 18:53:41.797 AO: SetAudiotime atc=1972599 tc=1972599 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.077 A/V timecodes audio 1972054 video 1971641 frameinterval 33366 avdel -413 avg 0 tcoffset 0
2011-03-07 18:53:42.090 AFD: video timecode 177528796 177537805 177528796 1972542 1972542 1972508 (dts active)
2011-03-07 18:53:42.091 AFD: audio timecode 177536866 177536866 1972631 1972663
2011-03-07 18:53:42.091 AO: AddFrames frames=1536, bytes=18432, used=92161, free=2979839, timecode=1972631 needsupmix=0
2011-03-07 18:53:42.093 AO: SetAudiotime atc=1972631 tc=1972631 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.098 Player(0): interlaced frame seen after 1 progressive frames
2011-03-07 18:53:42.098 Player(0): Locking scan to Interlaced.
2011-03-07 18:53:42.098 Player(0): Enabled deinterlacing
2011-03-07 18:53:42.101 Player(0): Video is 3.09447 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.101 A/V timecodes audio 1972086 video 1971574 frameinterval 33366 avdel -512 avg -103250 tcoffset 0
2011-03-07 18:53:42.108 Player(0): Video is 6.15708 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.108 A/V timecodes audio 1972086 video 1971607 frameinterval 33366 avdel -479 avg -205437 tcoffset 0
2011-03-07 18:53:42.112 Player(0): Video is 8.20677 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.113 A/V timecodes audio 1972086 video 1971641 frameinterval 33366 avdel -445 avg -273827 tcoffset 0
2011-03-07 18:53:42.117 Player(0): Video is 9.4893 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.117 A/V timecodes audio 1972118 video 1971674 frameinterval 33366 avdel -444 avg -316620 tcoffset 0
2011-03-07 18:53:42.118 AFD: video timecode 177531799 177531799 177531799 1972575 1972575 1972542 (dts active)
2011-03-07 18:53:42.118 AFD: audio timecode 177539746 177539746 1972663 1972695
2011-03-07 18:53:42.118 AO: AddFrames frames=1536, bytes=18432, used=92161, free=2979839, timecode=1972663 needsupmix=0
2011-03-07 18:53:42.120 AO: SetAudiotime atc=1972663 tc=1972663 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.121 Player(0): Video is 10.4437 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.121 A/V timecodes audio 1972118 video 1971708 frameinterval 33366 avdel -410 avg -348465 tcoffset 0
2011-03-07 18:53:42.125 Player(0): Video is 10.9048 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.125 A/V timecodes audio 1972118 video 1971741 frameinterval 33366 avdel -377 avg -363848 tcoffset 0
2011-03-07 18:53:42.129 Player(0): Video is 11.0033 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.130 A/V timecodes audio 1972118 video 1971774 frameinterval 33366 avdel -344 avg -367136 tcoffset 0
2011-03-07 18:53:42.134 Player(0): Video is 10.8299 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.134 A/V timecodes audio 1972118 video 1971808 frameinterval 33366 avdel -310 avg -361352 tcoffset 0
2011-03-07 18:53:42.138 AFD: video timecode 177534802 177534802 177534802 1972608 1972608 1972575 (dts active)
2011-03-07 18:53:42.138 Player(0): Video is 10.4452 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.138 A/V timecodes audio 1972118 video 1971841 frameinterval 33366 avdel -277 avg -348514 tcoffset 0
2011-03-07 18:53:42.138 AFD: audio timecode 177542626 177542626 1972695 1972727
2011-03-07 18:53:42.139 AO: AddFrames frames=1536, bytes=18432, used=98305, free=2973695, timecode=1972695 needsupmix=0
2011-03-07 18:53:42.142 AO: SetAudiotime atc=1972695 tc=1972695 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.142 Player(0): Video is 9.90934 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.142 A/V timecodes audio 1972118 video 1971874 frameinterval 33366 avdel -244 avg -330635 tcoffset 0
2011-03-07 18:53:42.146 Player(0): Video is 9.26021 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.146 A/V timecodes audio 1972118 video 1971908 frameinterval 33366 avdel -210 avg -308976 tcoffset 0
2011-03-07 18:53:42.150 Player(0): Video is 8.51861 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.150 A/V timecodes audio 1972150 video 1971941 frameinterval 33366 avdel -209 avg -284232 tcoffset 0
2011-03-07 18:53:42.154 Player(0): Video is 7.95492 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.155 A/V timecodes audio 1972150 video 1971974 frameinterval 33366 avdel -176 avg -265424 tcoffset 0
2011-03-07 18:53:42.156 AFD: video timecode 177537805 177546814 177537805 1972642 1972642 1972608 (dts active)
2011-03-07 18:53:42.158 AFD: audio timecode 177545506 177545506 1972727 1972759
2011-03-07 18:53:42.158 AO: AddFrames frames=1536, bytes=18432, used=98305, free=2973695, timecode=1972727 needsupmix=0
2011-03-07 18:53:42.159 Player(0): Video is 7.2849 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.159 A/V timecodes audio 1972150 video 1972008 frameinterval 33366 avdel -142 avg -243068 tcoffset 0
2011-03-07 18:53:42.159 AO: SetAudiotime atc=1972727 tc=1972727 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.163 Player(0): Video is 6.52763 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.163 A/V timecodes audio 1972150 video 1972041 frameinterval 33366 avdel -109 avg -217801 tcoffset 0
2011-03-07 18:53:42.167 Player(0): Video is 5.7124 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.167 A/V timecodes audio 1972150 video 1972075 frameinterval 33366 avdel -75 avg -190600 tcoffset 0
2011-03-07 18:53:42.172 Player(0): Video is 4.84625 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.172 A/V timecodes audio 1972150 video 1972108 frameinterval 33366 avdel -42 avg -161700 tcoffset 0
2011-03-07 18:53:42.174 AFD: video timecode 177540808 177540808 177540808 1972675 1972675 1972642 (dts active)
2011-03-07 18:53:42.174 AFD: audio timecode 177548386 177548386 1972759 1972791
2011-03-07 18:53:42.175 AO: AddFrames frames=1536, bytes=18432, used=104449, free=2967551, timecode=1972759 needsupmix=0
2011-03-07 18:53:42.176 Player(0): Video is 3.94938 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.176 A/V timecodes audio 1972150 video 1972141 frameinterval 33366 avdel -9 avg -131775 tcoffset 0
2011-03-07 18:53:42.177 AO: SetAudiotime atc=1972759 tc=1972759 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.180 Player(0): Video is 3.02946 frames behind audio (too slow), dropping frame to catch up.
2011-03-07 18:53:42.180 A/V timecodes audio 1972182 video 1972175 frameinterval 33366 avdel -7 avg -101081 tcoffset 0
2011-03-07 18:53:42.184 AVSync waitforframe 0 0
2011-03-07 18:53:42.184 AVSync show
2011-03-07 18:53:42.189 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:42.189 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:42.190 AFD: video timecode 177543811 177543811 177543811 1972709 1972709 1972675 (dts active)
2011-03-07 18:53:42.190 AFD: audio timecode 177551266 177551266 1972791 1972823
2011-03-07 18:53:42.190 AO: AddFrames frames=1536, bytes=18432, used=104449, free=2967551, timecode=1972791 needsupmix=0
2011-03-07 18:53:42.192 AO: SetAudiotime atc=1972791 tc=1972791 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.200 A/V timecodes audio 1972182 video 1972208 frameinterval 33366 avdel 26 avg -77560 tcoffset 0
2011-03-07 18:53:42.203 AFD: video timecode 177546814 177555823 177546814 1972742 1972742 1972709 (dts active)
2011-03-07 18:53:42.204 AVSync waitforframe -16666 0
2011-03-07 18:53:42.204 AVSync show
2011-03-07 18:53:42.204 AFD: audio timecode 177554146 177554146 1972823 1972855
2011-03-07 18:53:42.204 AO: AddFrames frames=1536, bytes=18432, used=110593, free=2961407, timecode=1972823 needsupmix=0
2011-03-07 18:53:42.206 AO: SetAudiotime atc=1972823 tc=1972823 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.216 AFD: video timecode 177549817 177549817 177549817 1972775 1972775 1972742 (dts active)
2011-03-07 18:53:42.217 AFD: audio timecode 177557026 177557026 1972855 1972887
2011-03-07 18:53:42.217 AO: AddFrames frames=1536, bytes=18432, used=110593, free=2961407, timecode=1972855 needsupmix=0
2011-03-07 18:53:42.218 AO: SetAudiotime atc=1972855 tc=1972855 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.229 AFD: video timecode 177552820 177552820 177552820 1972809 1972809 1972775 (dts active)
2011-03-07 18:53:42.229 AFD: audio timecode 177559906 177559906 1972887 1972919
2011-03-07 18:53:42.229 AO: AddFrames frames=1536, bytes=18432, used=116737, free=2955263, timecode=1972887 needsupmix=0
2011-03-07 18:53:42.231 AO: SetAudiotime atc=1972887 tc=1972887 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.240 A/V timecodes audio 1972214 video 1972241 frameinterval 33366 avdel 27 avg -51670 tcoffset 0
2011-03-07 18:53:42.241 AFD: video timecode 177555823 177564832 177555823 1972842 1972842 1972809 (dts active)
2011-03-07 18:53:42.244 AFD: audio timecode 177562786 177562786 1972919 1972951
2011-03-07 18:53:42.244 AO: AddFrames frames=1536, bytes=18432, used=116737, free=2955263, timecode=1972919 needsupmix=0
2011-03-07 18:53:42.244 AVSync waitforframe 0 0
2011-03-07 18:53:42.244 AVSync show
2011-03-07 18:53:42.246 AO: SetAudiotime atc=1972919 tc=1972919 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.257 AFD: video timecode 177558826 177558826 177558826 1972875 1972875 1972842 (dts active)
2011-03-07 18:53:42.257 AFD: audio timecode 177565666 177565666 1972951 1972983
2011-03-07 18:53:42.257 AO: AddFrames frames=1536, bytes=18432, used=122881, free=2949119, timecode=1972951 needsupmix=0
2011-03-07 18:53:42.258 AO: SetAudiotime atc=1972951 tc=1972951 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.269 AFD: video timecode 177561829 177561829 177561829 1972909 1972909 1972875 (dts active)
2011-03-07 18:53:42.269 AFD: audio timecode 177568546 177568546 1972983 1973015
2011-03-07 18:53:42.269 AO: AddFrames frames=1536, bytes=18432, used=129025, free=2942975, timecode=1972983 needsupmix=0
2011-03-07 18:53:42.271 AO: SetAudiotime atc=1972983 tc=1972983 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.273 A/V timecodes audio 1972246 video 1972275 frameinterval 33366 avdel 29 avg -32002 tcoffset 0
2011-03-07 18:53:42.277 AVSync waitforframe 0 0
2011-03-07 18:53:42.277 AVSync show
2011-03-07 18:53:42.284 AFD: video timecode 177564832 177573841 177564832 1972942 1972942 1972909 (dts active)
2011-03-07 18:53:42.285 AFD: audio timecode 177571426 177571426 1973015 1973047
2011-03-07 18:53:42.285 AO: AddFrames frames=1536, bytes=18432, used=129025, free=2942975, timecode=1973015 needsupmix=0
2011-03-07 18:53:42.287 AO: SetAudiotime atc=1973015 tc=1973015 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.298 AFD: video timecode 177567835 177567835 177567835 1972975 1972975 1972942 (dts active)
2011-03-07 18:53:42.298 AFD: audio timecode 177574306 177574306 1973047 1973079
2011-03-07 18:53:42.298 AO: AddFrames frames=1536, bytes=18432, used=135169, free=2936831, timecode=1973047 needsupmix=0
2011-03-07 18:53:42.300 AO: SetAudiotime atc=1973047 tc=1973047 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.307 A/V timecodes audio 1972278 video 1972308 frameinterval 33366 avdel 30 avg -16751 tcoffset 0
2011-03-07 18:53:42.310 AFD: video timecode 177570838 177570838 177570838 1973009 1973009 1972975 (dts active)
2011-03-07 18:53:42.311 AFD: audio timecode 177577186 177577186 1973079 1973111
2011-03-07 18:53:42.311 AO: AddFrames frames=1536, bytes=18432, used=135169, free=2936831, timecode=1973079 needsupmix=0
2011-03-07 18:53:42.312 AO: SetAudiotime atc=1973079 tc=1973079 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.321 AFD: video timecode 177573841 177582850 177573841 1973042 1973042 1973009 (dts active)
2011-03-07 18:53:42.323 AFD: audio timecode 177580066 177580066 1973111 1973143
2011-03-07 18:53:42.323 AO: AddFrames frames=1536, bytes=18432, used=141313, free=2930687, timecode=1973111 needsupmix=0
2011-03-07 18:53:42.325 AO: SetAudiotime atc=1973111 tc=1973111 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.326 AVSync waitforframe 0 0
2011-03-07 18:53:42.326 AVSync show
2011-03-07 18:53:42.338 AFD: video timecode 177576844 177576844 177576844 1973076 1973076 1973042 (dts active)
2011-03-07 18:53:42.339 AFD: audio timecode 177582946 177582946 1973143 1973175
2011-03-07 18:53:42.339 AO: AddFrames frames=1536, bytes=18432, used=147457, free=2924543, timecode=1973143 needsupmix=0
2011-03-07 18:53:42.340 AO: SetAudiotime atc=1973143 tc=1973143 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.340 AFD: audio timecode 177585826 177585826 1973175 1973207
2011-03-07 18:53:42.340 AO: AddFrames frames=1536, bytes=18432, used=147457, free=2924543, timecode=1973175 needsupmix=0
2011-03-07 18:53:42.342 AO: SetAudiotime atc=1973175 tc=1973175 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.353 AFD: video timecode 177579847 177579847 177579847 1973109 1973109 1973076 (dts active)
2011-03-07 18:53:42.354 AFD: audio timecode 177588706 177588706 1973207 1973239
2011-03-07 18:53:42.354 AO: AddFrames frames=1536, bytes=18432, used=153601, free=2918399, timecode=1973207 needsupmix=0
2011-03-07 18:53:42.355 AO: SetAudiotime atc=1973207 tc=1973207 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.357 A/V timecodes audio 1972342 video 1972341 frameinterval 33366 avdel -1 avg -5063 tcoffset 0
2011-03-07 18:53:42.362 AVSync waitforframe 0 0
2011-03-07 18:53:42.363 AVSync show
2011-03-07 18:53:42.367 AFD: video timecode 177582850 177591859 177582850 1973142 1973142 1973109 (dts active)
2011-03-07 18:53:42.367 AFD: audio timecode 177591586 177591586 1973239 1973271
2011-03-07 18:53:42.367 AO: AddFrames frames=1536, bytes=18432, used=159745, free=2912255, timecode=1973239 needsupmix=0
2011-03-07 18:53:42.368 AO: SetAudiotime atc=1973239 tc=1973239 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.372 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:42.373 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:42.379 AFD: video timecode 177585853 177585853 177585853 1973176 1973176 1973142 (dts active)
2011-03-07 18:53:42.380 AFD: audio timecode 177594466 177594466 1973271 1973303
2011-03-07 18:53:42.380 AO: AddFrames frames=1536, bytes=18432, used=159745, free=2912255, timecode=1973271 needsupmix=0
2011-03-07 18:53:42.382 AO: SetAudiotime atc=1973271 tc=1973271 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.390 A/V timecodes audio 1972374 video 1972375 frameinterval 33366 avdel 1 avg -4047 tcoffset 0
2011-03-07 18:53:42.394 AFD: video timecode 177588856 177588856 177588856 1973209 1973209 1973176 (dts active)
2011-03-07 18:53:42.394 AFD: audio timecode 177597346 177597346 1973303 1973335
2011-03-07 18:53:42.394 AO: AddFrames frames=1536, bytes=18432, used=165889, free=2906111, timecode=1973303 needsupmix=0
2011-03-07 18:53:42.395 AVSync waitforframe 0 0
2011-03-07 18:53:42.395 AVSync show
2011-03-07 18:53:42.396 AO: SetAudiotime atc=1973303 tc=1973303 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.405 AFD: video timecode 177591859 177600868 177591859 1973242 1973242 1973209 (dts active)
2011-03-07 18:53:42.406 AFD: audio timecode 177600226 177600226 1973335 1973367
2011-03-07 18:53:42.406 AO: AddFrames frames=1536, bytes=18432, used=165889, free=2906111, timecode=1973335 needsupmix=0
2011-03-07 18:53:42.408 AO: SetAudiotime atc=1973335 tc=1973335 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.419 AFD: video timecode 177594862 177594862 177594862 1973276 1973276 1973242 (dts active)
2011-03-07 18:53:42.419 AFD: audio timecode 177603106 177603106 1973367 1973399
2011-03-07 18:53:42.419 AO: AddFrames frames=1536, bytes=18432, used=172033, free=2899967, timecode=1973367 needsupmix=0
2011-03-07 18:53:42.420 AO: SetAudiotime atc=1973367 tc=1973367 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.423 A/V timecodes audio 1972406 video 1972408 frameinterval 33366 avdel 2 avg -2785 tcoffset 0
2011-03-07 18:53:42.427 AVSync waitforframe 0 0
2011-03-07 18:53:42.428 AVSync show
2011-03-07 18:53:42.432 AFD: video timecode 177597865 177597865 177597865 1973309 1973309 1973276 (dts active)
2011-03-07 18:53:42.432 AFD: audio timecode 177605986 177605986 1973399 1973431
2011-03-07 18:53:42.432 AO: AddFrames frames=1536, bytes=18432, used=178177, free=2893823, timecode=1973399 needsupmix=0
2011-03-07 18:53:42.434 AO: SetAudiotime atc=1973399 tc=1973399 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.444 AFD: video timecode 177600868 177609877 177600868 1973342 1973342 1973309 (dts active)
2011-03-07 18:53:42.445 AFD: audio timecode 177608866 177608866 1973431 1973463
2011-03-07 18:53:42.445 AO: AddFrames frames=1536, bytes=18432, used=178177, free=2893823, timecode=1973431 needsupmix=0
2011-03-07 18:53:42.446 AO: SetAudiotime atc=1973431 tc=1973431 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.457 A/V timecodes audio 1972438 video 1972442 frameinterval 33366 avdel 4 avg -1588 tcoffset 0
2011-03-07 18:53:42.457 AFD: video timecode 177603871 177603871 177603871 1973376 1973376 1973342 (dts active)
2011-03-07 18:53:42.458 AFD: audio timecode 177611746 177611746 1973463 1973495
2011-03-07 18:53:42.458 AO: AddFrames frames=1536, bytes=18432, used=184321, free=2887679, timecode=1973463 needsupmix=0
2011-03-07 18:53:42.459 AO: SetAudiotime atc=1973463 tc=1973463 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.471 AFD: video timecode 177606874 177606874 177606874 1973409 1973409 1973376 (dts active)
2011-03-07 18:53:42.471 AFD: audio timecode 177614626 177614626 1973495 1973527
2011-03-07 18:53:42.471 AO: AddFrames frames=1536, bytes=18432, used=184321, free=2887679, timecode=1973495 needsupmix=0
2011-03-07 18:53:42.472 AO: SetAudiotime atc=1973495 tc=1973495 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.476 AVSync waitforframe 0 0
2011-03-07 18:53:42.476 AVSync show
2011-03-07 18:53:42.486 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:42.486 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:53:42.487 AFD: video timecode 177609877 177618886 177609877 1973443 1973443 1973409 (dts active)
2011-03-07 18:53:42.488 AFD: audio timecode 177617506 177617506 1973527 1973559
2011-03-07 18:53:42.488 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973527 needsupmix=0
2011-03-07 18:53:42.490 AO: SetAudiotime atc=1973527 tc=1973527 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.492 A/V timecodes audio 1972470 video 1972475 frameinterval 33366 avdel 5 avg -191 tcoffset 0
2011-03-07 18:53:42.497 AVSync waitforframe 0 0
2011-03-07 18:53:42.498 AVSync show
2011-03-07 18:53:42.506 AFD: video timecode 177612880 177612880 177612880 1973476 1973476 1973443 (dts active)
2011-03-07 18:53:42.506 AFD: audio timecode 177620386 177620386 1973559 1973591
2011-03-07 18:53:42.507 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973559 needsupmix=0
2011-03-07 18:53:42.508 AO: SetAudiotime atc=1973559 tc=1973559 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.523 A/V timecodes audio 1972502 video 1972508 frameinterval 33366 avdel 6 avg 1106 tcoffset 0
2011-03-07 18:53:42.528 AVSync waitforframe 0 0
2011-03-07 18:53:42.528 AVSync show
2011-03-07 18:53:42.544 AFD: video timecode 177615883 177615883 177615883 1973509 1973509 1973476 (dts active)
2011-03-07 18:53:42.544 AFD: audio timecode 177623266 177623266 1973591 1973623
2011-03-07 18:53:42.544 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973591 needsupmix=0
2011-03-07 18:53:42.546 AO: SetAudiotime atc=1973591 tc=1973591 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.557 A/V timecodes audio 1972534 video 1972542 frameinterval 33366 avdel 8 avg 2329 tcoffset 0
2011-03-07 18:53:42.561 AVSync waitforframe 0 0
2011-03-07 18:53:42.561 AVSync show
2011-03-07 18:53:42.568 AFD: video timecode 177618886 177627895 177618886 1973543 1973543 1973509 (dts active)
2011-03-07 18:53:42.569 AFD: audio timecode 177626146 177626146 1973623 1973655
2011-03-07 18:53:42.569 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973623 needsupmix=0
2011-03-07 18:53:42.570 AO: SetAudiotime atc=1973623 tc=1973623 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.590 A/V timecodes audio 1972566 video 1972575 frameinterval 33366 avdel 9 avg 3746 tcoffset 0
2011-03-07 18:53:42.594 AVSync waitforframe 0 0
2011-03-07 18:53:42.594 AVSync show
2011-03-07 18:53:42.603 AFD: video timecode 177621889 177621889 177621889 1973576 1973576 1973543 (dts active)
2011-03-07 18:53:42.603 AFD: audio timecode 177629026 177629026 1973655 1973687
2011-03-07 18:53:42.603 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973655 needsupmix=0
2011-03-07 18:53:42.605 AO: SetAudiotime atc=1973655 tc=1973655 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.623 A/V timecodes audio 1972598 video 1972608 frameinterval 33366 avdel 10 avg 5059 tcoffset 0
2011-03-07 18:53:42.627 AVSync waitforframe 0 0
2011-03-07 18:53:42.627 AVSync show
2011-03-07 18:53:42.638 AFD: video timecode 177624892 177624892 177624892 1973609 1973609 1973576 (dts active)
2011-03-07 18:53:42.638 AFD: audio timecode 177631906 177631906 1973687 1973719
2011-03-07 18:53:42.638 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973687 needsupmix=0
2011-03-07 18:53:42.639 AO: SetAudiotime atc=1973687 tc=1973687 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.657 A/V timecodes audio 1972630 video 1972642 frameinterval 33366 avdel 12 avg 6294 tcoffset 0
2011-03-07 18:53:42.661 AVSync waitforframe 0 0
2011-03-07 18:53:42.661 AVSync show
2011-03-07 18:53:42.668 AFD: video timecode 177627895 177636904 177627895 1973643 1973643 1973609 (dts active)
2011-03-07 18:53:42.669 AFD: audio timecode 177634786 177634786 1973719 1973751
2011-03-07 18:53:42.669 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973719 needsupmix=0
2011-03-07 18:53:42.671 AO: SetAudiotime atc=1973719 tc=1973719 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.690 A/V timecodes audio 1972662 video 1972675 frameinterval 33366 avdel 13 avg 7720 tcoffset 0
2011-03-07 18:53:42.694 AVSync waitforframe 0 0
2011-03-07 18:53:42.695 AVSync show
2011-03-07 18:53:42.702 AFD: video timecode 177630898 177630898 177630898 1973676 1973676 1973643 (dts active)
2011-03-07 18:53:42.703 AFD: audio timecode 177637666 177637666 1973751 1973783
2011-03-07 18:53:42.703 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973751 needsupmix=0
2011-03-07 18:53:42.704 AO: SetAudiotime atc=1973751 tc=1973751 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.723 A/V timecodes audio 1972694 video 1972709 frameinterval 33366 avdel 15 avg 9040 tcoffset 0
2011-03-07 18:53:42.728 AVSync waitforframe 0 0
2011-03-07 18:53:42.728 AVSync show
2011-03-07 18:53:42.737 AFD: video timecode 177633901 177633901 177633901 1973710 1973710 1973676 (dts active)
2011-03-07 18:53:42.737 AFD: audio timecode 177640546 177640546 1973783 1973815
2011-03-07 18:53:42.737 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973783 needsupmix=0
2011-03-07 18:53:42.738 AO: SetAudiotime atc=1973783 tc=1973783 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.757 A/V timecodes audio 1972758 video 1972742 frameinterval 33366 avdel -16 avg 10530 tcoffset 0
2011-03-07 18:53:42.761 AVSync waitforframe 0 0
2011-03-07 18:53:42.761 AVSync show
2011-03-07 18:53:42.769 AFD: video timecode 177636904 177645913 177636904 1973743 1973743 1973710 (dts active)
2011-03-07 18:53:42.770 AFD: audio timecode 177643426 177643426 1973815 1973847
2011-03-07 18:53:42.770 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973815 needsupmix=0
2011-03-07 18:53:42.771 AO: SetAudiotime atc=1973815 tc=1973815 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.790 A/V timecodes audio 1972790 video 1972775 frameinterval 33366 avdel -15 avg 3897 tcoffset 0
2011-03-07 18:53:42.794 AVSync waitforframe 0 0
2011-03-07 18:53:42.794 AVSync show
2011-03-07 18:53:42.803 AFD: video timecode 177639907 177639907 177639907 1973776 1973776 1973743 (dts active)
2011-03-07 18:53:42.804 AFD: audio timecode 177646306 177646306 1973847 1973879
2011-03-07 18:53:42.804 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973847 needsupmix=0
2011-03-07 18:53:42.805 AO: SetAudiotime atc=1973847 tc=1973847 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.823 A/V timecodes audio 1972822 video 1972809 frameinterval 33366 avdel -13 avg -827 tcoffset 0
2011-03-07 18:53:42.828 AVSync waitforframe 0 0
2011-03-07 18:53:42.828 AVSync show
2011-03-07 18:53:42.837 AFD: video timecode 177642910 177642910 177642910 1973810 1973810 1973776 (dts active)
2011-03-07 18:53:42.837 AFD: audio timecode 177649186 177649186 1973879 1973911
2011-03-07 18:53:42.837 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973879 needsupmix=0
2011-03-07 18:53:42.839 AO: SetAudiotime atc=1973879 tc=1973879 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.857 A/V timecodes audio 1972854 video 1972842 frameinterval 33366 avdel -12 avg -3870 tcoffset 0
2011-03-07 18:53:42.861 AVSync waitforframe 0 0
2011-03-07 18:53:42.861 AVSync show
2011-03-07 18:53:42.868 AFD: video timecode 177645913 177654922 177645913 1973843 1973843 1973810 (dts active)
2011-03-07 18:53:42.869 AFD: audio timecode 177652066 177652066 1973911 1973943
2011-03-07 18:53:42.869 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973911 needsupmix=0
2011-03-07 18:53:42.871 AO: SetAudiotime atc=1973911 tc=1973911 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.890 A/V timecodes audio 1972886 video 1972875 frameinterval 33366 avdel -11 avg -5902 tcoffset 0
2011-03-07 18:53:42.894 AVSync waitforframe 0 0
2011-03-07 18:53:42.894 AVSync show
2011-03-07 18:53:42.903 AFD: video timecode 177648916 177648916 177648916 1973876 1973876 1973843 (dts active)
2011-03-07 18:53:42.903 AFD: audio timecode 177654946 177654946 1973943 1973975
2011-03-07 18:53:42.903 AO: AddFrames frames=1536, bytes=18432, used=190465, free=2881535, timecode=1973943 needsupmix=0
2011-03-07 18:53:42.904 AO: SetAudiotime atc=1973943 tc=1973943 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.905 AFD: audio timecode 177657826 177657826 1973975 1974007
2011-03-07 18:53:42.905 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1973975 needsupmix=0
2011-03-07 18:53:42.906 AO: SetAudiotime atc=1973975 tc=1973975 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.923 A/V timecodes audio 1972918 video 1972909 frameinterval 33366 avdel -9 avg -7176 tcoffset 0
2011-03-07 18:53:42.928 AVSync waitforframe 0 0
2011-03-07 18:53:42.928 AVSync show
2011-03-07 18:53:42.936 AFD: video timecode 177651919 177651919 177651919 1973910 1973910 1973876 (dts active)
2011-03-07 18:53:42.936 AFD: audio timecode 177660706 177660706 1974007 1974039
2011-03-07 18:53:42.937 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974007 needsupmix=0
2011-03-07 18:53:42.938 AO: SetAudiotime atc=1974007 tc=1974007 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.957 A/V timecodes audio 1972950 video 1972942 frameinterval 33366 avdel -8 avg -7632 tcoffset 0
2011-03-07 18:53:42.960 AVSync waitforframe 0 0
2011-03-07 18:53:42.960 AVSync show
2011-03-07 18:53:42.970 AFD: video timecode 177654922 177663931 177654922 1973943 1973943 1973910 (dts active)
2011-03-07 18:53:42.971 AFD: audio timecode 177663586 177663586 1974039 1974071
2011-03-07 18:53:42.971 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974039 needsupmix=0
2011-03-07 18:53:42.972 AO: SetAudiotime atc=1974039 tc=1974039 f=1536 pfu=0 pfs=0
2011-03-07 18:53:42.990 A/V timecodes audio 1972982 video 1972975 frameinterval 33366 avdel -7 avg -7724 tcoffset 0
2011-03-07 18:53:42.994 AVSync waitforframe 0 0
2011-03-07 18:53:42.995 AVSync show
2011-03-07 18:53:43.003 AFD: video timecode 177657925 177657925 177657925 1973976 1973976 1973943 (dts active)
2011-03-07 18:53:43.003 AFD: audio timecode 177666466 177666466 1974071 1974103
2011-03-07 18:53:43.003 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974071 needsupmix=0
2011-03-07 18:53:43.005 AO: SetAudiotime atc=1974071 tc=1974071 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.023 A/V timecodes audio 1973014 video 1973009 frameinterval 33366 avdel -5 avg -7543 tcoffset 0
2011-03-07 18:53:43.027 AVSync waitforframe 0 0
2011-03-07 18:53:43.027 AVSync show
2011-03-07 18:53:43.035 AFD: video timecode 177660928 177660928 177660928 1974010 1974010 1973976 (dts active)
2011-03-07 18:53:43.036 AFD: audio timecode 177669346 177669346 1974103 1974135
2011-03-07 18:53:43.036 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974103 needsupmix=0
2011-03-07 18:53:43.038 AO: SetAudiotime atc=1974103 tc=1974103 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.057 A/V timecodes audio 1973046 video 1973042 frameinterval 33366 avdel -4 avg -6907 tcoffset 0
2011-03-07 18:53:43.061 AVSync waitforframe 0 0
2011-03-07 18:53:43.061 AVSync show
2011-03-07 18:53:43.067 AFD: video timecode 177663931 177672940 177663931 1974043 1974043 1974010 (dts active)
2011-03-07 18:53:43.067 AFD: audio timecode 177672226 177672226 1974135 1974167
2011-03-07 18:53:43.067 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974135 needsupmix=0
2011-03-07 18:53:43.068 AO: SetAudiotime atc=1974135 tc=1974135 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.090 A/V timecodes audio 1973078 video 1973076 frameinterval 33366 avdel -2 avg -6180 tcoffset 0
2011-03-07 18:53:43.094 AVSync waitforframe 0 0
2011-03-07 18:53:43.094 AVSync show
2011-03-07 18:53:43.102 AFD: video timecode 177666934 177666934 177666934 1974077 1974077 1974043 (dts active)
2011-03-07 18:53:43.102 AFD: audio timecode 177675106 177675106 1974167 1974199
2011-03-07 18:53:43.102 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974167 needsupmix=0
2011-03-07 18:53:43.104 AO: SetAudiotime atc=1974167 tc=1974167 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.123 A/V timecodes audio 1973110 video 1973109 frameinterval 33366 avdel -1 avg -5135 tcoffset 0
2011-03-07 18:53:43.127 AVSync waitforframe 0 0
2011-03-07 18:53:43.127 AVSync show
2011-03-07 18:53:43.136 AFD: video timecode 177669937 177669937 177669937 1974110 1974110 1974077 (dts active)
2011-03-07 18:53:43.137 AFD: audio timecode 177677986 177677986 1974199 1974231
2011-03-07 18:53:43.137 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974199 needsupmix=0
2011-03-07 18:53:43.138 AO: SetAudiotime atc=1974199 tc=1974199 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.157 A/V timecodes audio 1973142 video 1973142 frameinterval 33366 avdel 0 avg -4101 tcoffset 0
2011-03-07 18:53:43.161 AVSync waitforframe 0 0
2011-03-07 18:53:43.161 AVSync show
2011-03-07 18:53:43.168 AFD: video timecode 177672940 177681949 177672940 1974143 1974143 1974110 (dts active)
2011-03-07 18:53:43.168 AFD: audio timecode 177680866 177680866 1974231 1974263
2011-03-07 18:53:43.168 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974231 needsupmix=0
2011-03-07 18:53:43.170 AO: SetAudiotime atc=1974231 tc=1974231 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.187 A/V timecodes audio 1973174 video 1973176 frameinterval 33366 avdel 2 avg -3075 tcoffset 0
2011-03-07 18:53:43.191 AVSync waitforframe 0 0
2011-03-07 18:53:43.191 AVSync show
2011-03-07 18:53:43.200 AFD: video timecode 177675943 177675943 177675943 1974177 1974177 1974143 (dts active)
2011-03-07 18:53:43.200 AFD: audio timecode 177683746 177683746 1974263 1974295
2011-03-07 18:53:43.200 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974263 needsupmix=0
2011-03-07 18:53:43.201 AO: SetAudiotime atc=1974263 tc=1974263 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.213 A/V timecodes audio 1973206 video 1973209 frameinterval 33366 avdel 3 avg -1806 tcoffset 0
2011-03-07 18:53:43.217 AVSync waitforframe 0 0
2011-03-07 18:53:43.217 AVSync show
2011-03-07 18:53:43.226 AFD: video timecode 177678946 177678946 177678946 1974210 1974210 1974177 (dts active)
2011-03-07 18:53:43.227 AFD: audio timecode 177686626 177686626 1974295 1974327
2011-03-07 18:53:43.227 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974295 needsupmix=0
2011-03-07 18:53:43.228 AO: SetAudiotime atc=1974295 tc=1974295 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.230 A/V timecodes audio 1973206 video 1973242 frameinterval 33366 avdel 36 avg -604 tcoffset 0
2011-03-07 18:53:43.234 AVSync waitforframe 0 0
2011-03-07 18:53:43.242 AFD: video timecode 177681949 177690958 177681949 1974243 1974243 1974210 (dts active)
2011-03-07 18:53:43.242 AFD: audio timecode 177689506 177689506 1974327 1974359
2011-03-07 18:53:43.242 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974327 needsupmix=0
2011-03-07 18:53:43.244 AVSync show
2011-03-07 18:53:43.244 AO: SetAudiotime atc=1974327 tc=1974327 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.251 A/V timecodes audio 1973238 video 1973276 frameinterval 33366 avdel 38 avg 8547 tcoffset 0
2011-03-07 18:53:43.255 AVSync waitforframe 0 0
2011-03-07 18:53:43.264 AFD: video timecode 177684952 177684952 177684952 1974277 1974277 1974243 (dts active)
2011-03-07 18:53:43.264 AFD: audio timecode 177692386 177692386 1974359 1974391
2011-03-07 18:53:43.264 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974359 needsupmix=0
2011-03-07 18:53:43.265 AO: SetAudiotime atc=1974359 tc=1974359 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.277 AVSync show
2011-03-07 18:53:43.284 A/V timecodes audio 1973270 video 1973309 frameinterval 33366 avdel 39 avg 15910 tcoffset 0
2011-03-07 18:53:43.288 AVSync waitforframe 0 0
2011-03-07 18:53:43.295 AFD: video timecode 177687955 177687955 177687955 1974310 1974310 1974277 (dts active)
2011-03-07 18:53:43.296 AFD: audio timecode 177695266 177695266 1974391 1974423
2011-03-07 18:53:43.296 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974391 needsupmix=0
2011-03-07 18:53:43.298 AO: SetAudiotime atc=1974391 tc=1974391 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.310 AVSync show
2011-03-07 18:53:43.317 A/V timecodes audio 1973302 video 1973342 frameinterval 33366 avdel 40 avg 21682 tcoffset 0
2011-03-07 18:53:43.321 AVSync waitforframe 0 0
2011-03-07 18:53:43.328 AFD: video timecode 177690958 177699967 177690958 1974343 1974343 1974310 (dts active)
2011-03-07 18:53:43.328 AFD: audio timecode 177698146 177698146 1974423 1974455
2011-03-07 18:53:43.328 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974423 needsupmix=0
2011-03-07 18:53:43.330 AO: SetAudiotime atc=1974423 tc=1974423 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.344 AVSync show
2011-03-07 18:53:43.351 A/V timecodes audio 1973334 video 1973376 frameinterval 33366 avdel 42 avg 26261 tcoffset 0
2011-03-07 18:53:43.355 AVSync waitforframe 0 0
2011-03-07 18:53:43.363 AFD: video timecode 177693961 177693961 177693961 1974377 1974377 1974343 (dts active)
2011-03-07 18:53:43.363 AFD: audio timecode 177701026 177701026 1974455 1974487
2011-03-07 18:53:43.363 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974455 needsupmix=0
2011-03-07 18:53:43.365 AO: SetAudiotime atc=1974455 tc=1974455 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.377 AVSync show
2011-03-07 18:53:43.384 A/V timecodes audio 1973366 video 1973409 frameinterval 33366 avdel 43 avg 30195 tcoffset 0
2011-03-07 18:53:43.388 AVSync waitforframe 0 0
2011-03-07 18:53:43.396 AFD: video timecode 177696964 177696964 177696964 1974410 1974410 1974377 (dts active)
2011-03-07 18:53:43.397 AFD: audio timecode 177703906 177703906 1974487 1974519
2011-03-07 18:53:43.397 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974487 needsupmix=0
2011-03-07 18:53:43.398 AO: SetAudiotime atc=1974487 tc=1974487 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.411 AVSync show
2011-03-07 18:53:43.417 A/V timecodes audio 1973398 video 1973443 frameinterval 33366 avdel 45 avg 33396 tcoffset 0
2011-03-07 18:53:43.421 AVSync waitforframe 0 0
2011-03-07 18:53:43.431 AFD: video timecode 177699967 177708976 177699967 1974444 1974444 1974410 (dts active)
2011-03-07 18:53:43.431 AFD: audio timecode 177706786 177706786 1974519 1974551
2011-03-07 18:53:43.431 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974519 needsupmix=0
2011-03-07 18:53:43.433 AO: SetAudiotime atc=1974519 tc=1974519 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.444 AVSync show
2011-03-07 18:53:43.451 A/V timecodes audio 1973430 video 1973476 frameinterval 33366 avdel 46 avg 36297 tcoffset 0
2011-03-07 18:53:43.455 AVSync waitforframe 0 0
2011-03-07 18:53:43.462 AFD: video timecode 177702970 177702970 177702970 1974477 1974477 1974444 (dts active)
2011-03-07 18:53:43.463 AFD: audio timecode 177709666 177709666 1974551 1974583
2011-03-07 18:53:43.463 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974551 needsupmix=0
2011-03-07 18:53:43.464 AO: SetAudiotime atc=1974551 tc=1974551 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.477 AVSync show
2011-03-07 18:53:43.484 A/V timecodes audio 1973462 video 1973509 frameinterval 33366 avdel 47 avg 38722 tcoffset 0
2011-03-07 18:53:43.488 AVSync waitforframe 0 0
2011-03-07 18:53:43.495 AFD: video timecode 177705973 177705973 177705973 1974510 1974510 1974477 (dts active)
2011-03-07 18:53:43.497 AFD: audio timecode 177712546 177712546 1974583 1974615
2011-03-07 18:53:43.497 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974583 needsupmix=0
2011-03-07 18:53:43.498 AO: SetAudiotime atc=1974583 tc=1974583 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.511 AVSync show
2011-03-07 18:53:43.518 A/V timecodes audio 1973494 video 1973543 frameinterval 33366 avdel 49 avg 40791 tcoffset 0
2011-03-07 18:53:43.521 AVSync waitforframe 0 0
2011-03-07 18:53:43.528 AFD: video timecode 177708976 177717985 177708976 1974544 1974544 1974510 (dts active)
2011-03-07 18:53:43.528 AFD: audio timecode 177715426 177715426 1974615 1974647
2011-03-07 18:53:43.528 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974615 needsupmix=0
2011-03-07 18:53:43.530 AO: SetAudiotime atc=1974615 tc=1974615 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.544 AVSync show
2011-03-07 18:53:43.551 A/V timecodes audio 1973526 video 1973576 frameinterval 33366 avdel 50 avg 42843 tcoffset 0
2011-03-07 18:53:43.555 AVSync waitforframe 0 0
2011-03-07 18:53:43.563 AFD: video timecode 177711979 177711979 177711979 1974577 1974577 1974544 (dts active)
2011-03-07 18:53:43.564 AFD: audio timecode 177718306 177718306 1974647 1974679
2011-03-07 18:53:43.564 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974647 needsupmix=0
2011-03-07 18:53:43.565 AO: SetAudiotime atc=1974647 tc=1974647 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.577 AVSync show
2011-03-07 18:53:43.584 A/V timecodes audio 1973558 video 1973609 frameinterval 33366 avdel 51 avg 44632 tcoffset 0
2011-03-07 18:53:43.588 AVSync waitforframe 0 0
2011-03-07 18:53:43.596 AFD: video timecode 177714982 177714982 177714982 1974610 1974610 1974577 (dts active)
2011-03-07 18:53:43.597 AFD: audio timecode 177721186 177721186 1974679 1974711
2011-03-07 18:53:43.597 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974679 needsupmix=0
2011-03-07 18:53:43.598 AO: SetAudiotime atc=1974679 tc=1974679 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.611 AVSync show
2011-03-07 18:53:43.617 A/V timecodes audio 1973590 video 1973643 frameinterval 33366 avdel 53 avg 46224 tcoffset 0
2011-03-07 18:53:43.621 AVSync waitforframe 0 0
2011-03-07 18:53:43.628 AFD: video timecode 177717985 177726994 177717985 1974644 1974644 1974610 (dts active)
2011-03-07 18:53:43.628 AFD: audio timecode 177724066 177724066 1974711 1974743
2011-03-07 18:53:43.628 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1974711 needsupmix=0
2011-03-07 18:53:43.630 AO: SetAudiotime atc=1974711 tc=1974711 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.630 AFD: audio timecode 177726946 177726946 1974743 1974775
2011-03-07 18:53:43.630 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974743 needsupmix=0
2011-03-07 18:53:43.632 AO: SetAudiotime atc=1974743 tc=1974743 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.644 AVSync show
2011-03-07 18:53:43.651 A/V timecodes audio 1973622 video 1973676 frameinterval 33366 avdel 54 avg 47918 tcoffset 0
2011-03-07 18:53:43.655 AVSync waitforframe 0 0
2011-03-07 18:53:43.662 AFD: video timecode 177720988 177720988 177720988 1974677 1974677 1974644 (dts active)
2011-03-07 18:53:43.662 AFD: audio timecode 177729826 177729826 1974775 1974807
2011-03-07 18:53:43.663 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974775 needsupmix=0
2011-03-07 18:53:43.664 AO: SetAudiotime atc=1974775 tc=1974775 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.677 AVSync show
2011-03-07 18:53:43.684 A/V timecodes audio 1973686 video 1973710 frameinterval 33366 avdel 24 avg 49438 tcoffset 0
2011-03-07 18:53:43.688 AVSync waitforframe 0 0
2011-03-07 18:53:43.697 AFD: video timecode 177723991 177723991 177723991 1974711 1974711 1974677 (dts active)
2011-03-07 18:53:43.697 AFD: audio timecode 177732706 177732706 1974807 1974839
2011-03-07 18:53:43.697 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974807 needsupmix=0
2011-03-07 18:53:43.699 AO: SetAudiotime atc=1974807 tc=1974807 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.711 AVSync show
2011-03-07 18:53:43.718 A/V timecodes audio 1973718 video 1973743 frameinterval 33366 avdel 25 avg 43078 tcoffset 0
2011-03-07 18:53:43.722 AVSync waitforframe 0 0
2011-03-07 18:53:43.728 AFD: video timecode 177726994 177736003 177726994 1974744 1974744 1974711 (dts active)
2011-03-07 18:53:43.728 AFD: audio timecode 177735586 177735586 1974839 1974871
2011-03-07 18:53:43.728 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974839 needsupmix=0
2011-03-07 18:53:43.730 AO: SetAudiotime atc=1974839 tc=1974839 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.744 AVSync show
2011-03-07 18:53:43.751 A/V timecodes audio 1973750 video 1973776 frameinterval 33366 avdel 26 avg 38558 tcoffset 0
2011-03-07 18:53:43.755 AVSync waitforframe 0 0
2011-03-07 18:53:43.763 AFD: video timecode 177729997 177729997 177729997 1974777 1974777 1974744 (dts active)
2011-03-07 18:53:43.764 AFD: audio timecode 177738466 177738466 1974871 1974903
2011-03-07 18:53:43.764 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974871 needsupmix=0
2011-03-07 18:53:43.765 AO: SetAudiotime atc=1974871 tc=1974871 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.778 AVSync show
2011-03-07 18:53:43.784 A/V timecodes audio 1973782 video 1973810 frameinterval 33366 avdel 28 avg 35418 tcoffset 0
2011-03-07 18:53:43.789 AVSync waitforframe 0 0
2011-03-07 18:53:43.796 AFD: video timecode 177733000 177733000 177733000 1974811 1974811 1974777 (dts active)
2011-03-07 18:53:43.797 AFD: audio timecode 177741346 177741346 1974903 1974935
2011-03-07 18:53:43.797 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974903 needsupmix=0
2011-03-07 18:53:43.799 AO: SetAudiotime atc=1974903 tc=1974903 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.811 AVSync show
2011-03-07 18:53:43.818 A/V timecodes audio 1973814 video 1973843 frameinterval 33366 avdel 29 avg 33563 tcoffset 0
2011-03-07 18:53:43.822 AVSync waitforframe 0 0
2011-03-07 18:53:43.829 AFD: video timecode 177736003 177745012 177736003 1974844 1974844 1974811 (dts active)
2011-03-07 18:53:43.830 AFD: audio timecode 177744226 177744226 1974935 1974967
2011-03-07 18:53:43.830 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974935 needsupmix=0
2011-03-07 18:53:43.831 AO: SetAudiotime atc=1974935 tc=1974935 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.844 AVSync show
2011-03-07 18:53:43.851 A/V timecodes audio 1973846 video 1973876 frameinterval 33366 avdel 30 avg 32422 tcoffset 0
2011-03-07 18:53:43.855 AVSync waitforframe 0 0
2011-03-07 18:53:43.864 AFD: video timecode 177739006 177739006 177739006 1974877 1974877 1974844 (dts active)
2011-03-07 18:53:43.864 AFD: audio timecode 177747106 177747106 1974967 1974999
2011-03-07 18:53:43.864 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974967 needsupmix=0
2011-03-07 18:53:43.866 AO: SetAudiotime atc=1974967 tc=1974967 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.878 AVSync show
2011-03-07 18:53:43.885 A/V timecodes audio 1973878 video 1973910 frameinterval 33366 avdel 32 avg 31816 tcoffset 0
2011-03-07 18:53:43.889 AVSync waitforframe 0 0
2011-03-07 18:53:43.898 AFD: video timecode 177742009 177742009 177742009 1974911 1974911 1974877 (dts active)
2011-03-07 18:53:43.899 AFD: audio timecode 177749986 177749986 1974999 1975031
2011-03-07 18:53:43.899 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1974999 needsupmix=0
2011-03-07 18:53:43.900 AO: SetAudiotime atc=1974999 tc=1974999 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.911 AVSync show
2011-03-07 18:53:43.918 A/V timecodes audio 1973910 video 1973943 frameinterval 33366 avdel 33 avg 31862 tcoffset 0
2011-03-07 18:53:43.921 AVSync waitforframe 0 0
2011-03-07 18:53:43.931 AFD: video timecode 177745012 177754021 177745012 1974944 1974944 1974911 (dts active)
2011-03-07 18:53:43.931 AFD: audio timecode 177752866 177752866 1975031 1975063
2011-03-07 18:53:43.931 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975031 needsupmix=0
2011-03-07 18:53:43.933 AO: SetAudiotime atc=1975031 tc=1975031 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.944 AVSync show
2011-03-07 18:53:43.951 A/V timecodes audio 1973942 video 1973976 frameinterval 33366 avdel 34 avg 32146 tcoffset 0
2011-03-07 18:53:43.955 AVSync waitforframe 0 0
2011-03-07 18:53:43.963 AFD: video timecode 177748015 177748015 177748015 1974977 1974977 1974944 (dts active)
2011-03-07 18:53:43.963 AFD: audio timecode 177755746 177755746 1975063 1975095
2011-03-07 18:53:43.963 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975063 needsupmix=0
2011-03-07 18:53:43.965 AO: SetAudiotime atc=1975063 tc=1975063 f=1536 pfu=0 pfs=0
2011-03-07 18:53:43.978 AVSync show
2011-03-07 18:53:43.985 A/V timecodes audio 1973974 video 1974010 frameinterval 33366 avdel 36 avg 32609 tcoffset 0
2011-03-07 18:53:43.989 AVSync waitforframe 0 0
2011-03-07 18:53:43.996 AFD: video timecode 177751018 177751018 177751018 1975011 1975011 1974977 (dts active)
2011-03-07 18:53:43.997 AFD: audio timecode 177758626 177758626 1975095 1975127
2011-03-07 18:53:43.997 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975095 needsupmix=0
2011-03-07 18:53:43.999 AO: SetAudiotime atc=1975095 tc=1975095 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.011 AVSync show
2011-03-07 18:53:44.018 A/V timecodes audio 1974006 video 1974043 frameinterval 33366 avdel 37 avg 33456 tcoffset 0
2011-03-07 18:53:44.022 AVSync waitforframe 0 0
2011-03-07 18:53:44.028 AFD: video timecode 177754021 177763030 177754021 1975044 1975044 1975011 (dts active)
2011-03-07 18:53:44.028 AFD: audio timecode 177761506 177761506 1975127 1975159
2011-03-07 18:53:44.028 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975127 needsupmix=0
2011-03-07 18:53:44.030 AO: SetAudiotime atc=1975127 tc=1975127 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.045 AVSync show
2011-03-07 18:53:44.051 A/V timecodes audio 1974038 video 1974077 frameinterval 33366 avdel 39 avg 34342 tcoffset 0
2011-03-07 18:53:44.055 AVSync waitforframe 0 0
2011-03-07 18:53:44.063 AFD: video timecode 177757024 177757024 177757024 1975078 1975078 1975044 (dts active)
2011-03-07 18:53:44.064 AFD: audio timecode 177764386 177764386 1975159 1975191
2011-03-07 18:53:44.064 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975159 needsupmix=0
2011-03-07 18:53:44.065 AO: SetAudiotime atc=1975159 tc=1975159 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.078 AVSync show
2011-03-07 18:53:44.085 A/V timecodes audio 1974070 video 1974110 frameinterval 33366 avdel 40 avg 35506 tcoffset 0
2011-03-07 18:53:44.089 AVSync waitforframe 0 0
2011-03-07 18:53:44.096 AFD: video timecode 177760027 177760027 177760027 1975111 1975111 1975078 (dts active)
2011-03-07 18:53:44.096 AFD: audio timecode 177767266 177767266 1975191 1975223
2011-03-07 18:53:44.096 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975191 needsupmix=0
2011-03-07 18:53:44.098 AO: SetAudiotime atc=1975191 tc=1975191 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.111 AVSync show
2011-03-07 18:53:44.118 A/V timecodes audio 1974102 video 1974143 frameinterval 33366 avdel 41 avg 36629 tcoffset 0
2011-03-07 18:53:44.122 AVSync waitforframe 0 0
2011-03-07 18:53:44.128 AFD: video timecode 177763030 177772039 177763030 1975144 1975144 1975111 (dts active)
2011-03-07 18:53:44.129 AFD: audio timecode 177770146 177770146 1975223 1975255
2011-03-07 18:53:44.129 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975223 needsupmix=0
2011-03-07 18:53:44.130 AO: SetAudiotime atc=1975223 tc=1975223 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.145 AVSync show
2011-03-07 18:53:44.152 A/V timecodes audio 1974134 video 1974177 frameinterval 33366 avdel 43 avg 37721 tcoffset 0
2011-03-07 18:53:44.156 AVSync waitforframe 0 0
2011-03-07 18:53:44.163 AFD: video timecode 177766033 177766033 177766033 1975178 1975178 1975144 (dts active)
2011-03-07 18:53:44.163 AFD: audio timecode 177773026 177773026 1975255 1975287
2011-03-07 18:53:44.163 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975255 needsupmix=0
2011-03-07 18:53:44.164 AO: SetAudiotime atc=1975255 tc=1975255 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.178 AVSync show
2011-03-07 18:53:44.185 A/V timecodes audio 1974166 video 1974210 frameinterval 33366 avdel 44 avg 39040 tcoffset 0
2011-03-07 18:53:44.189 AVSync waitforframe 0 0
2011-03-07 18:53:44.196 AFD: video timecode 177769036 177769036 177769036 1975211 1975211 1975178 (dts active)
2011-03-07 18:53:44.197 AFD: audio timecode 177775906 177775906 1975287 1975319
2011-03-07 18:53:44.197 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975287 needsupmix=0
2011-03-07 18:53:44.198 AO: SetAudiotime atc=1975287 tc=1975287 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.211 AVSync show
2011-03-07 18:53:44.218 A/V timecodes audio 1974198 video 1974243 frameinterval 33366 avdel 45 avg 40280 tcoffset 0
2011-03-07 18:53:44.222 AVSync waitforframe 0 0
2011-03-07 18:53:44.228 AFD: video timecode 177772039 177781048 177772039 1975244 1975244 1975211 (dts active)
2011-03-07 18:53:44.228 AFD: audio timecode 177778786 177778786 1975319 1975351
2011-03-07 18:53:44.228 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975319 needsupmix=0
2011-03-07 18:53:44.230 AO: SetAudiotime atc=1975319 tc=1975319 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.245 AVSync show
2011-03-07 18:53:44.252 A/V timecodes audio 1974230 video 1974277 frameinterval 33366 avdel 47 avg 41460 tcoffset 0
2011-03-07 18:53:44.256 AVSync waitforframe 0 0
2011-03-07 18:53:44.263 AFD: video timecode 177775042 177775042 177775042 1975278 1975278 1975244 (dts active)
2011-03-07 18:53:44.263 AFD: audio timecode 177781666 177781666 1975351 1975383
2011-03-07 18:53:44.263 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975351 needsupmix=0
2011-03-07 18:53:44.265 AO: SetAudiotime atc=1975351 tc=1975351 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.278 AVSync show
2011-03-07 18:53:44.285 A/V timecodes audio 1974262 video 1974310 frameinterval 33366 avdel 48 avg 42845 tcoffset 0
2011-03-07 18:53:44.289 AVSync waitforframe 0 0
2011-03-07 18:53:44.297 AFD: video timecode 177778045 177778045 177778045 1975311 1975311 1975278 (dts active)
2011-03-07 18:53:44.298 AFD: audio timecode 177784546 177784546 1975383 1975415
2011-03-07 18:53:44.298 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975383 needsupmix=0
2011-03-07 18:53:44.299 AO: SetAudiotime atc=1975383 tc=1975383 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.311 AVSync show
2011-03-07 18:53:44.318 A/V timecodes audio 1974294 video 1974343 frameinterval 33366 avdel 49 avg 44133 tcoffset 0
2011-03-07 18:53:44.322 AVSync waitforframe 0 0
2011-03-07 18:53:44.329 AFD: video timecode 177781048 177790057 177781048 1975344 1975344 1975311 (dts active)
2011-03-07 18:53:44.329 AFD: audio timecode 177787426 177787426 1975415 1975447
2011-03-07 18:53:44.329 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975415 needsupmix=0
2011-03-07 18:53:44.331 AO: SetAudiotime atc=1975415 tc=1975415 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.345 AVSync show
2011-03-07 18:53:44.352 A/V timecodes audio 1974326 video 1974377 frameinterval 33366 avdel 51 avg 45349 tcoffset 0
2011-03-07 18:53:44.356 AVSync waitforframe 0 0
2011-03-07 18:53:44.364 AFD: video timecode 177784051 177784051 177784051 1975378 1975378 1975344 (dts active)
2011-03-07 18:53:44.365 AFD: audio timecode 177790306 177790306 1975447 1975479
2011-03-07 18:53:44.365 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975447 needsupmix=0
2011-03-07 18:53:44.366 AO: SetAudiotime atc=1975447 tc=1975447 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.378 AVSync show
2011-03-07 18:53:44.385 A/V timecodes audio 1974358 video 1974410 frameinterval 33366 avdel 52 avg 46761 tcoffset 0
2011-03-07 18:53:44.389 AVSync waitforframe 0 0
2011-03-07 18:53:44.397 AFD: video timecode 177787054 177787054 177787054 1975411 1975411 1975378 (dts active)
2011-03-07 18:53:44.398 AFD: audio timecode 177793186 177793186 1975479 1975511
2011-03-07 18:53:44.398 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975479 needsupmix=0
2011-03-07 18:53:44.400 AO: SetAudiotime atc=1975479 tc=1975479 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.412 AVSync show
2011-03-07 18:53:44.418 A/V timecodes audio 1974390 video 1974444 frameinterval 33366 avdel 54 avg 48070 tcoffset 0
2011-03-07 18:53:44.422 AVSync waitforframe 0 0
2011-03-07 18:53:44.432 AFD: video timecode 177790057 177799066 177790057 1975445 1975445 1975411 (dts active)
2011-03-07 18:53:44.432 AFD: audio timecode 177796066 177796066 1975511 1975543
2011-03-07 18:53:44.432 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1975511 needsupmix=0
2011-03-07 18:53:44.434 AO: SetAudiotime atc=1975511 tc=1975511 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.434 AFD: audio timecode 177798946 177798946 1975543 1975575
2011-03-07 18:53:44.434 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975543 needsupmix=0
2011-03-07 18:53:44.435 AO: SetAudiotime atc=1975543 tc=1975543 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.445 AVSync show
2011-03-07 18:53:44.452 A/V timecodes audio 1974454 video 1974477 frameinterval 33366 avdel 23 avg 49552 tcoffset 0
2011-03-07 18:53:44.456 AVSync waitforframe 0 0
2011-03-07 18:53:44.463 AFD: video timecode 177793060 177793060 177793060 1975478 1975478 1975445 (dts active)
2011-03-07 18:53:44.464 AFD: audio timecode 177801826 177801826 1975575 1975607
2011-03-07 18:53:44.464 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975575 needsupmix=0
2011-03-07 18:53:44.466 AO: SetAudiotime atc=1975575 tc=1975575 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.478 AVSync show
2011-03-07 18:53:44.485 A/V timecodes audio 1974486 video 1974510 frameinterval 33366 avdel 24 avg 42914 tcoffset 0
2011-03-07 18:53:44.489 AVSync waitforframe 0 0
2011-03-07 18:53:44.497 AFD: video timecode 177796063 177796063 177796063 1975511 1975511 1975478 (dts active)
2011-03-07 18:53:44.497 AFD: audio timecode 177804706 177804706 1975607 1975639
2011-03-07 18:53:44.497 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975607 needsupmix=0
2011-03-07 18:53:44.499 AO: SetAudiotime atc=1975607 tc=1975607 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.512 AVSync show
2011-03-07 18:53:44.519 A/V timecodes audio 1974518 video 1974544 frameinterval 33366 avdel 26 avg 38185 tcoffset 0
2011-03-07 18:53:44.523 AVSync waitforframe 0 0
2011-03-07 18:53:44.529 AFD: video timecode 177799066 177808075 177799066 1975545 1975545 1975511 (dts active)
2011-03-07 18:53:44.530 AFD: audio timecode 177807586 177807586 1975639 1975671
2011-03-07 18:53:44.530 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975639 needsupmix=0
2011-03-07 18:53:44.531 AO: SetAudiotime atc=1975639 tc=1975639 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.545 AVSync show
2011-03-07 18:53:44.552 A/V timecodes audio 1974550 video 1974577 frameinterval 33366 avdel 27 avg 35138 tcoffset 0
2011-03-07 18:53:44.556 AVSync waitforframe 0 0
2011-03-07 18:53:44.563 AFD: video timecode 177802069 177802069 177802069 1975578 1975578 1975545 (dts active)
2011-03-07 18:53:44.564 AFD: audio timecode 177810466 177810466 1975671 1975703
2011-03-07 18:53:44.564 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975671 needsupmix=0
2011-03-07 18:53:44.566 AO: SetAudiotime atc=1975671 tc=1975671 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.578 AVSync show
2011-03-07 18:53:44.585 A/V timecodes audio 1974582 video 1974610 frameinterval 33366 avdel 28 avg 33103 tcoffset 0
2011-03-07 18:53:44.589 AVSync waitforframe 0 0
2011-03-07 18:53:44.596 AFD: video timecode 177805072 177805072 177805072 1975611 1975611 1975578 (dts active)
2011-03-07 18:53:44.597 AFD: audio timecode 177813346 177813346 1975703 1975735
2011-03-07 18:53:44.597 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975703 needsupmix=0
2011-03-07 18:53:44.598 AO: SetAudiotime atc=1975703 tc=1975703 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.612 AVSync show
2011-03-07 18:53:44.619 A/V timecodes audio 1974614 video 1974644 frameinterval 33366 avdel 30 avg 31827 tcoffset 0
2011-03-07 18:53:44.623 AVSync waitforframe 0 0
2011-03-07 18:53:44.630 AFD: video timecode 177808075 177817084 177808075 1975645 1975645 1975611 (dts active)
2011-03-07 18:53:44.630 AFD: audio timecode 177816226 177816226 1975735 1975767
2011-03-07 18:53:44.630 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975735 needsupmix=0
2011-03-07 18:53:44.632 AO: SetAudiotime atc=1975735 tc=1975735 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.645 AVSync show
2011-03-07 18:53:44.652 A/V timecodes audio 1974646 video 1974677 frameinterval 33366 avdel 31 avg 31370 tcoffset 0
2011-03-07 18:53:44.656 AVSync waitforframe 0 0
2011-03-07 18:53:44.664 AFD: video timecode 177811078 177811078 177811078 1975678 1975678 1975645 (dts active)
2011-03-07 18:53:44.665 AFD: audio timecode 177819106 177819106 1975767 1975799
2011-03-07 18:53:44.665 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1975767 needsupmix=0
2011-03-07 18:53:44.667 AO: SetAudiotime atc=1975767 tc=1975767 f=1536 pfu=0 pfs=0
2011-03-07 18:53:44.678 AVSync show
2011-03-07 18:53:44.685 A/V timecodes audio 1974678 video 1974711 frameinterval 33366 avdel 33 avg 31277 tcoffset 0

...

'video_output' mean = '33365.88', std. dev. = '151.49', fps = '29.97'
2011-03-07 18:54:01.536 A/V timecodes audio 1991510 video 1991561 frameinterval 33366 avdel 51 avg 45238 tcoffset 0
2011-03-07 18:54:01.540 AVSync waitforframe 0 0
2011-03-07 18:54:01.546 AFD: video timecode 179330596 179339605 179330596 1992562 1992562 1992528 (dts active)
2011-03-07 18:54:01.547 AFD: audio timecode 179336866 179336866 1992631 1992663
2011-03-07 18:54:01.547 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1992631 needsupmix=0
2011-03-07 18:54:01.548 AO: SetAudiotime atc=1992631 tc=1992631 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.562 AVSync show
2011-03-07 18:54:01.569 A/V timecodes audio 1991542 video 1991594 frameinterval 33366 avdel 52 avg 46678 tcoffset 0
2011-03-07 18:54:01.574 AVSync waitforframe 0 0
2011-03-07 18:54:01.581 AFD: video timecode 179333599 179333599 179333599 1992595 1992595 1992562 (dts active)
2011-03-07 18:54:01.582 AFD: audio timecode 179339746 179339746 1992663 1992695
2011-03-07 18:54:01.582 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1992663 needsupmix=0
2011-03-07 18:54:01.583 AO: SetAudiotime atc=1992663 tc=1992663 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.595 AVSync show
2011-03-07 18:54:01.603 A/V timecodes audio 1991606 video 1991627 frameinterval 33366 avdel 21 avg 48008 tcoffset 0
2011-03-07 18:54:01.607 AVSync waitforframe 0 0
2011-03-07 18:54:01.614 AFD: video timecode 179336602 179336602 179336602 1992628 1992628 1992595 (dts active)
2011-03-07 18:54:01.614 AFD: audio timecode 179342626 179342626 1992695 1992727
2011-03-07 18:54:01.614 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1992695 needsupmix=0
2011-03-07 18:54:01.615 AO: SetAudiotime atc=1992695 tc=1992695 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.616 AFD: audio timecode 179345506 179345506 1992727 1992759
2011-03-07 18:54:01.616 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992727 needsupmix=0
2011-03-07 18:54:01.617 AO: SetAudiotime atc=1992727 tc=1992727 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.629 AVSync show
2011-03-07 18:54:01.636 A/V timecodes audio 1991638 video 1991661 frameinterval 33366 avdel 23 avg 41256 tcoffset 0
2011-03-07 18:54:01.640 AVSync waitforframe 0 0
2011-03-07 18:54:01.647 AFD: video timecode 179339605 179348614 179339605 1992662 1992662 1992628 (dts active)
2011-03-07 18:54:01.647 AFD: audio timecode 179348386 179348386 1992759 1992791
2011-03-07 18:54:01.648 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992759 needsupmix=0
2011-03-07 18:54:01.649 AO: SetAudiotime atc=1992759 tc=1992759 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.662 AVSync show
2011-03-07 18:54:01.670 A/V timecodes audio 1991670 video 1991694 frameinterval 33366 avdel 24 avg 36692 tcoffset 0
2011-03-07 18:54:01.674 AVSync waitforframe 0 0
2011-03-07 18:54:01.681 AFD: video timecode 179342608 179342608 179342608 1992695 1992695 1992662 (dts active)
2011-03-07 18:54:01.681 AFD: audio timecode 179351266 179351266 1992791 1992823
2011-03-07 18:54:01.681 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992791 needsupmix=0
2011-03-07 18:54:01.683 AO: SetAudiotime atc=1992791 tc=1992791 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.695 AVSync show
2011-03-07 18:54:01.703 A/V timecodes audio 1991702 video 1991728 frameinterval 33366 avdel 26 avg 33519 tcoffset 0
2011-03-07 18:54:01.707 AVSync waitforframe 0 0
2011-03-07 18:54:01.714 AFD: video timecode 179345611 179345611 179345611 1992729 1992729 1992695 (dts active)
2011-03-07 18:54:01.714 AFD: audio timecode 179354146 179354146 1992823 1992855
2011-03-07 18:54:01.714 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992823 needsupmix=0
2011-03-07 18:54:01.716 AO: SetAudiotime atc=1992823 tc=1992823 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.729 AVSync show
2011-03-07 18:54:01.736 A/V timecodes audio 1991734 video 1991761 frameinterval 33366 avdel 27 avg 31639 tcoffset 0
2011-03-07 18:54:01.740 AVSync waitforframe 0 0
2011-03-07 18:54:01.747 AFD: video timecode 179348614 179357623 179348614 1992762 1992762 1992729 (dts active)
2011-03-07 18:54:01.747 AFD: audio timecode 179357026 179357026 1992855 1992887
2011-03-07 18:54:01.748 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992855 needsupmix=0
2011-03-07 18:54:01.749 AO: SetAudiotime atc=1992855 tc=1992855 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.762 AVSync show
2011-03-07 18:54:01.770 A/V timecodes audio 1991766 video 1991794 frameinterval 33366 avdel 28 avg 30479 tcoffset 0
2011-03-07 18:54:01.774 AVSync waitforframe 0 0
2011-03-07 18:54:01.782 AFD: video timecode 179351617 179351617 179351617 1992795 1992795 1992762 (dts active)
2011-03-07 18:54:01.782 AFD: audio timecode 179359906 179359906 1992887 1992919
2011-03-07 18:54:01.782 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992887 needsupmix=0
2011-03-07 18:54:01.783 AO: SetAudiotime atc=1992887 tc=1992887 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.795 AVSync show
2011-03-07 18:54:01.803 A/V timecodes audio 1991798 video 1991828 frameinterval 33366 avdel 30 avg 29859 tcoffset 0
2011-03-07 18:54:01.807 AVSync waitforframe 0 0
2011-03-07 18:54:01.815 AFD: video timecode 179354620 179354620 179354620 1992829 1992829 1992795 (dts active)
2011-03-07 18:54:01.816 AFD: audio timecode 179362786 179362786 1992919 1992951
2011-03-07 18:54:01.816 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992919 needsupmix=0
2011-03-07 18:54:01.817 AO: SetAudiotime atc=1992919 tc=1992919 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.829 AVSync show
2011-03-07 18:54:01.836 A/V timecodes audio 1991830 video 1991861 frameinterval 33366 avdel 31 avg 29894 tcoffset 0
2011-03-07 18:54:01.840 AVSync waitforframe 0 0
2011-03-07 18:54:01.847 AFD: video timecode 179357623 179366632 179357623 1992862 1992862 1992829 (dts active)
2011-03-07 18:54:01.848 AFD: audio timecode 179365666 179365666 1992951 1992983
2011-03-07 18:54:01.848 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992951 needsupmix=0
2011-03-07 18:54:01.849 AO: SetAudiotime atc=1992951 tc=1992951 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.862 AVSync show
2011-03-07 18:54:01.870 A/V timecodes audio 1991862 video 1991894 frameinterval 33366 avdel 32 avg 30170 tcoffset 0
2011-03-07 18:54:01.874 AVSync waitforframe 0 0
2011-03-07 18:54:01.882 AFD: video timecode 179360626 179360626 179360626 1992895 1992895 1992862 (dts active)
2011-03-07 18:54:01.882 AFD: audio timecode 179368546 179368546 1992983 1993015
2011-03-07 18:54:01.882 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1992983 needsupmix=0
2011-03-07 18:54:01.883 AO: SetAudiotime atc=1992983 tc=1992983 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.895 AVSync show
2011-03-07 18:54:01.903 A/V timecodes audio 1991894 video 1991928 frameinterval 33366 avdel 34 avg 30627 tcoffset 0
2011-03-07 18:54:01.907 AVSync waitforframe 0 0
2011-03-07 18:54:01.915 AFD: video timecode 179363629 179363629 179363629 1992929 1992929 1992895 (dts active)
2011-03-07 18:54:01.916 AFD: audio timecode 179371426 179371426 1993015 1993047
2011-03-07 18:54:01.916 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993015 needsupmix=0
2011-03-07 18:54:01.917 AO: SetAudiotime atc=1993015 tc=1993015 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.929 AVSync show
2011-03-07 18:54:01.936 A/V timecodes audio 1991926 video 1991961 frameinterval 33366 avdel 35 avg 31470 tcoffset 0
2011-03-07 18:54:01.940 AVSync waitforframe 0 0
2011-03-07 18:54:01.950 AFD: video timecode 179366632 179375641 179366632 1992962 1992962 1992929 (dts active)
2011-03-07 18:54:01.951 AFD: audio timecode 179374306 179374306 1993047 1993079
2011-03-07 18:54:01.951 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993047 needsupmix=0
2011-03-07 18:54:01.953 AO: SetAudiotime atc=1993047 tc=1993047 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.962 AVSync show
2011-03-07 18:54:01.970 A/V timecodes audio 1991958 video 1991994 frameinterval 33366 avdel 36 avg 32352 tcoffset 0
2011-03-07 18:54:01.974 AVSync waitforframe 0 0
2011-03-07 18:54:01.983 AFD: video timecode 179369635 179369635 179369635 1992995 1992995 1992962 (dts active)
2011-03-07 18:54:01.983 AFD: audio timecode 179377186 179377186 1993079 1993111
2011-03-07 18:54:01.983 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993079 needsupmix=0
2011-03-07 18:54:01.984 AO: SetAudiotime atc=1993079 tc=1993079 f=1536 pfu=0 pfs=0
2011-03-07 18:54:01.995 AVSync show
2011-03-07 18:54:02.003 A/V timecodes audio 1991990 video 1992028 frameinterval 33366 avdel 38 avg 33264 tcoffset 0
2011-03-07 18:54:02.007 AVSync waitforframe 0 0
2011-03-07 18:54:02.015 AFD: video timecode 179372638 179372638 179372638 1993029 1993029 1992995 (dts active)
2011-03-07 18:54:02.015 AFD: audio timecode 179380066 179380066 1993111 1993143
2011-03-07 18:54:02.015 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993111 needsupmix=0
2011-03-07 18:54:02.016 AO: SetAudiotime atc=1993111 tc=1993111 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.029 AVSync show
2011-03-07 18:54:02.036 A/V timecodes audio 1992022 video 1992061 frameinterval 33366 avdel 39 avg 34448 tcoffset 0
2011-03-07 18:54:02.041 AVSync waitforframe 0 0
2011-03-07 18:54:02.046 AFD: video timecode 179375641 179384650 179375641 1993062 1993062 1993029 (dts active)
2011-03-07 18:54:02.048 AFD: audio timecode 179382946 179382946 1993143 1993175
2011-03-07 18:54:02.048 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993143 needsupmix=0
2011-03-07 18:54:02.049 AO: SetAudiotime atc=1993143 tc=1993143 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.062 AVSync show
2011-03-07 18:54:02.070 A/V timecodes audio 1992054 video 1992095 frameinterval 33366 avdel 41 avg 35586 tcoffset 0
2011-03-07 18:54:02.074 AVSync waitforframe 0 0
2011-03-07 18:54:02.081 AFD: video timecode 179378644 179378644 179378644 1993096 1993096 1993062 (dts active)
2011-03-07 18:54:02.082 AFD: audio timecode 179385826 179385826 1993175 1993207
2011-03-07 18:54:02.082 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993175 needsupmix=0
2011-03-07 18:54:02.083 AO: SetAudiotime atc=1993175 tc=1993175 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.096 AVSync show
2011-03-07 18:54:02.103 A/V timecodes audio 1992086 video 1992128 frameinterval 33366 avdel 42 avg 36939 tcoffset 0
2011-03-07 18:54:02.107 AVSync waitforframe 0 0
2011-03-07 18:54:02.115 AFD: video timecode 179381647 179381647 179381647 1993129 1993129 1993096 (dts active)
2011-03-07 18:54:02.115 AFD: audio timecode 179388706 179388706 1993207 1993239
2011-03-07 18:54:02.115 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993207 needsupmix=0
2011-03-07 18:54:02.117 AO: SetAudiotime atc=1993207 tc=1993207 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.129 AVSync show
2011-03-07 18:54:02.136 A/V timecodes audio 1992118 video 1992161 frameinterval 33366 avdel 43 avg 38204 tcoffset 0
2011-03-07 18:54:02.141 AVSync waitforframe 0 0
2011-03-07 18:54:02.147 AFD: video timecode 179384650 179393659 179384650 1993162 1993162 1993129 (dts active)
2011-03-07 18:54:02.148 AFD: audio timecode 179391586 179391586 1993239 1993271
2011-03-07 18:54:02.148 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993239 needsupmix=0
2011-03-07 18:54:02.149 AO: SetAudiotime atc=1993239 tc=1993239 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.162 AVSync show
2011-03-07 18:54:02.170 A/V timecodes audio 1992150 video 1992195 frameinterval 33366 avdel 45 avg 39403 tcoffset 0
2011-03-07 18:54:02.174 AVSync waitforframe 0 0
2011-03-07 18:54:02.181 AFD: video timecode 179387653 179387653 179387653 1993196 1993196 1993162 (dts active)
2011-03-07 18:54:02.182 AFD: audio timecode 179394466 179394466 1993271 1993303
2011-03-07 18:54:02.182 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993271 needsupmix=0
2011-03-07 18:54:02.183 AO: SetAudiotime atc=1993271 tc=1993271 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.196 AVSync show
2011-03-07 18:54:02.203 A/V timecodes audio 1992182 video 1992228 frameinterval 33366 avdel 46 avg 40802 tcoffset 0
2011-03-07 18:54:02.208 AVSync waitforframe 0 0
2011-03-07 18:54:02.215 AFD: video timecode 179390656 179390656 179390656 1993229 1993229 1993196 (dts active)
2011-03-07 18:54:02.215 AFD: audio timecode 179397346 179397346 1993303 1993335
2011-03-07 18:54:02.215 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993303 needsupmix=0
2011-03-07 18:54:02.217 AO: SetAudiotime atc=1993303 tc=1993303 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.229 AVSync show
2011-03-07 18:54:02.237 A/V timecodes audio 1992214 video 1992261 frameinterval 33366 avdel 47 avg 42101 tcoffset 0
2011-03-07 18:54:02.241 AVSync waitforframe 0 0
2011-03-07 18:54:02.247 AFD: video timecode 179393659 179402668 179393659 1993262 1993262 1993229 (dts active)
2011-03-07 18:54:02.248 AFD: audio timecode 179400226 179400226 1993335 1993367
2011-03-07 18:54:02.248 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993335 needsupmix=0
2011-03-07 18:54:02.249 AO: SetAudiotime atc=1993335 tc=1993335 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.262 AVSync show
2011-03-07 18:54:02.270 A/V timecodes audio 1992246 video 1992295 frameinterval 33366 avdel 49 avg 43325 tcoffset 0
2011-03-07 18:54:02.274 AVSync waitforframe 0 0
2011-03-07 18:54:02.282 AFD: video timecode 179396662 179396662 179396662 1993296 1993296 1993262 (dts active)
2011-03-07 18:54:02.282 AFD: audio timecode 179403106 179403106 1993367 1993399
2011-03-07 18:54:02.282 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993367 needsupmix=0
2011-03-07 18:54:02.284 AO: SetAudiotime atc=1993367 tc=1993367 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.296 AVSync show
2011-03-07 18:54:02.303 A/V timecodes audio 1992278 video 1992328 frameinterval 33366 avdel 50 avg 44743 tcoffset 0
2011-03-07 18:54:02.308 AVSync waitforframe 0 0
2011-03-07 18:54:02.315 AFD: video timecode 179399665 179399665 179399665 1993329 1993329 1993296 (dts active)
2011-03-07 18:54:02.315 AFD: audio timecode 179405986 179405986 1993399 1993431
2011-03-07 18:54:02.315 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993399 needsupmix=0
2011-03-07 18:54:02.317 AO: SetAudiotime atc=1993399 tc=1993399 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.329 AVSync show
2011-03-07 18:54:02.337 A/V timecodes audio 1992310 video 1992361 frameinterval 33366 avdel 51 avg 46057 tcoffset 0
2011-03-07 18:54:02.341 AVSync waitforframe 0 0
2011-03-07 18:54:02.347 AFD: video timecode 179402668 179411677 179402668 1993362 1993362 1993329 (dts active)
2011-03-07 18:54:02.348 AFD: audio timecode 179408866 179408866 1993431 1993463
2011-03-07 18:54:02.348 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993431 needsupmix=0
2011-03-07 18:54:02.350 AO: SetAudiotime atc=1993431 tc=1993431 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.362 AVSync show
2011-03-07 18:54:02.370 A/V timecodes audio 1992342 video 1992395 frameinterval 33366 avdel 53 avg 47292 tcoffset 0
2011-03-07 18:54:02.374 AVSync waitforframe 0 0
2011-03-07 18:54:02.381 AFD: video timecode 179405671 179405671 179405671 1993396 1993396 1993362 (dts active)
2011-03-07 18:54:02.382 AFD: audio timecode 179411746 179411746 1993463 1993495
2011-03-07 18:54:02.382 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993463 needsupmix=0
2011-03-07 18:54:02.383 AO: SetAudiotime atc=1993463 tc=1993463 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.383 AFD: audio timecode 179414626 179414626 1993495 1993527
2011-03-07 18:54:02.384 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993495 needsupmix=0
2011-03-07 18:54:02.385 AO: SetAudiotime atc=1993495 tc=1993495 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.396 AVSync show
2011-03-07 18:54:02.403 A/V timecodes audio 1992406 video 1992428 frameinterval 33366 avdel 22 avg 48719 tcoffset 0
2011-03-07 18:54:02.407 AVSync waitforframe 0 0
2011-03-07 18:54:02.415 AFD: video timecode 179408674 179408674 179408674 1993429 1993429 1993396 (dts active)
2011-03-07 18:54:02.416 AFD: audio timecode 179417506 179417506 1993527 1993559
2011-03-07 18:54:02.416 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993527 needsupmix=0
2011-03-07 18:54:02.417 AO: SetAudiotime atc=1993527 tc=1993527 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.429 AVSync show
2011-03-07 18:54:02.437 A/V timecodes audio 1992438 video 1992462 frameinterval 33366 avdel 24 avg 42039 tcoffset 0
2011-03-07 18:54:02.440 AVSync waitforframe 0 0
2011-03-07 18:54:02.450 AFD: video timecode 179411677 179420686 179411677 1993463 1993463 1993429 (dts active)
2011-03-07 18:54:02.451 AFD: audio timecode 179420386 179420386 1993559 1993591
2011-03-07 18:54:02.451 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993559 needsupmix=0
2011-03-07 18:54:02.453 AO: SetAudiotime atc=1993559 tc=1993559 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.463 AVSync show
2011-03-07 18:54:02.470 A/V timecodes audio 1992470 video 1992495 frameinterval 33366 avdel 25 avg 37529 tcoffset 0
2011-03-07 18:54:02.474 AVSync waitforframe 0 0
2011-03-07 18:54:02.482 AFD: video timecode 179414680 179414680 179414680 1993496 1993496 1993463 (dts active)
2011-03-07 18:54:02.482 AFD: audio timecode 179423266 179423266 1993591 1993623
2011-03-07 18:54:02.482 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993591 needsupmix=0
2011-03-07 18:54:02.483 AO: SetAudiotime atc=1993591 tc=1993591 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.496 AVSync show
2011-03-07 18:54:02.504 A/V timecodes audio 1992502 video 1992528 frameinterval 33366 avdel 26 avg 34396 tcoffset 0
2011-03-07 18:54:02.508 AVSync waitforframe 0 0
2011-03-07 18:54:02.515 AFD: video timecode 179417683 179417683 179417683 1993529 1993529 1993496 (dts active)
2011-03-07 18:54:02.516 AFD: audio timecode 179426146 179426146 1993623 1993655
2011-03-07 18:54:02.516 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993623 needsupmix=0
2011-03-07 18:54:02.518 AO: SetAudiotime atc=1993623 tc=1993623 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.529 AVSync show
2011-03-07 18:54:02.537 A/V timecodes audio 1992534 video 1992562 frameinterval 33366 avdel 28 avg 32297 tcoffset 0
2011-03-07 18:54:02.541 AVSync waitforframe 0 0
2011-03-07 18:54:02.548 AFD: video timecode 179420686 179429695 179420686 1993563 1993563 1993529 (dts active)
2011-03-07 18:54:02.549 AFD: audio timecode 179429026 179429026 1993655 1993687
2011-03-07 18:54:02.549 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993655 needsupmix=0
2011-03-07 18:54:02.550 AO: SetAudiotime atc=1993655 tc=1993655 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.563 AVSync show
2011-03-07 18:54:02.570 A/V timecodes audio 1992566 video 1992595 frameinterval 33366 avdel 29 avg 31222 tcoffset 0
2011-03-07 18:54:02.575 AVSync waitforframe 0 0
2011-03-07 18:54:02.582 AFD: video timecode 179423689 179423689 179423689 1993596 1993596 1993563 (dts active)
2011-03-07 18:54:02.583 AFD: audio timecode 179431906 179431906 1993687 1993719
2011-03-07 18:54:02.583 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993687 needsupmix=0
2011-03-07 18:54:02.584 AO: SetAudiotime atc=1993687 tc=1993687 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.596 AVSync show
2011-03-07 18:54:02.604 A/V timecodes audio 1992598 video 1992628 frameinterval 33366 avdel 30 avg 30666 tcoffset 0
2011-03-07 18:54:02.608 AVSync waitforframe 0 0
2011-03-07 18:54:02.616 AFD: video timecode 179426692 179426692 179426692 1993629 1993629 1993596 (dts active)
2011-03-07 18:54:02.617 AFD: audio timecode 179434786 179434786 1993719 1993751
2011-03-07 18:54:02.617 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993719 needsupmix=0
2011-03-07 18:54:02.618 AO: SetAudiotime atc=1993719 tc=1993719 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.629 AVSync show
2011-03-07 18:54:02.637 A/V timecodes audio 1992630 video 1992662 frameinterval 33366 avdel 32 avg 30499 tcoffset 0
2011-03-07 18:54:02.641 AVSync waitforframe 0 0
2011-03-07 18:54:02.648 AFD: video timecode 179429695 179438704 179429695 1993663 1993663 1993629 (dts active)
2011-03-07 18:54:02.648 AFD: audio timecode 179437666 179437666 1993751 1993783
2011-03-07 18:54:02.648 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993751 needsupmix=0
2011-03-07 18:54:02.650 AO: SetAudiotime atc=1993751 tc=1993751 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.663 AVSync show
2011-03-07 18:54:02.670 A/V timecodes audio 1992662 video 1992695 frameinterval 33366 avdel 33 avg 30874 tcoffset 0
2011-03-07 18:54:02.674 AVSync waitforframe 0 0
2011-03-07 18:54:02.683 AFD: video timecode 179432698 179432698 179432698 1993696 1993696 1993663 (dts active)
2011-03-07 18:54:02.683 AFD: audio timecode 179440546 179440546 1993783 1993815
2011-03-07 18:54:02.683 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993783 needsupmix=0
2011-03-07 18:54:02.685 AO: SetAudiotime atc=1993783 tc=1993783 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.696 AVSync show
2011-03-07 18:54:02.704 A/V timecodes audio 1992694 video 1992729 frameinterval 33366 avdel 35 avg 31405 tcoffset 0
2011-03-07 18:54:02.708 AVSync waitforframe 0 0
2011-03-07 18:54:02.715 AFD: video timecode 179435701 179435701 179435701 1993730 1993730 1993696 (dts active)
2011-03-07 18:54:02.716 AFD: audio timecode 179443426 179443426 1993815 1993847
2011-03-07 18:54:02.716 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993815 needsupmix=0
2011-03-07 18:54:02.717 AO: SetAudiotime atc=1993815 tc=1993815 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.730 AVSync show
2011-03-07 18:54:02.737 A/V timecodes audio 1992726 video 1992762 frameinterval 33366 avdel 36 avg 32303 tcoffset 0
2011-03-07 18:54:02.741 AVSync waitforframe 0 0
2011-03-07 18:54:02.747 AFD: video timecode 179438704 179447713 179438704 1993763 1993763 1993730 (dts active)
2011-03-07 18:54:02.748 AFD: audio timecode 179446306 179446306 1993847 1993879
2011-03-07 18:54:02.748 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993847 needsupmix=0
2011-03-07 18:54:02.749 AO: SetAudiotime atc=1993847 tc=1993847 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.763 AVSync show
2011-03-07 18:54:02.770 A/V timecodes audio 1992758 video 1992795 frameinterval 33366 avdel 37 avg 33227 tcoffset 0
2011-03-07 18:54:02.775 AVSync waitforframe 0 0
2011-03-07 18:54:02.783 AFD: video timecode 179441707 179441707 179441707 1993796 1993796 1993763 (dts active)
2011-03-07 18:54:02.784 AFD: audio timecode 179449186 179449186 1993879 1993911
2011-03-07 18:54:02.784 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993879 needsupmix=0
2011-03-07 18:54:02.786 AO: SetAudiotime atc=1993879 tc=1993879 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.796 AVSync show
2011-03-07 18:54:02.804 A/V timecodes audio 1992790 video 1992829 frameinterval 33366 avdel 39 avg 34170 tcoffset 0
2011-03-07 18:54:02.808 AVSync waitforframe 0 0
2011-03-07 18:54:02.815 AFD: video timecode 179444710 179444710 179444710 1993830 1993830 1993796 (dts active)
2011-03-07 18:54:02.816 AFD: audio timecode 179452066 179452066 1993911 1993943
2011-03-07 18:54:02.816 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993911 needsupmix=0
2011-03-07 18:54:02.818 AO: SetAudiotime atc=1993911 tc=1993911 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.830 AVSync show
2011-03-07 18:54:02.837 A/V timecodes audio 1992822 video 1992862 frameinterval 33366 avdel 40 avg 35377 tcoffset 0
2011-03-07 18:54:02.841 AVSync waitforframe 0 0
2011-03-07 18:54:02.848 AFD: video timecode 179447713 179456722 179447713 1993863 1993863 1993830 (dts active)
2011-03-07 18:54:02.848 AFD: audio timecode 179454946 179454946 1993943 1993975
2011-03-07 18:54:02.848 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1993943 needsupmix=0
2011-03-07 18:54:02.850 AO: SetAudiotime atc=1993943 tc=1993943 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.863 AVSync show
2011-03-07 18:54:02.870 A/V timecodes audio 1992854 video 1992895 frameinterval 33366 avdel 41 avg 36532 tcoffset 0
2011-03-07 18:54:02.875 AVSync waitforframe 0 0
2011-03-07 18:54:02.882 AFD: video timecode 179450716 179450716 179450716 1993896 1993896 1993863 (dts active)
2011-03-07 18:54:02.882 AFD: audio timecode 179457826 179457826 1993975 1994007
2011-03-07 18:54:02.883 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993975 needsupmix=0
2011-03-07 18:54:02.884 AO: SetAudiotime atc=1993975 tc=1993975 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.896 AVSync show
2011-03-07 18:54:02.904 A/V timecodes audio 1992886 video 1992929 frameinterval 33366 avdel 43 avg 37649 tcoffset 0
2011-03-07 18:54:02.908 AVSync waitforframe 0 0
2011-03-07 18:54:02.916 AFD: video timecode 179453719 179453719 179453719 1993930 1993930 1993896 (dts active)
2011-03-07 18:54:02.916 AFD: audio timecode 179460706 179460706 1994007 1994039
2011-03-07 18:54:02.916 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994007 needsupmix=0
2011-03-07 18:54:02.918 AO: SetAudiotime atc=1994007 tc=1994007 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.930 AVSync show
2011-03-07 18:54:02.937 A/V timecodes audio 1992918 video 1992962 frameinterval 33366 avdel 44 avg 38986 tcoffset 0
2011-03-07 18:54:02.941 AVSync waitforframe 0 0
2011-03-07 18:54:02.950 AFD: video timecode 179456722 179465731 179456722 1993963 1993963 1993930 (dts active)
2011-03-07 18:54:02.952 AFD: audio timecode 179463586 179463586 1994039 1994071
2011-03-07 18:54:02.952 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994039 needsupmix=0
2011-03-07 18:54:02.953 AO: SetAudiotime atc=1994039 tc=1994039 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.963 AVSync show
2011-03-07 18:54:02.970 A/V timecodes audio 1992950 video 1992995 frameinterval 33366 avdel 45 avg 40239 tcoffset 0
2011-03-07 18:54:02.975 AVSync waitforframe 0 0
2011-03-07 18:54:02.982 AFD: video timecode 179459725 179459725 179459725 1993996 1993996 1993963 (dts active)
2011-03-07 18:54:02.982 AFD: audio timecode 179466466 179466466 1994071 1994103
2011-03-07 18:54:02.982 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994071 needsupmix=0
2011-03-07 18:54:02.984 AO: SetAudiotime atc=1994071 tc=1994071 f=1536 pfu=0 pfs=0
2011-03-07 18:54:02.996 AVSync show
2011-03-07 18:54:03.004 A/V timecodes audio 1992982 video 1993029 frameinterval 33366 avdel 47 avg 41429 tcoffset 0
2011-03-07 18:54:03.008 AVSync waitforframe 0 0
2011-03-07 18:54:03.015 AFD: video timecode 179462728 179462728 179462728 1994030 1994030 1993996 (dts active)
2011-03-07 18:54:03.016 AFD: audio timecode 179469346 179469346 1994103 1994135
2011-03-07 18:54:03.016 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994103 needsupmix=0
2011-03-07 18:54:03.017 AO: SetAudiotime atc=1994103 tc=1994103 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.030 AVSync show
2011-03-07 18:54:03.037 A/V timecodes audio 1993014 video 1993062 frameinterval 33366 avdel 48 avg 42821 tcoffset 0
2011-03-07 18:54:03.041 AVSync waitforframe 0 0
2011-03-07 18:54:03.047 AFD: video timecode 179465731 179474740 179465731 1994063 1994063 1994030 (dts active)
2011-03-07 18:54:03.048 AFD: audio timecode 179472226 179472226 1994135 1994167
2011-03-07 18:54:03.048 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994135 needsupmix=0
2011-03-07 18:54:03.050 AO: SetAudiotime atc=1994135 tc=1994135 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.063 AVSync show
2011-03-07 18:54:03.071 A/V timecodes audio 1993046 video 1993096 frameinterval 33366 avdel 50 avg 44115 tcoffset 0
2011-03-07 18:54:03.075 AVSync waitforframe 0 0
2011-03-07 18:54:03.083 AFD: video timecode 179468734 179468734 179468734 1994097 1994097 1994063 (dts active)
2011-03-07 18:54:03.083 AFD: audio timecode 179475106 179475106 1994167 1994199
2011-03-07 18:54:03.083 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994167 needsupmix=0
2011-03-07 18:54:03.084 AO: SetAudiotime atc=1994167 tc=1994167 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.097 AVSync show
2011-03-07 18:54:03.104 A/V timecodes audio 1993078 video 1993129 frameinterval 33366 avdel 51 avg 45586 tcoffset 0
2011-03-07 18:54:03.108 AVSync waitforframe 0 0
2011-03-07 18:54:03.115 AFD: video timecode 179471737 179471737 179471737 1994130 1994130 1994097 (dts active)
2011-03-07 18:54:03.116 AFD: audio timecode 179477986 179477986 1994199 1994231
2011-03-07 18:54:03.116 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994199 needsupmix=0
2011-03-07 18:54:03.117 AO: SetAudiotime atc=1994199 tc=1994199 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.130 AVSync show
2011-03-07 18:54:03.137 A/V timecodes audio 1993110 video 1993162 frameinterval 33366 avdel 52 avg 46939 tcoffset 0
2011-03-07 18:54:03.142 AVSync waitforframe 0 0
2011-03-07 18:54:03.147 AFD: video timecode 179474740 179483749 179474740 1994163 1994163 1994130 (dts active)
2011-03-07 18:54:03.147 AFD: audio timecode 179480866 179480866 1994231 1994263
2011-03-07 18:54:03.147 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994231 needsupmix=0
2011-03-07 18:54:03.149 AO: SetAudiotime atc=1994231 tc=1994231 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.163 AVSync show
2011-03-07 18:54:03.171 A/V timecodes audio 1993174 video 1993196 frameinterval 33366 avdel 22 avg 48204 tcoffset 0
2011-03-07 18:54:03.175 AVSync waitforframe 0 0
2011-03-07 18:54:03.182 AFD: video timecode 179477743 179477743 179477743 1994197 1994197 1994163 (dts active)
2011-03-07 18:54:03.182 AFD: audio timecode 179483746 179483746 1994263 1994295
2011-03-07 18:54:03.182 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1994263 needsupmix=0
2011-03-07 18:54:03.183 AO: SetAudiotime atc=1994263 tc=1994263 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.184 AFD: audio timecode 179486626 179486626 1994295 1994327
2011-03-07 18:54:03.184 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1994295 needsupmix=0
2011-03-07 18:54:03.185 AO: SetAudiotime atc=1994295 tc=1994295 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.197 AVSync show
2011-03-07 18:54:03.204 A/V timecodes audio 1993206 video 1993229 frameinterval 33366 avdel 23 avg 41653 tcoffset 0
2011-03-07 18:54:03.214 AFD: video timecode 179480746 179480746 179480746 1994230 1994230 1994197 (dts active)
2011-03-07 18:54:03.214 AFD: audio timecode 179489506 179489506 1994327 1994359
2011-03-07 18:54:03.214 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1994327 needsupmix=0
2011-03-07 18:54:03.216 AO: SetAudiotime atc=1994327 tc=1994327 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.216 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2011-03-07 18:54:03.216 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2011-03-07 18:54:03.225 AVSync waitforframe 0 0
2011-03-07 18:54:03.230 AVSync show
2011-03-07 18:54:03.237 A/V timecodes audio 1993238 video 1993262 frameinterval 33366 avdel 24 avg 36989 tcoffset 0
2011-03-07 18:54:03.241 AVSync waitforframe 0 0
2011-03-07 18:54:03.247 AFD: video timecode 179483749 179492758 179483749 1994263 1994263 1994230 (dts active)
2011-03-07 18:54:03.247 AFD: audio timecode 179492386 179492386 1994359 1994391
2011-03-07 18:54:03.248 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1994359 needsupmix=0
2011-03-07 18:54:03.249 AO: SetAudiotime atc=1994359 tc=1994359 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.263 AVSync show
2011-03-07 18:54:03.271 A/V timecodes audio 1993270 video 1993296 frameinterval 33366 avdel 26 avg 33741 tcoffset 0
2011-03-07 18:54:03.281 AFD: video timecode 179486752 179486752 179486752 1994297 1994297 1994263 (dts active)
2011-03-07 18:54:03.282 AFD: audio timecode 179495266 179495266 1994391 1994423
2011-03-07 18:54:03.282 AO: AddFrames frames=1536, bytes=18432, used=202753, free=2869247, timecode=1994391 needsupmix=0
2011-03-07 18:54:03.284 AO: SetAudiotime atc=1994391 tc=1994391 f=1536 pfu=0 pfs=0
2011-03-07 18:54:03.289 TV: HandleStateChange(0) -- begin
2011-03-07 18:54:03.289 TV: Attempting to change from WatchingPreRecorded to None
2011-03-07 18:54:03.289 TV: StopStuff() for player ctx 0 -- begin
2011-03-07 18:54:03.289 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
2011-03-07 18:54:03.289 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
2011-03-07 18:54:03.289 Player(0): StopPlaying - begin
2011-03-07 18:54:03.290 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:54:03.290 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:54:03.295 Player(0): Decoder thread exiting.
2011-03-07 18:54:03.295 Player(0): Exited decoder loop.
2011-03-07 18:54:03.389 AO: Killing AudioOutputDSP
2011-03-07 18:54:03.390 CoreAudioData::AudioStreamChangeFormat(262)
2011-03-07 18:54:03.702 Player(0): StopPlaying - end
2011-03-07 18:54:03.702 TV: StopStuff(): stopping ring buffer
2011-03-07 18:54:03.702 TV: StopStuff(): stopping player
2011-03-07 18:54:03.702 TV: StopStuff() -- end
2011-03-07 18:54:03.702 TV: Changing from WatchingPreRecorded to None
2011-03-07 18:54:03.703 TV: HandleStateChange(0) -- end
2011-03-07 18:54:03.703 TV: StartTV -- process events end
2011-03-07 18:54:03.703 TV: StartTV -- process events 2 begin
2011-03-07 18:54:03.733 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:54:03.733 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2011-03-07 18:54:03.733 TV: StartTV -- process events 2 end
2011-03-07 18:54:03.733 TV::~TV() -- begin
2011-03-07 18:54:03.744 TV::~TV() -- lock
2011-03-07 18:54:03.744 Player(0): StopPlaying - begin
2011-03-07 18:54:03.744 Player(0): Exited decoder loop.
2011-03-07 18:54:03.744 Player(0): StopPlaying - end
2011-03-07 18:54:03.756 TV::~TV() -- end
2011-03-07 18:54:03.757 TV: StartTV -- end