Ticket #5552: garbled_playback_timestamp.txt

File garbled_playback_timestamp.txt, 74.2 KB (added by scram69@…, 7 years ago)

Speakers->5.1 garbled playback

Line 
12011-03-07 18:54:40.945 TV: StartTV() -- begin
22011-03-07 18:54:40.945 TV: ctor -- begin
32011-03-07 18:54:40.945 TV: ctor -- end
42011-03-07 18:54:40.945 TV: Init -- begin
52011-03-07 18:54:40.960 TV: DrawUnusedRects() -- begin
62011-03-07 18:54:40.960 TV: DrawUnusedRects() -- end
72011-03-07 18:54:40.983 TV: Init -- end
82011-03-07 18:54:40.984 TV: tv->Playback() -- begin
92011-03-07 18:54:41.002 TV: HandleStateChange(0) -- begin
102011-03-07 18:54:41.002 TV: Attempting to change from None to WatchingPreRecorded
112011-03-07 18:54:41.009 RingBuf(myth://192.168.1.50:6543/2051_20110303200000.mpg): OpenFile(myth://192.168.1.50:6543/2051_20110303200000.mpg, 2000 ms)
122011-03-07 18:54:41.106 TV: StartPlayer(0, WatchingPreRecorded, main) -- begin
132011-03-07 18:54:41.106 TV: Elapsed time since TV constructor was called: 161 ms
142011-03-07 18:54:41.215 CoreAudioData::CoreAudioData - default device ID = 261
152011-03-07 18:54:41.216 AO: Sample rate 44100 is supported
162011-03-07 18:54:41.216 AO: Sample rate 48000 is supported
172011-03-07 18:54:41.216 AO: Sample rate 96000 is supported
182011-03-07 18:54:41.216 AudioOutputCA::Support 2 channels
192011-03-07 18:54:41.216 AO: 2 channel(s) are supported
202011-03-07 18:54:41.216 AudioOutputCA::Support 4 channels
212011-03-07 18:54:41.216 AO: 4 channel(s) are supported
222011-03-07 18:54:41.216 AO: Killing AudioOutputDSP
232011-03-07 18:54:41.275 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
242011-03-07 18:54:41.276 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
252011-03-07 18:54:41.276 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
262011-03-07 18:54:41.276 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
272011-03-07 18:54:41.276 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
282011-03-07 18:54:41.276 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
292011-03-07 18:54:41.276 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
302011-03-07 18:54:41.277 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
312011-03-07 18:54:41.277 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
322011-03-07 18:54:41.277 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
332011-03-07 18:54:41.277 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
342011-03-07 18:54:41.277 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
352011-03-07 18:54:41.277 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
362011-03-07 18:54:41.278 [mpeg2video @ 0x8a45a640]mpeg_decode_postinit() failure
372011-03-07 18:54:42.176 AFD: Stream #0, has id 0x840 codec id MPEG2VIDEO, type Video, bitrate 20000000 at 0x20abb250
382011-03-07 18:54:42.195 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
392011-03-07 18:54:42.195 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
402011-03-07 18:54:42.196 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt()
412011-03-07 18:54:42.196 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
422011-03-07 18:54:42.196 VDP: LoadBestPreferences(2048x2048, 0)
432011-03-07 18:54:42.196 VDP: LoadBestPreferences(2048x2048, 60)
442011-03-07 18:54:42.196 VDP: LoadBestPreferences(1920x1080, 60)
452011-03-07 18:54:42.197 AFD: Using 1 CPUs for decoding
462011-03-07 18:54:42.197 AFD: InitVideoCodec() 0x22895800 id(MPEG2VIDEO) type (Video).
472011-03-07 18:54:42.197 AFD: Selected FPS is 29.97 (avg 34.2011 stream 29.97 container 90000 estimated 29.97)
482011-03-07 18:54:42.197 Player(1): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
492011-03-07 18:54:42.197 AFD: EIA-708 caption service #1 is in the English language.
502011-03-07 18:54:42.197 AFD: Using ffmpeg for video decoding
512011-03-07 18:54:42.197 AFD: Looking for decoder for MPEG2VIDEO
522011-03-07 18:54:42.197 AFD: Opened codec 0x22895800, id(MPEG2VIDEO) type(Video)
532011-03-07 18:54:42.197 AFD: Stream #1, has id 0x841 codec id AC3, type Audio, bitrate 384000 at 0x20d00880
542011-03-07 18:54:42.197 AFD: codec AC3 has 6 channels
552011-03-07 18:54:42.197 AFD: Looking for decoder for AC3
562011-03-07 18:54:42.197 AFD: Opened codec 0x228a0e00, id(AC3) type(Audio)
572011-03-07 18:54:42.197 AFD: Audio Track #1 is A/V stream #1 and has 6 channels in the English language(6647399).
582011-03-07 18:54:42.198 AFD: Stream #2, has id 0x842 codec id AC3, type Audio, bitrate 192000 at 0x20ad7390
592011-03-07 18:54:42.198 AFD: codec AC3 has 1 channels
602011-03-07 18:54:42.198 AFD: Looking for decoder for AC3
612011-03-07 18:54:42.198 AFD: Opened codec 0x228a1200, id(AC3) type(Audio)
622011-03-07 18:54:42.198 AFD: Audio Track #2 is A/V stream #2 and has 1 channels in the English language(6647399).
632011-03-07 18:54:42.198 AFD: Stream #3, has id 0x843 codec id DVB_VBI, type Data, bitrate 0 at 0x20ad76c0
642011-03-07 18:54:42.198 AFD: data codec (Data)
652011-03-07 18:54:42.241 AFD: Trying to select audio track (w/lang)
662011-03-07 18:54:42.241 AFD: Selected track 1: English AC3 5.1ch (A/V Stream #1)
672011-03-07 18:54:42.241 AFD: Initializing audio parms from audio track #1
682011-03-07 18:54:42.241 AFD: Audio format changed
69                        from id(NONE)     -1Hz -1ch -1bps     to id( AC3)  48000Hz  6ch 16bps   
702011-03-07 18:54:42.241 AO: Killing AudioOutputDSP
712011-03-07 18:54:42.316 CoreAudioData::CoreAudioData - default device ID = 261
722011-03-07 18:54:42.317 AO: Sample rate 44100 is supported
732011-03-07 18:54:42.317 AO: Sample rate 48000 is supported
742011-03-07 18:54:42.317 AO: Sample rate 96000 is supported
752011-03-07 18:54:42.318 AudioOutputCA::Support 1 channels
762011-03-07 18:54:42.318 AO: 1 channel(s) are supported
772011-03-07 18:54:42.318 AudioOutputCA::Support 2 channels
782011-03-07 18:54:42.318 AO: 2 channel(s) are supported
792011-03-07 18:54:42.318 AudioOutputCA::Support 4 channels
802011-03-07 18:54:42.318 AO: 4 channel(s) are supported
812011-03-07 18:54:42.318 AO: Needs downmix from 6 -> 4 channels
822011-03-07 18:54:42.318 AO: Killing AudioOutputDSP
832011-03-07 18:54:42.318 AO: Original codec was AC3, signed 16 bit, 48 kHz, 6 channels
842011-03-07 18:54:42.318 AO: enc(0), passthru(0), canAC3(1), canDTS(1), canLPCM(1), configured_channels(4), 4 channels supported(1)
852011-03-07 18:54:42.318 AO: Audio processing enabled
862011-03-07 18:54:42.318 AO: Opening audio device 'CoreAudio:' ch 4(6) sr 48000 sf 32 bit floating point reenc 1
872011-03-07 18:54:42.318 AudioOutputCA::OpenDevice() Trying Analog.
882011-03-07 18:54:42.703 AO: Software volume enabled
892011-03-07 18:54:42.710 AO: Audio fragment size: 0
902011-03-07 18:54:42.710 AO: Audio Stretch Factor: 1
912011-03-07 18:54:42.710 AO: Ending Reconfigure()
922011-03-07 18:54:42.710 AudioPlayer: Enabling Audio
932011-03-07 18:54:42.711 AO: Needs downmix from 6 -> 4 channels
942011-03-07 18:54:42.711 AO: Reconfigure(): No change -> exiting
952011-03-07 18:54:42.711 Dec: Selected track #1 in the Unknown language(0)
962011-03-07 18:54:42.711 Dec: Selected track #1 in the English language(6647399)
972011-03-07 18:54:42.711 Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
982011-03-07 18:54:42.735 Dec: Position map filled from DB to: 55605
992011-03-07 18:54:42.735 Dec: SyncPositionMap prerecorded, from DB: 3708 entries
1002011-03-07 18:54:42.735 Dec: SyncPositionMap, new totframes: 55605, new length: 1855, posMap size: 3708
1012011-03-07 18:54:42.736 AFD: Position map found
1022011-03-07 18:54:42.736 AFD: Successfully opened decoder for file: "myth://192.168.1.50:6543/2051_20110303200000.mpg". novideo(0)
1032011-03-07 18:54:42.748 VideoOutput: Allowed renderers: quartz-blit,opengl
1042011-03-07 18:54:42.748 VideoOutput: Allowed renderers (filt: ffmpeg): quartz-blit,opengl
1052011-03-07 18:54:42.755 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
1062011-03-07 18:54:42.756 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
1072011-03-07 18:54:42.756 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt()
1082011-03-07 18:54:42.756 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
1092011-03-07 18:54:42.756 VDP: LoadBestPreferences(2048x2048, 0)
1102011-03-07 18:54:42.756 VDP: LoadBestPreferences(2048x2048, 60)
1112011-03-07 18:54:42.756 VDP: LoadBestPreferences(1920x1080, 60)
1122011-03-07 18:54:42.756 VideoOutput: Preferred renderer: quartz-blit
1132011-03-07 18:54:42.756 VideoOutput: Trying video renderer: 'quartz-blit'
1142011-03-07 18:54:42.764 VDP: Ignoring profile item 253 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
1152011-03-07 18:54:42.764 VDP: Ignoring profile item 254 (renderer xv-blit is not supported w/decoder ffmpeg (supported: null,quartz-blit,opengl))
1162011-03-07 18:54:42.764 VDP: Accepting: cmp(>= 1280 720) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(enabled) deint(linearblend,linearblend) filt()
1172011-03-07 18:54:42.764 VDP: Accepting: cmp(> 0 0) dec(ffmpeg) cpus(1) skiploop(enabled) rend(quartz-blit) osd(softblend) osdfade(disabled) deint(linearblend,linearblend) filt()
1182011-03-07 18:54:42.764 VDP: LoadBestPreferences(2048x2048, 0)
1192011-03-07 18:54:42.764 VDP: LoadBestPreferences(2048x2048, 60)
1202011-03-07 18:54:42.764 VideoOutWindow::SetPIPState. pip_state: 0]
1212011-03-07 18:54:42.765 SetVideoFrameRate(29.97) - unimplemented?
1222011-03-07 18:54:42.765 VideoOutputQuartz::Init(WxH 1920x1080, aspect=1.77778, winid=4402816
123                        win_bounds(x 0, y0, WxH 1360x768), WId embedid=0)
1242011-03-07 18:54:42.765 Display Rect  left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333
1252011-03-07 18:54:42.765 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1262011-03-07 18:54:42.765 VDP: LoadBestPreferences(1920x1088, 60)
1272011-03-07 18:54:42.765 VideoOutputQuartz::VideoAspectRatioChanged(aspect=1.77778) [was 1.3333]
1282011-03-07 18:54:42.765 Display Rect  left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333
1292011-03-07 18:54:42.765 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1302011-03-07 18:54:42.772 Screen size is 1100 x 620 (mm), aspect 1.77419
1312011-03-07 18:54:42.772 Main window is 1100 x 620 (mm), aspect 1.77419
1322011-03-07 18:54:42.772 VideoOutputQuartz::CreateQuartzBuffers() render: quartz-blit, allowed: quartz-blit
1332011-03-07 18:54:42.772 VDP: SetVideoRenderer(quartz-blit)
1342011-03-07 18:54:42.773 VDP: SetVideoRender(quartz-blit) == GetVideoRenderer()
1352011-03-07 18:54:42.773 VideoOutputQuartz::VProf: rend(quartz-blit) osd(softblend) deint(linearblend,linearblend) filt()
1362011-03-07 18:54:42.902 Main window: Viewport currently 0,0 -> 1360,768
1372011-03-07 18:54:42.902 Main window: Viewport is 1360 x 768
1382011-03-07 18:54:42.902 Main window: Image is 1920 x 1088
1392011-03-07 18:54:42.902 Main window: Scaling to 0.708333 x 0.705882 of original
1402011-03-07 18:54:42.902 Display Rect  left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778
1412011-03-07 18:54:42.903 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1422011-03-07 18:54:42.903 Main window: Viewport is 1360 x 768
1432011-03-07 18:54:42.903 Main window: Image is 1920 x 1088
1442011-03-07 18:54:42.903 Main window: Scaling to 0.708333 x 0.705882 of original
1452011-03-07 18:54:42.903 Over/underscan. V: 0, H: 0
1462011-03-07 18:54:42.903 Display Rect  left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778
1472011-03-07 18:54:42.903 Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1482011-03-07 18:54:42.903 Player(1): LoadFilters(''..) -> 0x0
1492011-03-07 18:54:42.908 Player(1): Decoder thread starting.
1502011-03-07 18:54:42.908 AFD: DoFastForward(1370 (0), do discard frames)
1512011-03-07 18:54:42.908 Dec: DoFastForward(1370 (0), do discard frames)
1522011-03-07 18:54:42.908 Dec: FindPosition(1370, search not adjusted) -->
153                        [91:1365(80353268),92:1380(81204532)]
1542011-03-07 18:54:42.910 AFD: SeekReset(1380, 0, do flush, do discard)
1552011-03-07 18:54:42.910 AFD: SeekReset() flushing
1562011-03-07 18:54:42.910 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1572011-03-07 18:54:42.910 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
1582011-03-07 18:54:42.910 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
1592011-03-07 18:54:42.911 Player(1): ClearAfterSeek(0)
1602011-03-07 18:54:42.917 OSD: Base theme size: 1920x1080
1612011-03-07 18:54:42.917 OSD: Scaling factors: 1x1
1622011-03-07 18:54:42.924 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
163                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 132
164                        Name: 'basenormal'      Type: 'fontdef'
1652011-03-07 18:54:42.927 OSD: Loaded window osd_message
1662011-03-07 18:54:42.934 OSD: Loaded window osd_input
1672011-03-07 18:54:42.939 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
168                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 196
169                        Name: 'basesmall'       Type: 'fontdef'
1702011-03-07 18:54:42.940 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
171                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 229
172                        Name: 'basesmalllightblue'      Type: 'fontdef'
1732011-03-07 18:54:42.960 OSD: Loaded window program_info
1742011-03-07 18:54:42.965 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
175                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 567
176                        Name: 'basesmall'       Type: 'fontdef'
1772011-03-07 18:54:42.966 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
178                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 600
179                        Name: 'basesmalllightblue'      Type: 'fontdef'
1802011-03-07 18:54:42.971 OSD: Loaded window browse_info
1812011-03-07 18:54:42.977 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
182                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 685
183                        Name: 'basenormal'      Type: 'fontdef'
1842011-03-07 18:54:42.980 OSD: Loaded window osd_status
1852011-03-07 18:54:42.986 MythFontProperties, Error: Failed to load 'CartoGothic Std', got 'Arial' instead
186                        Location: /Users/admin/.mythtv/themes/Arclight/osd.xml @ 901
187                        Name: 'basenormal'      Type: 'fontdef'
1882011-03-07 18:54:42.988 OSD: Loaded window osd_program_editor
1892011-03-07 18:54:42.988 OSD: Loaded OSD: size 1920x1080 offset 0+0
1902011-03-07 18:54:42.988 OSD: Base theme size: 1920x1080
1912011-03-07 18:54:42.988 OSD: Scaling factors: 1x1
1922011-03-07 18:54:42.988 Player(1): ClearAfterSeek(0)
1932011-03-07 18:54:42.995 [mpeg2video @ 0x8a45a640]warning: first frame is no keyframe
1942011-03-07 18:54:42.995 VDP: GetFilteredDeint() : quartz-blit -> 'linearblend'
1952011-03-07 18:54:42.999 FilterManager: GetFilterInfo(convert) returning: 0x0
1962011-03-07 18:54:42.999 FilterManager: GetFilterInfo(linearblend) returning: 0x1fd8c9d0
1972011-03-07 18:54:43.000 VideoOutput: Using deinterlace method linearblend
1982011-03-07 18:54:43.000 VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
1992011-03-07 18:54:43.004 AFD: video timecode 179429695 179429695 179420686 1993663 1993663 0 (reordered active)
2002011-03-07 18:54:43.004 Detect Letterbox: YV12 frame format detected
2012011-03-07 18:54:43.004 Detect Letterbox: The source is already in widescreen (aspect: 1.77778)
2022011-03-07 18:54:43.007 Player(1): Video timing method: USleep with busy wait
2032011-03-07 18:54:43.007 Player(1): Display Refresh Rate: 60.002 Video Frame Rate: 29.971
2042011-03-07 18:54:43.007 playCtx: StartPlaying(): took 0 ms to start player.
2052011-03-07 18:54:43.008 TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok
2062011-03-07 18:54:43.009 TV: Changing from None to WatchingPreRecorded
2072011-03-07 18:54:43.034 TV: DrawUnusedRects() -- begin
2082011-03-07 18:54:43.034 TV: DrawUnusedRects() -- end
2092011-03-07 18:54:43.035 TV: HandleStateChange(0) -- end
2102011-03-07 18:54:43.035 TV: tv->Playback() -- end
2112011-03-07 18:54:43.035 TV: StartTV -- process events begin
2122011-03-07 18:54:43.036 Player(1): Waiting for video buffers...
2132011-03-07 18:54:43.036 AO: Pause 1
2142011-03-07 18:54:43.072 AFD: audio timecode 179431906 179431906 1993687 1993719
2152011-03-07 18:54:43.072 AO: AddFrames frames=1536, bytes=18432, used=1, free=3071999, timecode=1993687 needsupmix=0
2162011-03-07 18:54:43.073 AO, ERROR: Error occurred while downmixing
2172011-03-07 18:54:43.073 AO: SetAudiotime atc=1993687 tc=1993687 f=1536 pfu=0 pfs=0
2182011-03-07 18:54:43.097 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2192011-03-07 18:54:43.097 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2202011-03-07 18:54:43.135 AFD: audio timecode 179434786 179434786 1993719 1993751
2212011-03-07 18:54:43.135 AO: AddFrames frames=1536, bytes=18432, used=24577, free=3047423, timecode=1993719 needsupmix=0
2222011-03-07 18:54:43.135 AO, ERROR: Error occurred while downmixing
2232011-03-07 18:54:43.135 AO: SetAudiotime atc=1993719 tc=1993719 f=1536 pfu=0 pfs=0
2242011-03-07 18:54:43.136 AFD: audio timecode 179437666 179437666 1993751 1993783
2252011-03-07 18:54:43.136 AO: AddFrames frames=1536, bytes=18432, used=49153, free=3022847, timecode=1993751 needsupmix=0
2262011-03-07 18:54:43.136 AO, ERROR: Error occurred while downmixing
2272011-03-07 18:54:43.136 AO: SetAudiotime atc=1993751 tc=1993751 f=1536 pfu=0 pfs=0
2282011-03-07 18:54:43.137 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2292011-03-07 18:54:43.137 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2302011-03-07 18:54:43.145 AFD: video timecode 179423689 179423689 179423689 1993596 1993596 1993663 (dts active)
2312011-03-07 18:54:43.155 AFD: video timecode 179426692 179426692 179426692 1993629 1993629 1993596 (dts active)
2322011-03-07 18:54:43.162 Player(1): Waited 100ms for video buffers LUUULAAAAAAAAAAAAAAAAAAAAAAAAAA
2332011-03-07 18:54:43.164 AFD: video timecode 179429695 179438704 179429695 1993663 1993663 1993629 (dts active)
2342011-03-07 18:54:43.175 AFD: video timecode 179432698 179432698 179432698 1993696 1993696 1993663 (dts active)
2352011-03-07 18:54:43.175 AFD: audio timecode 179440546 179440546 1993783 1993815
2362011-03-07 18:54:43.175 AO: AddFrames frames=1536, bytes=18432, used=73729, free=2998271, timecode=1993783 needsupmix=0
2372011-03-07 18:54:43.176 AO, ERROR: Error occurred while downmixing
2382011-03-07 18:54:43.176 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
2392011-03-07 18:54:43.176 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
2402011-03-07 18:54:43.176 AO: SetAudiotime atc=1993783 tc=1993783 f=1536 pfu=0 pfs=0
2412011-03-07 18:54:43.185 AFD: video timecode 179435701 179435701 179435701 1993730 1993730 1993696 (dts active)
2422011-03-07 18:54:43.186 AFD: audio timecode 179443426 179443426 1993815 1993847
2432011-03-07 18:54:43.186 AO: AddFrames frames=1536, bytes=18432, used=98305, free=2973695, timecode=1993815 needsupmix=0
2442011-03-07 18:54:43.186 AO, ERROR: Error occurred while downmixing
2452011-03-07 18:54:43.186 AO: SetAudiotime atc=1993815 tc=1993815 f=1536 pfu=0 pfs=0
2462011-03-07 18:54:43.195 AFD: video timecode 179438704 179447713 179438704 1993763 1993763 1993730 (dts active)
2472011-03-07 18:54:43.196 AFD: audio timecode 179446306 179446306 1993847 1993879
2482011-03-07 18:54:43.196 AO: AddFrames frames=1536, bytes=18432, used=122881, free=2949119, timecode=1993847 needsupmix=0
2492011-03-07 18:54:43.196 AO, ERROR: Error occurred while downmixing
2502011-03-07 18:54:43.196 AO: SetAudiotime atc=1993847 tc=1993847 f=1536 pfu=0 pfs=0
2512011-03-07 18:54:43.206 AFD: video timecode 179441707 179441707 179441707 1993796 1993796 1993763 (dts active)
2522011-03-07 18:54:43.207 AFD: audio timecode 179449186 179449186 1993879 1993911
2532011-03-07 18:54:43.207 AO: AddFrames frames=1536, bytes=18432, used=147457, free=2924543, timecode=1993879 needsupmix=0
2542011-03-07 18:54:43.207 AO, ERROR: Error occurred while downmixing
2552011-03-07 18:54:43.207 AO: SetAudiotime atc=1993879 tc=1993879 f=1536 pfu=0 pfs=0
2562011-03-07 18:54:43.217 AFD: video timecode 179444710 179444710 179444710 1993830 1993830 1993796 (dts active)
2572011-03-07 18:54:43.217 AFD: audio timecode 179452066 179452066 1993911 1993943
2582011-03-07 18:54:43.217 AO: AddFrames frames=1536, bytes=18432, used=172033, free=2899967, timecode=1993911 needsupmix=0
2592011-03-07 18:54:43.217 AO, ERROR: Error occurred while downmixing
2602011-03-07 18:54:43.217 AO: SetAudiotime atc=1993911 tc=1993911 f=1536 pfu=0 pfs=0
2612011-03-07 18:54:43.226 AFD: video timecode 179447713 179456722 179447713 1993863 1993863 1993830 (dts active)
2622011-03-07 18:54:43.226 AFD: audio timecode 179454946 179454946 1993943 1993975
2632011-03-07 18:54:43.226 AO: AddFrames frames=1536, bytes=18432, used=196609, free=2875391, timecode=1993943 needsupmix=0
2642011-03-07 18:54:43.226 AO, ERROR: Error occurred while downmixing
2652011-03-07 18:54:43.226 AO: SetAudiotime atc=1993943 tc=1993943 f=1536 pfu=0 pfs=0
2662011-03-07 18:54:43.236 AFD: video timecode 179450716 179450716 179450716 1993896 1993896 1993863 (dts active)
2672011-03-07 18:54:43.237 AFD: audio timecode 179457826 179457826 1993975 1994007
2682011-03-07 18:54:43.237 AO: AddFrames frames=1536, bytes=18432, used=221185, free=2850815, timecode=1993975 needsupmix=0
2692011-03-07 18:54:43.237 AO, ERROR: Error occurred while downmixing
2702011-03-07 18:54:43.237 AO: SetAudiotime atc=1993975 tc=1993975 f=1536 pfu=0 pfs=0
2712011-03-07 18:54:43.247 AFD: video timecode 179453719 179453719 179453719 1993930 1993930 1993896 (dts active)
2722011-03-07 18:54:43.248 AFD: audio timecode 179460706 179460706 1994007 1994039
2732011-03-07 18:54:43.248 AO: AddFrames frames=1536, bytes=18432, used=245761, free=2826239, timecode=1994007 needsupmix=0
2742011-03-07 18:54:43.248 AO, ERROR: Error occurred while downmixing
2752011-03-07 18:54:43.248 AO: SetAudiotime atc=1994007 tc=1994007 f=1536 pfu=0 pfs=0
2762011-03-07 18:54:43.251 AO: Pause 0
2772011-03-07 18:54:43.251 Player(1): progressive frame seen after 2 interlaced  frames
2782011-03-07 18:54:43.261 AFD: video timecode 179456722 179465731 179456722 1993963 1993963 1993930 (dts active)
2792011-03-07 18:54:43.262 AFD: audio timecode 179463586 179463586 1994039 1994071
2802011-03-07 18:54:43.262 AO: AddFrames frames=1536, bytes=18432, used=270337, free=2801663, timecode=1994039 needsupmix=0
2812011-03-07 18:54:43.262 AO, ERROR: Error occurred while downmixing
2822011-03-07 18:54:43.262 AO: SetAudiotime atc=1994039 tc=1994039 f=1536 pfu=0 pfs=0
2832011-03-07 18:54:43.278 AFD: video timecode 179459725 179459725 179459725 1993996 1993996 1993963 (dts active)
2842011-03-07 18:54:43.278 AFD: audio timecode 179466466 179466466 1994071 1994103
2852011-03-07 18:54:43.278 AO: AddFrames frames=1536, bytes=18432, used=270337, free=2801663, timecode=1994071 needsupmix=0
2862011-03-07 18:54:43.278 AO, ERROR: Error occurred while downmixing
2872011-03-07 18:54:43.278 AO: SetAudiotime atc=1994071 tc=1994071 f=1536 pfu=0 pfs=0
2882011-03-07 18:54:43.289 AFD: video timecode 179462728 179462728 179462728 1994030 1994030 1993996 (dts active)
2892011-03-07 18:54:43.289 AFD: audio timecode 179469346 179469346 1994103 1994135
2902011-03-07 18:54:43.289 AO: AddFrames frames=1536, bytes=18432, used=294913, free=2777087, timecode=1994103 needsupmix=0
2912011-03-07 18:54:43.289 AO, ERROR: Error occurred while downmixing
2922011-03-07 18:54:43.289 AO: SetAudiotime atc=1994103 tc=1994103 f=1536 pfu=0 pfs=0
2932011-03-07 18:54:43.301 AFD: video timecode 179465731 179474740 179465731 1994063 1994063 1994030 (dts active)
2942011-03-07 18:54:43.302 AFD: audio timecode 179472226 179472226 1994135 1994167
2952011-03-07 18:54:43.302 AO: AddFrames frames=1536, bytes=18432, used=319489, free=2752511, timecode=1994135 needsupmix=0
2962011-03-07 18:54:43.302 AO, ERROR: Error occurred while downmixing
2972011-03-07 18:54:43.302 AO: SetAudiotime atc=1994135 tc=1994135 f=1536 pfu=0 pfs=0
2982011-03-07 18:54:43.312 VideoOutput: Created YV12 OSD.
2992011-03-07 18:54:43.318 AFD: video timecode 179468734 179468734 179468734 1994097 1994097 1994063 (dts active)
3002011-03-07 18:54:43.319 AFD: audio timecode 179475106 179475106 1994167 1994199
3012011-03-07 18:54:43.319 AO: AddFrames frames=1536, bytes=18432, used=319489, free=2752511, timecode=1994167 needsupmix=0
3022011-03-07 18:54:43.319 AO, ERROR: Error occurred while downmixing
3032011-03-07 18:54:43.319 AO: SetAudiotime atc=1994167 tc=1994167 f=1536 pfu=0 pfs=0
3042011-03-07 18:54:43.327 AVSync waitforframe 0 0
3052011-03-07 18:54:43.327 AVSync show
3062011-03-07 18:54:43.331 AFD: video timecode 179471737 179471737 179471737 1994130 1994130 1994097 (dts active)
3072011-03-07 18:54:43.332 AFD: audio timecode 179477986 179477986 1994199 1994231
3082011-03-07 18:54:43.332 AO: AddFrames frames=1536, bytes=18432, used=344065, free=2727935, timecode=1994199 needsupmix=0
3092011-03-07 18:54:43.332 AO, ERROR: Error occurred while downmixing
3102011-03-07 18:54:43.332 AO: SetAudiotime atc=1994199 tc=1994199 f=1536 pfu=0 pfs=0
3112011-03-07 18:54:43.340 AFD: video timecode 179474740 179483749 179474740 1994163 1994163 1994130 (dts active)
3122011-03-07 18:54:43.341 AFD: audio timecode 179480866 179480866 1994231 1994263
3132011-03-07 18:54:43.341 AO: AddFrames frames=1536, bytes=18432, used=344065, free=2727935, timecode=1994231 needsupmix=0
3142011-03-07 18:54:43.341 AO, ERROR: Error occurred while downmixing
3152011-03-07 18:54:43.341 AO: SetAudiotime atc=1994231 tc=1994231 f=1536 pfu=0 pfs=0
3162011-03-07 18:54:43.351 AFD: EIA-708 caption service #1 is in the English language.
3172011-03-07 18:54:43.351 AFD: EIA-608 caption service #1 is in the Undetermined language.
3182011-03-07 18:54:43.351 AFD: video timecode 179477743 179477743 179477743 1994197 1994197 1994163 (dts active)
3192011-03-07 18:54:43.351 AFD: audio timecode 179483746 179483746 1994263 1994295
3202011-03-07 18:54:43.351 AO: AddFrames frames=1536, bytes=18432, used=368641, free=2703359, timecode=1994263 needsupmix=0
3212011-03-07 18:54:43.351 AO, ERROR: Error occurred while downmixing
3222011-03-07 18:54:43.351 AO: SetAudiotime atc=1994263 tc=1994263 f=1536 pfu=0 pfs=0
3232011-03-07 18:54:43.352 AFD: audio timecode 179486626 179486626 1994295 1994327
3242011-03-07 18:54:43.352 AO: AddFrames frames=1536, bytes=18432, used=393217, free=2678783, timecode=1994295 needsupmix=0
3252011-03-07 18:54:43.352 AO, ERROR: Error occurred while downmixing
3262011-03-07 18:54:43.352 AO: SetAudiotime atc=1994295 tc=1994295 f=1536 pfu=0 pfs=0
3272011-03-07 18:54:43.352 Dec: Selected track #1 in the Undetermined language(7695972)
3282011-03-07 18:54:43.362 AFD: video timecode 179480746 179480746 179480746 1994230 1994230 1994197 (dts active)
3292011-03-07 18:54:43.362 AFD: audio timecode 179489506 179489506 1994327 1994359
3302011-03-07 18:54:43.362 AO: AddFrames frames=1536, bytes=18432, used=417793, free=2654207, timecode=1994327 needsupmix=0
3312011-03-07 18:54:43.362 AO, ERROR: Error occurred while downmixing
3322011-03-07 18:54:43.362 AO: SetAudiotime atc=1994327 tc=1994327 f=1536 pfu=0 pfs=0
3332011-03-07 18:54:43.371 AFD: video timecode 179483749 179492758 179483749 1994263 1994263 1994230 (dts active)
3342011-03-07 18:54:43.371 AFD: audio timecode 179492386 179492386 1994359 1994391
3352011-03-07 18:54:43.372 AO: AddFrames frames=1536, bytes=18432, used=417793, free=2654207, timecode=1994359 needsupmix=0
3362011-03-07 18:54:43.372 AO, ERROR: Error occurred while downmixing
3372011-03-07 18:54:43.372 AO: SetAudiotime atc=1994359 tc=1994359 f=1536 pfu=0 pfs=0
3382011-03-07 18:54:43.383 AFD: video timecode 179486752 179486752 179486752 1994297 1994297 1994263 (dts active)
3392011-03-07 18:54:43.384 AFD: audio timecode 179495266 179495266 1994391 1994423
3402011-03-07 18:54:43.384 AO: AddFrames frames=1536, bytes=18432, used=442369, free=2629631, timecode=1994391 needsupmix=0
3412011-03-07 18:54:43.384 AO, ERROR: Error occurred while downmixing
3422011-03-07 18:54:43.384 AO: SetAudiotime atc=1994391 tc=1994391 f=1536 pfu=0 pfs=0
3432011-03-07 18:54:43.392 A/V timecodes audio 1993750 video 1993663 frameinterval 33366 avdel -87 avg 0 tcoffset 0
3442011-03-07 18:54:43.392 Player(1): interlaced frame seen after 1 progressive frames
3452011-03-07 18:54:43.392 Player(1): Locking scan to Interlaced.
3462011-03-07 18:54:43.392 Player(1): Enabled deinterlacing
3472011-03-07 18:54:43.394 AFD: video timecode 179489755 179489755 179489755 1994330 1994330 1994297 (dts active)
3482011-03-07 18:54:43.395 AFD: audio timecode 179498146 179498146 1994423 1994455
3492011-03-07 18:54:43.395 AO: AddFrames frames=1536, bytes=18432, used=466945, free=2605055, timecode=1994423 needsupmix=0
3502011-03-07 18:54:43.395 AO, ERROR: Error occurred while downmixing
3512011-03-07 18:54:43.396 AO: SetAudiotime atc=1994423 tc=1994423 f=1536 pfu=0 pfs=0
3522011-03-07 18:54:43.396 AVSync waitforframe 0 0
3532011-03-07 18:54:43.396 AVSync show
3542011-03-07 18:54:43.406 AFD: video timecode 179492758 179501767 179492758 1994363 1994363 1994330 (dts active)
3552011-03-07 18:54:43.406 AFD: audio timecode 179501026 179501026 1994455 1994487
3562011-03-07 18:54:43.406 AO: AddFrames frames=1536, bytes=18432, used=466945, free=2605055, timecode=1994455 needsupmix=0
3572011-03-07 18:54:43.406 AO, ERROR: Error occurred while downmixing
3582011-03-07 18:54:43.407 AO: SetAudiotime atc=1994455 tc=1994455 f=1536 pfu=0 pfs=0
3592011-03-07 18:54:43.419 AFD: video timecode 179495761 179495761 179495761 1994397 1994397 1994363 (dts active)
3602011-03-07 18:54:43.420 A/V timecodes audio 1993782 video 1993596 frameinterval 33366 avdel -186 avg -21750 tcoffset 0
3612011-03-07 18:54:43.420 AFD: audio timecode 179503906 179503906 1994487 1994519
3622011-03-07 18:54:43.420 AO: AddFrames frames=1536, bytes=18432, used=491521, free=2580479, timecode=1994487 needsupmix=0
3632011-03-07 18:54:43.420 AO, ERROR: Error occurred while downmixing
3642011-03-07 18:54:43.420 AO: SetAudiotime atc=1994487 tc=1994487 f=1536 pfu=0 pfs=0
3652011-03-07 18:54:43.426 AVSync waitforframe -16666 0
3662011-03-07 18:54:43.426 AVSync show
3672011-03-07 18:54:43.434 AFD: video timecode 179498764 179498764 179498764 1994430 1994430 1994397 (dts active)
3682011-03-07 18:54:43.434 AFD: audio timecode 179506786 179506786 1994519 1994551
3692011-03-07 18:54:43.434 AO: AddFrames frames=1536, bytes=18432, used=491521, free=2580479, timecode=1994519 needsupmix=0
3702011-03-07 18:54:43.435 AO, ERROR: Error occurred while downmixing
3712011-03-07 18:54:43.435 AO: SetAudiotime atc=1994519 tc=1994519 f=1536 pfu=0 pfs=0
3722011-03-07 18:54:43.447 AFD: video timecode 179501767 179510776 179501767 1994464 1994464 1994430 (dts active)
3732011-03-07 18:54:43.447 AFD: audio timecode 179509666 179509666 1994551 1994583
3742011-03-07 18:54:43.447 AO: AddFrames frames=1536, bytes=18432, used=516097, free=2555903, timecode=1994551 needsupmix=0
3752011-03-07 18:54:43.447 AO, ERROR: Error occurred while downmixing
3762011-03-07 18:54:43.447 AO: SetAudiotime atc=1994551 tc=1994551 f=1536 pfu=0 pfs=0
3772011-03-07 18:54:43.456 A/V timecodes audio 1993814 video 1993629 frameinterval 33366 avdel -185 avg -62812 tcoffset 0
3782011-03-07 18:54:43.458 AFD: video timecode 179504770 179504770 179504770 1994497 1994497 1994464 (dts active)
3792011-03-07 18:54:43.459 AFD: audio timecode 179512546 179512546 1994583 1994615
3802011-03-07 18:54:43.459 AO: AddFrames frames=1536, bytes=18432, used=540673, free=2531327, timecode=1994583 needsupmix=0
3812011-03-07 18:54:43.459 AO, ERROR: Error occurred while downmixing
3822011-03-07 18:54:43.459 AO: SetAudiotime atc=1994583 tc=1994583 f=1536 pfu=0 pfs=0
3832011-03-07 18:54:43.461 AVSync waitforframe 0 0
3842011-03-07 18:54:43.461 AVSync show
3852011-03-07 18:54:43.470 AFD: video timecode 179507773 179507773 179507773 1994530 1994530 1994497 (dts active)
3862011-03-07 18:54:43.471 AFD: audio timecode 179515426 179515426 1994615 1994647
3872011-03-07 18:54:43.471 AO: AddFrames frames=1536, bytes=18432, used=540673, free=2531327, timecode=1994615 needsupmix=0
3882011-03-07 18:54:43.471 AO, ERROR: Error occurred while downmixing
3892011-03-07 18:54:43.471 AO: SetAudiotime atc=1994615 tc=1994615 f=1536 pfu=0 pfs=0
3902011-03-07 18:54:43.481 AFD: video timecode 179510776 179519785 179510776 1994564 1994564 1994530 (dts active)
3912011-03-07 18:54:43.481 AFD: audio timecode 179518306 179518306 1994647 1994679
3922011-03-07 18:54:43.481 AO: AddFrames frames=1536, bytes=18432, used=565249, free=2506751, timecode=1994647 needsupmix=0
3932011-03-07 18:54:43.481 AO, ERROR: Error occurred while downmixing
3942011-03-07 18:54:43.481 AO: SetAudiotime atc=1994647 tc=1994647 f=1536 pfu=0 pfs=0
3952011-03-07 18:54:43.489 A/V timecodes audio 1993846 video 1993663 frameinterval 33366 avdel -183 avg -93359 tcoffset 0
3962011-03-07 18:54:43.492 AFD: video timecode 179513779 179513779 179513779 1994597 1994597 1994564 (dts active)
3972011-03-07 18:54:43.492 AFD: audio timecode 179521186 179521186 1994679 1994711
3982011-03-07 18:54:43.492 AO: AddFrames frames=1536, bytes=18432, used=589825, free=2482175, timecode=1994679 needsupmix=0
3992011-03-07 18:54:43.492 AO, ERROR: Error occurred while downmixing
4002011-03-07 18:54:43.492 AO: SetAudiotime atc=1994679 tc=1994679 f=1536 pfu=0 pfs=0
4012011-03-07 18:54:43.494 Player(1): Video is 3.46967 frames behind audio (too slow), dropping frame to catch up.
4022011-03-07 18:54:43.494 A/V timecodes audio 1993846 video 1993696 frameinterval 33366 avdel -150 avg -115769 tcoffset 0
4032011-03-07 18:54:43.498 Player(1): Video is 3.72613 frames behind audio (too slow), dropping frame to catch up.
4042011-03-07 18:54:43.499 A/V timecodes audio 1993878 video 1993730 frameinterval 33366 avdel -148 avg -124326 tcoffset 0
4052011-03-07 18:54:43.503 Player(1): Video is 3.90349 frames behind audio (too slow), dropping frame to catch up.
4062011-03-07 18:54:43.503 A/V timecodes audio 1993878 video 1993763 frameinterval 33366 avdel -115 avg -130244 tcoffset 0
4072011-03-07 18:54:43.506 AFD: video timecode 179516782 179516782 179516782 1994630 1994630 1994597 (dts active)
4082011-03-07 18:54:43.507 AFD: audio timecode 179524066 179524066 1994711 1994743
4092011-03-07 18:54:43.507 AO: AddFrames frames=1536, bytes=18432, used=589825, free=2482175, timecode=1994711 needsupmix=0
4102011-03-07 18:54:43.507 AO, ERROR: Error occurred while downmixing
4112011-03-07 18:54:43.507 Player(1): Video is 3.78928 frames behind audio (too slow), dropping frame to catch up.
4122011-03-07 18:54:43.507 A/V timecodes audio 1993878 video 1993796 frameinterval 33366 avdel -82 avg -126433 tcoffset 0
4132011-03-07 18:54:43.507 AO: SetAudiotime atc=1994711 tc=1994711 f=1536 pfu=0 pfs=0
4142011-03-07 18:54:43.511 Player(1): Video is 3.45633 frames behind audio (too slow), dropping frame to catch up.
4152011-03-07 18:54:43.512 A/V timecodes audio 1993878 video 1993830 frameinterval 33366 avdel -48 avg -115324 tcoffset 0
4162011-03-07 18:54:43.518 AFD: video timecode 179519785 179528794 179519785 1994664 1994664 1994630 (dts active)
4172011-03-07 18:54:43.518 AFD: audio timecode 179526946 179526946 1994743 1994775
4182011-03-07 18:54:43.518 AO: AddFrames frames=1536, bytes=18432, used=614401, free=2457599, timecode=1994743 needsupmix=0
4192011-03-07 18:54:43.518 AO, ERROR: Error occurred while downmixing
4202011-03-07 18:54:43.518 AO: SetAudiotime atc=1994743 tc=1994743 f=1536 pfu=0 pfs=0
4212011-03-07 18:54:43.527 AFD: video timecode 179522788 179522788 179522788 1994697 1994697 1994664 (dts active)
4222011-03-07 18:54:43.528 AFD: audio timecode 179529826 179529826 1994775 1994807
4232011-03-07 18:54:43.528 AO: AddFrames frames=1536, bytes=18432, used=614401, free=2457599, timecode=1994775 needsupmix=0
4242011-03-07 18:54:43.528 AO, ERROR: Error occurred while downmixing
4252011-03-07 18:54:43.528 AO: SetAudiotime atc=1994775 tc=1994775 f=1536 pfu=0 pfs=0
4262011-03-07 18:54:43.536 AFD: video timecode 179525791 179525791 179525791 1994731 1994731 1994697 (dts active)
4272011-03-07 18:54:43.537 AFD: audio timecode 179532706 179532706 1994807 1994839
4282011-03-07 18:54:43.537 AO: AddFrames frames=1536, bytes=18432, used=638977, free=2433023, timecode=1994807 needsupmix=0
4292011-03-07 18:54:43.537 AO, ERROR: Error occurred while downmixing
4302011-03-07 18:54:43.537 AO: SetAudiotime atc=1994807 tc=1994807 f=1536 pfu=0 pfs=0
4312011-03-07 18:54:43.549 AFD: video timecode 179528794 179537803 179528794 1994764 1994764 1994731 (dts active)
4322011-03-07 18:54:43.549 AVSync waitforframe 0 0
4332011-03-07 18:54:43.549 AVSync show
4342011-03-07 18:54:43.549 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
4352011-03-07 18:54:43.550 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
4362011-03-07 18:54:43.550 AFD: audio timecode 179535586 179535586 1994839 1994871
4372011-03-07 18:54:43.550 AO: AddFrames frames=1536, bytes=18432, used=663553, free=2408447, timecode=1994839 needsupmix=0
4382011-03-07 18:54:43.550 AO, ERROR: Error occurred while downmixing
4392011-03-07 18:54:43.550 AO: SetAudiotime atc=1994839 tc=1994839 f=1536 pfu=0 pfs=0
4402011-03-07 18:54:43.561 AFD: video timecode 179531797 179531797 179531797 1994797 1994797 1994764 (dts active)
4412011-03-07 18:54:43.561 AFD: audio timecode 179538466 179538466 1994871 1994903
4422011-03-07 18:54:43.561 AO: AddFrames frames=1536, bytes=18432, used=663553, free=2408447, timecode=1994871 needsupmix=0
4432011-03-07 18:54:43.561 AO, ERROR: Error occurred while downmixing
4442011-03-07 18:54:43.561 AO: SetAudiotime atc=1994871 tc=1994871 f=1536 pfu=0 pfs=0
4452011-03-07 18:54:43.565 A/V timecodes audio 1993942 video 1993863 frameinterval 33366 avdel -79 avg -98493 tcoffset 0
4462011-03-07 18:54:43.570 AVSync waitforframe -16666 0
4472011-03-07 18:54:43.570 AVSync show
4482011-03-07 18:54:43.573 AFD: video timecode 179534800 179534800 179534800 1994831 1994831 1994797 (dts active)
4492011-03-07 18:54:43.574 AFD: audio timecode 179541346 179541346 1994903 1994935
4502011-03-07 18:54:43.574 AO: AddFrames frames=1536, bytes=18432, used=688129, free=2383871, timecode=1994903 needsupmix=0
4512011-03-07 18:54:43.574 AO, ERROR: Error occurred while downmixing
4522011-03-07 18:54:43.574 AO: SetAudiotime atc=1994903 tc=1994903 f=1536 pfu=0 pfs=0
4532011-03-07 18:54:43.583 AFD: video timecode 179537803 179546812 179537803 1994864 1994864 1994831 (dts active)
4542011-03-07 18:54:43.583 AFD: audio timecode 179544226 179544226 1994935 1994967
4552011-03-07 18:54:43.583 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1994935 needsupmix=0
4562011-03-07 18:54:43.583 AO, ERROR: Error occurred while downmixing
4572011-03-07 18:54:43.583 AO: SetAudiotime atc=1994935 tc=1994935 f=1536 pfu=0 pfs=0
4582011-03-07 18:54:43.606 A/V timecodes audio 1993974 video 1993896 frameinterval 33366 avdel -78 avg -93619 tcoffset 0
4592011-03-07 18:54:43.610 AVSync waitforframe 0 0
4602011-03-07 18:54:43.611 AVSync show
4612011-03-07 18:54:43.618 AFD: video timecode 179540806 179540806 179540806 1994897 1994897 1994864 (dts active)
4622011-03-07 18:54:43.618 AFD: audio timecode 179547106 179547106 1994967 1994999
4632011-03-07 18:54:43.618 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1994967 needsupmix=0
4642011-03-07 18:54:43.618 AO, ERROR: Error occurred while downmixing
4652011-03-07 18:54:43.618 AO: SetAudiotime atc=1994967 tc=1994967 f=1536 pfu=0 pfs=0
4662011-03-07 18:54:43.640 A/V timecodes audio 1994006 video 1993930 frameinterval 33366 avdel -76 avg -89714 tcoffset 0
4672011-03-07 18:54:43.644 AVSync waitforframe -16666 0
4682011-03-07 18:54:43.644 AVSync show
4692011-03-07 18:54:43.652 AFD: video timecode 179543809 179543809 179543809 1994931 1994931 1994897 (dts active)
4702011-03-07 18:54:43.652 AFD: audio timecode 179549986 179549986 1994999 1995031
4712011-03-07 18:54:43.652 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1994999 needsupmix=0
4722011-03-07 18:54:43.652 AO, ERROR: Error occurred while downmixing
4732011-03-07 18:54:43.652 AO: SetAudiotime atc=1994999 tc=1994999 f=1536 pfu=0 pfs=0
4742011-03-07 18:54:43.673 A/V timecodes audio 1994038 video 1993963 frameinterval 33366 avdel -75 avg -86285 tcoffset 0
4752011-03-07 18:54:43.676 AVSync waitforframe 0 0
4762011-03-07 18:54:43.677 AVSync show
4772011-03-07 18:54:43.686 AFD: video timecode 179546812 179555821 179546812 1994964 1994964 1994931 (dts active)
4782011-03-07 18:54:43.687 AFD: audio timecode 179552866 179552866 1995031 1995063
4792011-03-07 18:54:43.687 AO: AddFrames frames=1536, bytes=18432, used=688129, free=2383871, timecode=1995031 needsupmix=0
4802011-03-07 18:54:43.687 AO, ERROR: Error occurred while downmixing
4812011-03-07 18:54:43.687 AO: SetAudiotime atc=1995031 tc=1995031 f=1536 pfu=0 pfs=0
4822011-03-07 18:54:43.687 AFD: audio timecode 179555746 179555746 1995063 1995095
4832011-03-07 18:54:43.687 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995063 needsupmix=0
4842011-03-07 18:54:43.687 AO, ERROR: Error occurred while downmixing
4852011-03-07 18:54:43.687 AO: SetAudiotime atc=1995063 tc=1995063 f=1536 pfu=0 pfs=0
4862011-03-07 18:54:43.706 A/V timecodes audio 1994070 video 1993996 frameinterval 33366 avdel -74 avg -83463 tcoffset 0
4872011-03-07 18:54:43.711 AVSync waitforframe -16666 0
4882011-03-07 18:54:43.711 AVSync show
4892011-03-07 18:54:43.718 AFD: video timecode 179549815 179549815 179549815 1994997 1994997 1994964 (dts active)
4902011-03-07 18:54:43.720 AFD: audio timecode 179558626 179558626 1995095 1995127
4912011-03-07 18:54:43.720 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995095 needsupmix=0
4922011-03-07 18:54:43.720 AO, ERROR: Error occurred while downmixing
4932011-03-07 18:54:43.720 AO: SetAudiotime atc=1995095 tc=1995095 f=1536 pfu=0 pfs=0
4942011-03-07 18:54:43.739 A/V timecodes audio 1994102 video 1994030 frameinterval 33366 avdel -72 avg -81097 tcoffset 0
4952011-03-07 18:54:43.744 AVSync waitforframe 0 0
4962011-03-07 18:54:43.744 AVSync show
4972011-03-07 18:54:43.752 AFD: video timecode 179552818 179552818 179552818 1995031 1995031 1994997 (dts active)
4982011-03-07 18:54:43.752 AFD: audio timecode 179561506 179561506 1995127 1995159
4992011-03-07 18:54:43.752 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995127 needsupmix=0
5002011-03-07 18:54:43.753 AO, ERROR: Error occurred while downmixing
5012011-03-07 18:54:43.753 AO: SetAudiotime atc=1995127 tc=1995127 f=1536 pfu=0 pfs=0
5022011-03-07 18:54:43.773 A/V timecodes audio 1994134 video 1994063 frameinterval 33366 avdel -71 avg -78822 tcoffset 0
5032011-03-07 18:54:43.777 AVSync waitforframe -16666 0
5042011-03-07 18:54:43.777 AVSync show
5052011-03-07 18:54:43.784 AFD: video timecode 179555821 179564830 179555821 1995064 1995064 1995031 (dts active)
5062011-03-07 18:54:43.784 AFD: audio timecode 179564386 179564386 1995159 1995191
5072011-03-07 18:54:43.784 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995159 needsupmix=0
5082011-03-07 18:54:43.784 AO, ERROR: Error occurred while downmixing
5092011-03-07 18:54:43.784 AO: SetAudiotime atc=1995159 tc=1995159 f=1536 pfu=0 pfs=0
5102011-03-07 18:54:43.806 A/V timecodes audio 1994166 video 1994097 frameinterval 33366 avdel -69 avg -76866 tcoffset 0
5112011-03-07 18:54:43.810 AVSync waitforframe 0 0
5122011-03-07 18:54:43.810 AVSync show
5132011-03-07 18:54:43.818 AFD: video timecode 179558824 179558824 179558824 1995098 1995098 1995064 (dts active)
5142011-03-07 18:54:43.819 AFD: audio timecode 179567266 179567266 1995191 1995223
5152011-03-07 18:54:43.819 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995191 needsupmix=0
5162011-03-07 18:54:43.819 AO, ERROR: Error occurred while downmixing
5172011-03-07 18:54:43.819 AO: SetAudiotime atc=1995191 tc=1995191 f=1536 pfu=0 pfs=0
5182011-03-07 18:54:43.839 A/V timecodes audio 1994198 video 1994130 frameinterval 33366 avdel -68 avg -74899 tcoffset 0
5192011-03-07 18:54:43.844 AVSync waitforframe -16666 0
5202011-03-07 18:54:43.844 AVSync show
5212011-03-07 18:54:43.851 AFD: video timecode 179561827 179561827 179561827 1995131 1995131 1995098 (dts active)
5222011-03-07 18:54:43.851 AFD: audio timecode 179570146 179570146 1995223 1995255
5232011-03-07 18:54:43.851 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995223 needsupmix=0
5242011-03-07 18:54:43.851 AO, ERROR: Error occurred while downmixing
5252011-03-07 18:54:43.852 AO: SetAudiotime atc=1995223 tc=1995223 f=1536 pfu=0 pfs=0
5262011-03-07 18:54:43.873 A/V timecodes audio 1994230 video 1994163 frameinterval 33366 avdel -67 avg -73174 tcoffset 0
5272011-03-07 18:54:43.877 AVSync waitforframe 0 0
5282011-03-07 18:54:43.877 AVSync show
5292011-03-07 18:54:43.884 AFD: video timecode 179564830 179573839 179564830 1995164 1995164 1995131 (dts active)
5302011-03-07 18:54:43.885 AFD: audio timecode 179573026 179573026 1995255 1995287
5312011-03-07 18:54:43.885 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995255 needsupmix=0
5322011-03-07 18:54:43.885 AO, ERROR: Error occurred while downmixing
5332011-03-07 18:54:43.885 AO: SetAudiotime atc=1995255 tc=1995255 f=1536 pfu=0 pfs=0
5342011-03-07 18:54:43.906 A/V timecodes audio 1994262 video 1994197 frameinterval 33366 avdel -65 avg -71630 tcoffset 0
5352011-03-07 18:54:43.917 AFD: video timecode 179567833 179567833 179567833 1995198 1995198 1995164 (dts active)
5362011-03-07 18:54:43.918 AFD: audio timecode 179575906 179575906 1995287 1995319
5372011-03-07 18:54:43.918 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995287 needsupmix=0
5382011-03-07 18:54:43.918 AO, ERROR: Error occurred while downmixing
5392011-03-07 18:54:43.918 AO: SetAudiotime atc=1995287 tc=1995287 f=1536 pfu=0 pfs=0
5402011-03-07 18:54:43.927 AVSync waitforframe -16666 0
5412011-03-07 18:54:43.927 AVSync show
5422011-03-07 18:54:43.942 A/V timecodes audio 1994294 video 1994230 frameinterval 33366 avdel -64 avg -69972 tcoffset 0
5432011-03-07 18:54:43.948 AVSync waitforframe 0 0
5442011-03-07 18:54:43.948 AVSync show
5452011-03-07 18:54:43.954 AFD: video timecode 179570836 179570836 179570836 1995231 1995231 1995198 (dts active)
5462011-03-07 18:54:43.954 AFD: audio timecode 179578786 179578786 1995319 1995351
5472011-03-07 18:54:43.954 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995319 needsupmix=0
5482011-03-07 18:54:43.954 AO, ERROR: Error occurred while downmixing
5492011-03-07 18:54:43.954 AO: SetAudiotime atc=1995319 tc=1995319 f=1536 pfu=0 pfs=0
5502011-03-07 18:54:43.973 A/V timecodes audio 1994326 video 1994263 frameinterval 33366 avdel -63 avg -68479 tcoffset 0
5512011-03-07 18:54:43.977 AVSync waitforframe -16666 0
5522011-03-07 18:54:43.977 AVSync show
5532011-03-07 18:54:43.983 AFD: video timecode 179573839 179582848 179573839 1995264 1995264 1995231 (dts active)
5542011-03-07 18:54:43.983 AFD: audio timecode 179581666 179581666 1995351 1995383
5552011-03-07 18:54:43.983 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995351 needsupmix=0
5562011-03-07 18:54:43.983 AO, ERROR: Error occurred while downmixing
5572011-03-07 18:54:43.983 AO: SetAudiotime atc=1995351 tc=1995351 f=1536 pfu=0 pfs=0
5582011-03-07 18:54:44.006 A/V timecodes audio 1994358 video 1994297 frameinterval 33366 avdel -61 avg -67109 tcoffset 0
5592011-03-07 18:54:44.010 AVSync waitforframe 0 0
5602011-03-07 18:54:44.010 AVSync show
5612011-03-07 18:54:44.018 AFD: video timecode 179576842 179576842 179576842 1995298 1995298 1995264 (dts active)
5622011-03-07 18:54:44.018 AFD: audio timecode 179584546 179584546 1995383 1995415
5632011-03-07 18:54:44.018 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995383 needsupmix=0
5642011-03-07 18:54:44.018 AO, ERROR: Error occurred while downmixing
5652011-03-07 18:54:44.018 AO: SetAudiotime atc=1995383 tc=1995383 f=1536 pfu=0 pfs=0
5662011-03-07 18:54:44.039 A/V timecodes audio 1994422 video 1994330 frameinterval 33366 avdel -92 avg -65581 tcoffset 0
5672011-03-07 18:54:44.044 AVSync waitforframe -16666 0
5682011-03-07 18:54:44.044 AVSync show
5692011-03-07 18:54:44.051 AFD: video timecode 179579845 179579845 179579845 1995331 1995331 1995298 (dts active)
5702011-03-07 18:54:44.052 AFD: audio timecode 179587426 179587426 1995415 1995447
5712011-03-07 18:54:44.052 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995415 needsupmix=0
5722011-03-07 18:54:44.052 AO, ERROR: Error occurred while downmixing
5732011-03-07 18:54:44.052 AO: SetAudiotime atc=1995415 tc=1995415 f=1536 pfu=0 pfs=0
5742011-03-07 18:54:44.073 A/V timecodes audio 1994454 video 1994363 frameinterval 33366 avdel -91 avg -72185 tcoffset 0
5752011-03-07 18:54:44.077 AVSync waitforframe 0 0
5762011-03-07 18:54:44.077 AVSync show
5772011-03-07 18:54:44.082 AFD: video timecode 179582848 179591857 179582848 1995364 1995364 1995331 (dts active)
5782011-03-07 18:54:44.083 AFD: audio timecode 179590306 179590306 1995447 1995479
5792011-03-07 18:54:44.083 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995447 needsupmix=0
5802011-03-07 18:54:44.083 AO, ERROR: Error occurred while downmixing
5812011-03-07 18:54:44.083 AO: SetAudiotime atc=1995447 tc=1995447 f=1536 pfu=0 pfs=0
5822011-03-07 18:54:44.106 A/V timecodes audio 1994486 video 1994397 frameinterval 33366 avdel -89 avg -76888 tcoffset 0
5832011-03-07 18:54:44.110 AVSync waitforframe -16666 0
5842011-03-07 18:54:44.110 AVSync show
5852011-03-07 18:54:44.118 AFD: video timecode 179585851 179585851 179585851 1995398 1995398 1995364 (dts active)
5862011-03-07 18:54:44.118 AFD: audio timecode 179593186 179593186 1995479 1995511
5872011-03-07 18:54:44.118 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995479 needsupmix=0
5882011-03-07 18:54:44.118 AO, ERROR: Error occurred while downmixing
5892011-03-07 18:54:44.118 AO: SetAudiotime atc=1995479 tc=1995479 f=1536 pfu=0 pfs=0
5902011-03-07 18:54:44.139 A/V timecodes audio 1994518 video 1994430 frameinterval 33366 avdel -88 avg -79916 tcoffset 0
5912011-03-07 18:54:44.144 AVSync waitforframe 0 0
5922011-03-07 18:54:44.144 AVSync show
5932011-03-07 18:54:44.151 AFD: video timecode 179588854 179588854 179588854 1995431 1995431 1995398 (dts active)
5942011-03-07 18:54:44.152 AFD: audio timecode 179596066 179596066 1995511 1995543
5952011-03-07 18:54:44.152 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995511 needsupmix=0
5962011-03-07 18:54:44.152 AO, ERROR: Error occurred while downmixing
5972011-03-07 18:54:44.152 AO: SetAudiotime atc=1995511 tc=1995511 f=1536 pfu=0 pfs=0
5982011-03-07 18:54:44.173 A/V timecodes audio 1994550 video 1994464 frameinterval 33366 avdel -86 avg -81937 tcoffset 0
5992011-03-07 18:54:44.176 AVSync waitforframe -16666 0
6002011-03-07 18:54:44.176 AVSync show
6012011-03-07 18:54:44.185 AFD: video timecode 179591857 179600866 179591857 1995465 1995465 1995431 (dts active)
6022011-03-07 18:54:44.186 AFD: audio timecode 179598946 179598946 1995543 1995575
6032011-03-07 18:54:44.186 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995543 needsupmix=0
6042011-03-07 18:54:44.186 AO, ERROR: Error occurred while downmixing
6052011-03-07 18:54:44.186 AO: SetAudiotime atc=1995543 tc=1995543 f=1536 pfu=0 pfs=0
6062011-03-07 18:54:44.206 A/V timecodes audio 1994582 video 1994497 frameinterval 33366 avdel -85 avg -82952 tcoffset 0
6072011-03-07 18:54:44.210 AVSync waitforframe 0 0
6082011-03-07 18:54:44.210 AVSync show
6092011-03-07 18:54:44.217 AFD: video timecode 179594860 179594860 179594860 1995498 1995498 1995465 (dts active)
6102011-03-07 18:54:44.218 AFD: audio timecode 179601826 179601826 1995575 1995607
6112011-03-07 18:54:44.219 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995575 needsupmix=0
6122011-03-07 18:54:44.219 AO, ERROR: Error occurred while downmixing
6132011-03-07 18:54:44.219 AO: SetAudiotime atc=1995575 tc=1995575 f=1536 pfu=0 pfs=0
6142011-03-07 18:54:44.239 A/V timecodes audio 1994614 video 1994530 frameinterval 33366 avdel -84 avg -83464 tcoffset 0
6152011-03-07 18:54:44.243 AVSync waitforframe -16666 0
6162011-03-07 18:54:44.244 AVSync show
6172011-03-07 18:54:44.251 AFD: video timecode 179597863 179597863 179597863 1995531 1995531 1995498 (dts active)
6182011-03-07 18:54:44.251 AFD: audio timecode 179604706 179604706 1995607 1995639
6192011-03-07 18:54:44.251 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995607 needsupmix=0
6202011-03-07 18:54:44.252 AO, ERROR: Error occurred while downmixing
6212011-03-07 18:54:44.252 AO: SetAudiotime atc=1995607 tc=1995607 f=1536 pfu=0 pfs=0
6222011-03-07 18:54:44.273 A/V timecodes audio 1994646 video 1994564 frameinterval 33366 avdel -82 avg -83598 tcoffset 0
6232011-03-07 18:54:44.277 AVSync waitforframe 0 0
6242011-03-07 18:54:44.277 AVSync show
6252011-03-07 18:54:44.283 AFD: video timecode 179600866 179609875 179600866 1995565 1995565 1995531 (dts active)
6262011-03-07 18:54:44.283 AFD: audio timecode 179607586 179607586 1995639 1995671
6272011-03-07 18:54:44.283 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995639 needsupmix=0
6282011-03-07 18:54:44.283 AO, ERROR: Error occurred while downmixing
6292011-03-07 18:54:44.283 AO: SetAudiotime atc=1995639 tc=1995639 f=1536 pfu=0 pfs=0
6302011-03-07 18:54:44.306 A/V timecodes audio 1994678 video 1994597 frameinterval 33366 avdel -81 avg -83198 tcoffset 0
6312011-03-07 18:54:44.310 AVSync waitforframe -16666 0
6322011-03-07 18:54:44.310 AVSync show
6332011-03-07 18:54:44.317 AFD: video timecode 179603869 179603869 179603869 1995598 1995598 1995565 (dts active)
6342011-03-07 18:54:44.318 AFD: audio timecode 179610466 179610466 1995671 1995703
6352011-03-07 18:54:44.318 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995671 needsupmix=0
6362011-03-07 18:54:44.318 AO, ERROR: Error occurred while downmixing
6372011-03-07 18:54:44.318 AO: SetAudiotime atc=1995671 tc=1995671 f=1536 pfu=0 pfs=0
6382011-03-07 18:54:44.339 A/V timecodes audio 1994710 video 1994630 frameinterval 33366 avdel -80 avg -82648 tcoffset 0
6392011-03-07 18:54:44.344 AVSync waitforframe 0 0
6402011-03-07 18:54:44.344 AVSync show
6412011-03-07 18:54:44.352 AFD: video timecode 179606872 179606872 179606872 1995631 1995631 1995598 (dts active)
6422011-03-07 18:54:44.352 AFD: audio timecode 179613346 179613346 1995703 1995735
6432011-03-07 18:54:44.352 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995703 needsupmix=0
6442011-03-07 18:54:44.352 AO, ERROR: Error occurred while downmixing
6452011-03-07 18:54:44.352 AO: SetAudiotime atc=1995703 tc=1995703 f=1536 pfu=0 pfs=0
6462011-03-07 18:54:44.373 A/V timecodes audio 1994742 video 1994664 frameinterval 33366 avdel -78 avg -81986 tcoffset 0
6472011-03-07 18:54:44.377 AVSync waitforframe -16666 0
6482011-03-07 18:54:44.377 AVSync show
6492011-03-07 18:54:44.384 AFD: video timecode 179609875 179618884 179609875 1995665 1995665 1995631 (dts active)
6502011-03-07 18:54:44.384 AFD: audio timecode 179616226 179616226 1995735 1995767
6512011-03-07 18:54:44.385 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995735 needsupmix=0
6522011-03-07 18:54:44.385 AO, ERROR: Error occurred while downmixing
6532011-03-07 18:54:44.385 AO: SetAudiotime atc=1995735 tc=1995735 f=1536 pfu=0 pfs=0
6542011-03-07 18:54:44.406 A/V timecodes audio 1994774 video 1994697 frameinterval 33366 avdel -77 avg -80989 tcoffset 0
6552011-03-07 18:54:44.410 AVSync waitforframe 0 0
6562011-03-07 18:54:44.411 AVSync show
6572011-03-07 18:54:44.418 AFD: video timecode 179612878 179612878 179612878 1995698 1995698 1995665 (dts active)
6582011-03-07 18:54:44.418 AFD: audio timecode 179619106 179619106 1995767 1995799
6592011-03-07 18:54:44.418 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995767 needsupmix=0
6602011-03-07 18:54:44.418 AO, ERROR: Error occurred while downmixing
6612011-03-07 18:54:44.419 AO: SetAudiotime atc=1995767 tc=1995767 f=1536 pfu=0 pfs=0
6622011-03-07 18:54:44.439 A/V timecodes audio 1994806 video 1994731 frameinterval 33366 avdel -75 avg -79991 tcoffset 0
6632011-03-07 18:54:44.443 AVSync waitforframe -16666 0
6642011-03-07 18:54:44.444 AVSync show
6652011-03-07 18:54:44.451 AFD: video timecode 179615881 179615881 179615881 1995732 1995732 1995698 (dts active)
6662011-03-07 18:54:44.451 AFD: audio timecode 179621986 179621986 1995799 1995831
6672011-03-07 18:54:44.451 AO: AddFrames frames=1536, bytes=18432, used=712705, free=2359295, timecode=1995799 needsupmix=0
6682011-03-07 18:54:44.451 AO, ERROR: Error occurred while downmixing
669
670...
671
672'video_output' mean = '33366.15', std. dev. = '240.52', fps = '29.97'
6732011-03-07 18:54:59.872 A/V timecodes audio 2010230 video 2010246 frameinterval 33366 avdel 16 avg 10757 tcoffset 0
6742011-03-07 18:54:59.877 AVSync waitforframe 0 0
6752011-03-07 18:54:59.883 AFD: video timecode 181012276 181012276 181012276 2011247 2011247 2011214 (dts active)
6762011-03-07 18:54:59.883 AFD: audio timecode 181018786 181018786 2011319 2011351
6772011-03-07 18:54:59.883 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2011319 needsupmix=0
6782011-03-07 18:54:59.884 AO, ERROR: Error occurred while downmixing
6792011-03-07 18:54:59.884 AO: SetAudiotime atc=2011319 tc=2011319 f=1536 pfu=0 pfs=0
6802011-03-07 18:54:59.898 AVSync show
6812011-03-07 18:54:59.905 A/V timecodes audio 2010262 video 2010279 frameinterval 33366 avdel 17 avg 12067 tcoffset 0
6822011-03-07 18:54:59.909 AVSync waitforframe 0 0
6832011-03-07 18:54:59.916 AFD: video timecode 181015279 181024288 181015279 2011280 2011280 2011247 (dts active)
6842011-03-07 18:54:59.917 AFD: audio timecode 181021666 181021666 2011351 2011383
6852011-03-07 18:54:59.917 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2011351 needsupmix=0
6862011-03-07 18:54:59.917 AO, ERROR: Error occurred while downmixing
6872011-03-07 18:54:59.917 AO: SetAudiotime atc=2011351 tc=2011351 f=1536 pfu=0 pfs=0
6882011-03-07 18:54:59.931 AVSync show
6892011-03-07 18:54:59.939 A/V timecodes audio 2010294 video 2010313 frameinterval 33366 avdel 19 avg 13300 tcoffset 0
6902011-03-07 18:54:59.943 AVSync waitforframe 0 0
6912011-03-07 18:54:59.951 AFD: video timecode 181018282 181018282 181018282 2011314 2011314 2011280 (dts active)
6922011-03-07 18:54:59.951 AFD: audio timecode 181024546 181024546 2011383 2011415
6932011-03-07 18:54:59.951 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2011383 needsupmix=0
6942011-03-07 18:54:59.951 AO, ERROR: Error occurred while downmixing
6952011-03-07 18:54:59.951 AO: SetAudiotime atc=2011383 tc=2011383 f=1536 pfu=0 pfs=0
6962011-03-07 18:54:59.965 AVSync show
6972011-03-07 18:54:59.972 A/V timecodes audio 2010326 video 2010346 frameinterval 33366 avdel 20 avg 14725 tcoffset 0
6982011-03-07 18:54:59.977 AVSync waitforframe 0 0
6992011-03-07 18:54:59.984 AFD: video timecode 181021285 181021285 181021285 2011347 2011347 2011314 (dts active)
7002011-03-07 18:54:59.985 AFD: audio timecode 181027426 181027426 2011415 2011447
7012011-03-07 18:54:59.985 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2011415 needsupmix=0
7022011-03-07 18:54:59.985 AO, ERROR: Error occurred while downmixing
7032011-03-07 18:54:59.985 AO: SetAudiotime atc=2011415 tc=2011415 f=1536 pfu=0 pfs=0
7042011-03-07 18:54:59.998 AVSync show
7052011-03-07 18:55:00.006 A/V timecodes audio 2010358 video 2010379 frameinterval 33366 avdel 21 avg 16043 tcoffset 0
7062011-03-07 18:55:00.010 AVSync waitforframe 0 0
7072011-03-07 18:55:00.017 AFD: video timecode 181024288 181033297 181024288 2011380 2011380 2011347 (dts active)
7082011-03-07 18:55:00.017 AFD: audio timecode 181030306 181030306 2011447 2011479
7092011-03-07 18:55:00.017 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2011447 needsupmix=0
7102011-03-07 18:55:00.017 AO, ERROR: Error occurred while downmixing
7112011-03-07 18:55:00.017 AO: SetAudiotime atc=2011447 tc=2011447 f=1536 pfu=0 pfs=0
7122011-03-07 18:55:00.017 AFD: audio timecode 181033186 181033186 2011479 2011511
7132011-03-07 18:55:00.017 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011479 needsupmix=0
7142011-03-07 18:55:00.017 AO, ERROR: Error occurred while downmixing
7152011-03-07 18:55:00.017 AO: SetAudiotime atc=2011479 tc=2011479 f=1536 pfu=0 pfs=0
7162011-03-07 18:55:00.032 AVSync show
7172011-03-07 18:55:00.039 A/V timecodes audio 2010422 video 2010413 frameinterval 33366 avdel -9 avg 17282 tcoffset 0
7182011-03-07 18:55:00.043 AVSync waitforframe 0 0
7192011-03-07 18:55:00.050 AFD: video timecode 181027291 181027291 181027291 2011414 2011414 2011380 (dts active)
7202011-03-07 18:55:00.051 AFD: audio timecode 181036066 181036066 2011511 2011543
7212011-03-07 18:55:00.051 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011511 needsupmix=0
7222011-03-07 18:55:00.051 AO, ERROR: Error occurred while downmixing
7232011-03-07 18:55:00.051 AO: SetAudiotime atc=2011511 tc=2011511 f=1536 pfu=0 pfs=0
7242011-03-07 18:55:00.065 AVSync show
7252011-03-07 18:55:00.072 A/V timecodes audio 2010454 video 2010446 frameinterval 33366 avdel -8 avg 10711 tcoffset 0
7262011-03-07 18:55:00.077 AVSync waitforframe 0 0
7272011-03-07 18:55:00.084 AFD: video timecode 181030294 181030294 181030294 2011447 2011447 2011414 (dts active)
7282011-03-07 18:55:00.084 AFD: audio timecode 181038946 181038946 2011543 2011575
7292011-03-07 18:55:00.085 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011543 needsupmix=0
7302011-03-07 18:55:00.085 AO, ERROR: Error occurred while downmixing
7312011-03-07 18:55:00.085 AO: SetAudiotime atc=2011543 tc=2011543 f=1536 pfu=0 pfs=0
7322011-03-07 18:55:00.098 AVSync show
7332011-03-07 18:55:00.106 A/V timecodes audio 2010486 video 2010480 frameinterval 33366 avdel -6 avg 6033 tcoffset 0
7342011-03-07 18:55:00.110 AVSync waitforframe 0 0
7352011-03-07 18:55:00.119 AFD: video timecode 181033297 181042306 181033297 2011481 2011481 2011447 (dts active)
7362011-03-07 18:55:00.119 AFD: audio timecode 181041826 181041826 2011575 2011607
7372011-03-07 18:55:00.119 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011575 needsupmix=0
7382011-03-07 18:55:00.119 AO, ERROR: Error occurred while downmixing
7392011-03-07 18:55:00.119 AO: SetAudiotime atc=2011575 tc=2011575 f=1536 pfu=0 pfs=0
7402011-03-07 18:55:00.132 AVSync show
7412011-03-07 18:55:00.139 A/V timecodes audio 2010518 video 2010513 frameinterval 33366 avdel -5 avg 3024 tcoffset 0
7422011-03-07 18:55:00.144 AVSync waitforframe 0 0
7432011-03-07 18:55:00.151 AFD: video timecode 181036300 181036300 181036300 2011514 2011514 2011481 (dts active)
7442011-03-07 18:55:00.152 AFD: audio timecode 181044706 181044706 2011607 2011639
7452011-03-07 18:55:00.152 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011607 needsupmix=0
7462011-03-07 18:55:00.152 AO, ERROR: Error occurred while downmixing
7472011-03-07 18:55:00.152 AO: SetAudiotime atc=2011607 tc=2011607 f=1536 pfu=0 pfs=0
7482011-03-07 18:55:00.165 AVSync show
7492011-03-07 18:55:00.173 A/V timecodes audio 2010550 video 2010546 frameinterval 33366 avdel -4 avg 1018 tcoffset 0
7502011-03-07 18:55:00.177 AVSync waitforframe 0 0
7512011-03-07 18:55:00.184 AFD: video timecode 181039303 181039303 181039303 2011547 2011547 2011514 (dts active)
7522011-03-07 18:55:00.184 AFD: audio timecode 181047586 181047586 2011639 2011671
7532011-03-07 18:55:00.184 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011639 needsupmix=0
7542011-03-07 18:55:00.184 AO, ERROR: Error occurred while downmixing
7552011-03-07 18:55:00.184 AO: SetAudiotime atc=2011639 tc=2011639 f=1536 pfu=0 pfs=0
7562011-03-07 18:55:00.198 AVSync show
7572011-03-07 18:55:00.206 A/V timecodes audio 2010582 video 2010580 frameinterval 33366 avdel -2 avg -236 tcoffset 0
7582011-03-07 18:55:00.210 AVSync waitforframe 0 0
7592011-03-07 18:55:00.216 AFD: video timecode 181042306 181051315 181042306 2011581 2011581 2011547 (dts active)
7602011-03-07 18:55:00.216 AFD: audio timecode 181050466 181050466 2011671 2011703
7612011-03-07 18:55:00.216 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011671 needsupmix=0
7622011-03-07 18:55:00.216 AO, ERROR: Error occurred while downmixing
7632011-03-07 18:55:00.216 AO: SetAudiotime atc=2011671 tc=2011671 f=1536 pfu=0 pfs=0
7642011-03-07 18:55:00.232 AVSync show
7652011-03-07 18:55:00.239 A/V timecodes audio 2010614 video 2010613 frameinterval 33366 avdel -1 avg -677 tcoffset 0
7662011-03-07 18:55:00.243 AVSync waitforframe 0 0
7672011-03-07 18:55:00.250 AFD: video timecode 181045309 181045309 181045309 2011614 2011614 2011581 (dts active)
7682011-03-07 18:55:00.251 AFD: audio timecode 181053346 181053346 2011703 2011735
7692011-03-07 18:55:00.251 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011703 needsupmix=0
7702011-03-07 18:55:00.251 AO, ERROR: Error occurred while downmixing
7712011-03-07 18:55:00.251 AO: SetAudiotime atc=2011703 tc=2011703 f=1536 pfu=0 pfs=0
7722011-03-07 18:55:00.265 AVSync show
7732011-03-07 18:55:00.273 A/V timecodes audio 2010646 video 2010646 frameinterval 33366 avdel 0 avg -757 tcoffset 0
7742011-03-07 18:55:00.277 AVSync waitforframe 0 0
7752011-03-07 18:55:00.283 AFD: video timecode 181048312 181048312 181048312 2011647 2011647 2011614 (dts active)
7762011-03-07 18:55:00.284 AFD: audio timecode 181056226 181056226 2011735 2011767
7772011-03-07 18:55:00.284 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011735 needsupmix=0
7782011-03-07 18:55:00.284 AO, ERROR: Error occurred while downmixing
7792011-03-07 18:55:00.284 AO: SetAudiotime atc=2011735 tc=2011735 f=1536 pfu=0 pfs=0
7802011-03-07 18:55:00.298 AVSync show
7812011-03-07 18:55:00.306 A/V timecodes audio 2010678 video 2010680 frameinterval 33366 avdel 2 avg -567 tcoffset 0
7822011-03-07 18:55:00.310 AVSync waitforframe 0 0
7832011-03-07 18:55:00.316 AFD: video timecode 181051315 181060324 181051315 2011681 2011681 2011647 (dts active)
7842011-03-07 18:55:00.316 AFD: audio timecode 181059106 181059106 2011767 2011799
7852011-03-07 18:55:00.316 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011767 needsupmix=0
7862011-03-07 18:55:00.316 AO, ERROR: Error occurred while downmixing
7872011-03-07 18:55:00.316 AO: SetAudiotime atc=2011767 tc=2011767 f=1536 pfu=0 pfs=0
7882011-03-07 18:55:00.332 AVSync show
7892011-03-07 18:55:00.339 A/V timecodes audio 2010710 video 2010713 frameinterval 33366 avdel 3 avg 74 tcoffset 0
7902011-03-07 18:55:00.343 AVSync waitforframe 0 0
7912011-03-07 18:55:00.351 AFD: video timecode 181054318 181054318 181054318 2011714 2011714 2011681 (dts active)
7922011-03-07 18:55:00.351 AFD: audio timecode 181061986 181061986 2011799 2011831
7932011-03-07 18:55:00.352 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011799 needsupmix=0
7942011-03-07 18:55:00.352 AO, ERROR: Error occurred while downmixing
7952011-03-07 18:55:00.352 AO: SetAudiotime atc=2011799 tc=2011799 f=1536 pfu=0 pfs=0
7962011-03-07 18:55:00.365 AVSync show
7972011-03-07 18:55:00.373 A/V timecodes audio 2010742 video 2010747 frameinterval 33366 avdel 5 avg 805 tcoffset 0
7982011-03-07 18:55:00.377 AVSync waitforframe 0 0
7992011-03-07 18:55:00.384 AFD: video timecode 181057321 181057321 181057321 2011748 2011748 2011714 (dts active)
8002011-03-07 18:55:00.384 AFD: audio timecode 181064866 181064866 2011831 2011863
8012011-03-07 18:55:00.384 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011831 needsupmix=0
8022011-03-07 18:55:00.384 AO, ERROR: Error occurred while downmixing
8032011-03-07 18:55:00.384 AO: SetAudiotime atc=2011831 tc=2011831 f=1536 pfu=0 pfs=0
8042011-03-07 18:55:00.398 AVSync show
8052011-03-07 18:55:00.406 A/V timecodes audio 2010774 video 2010780 frameinterval 33366 avdel 6 avg 1853 tcoffset 0
8062011-03-07 18:55:00.410 AVSync waitforframe 0 0
8072011-03-07 18:55:00.416 AFD: video timecode 181060324 181069333 181060324 2011781 2011781 2011748 (dts active)
8082011-03-07 18:55:00.417 AFD: audio timecode 181067746 181067746 2011863 2011895
8092011-03-07 18:55:00.417 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011863 needsupmix=0
8102011-03-07 18:55:00.417 AO, ERROR: Error occurred while downmixing
8112011-03-07 18:55:00.417 AO: SetAudiotime atc=2011863 tc=2011863 f=1536 pfu=0 pfs=0
8122011-03-07 18:55:00.432 AVSync show
8132011-03-07 18:55:00.439 A/V timecodes audio 2010806 video 2010813 frameinterval 33366 avdel 7 avg 2889 tcoffset 0
8142011-03-07 18:55:00.444 AVSync waitforframe 0 0
8152011-03-07 18:55:00.451 AFD: video timecode 181063327 181063327 181063327 2011814 2011814 2011781 (dts active)
8162011-03-07 18:55:00.451 AFD: audio timecode 181070626 181070626 2011895 2011927
8172011-03-07 18:55:00.451 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011895 needsupmix=0
8182011-03-07 18:55:00.452 AO, ERROR: Error occurred while downmixing
8192011-03-07 18:55:00.452 AO: SetAudiotime atc=2011895 tc=2011895 f=1536 pfu=0 pfs=0
8202011-03-07 18:55:00.465 AVSync show
8212011-03-07 18:55:00.473 A/V timecodes audio 2010838 video 2010847 frameinterval 33366 avdel 9 avg 3916 tcoffset 0
8222011-03-07 18:55:00.477 AVSync waitforframe 0 0
8232011-03-07 18:55:00.484 AFD: video timecode 181066330 181066330 181066330 2011848 2011848 2011814 (dts active)
8242011-03-07 18:55:00.484 AFD: audio timecode 181073506 181073506 2011927 2011959
8252011-03-07 18:55:00.484 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011927 needsupmix=0
8262011-03-07 18:55:00.484 AO, ERROR: Error occurred while downmixing
8272011-03-07 18:55:00.484 AO: SetAudiotime atc=2011927 tc=2011927 f=1536 pfu=0 pfs=0
8282011-03-07 18:55:00.499 AVSync show
8292011-03-07 18:55:00.506 A/V timecodes audio 2010870 video 2010880 frameinterval 33366 avdel 10 avg 5187 tcoffset 0
8302011-03-07 18:55:00.510 AVSync waitforframe 0 0
8312011-03-07 18:55:00.517 AFD: video timecode 181069333 181078342 181069333 2011881 2011881 2011848 (dts active)
8322011-03-07 18:55:00.518 AFD: audio timecode 181076386 181076386 2011959 2011991
8332011-03-07 18:55:00.518 AO: AddFrames frames=1536, bytes=18432, used=786433, free=2285567, timecode=2011959 needsupmix=0
8342011-03-07 18:55:00.518 AO, ERROR: Error occurred while downmixing
8352011-03-07 18:55:00.518 AO: SetAudiotime atc=2011959 tc=2011959 f=1536 pfu=0 pfs=0
8362011-03-07 18:55:00.532 AVSync show
8372011-03-07 18:55:00.540 A/V timecodes audio 2010902 video 2010913 frameinterval 33366 avdel 11 avg 6390 tcoffset 0
8382011-03-07 18:55:00.544 AVSync waitforframe 0 0
8392011-03-07 18:55:00.551 AFD: video timecode 181072336 181072336 181072336 2011914 2011914 2011881 (dts active)
8402011-03-07 18:55:00.552 AFD: audio timecode 181079266 181079266 2011991 2012023
8412011-03-07 18:55:00.552 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2011991 needsupmix=0
8422011-03-07 18:55:00.552 AO, ERROR: Error occurred while downmixing
8432011-03-07 18:55:00.552 AO: SetAudiotime atc=2011991 tc=2011991 f=1536 pfu=0 pfs=0
8442011-03-07 18:55:00.565 AVSync show
8452011-03-07 18:55:00.573 A/V timecodes audio 2010934 video 2010947 frameinterval 33366 avdel 13 avg 7542 tcoffset 0
8462011-03-07 18:55:00.577 AVSync waitforframe 0 0
8472011-03-07 18:55:00.584 AFD: video timecode 181075339 181075339 181075339 2011948 2011948 2011914 (dts active)
8482011-03-07 18:55:00.585 AFD: audio timecode 181082146 181082146 2012023 2012055
8492011-03-07 18:55:00.585 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2012023 needsupmix=0
8502011-03-07 18:55:00.585 AO, ERROR: Error occurred while downmixing
8512011-03-07 18:55:00.585 AO: SetAudiotime atc=2012023 tc=2012023 f=1536 pfu=0 pfs=0
8522011-03-07 18:55:00.599 AVSync show
8532011-03-07 18:55:00.606 A/V timecodes audio 2010966 video 2010980 frameinterval 33366 avdel 14 avg 8906 tcoffset 0
8542011-03-07 18:55:00.610 AVSync waitforframe 0 0
8552011-03-07 18:55:00.619 AFD: video timecode 181078342 181087351 181078342 2011981 2011981 2011948 (dts active)
8562011-03-07 18:55:00.619 AFD: audio timecode 181085026 181085026 2012055 2012087
8572011-03-07 18:55:00.619 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2012055 needsupmix=0
8582011-03-07 18:55:00.619 AO, ERROR: Error occurred while downmixing
8592011-03-07 18:55:00.619 AO: SetAudiotime atc=2012055 tc=2012055 f=1536 pfu=0 pfs=0
8602011-03-07 18:55:00.632 AVSync show
8612011-03-07 18:55:00.640 A/V timecodes audio 2010998 video 2011013 frameinterval 33366 avdel 15 avg 10179 tcoffset 0
8622011-03-07 18:55:00.644 AVSync waitforframe 0 0
8632011-03-07 18:55:00.651 AFD: video timecode 181081345 181081345 181081345 2012014 2012014 2011981 (dts active)
8642011-03-07 18:55:00.652 AFD: audio timecode 181087906 181087906 2012087 2012119
8652011-03-07 18:55:00.652 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2012087 needsupmix=0
8662011-03-07 18:55:00.652 AO, ERROR: Error occurred while downmixing
8672011-03-07 18:55:00.652 AO: SetAudiotime atc=2012087 tc=2012087 f=1536 pfu=0 pfs=0
8682011-03-07 18:55:00.665 AVSync show
8692011-03-07 18:55:00.673 A/V timecodes audio 2011030 video 2011047 frameinterval 33366 avdel 17 avg 11384 tcoffset 0
8702011-03-07 18:55:00.683 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
8712011-03-07 18:55:00.683 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
8722011-03-07 18:55:00.684 AFD: video timecode 181084348 181084348 181084348 2012048 2012048 2012014 (dts active)
8732011-03-07 18:55:00.686 AFD: audio timecode 181090786 181090786 2012119 2012151
8742011-03-07 18:55:00.686 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2012119 needsupmix=0
8752011-03-07 18:55:00.686 AO, ERROR: Error occurred while downmixing
8762011-03-07 18:55:00.686 AO: SetAudiotime atc=2012119 tc=2012119 f=1536 pfu=0 pfs=0
8772011-03-07 18:55:00.692 AVSync waitforframe 0 0
8782011-03-07 18:55:00.699 AVSync show
8792011-03-07 18:55:00.706 A/V timecodes audio 2011062 video 2011080 frameinterval 33366 avdel 18 avg 12788 tcoffset 0
8802011-03-07 18:55:00.710 AVSync waitforframe 0 0
8812011-03-07 18:55:00.717 AFD: video timecode 181087351 181096360 181087351 2012081 2012081 2012048 (dts active)
8822011-03-07 18:55:00.717 AFD: audio timecode 181093666 181093666 2012151 2012183
8832011-03-07 18:55:00.717 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2012151 needsupmix=0
8842011-03-07 18:55:00.717 AO, ERROR: Error occurred while downmixing
8852011-03-07 18:55:00.717 AO: SetAudiotime atc=2012151 tc=2012151 f=1536 pfu=0 pfs=0
8862011-03-07 18:55:00.732 AVSync show
8872011-03-07 18:55:00.740 A/V timecodes audio 2011094 video 2011114 frameinterval 33366 avdel 20 avg 14091 tcoffset 0
8882011-03-07 18:55:00.750 AFD: video timecode 181090354 181090354 181090354 2012115 2012115 2012081 (dts active)
8892011-03-07 18:55:00.750 AFD: audio timecode 181096546 181096546 2012183 2012215
8902011-03-07 18:55:00.750 AO: AddFrames frames=1536, bytes=18432, used=761857, free=2310143, timecode=2012183 needsupmix=0
8912011-03-07 18:55:00.750 AO, ERROR: Error occurred while downmixing
8922011-03-07 18:55:00.750 AO: SetAudiotime atc=2012183 tc=2012183 f=1536 pfu=0 pfs=0
8932011-03-07 18:55:00.756 PreviewQueue: Requesting preview for '2051_20110303200000.mpg_0x0_-1s'
8942011-03-07 18:55:00.757 PreviewQueue: Requested preview for '2051_20110303200000.mpg_0x0_-1s'
8952011-03-07 18:55:00.757 TV: HandleStateChange(0) -- begin
8962011-03-07 18:55:00.757 TV: Attempting to change from WatchingPreRecorded to None
8972011-03-07 18:55:00.757 TV: StopStuff() for player ctx 0 -- begin
8982011-03-07 18:55:00.757 TV: SetActive(0,w/o OSD) 0 -> 0 -- begin
8992011-03-07 18:55:00.757 TV: SetActive(0,w/o OSD) 0 -> 0 -- end
9002011-03-07 18:55:00.757 Player(1): StopPlaying - begin
9012011-03-07 18:55:00.761 Player(1): Decoder thread exiting.
9022011-03-07 18:55:00.761 Player(1): Exited decoder loop.
9032011-03-07 18:55:00.856 AO: Killing AudioOutputDSP
9042011-03-07 18:55:00.883 Player(1): StopPlaying - end
9052011-03-07 18:55:00.883 TV: StopStuff(): stopping ring buffer
9062011-03-07 18:55:00.884 TV: StopStuff(): stopping player
9072011-03-07 18:55:00.884 TV: StopStuff() -- end
9082011-03-07 18:55:00.884 TV: Changing from WatchingPreRecorded to None
9092011-03-07 18:55:00.884 TV: HandleStateChange(0) -- end
9102011-03-07 18:55:00.884 TV: StartTV -- process events end
9112011-03-07 18:55:00.884 TV: StartTV -- process events 2 begin
9122011-03-07 18:55:00.884 TV: StartTV -- process events 2 end
9132011-03-07 18:55:00.884 TV::~TV() -- begin
9142011-03-07 18:55:00.894 TV::~TV() -- lock
9152011-03-07 18:55:00.895 Player(1): StopPlaying - begin
9162011-03-07 18:55:00.895 Player(1): Exited decoder loop.
9172011-03-07 18:55:00.895 Player(1): StopPlaying - end
9182011-03-07 18:55:00.905 TV::~TV() -- end
9192011-03-07 18:55:00.906 TV: StartTV -- end