Ticket #5749: shortlog

File shortlog, 75.5 KB (added by dl-mythtv@…, 16 years ago)

mythfrontend --verbose log showing audio buffer underrun

Line 
12008-09-25 18:52:51.793 Disabled deinterlacing
22008-09-25 18:52:51.793 NVP: A/V Divergence: -1.90685, Rate: -0.782953, Warpfactor: 0.999, warpfactor_avg: 1
32008-09-25 18:52:51.798 AFD: video timecode 2537944484 2537939980 28199333 28199316
42008-09-25 18:52:51.799 AFD: audio timecode 2537948897 2537948897 28199432 28199464
52008-09-25 18:52:51.799 GetAudiotime now=1222393971.799866, set=1222393971.779296, ret=20, audt=28199007 sf=1
62008-09-25 18:52:51.799 AO: _AddSamples samples=1536 bytes=6144, used=18433, free=1517567, timecode=28199432 needsupmix 0
72008-09-25 18:52:51.803 AFD: video timecode 2537941481 2537941481 28199349 28199333
82008-09-25 18:52:51.806 AFD: video timecode 2537942983 2537942983 28199366 28199349
92008-09-25 18:52:51.807 AFD: audio timecode 2537951777 2537951777 28199464 28199496
102008-09-25 18:52:51.807 GetAudiotime now=1222393971.807641, set=1222393971.779296, ret=28, audt=28199007 sf=1
112008-09-25 18:52:51.807 AO: _AddSamples samples=1536 bytes=6144, used=24577, free=1511423, timecode=28199464 needsupmix 0
122008-09-25 18:52:51.809 GetAudiotime now=1222393971.809674, set=1222393971.779296, ret=30, audt=28199007 sf=1
132008-09-25 18:52:51.809 NVP: A/V Divergence: -2.4941, Rate: -0.587245, Warpfactor: 0.998501, warpfactor_avg: 1
142008-09-25 18:52:51.813 AFD: video timecode 2537948989 2537944484 28199383 0
152008-09-25 18:52:51.816 AFD: video timecode 2537945986 2537945986 28199399 28199383
162008-09-25 18:52:51.819 AFD: video timecode 2537947487 2537947487 28199416 28199399
172008-09-25 18:52:51.823 AFD: video timecode 2537953493 2537948989 28199433 28199416
182008-09-25 18:52:51.826 GetAudiotime now=1222393971.826504, set=1222393971.779296, ret=47, audt=28199007 sf=1
192008-09-25 18:52:51.826 NVP: A/V Divergence: -2.94947, Rate: -0.455374, Warpfactor: 0.998001, warpfactor_avg: 1
202008-09-25 18:52:51.828 AFD: video timecode 2537950490 2537950490 28199449 28199433
212008-09-25 18:52:51.831 AFD: video timecode 2537951992 2537951992 28199466 28199449
222008-09-25 18:52:51.834 AFD: video timecode 2537957998 2537953493 28199483 28199466
232008-09-25 18:52:51.842 GetAudiotime now=1222393971.842893, set=1222393971.779296, ret=63, audt=28199007 sf=1
242008-09-25 18:52:51.843 NVP: A/V Divergence: -3.27603, Rate: -0.32656, Warpfactor: 0.997502, warpfactor_avg: 1
252008-09-25 18:52:51.843 NVP: Video is 3.27603 frames behind audio (too slow), dropping frame to catch up.
262008-09-25 18:52:51.843 GetAudiotime now=1222393971.843196, set=1222393971.779296, ret=63, audt=28199007 sf=1
272008-09-25 18:52:51.843 NVP: A/V Divergence: -3.2662, Rate: 0.00983037, Warpfactor: 0.997004, warpfactor_avg: 1
282008-09-25 18:52:51.843 NVP: Video is 3.2662 frames behind audio (too slow), dropping frame to catch up.
292008-09-25 18:52:51.843 GetAudiotime now=1222393971.843342, set=1222393971.779296, ret=64, audt=28199007 sf=1
302008-09-25 18:52:51.843 NVP: A/V Divergence: -3.03405, Rate: 0.232152, Warpfactor: 0.996505, warpfactor_avg: 1
312008-09-25 18:52:51.843 NVP: Video is 3.03405 frames behind audio (too slow), dropping frame to catch up.
322008-09-25 18:52:51.843 GetAudiotime now=1222393971.843494, set=1222393971.779296, ret=64, audt=28199007 sf=1
332008-09-25 18:52:51.843 NVP: A/V Divergence: -2.60517, Rate: 0.42888, Warpfactor: 0.996007, warpfactor_avg: 1
342008-09-25 18:52:51.848 AFD: video timecode 2537954995 2537954995 28199499 28199483
352008-09-25 18:52:51.854 AFD: video timecode 2537956496 2537956496 28199516 28199499
362008-09-25 18:52:51.860 AFD: video timecode 2537962502 2537957998 28199533 28199516
372008-09-25 18:52:51.866 AFD: video timecode 2537959499 2537959499 28199549 28199533
382008-09-25 18:52:51.875 GetAudiotime now=1222393971.875848, set=1222393971.779296, ret=96, audt=28199007 sf=1
392008-09-25 18:52:51.876 NVP: A/V Divergence: -2.5083, Rate: 0.0968651, Warpfactor: 0.995509, warpfactor_avg: 0.999999
402008-09-25 18:52:51.880 AFD: video timecode 2537961001 2537961001 28199566 28199549
412008-09-25 18:52:51.892 GetAudiotime now=1222393971.892847, set=1222393971.779296, ret=113, audt=28199007 sf=1
422008-09-25 18:52:51.893 NVP: A/V Divergence: -2.45064, Rate: 0.0576635, Warpfactor: 0.995011, warpfactor_avg: 0.999999
432008-09-25 18:52:51.896 AFD: video timecode 2537967007 2537962502 28199583 28199566
442008-09-25 18:52:51.899 SetAudiotime set=1222393971.899396, audt=28199011 atc=28199496 tb=93284 sb=62564 eds=4800000 abps=4 sf=1
452008-09-25 18:52:51.899 AO: audio waiting for space on soundcard: have 2972 need 6144
462008-09-25 18:52:51.904 SetAudiotime set=1222393971.904607, audt=28199016 atc=28199496 tb=92280 sb=61560 eds=4800000 abps=4 sf=1
472008-09-25 18:52:51.904 AO: audio waiting for space on soundcard: have 3976 need 6144
482008-09-25 18:52:51.909 GetAudiotime now=1222393971.909526, set=1222393971.904607, ret=4, audt=28199016 sf=1
492008-09-25 18:52:51.909 NVP: A/V Divergence: -0.654139, Rate: 1.7965, Warpfactor: 0.995508, warpfactor_avg: 0.999999
502008-09-25 18:52:51.909 SetAudiotime set=1222393971.909810, audt=28199021 atc=28199496 tb=91284 sb=60564 eds=4800000 abps=4 sf=1
512008-09-25 18:52:51.909 AO: audio waiting for space on soundcard: have 4972 need 6144
522008-09-25 18:52:51.912 AFD: video timecode 2537964004 2537964004 28199600 28199583
532008-09-25 18:52:51.914 SetAudiotime set=1222393971.914954, audt=28199026 atc=28199496 tb=90296 sb=59576 eds=4800000 abps=4 sf=1
542008-09-25 18:52:51.915 AO: audio waiting for space on soundcard: have 5960 need 6144
552008-09-25 18:52:51.920 SetAudiotime set=1222393971.920156, audt=28199031 atc=28199496 tb=89296 sb=58576 eds=4800000 abps=4 sf=1
562008-09-25 18:52:51.920 GetAudiotime now=1222393971.920212, set=1222393971.920156, ret=0, audt=28199031 sf=1
572008-09-25 18:52:51.920 AO: Broadcasting free space avail
582008-09-25 18:52:51.920 WriteAudio: Preparing 6144 bytes (1536 frames)
592008-09-25 18:52:51.920 SetAudiotime set=1222393971.920351, audt=28199032 atc=28199496 tb=89260 sb=64684 eds=4800000 abps=4 sf=1
602008-09-25 18:52:51.920 AO: audio waiting for space on soundcard: have 852 need 6144
612008-09-25 18:52:51.926 GetAudiotime now=1222393971.926218, set=1222393971.920351, ret=5, audt=28199032 sf=1
622008-09-25 18:52:51.926 NVP: A/V Divergence: 0.693221, Rate: 1.34736, Warpfactor: 0.996006, warpfactor_avg: 0.999999
632008-09-25 18:52:51.926 SetAudiotime set=1222393971.926531, audt=28199038 atc=28199496 tb=88072 sb=63496 eds=4800000 abps=4 sf=1
642008-09-25 18:52:51.926 AO: audio waiting for space on soundcard: have 2040 need 6144
652008-09-25 18:52:51.931 SetAudiotime set=1222393971.931650, audt=28199043 atc=28199496 tb=87088 sb=62512 eds=4800000 abps=4 sf=1
662008-09-25 18:52:51.931 AO: audio waiting for space on soundcard: have 3024 need 6144
672008-09-25 18:52:51.931 AFD: video timecode 2537965505 2537965505 28199616 28199600
682008-09-25 18:52:51.936 SetAudiotime set=1222393971.936785, audt=28199048 atc=28199496 tb=86104 sb=61528 eds=4800000 abps=4 sf=1
692008-09-25 18:52:51.936 AO: audio waiting for space on soundcard: have 4008 need 6144
702008-09-25 18:52:51.942 GetAudiotime now=1222393971.942832, set=1222393971.936785, ret=6, audt=28199048 sf=1
712008-09-25 18:52:51.943 NVP: A/V Divergence: 1.68872, Rate: 0.995504, Warpfactor: 0.996504, warpfactor_avg: 0.999999
722008-09-25 18:52:51.943 SetAudiotime set=1222393971.943093, audt=28199054 atc=28199496 tb=84892 sb=60316 eds=4800000 abps=4 sf=1
732008-09-25 18:52:51.943 AO: audio waiting for space on soundcard: have 5220 need 6144
742008-09-25 18:52:51.947 AFD: video timecode 2537971511 2537967007 28199633 28199616
752008-09-25 18:52:51.948 SetAudiotime set=1222393971.948232, audt=28199059 atc=28199496 tb=83904 sb=59328 eds=4800000 abps=4 sf=1
762008-09-25 18:52:51.948 GetAudiotime now=1222393971.948393, set=1222393971.948232, ret=0, audt=28199059 sf=1
772008-09-25 18:52:51.948 AO: Broadcasting free space avail
782008-09-25 18:52:51.948 WriteAudio: Preparing 6144 bytes (1536 frames)
792008-09-25 18:52:51.948 SetAudiotime set=1222393971.948536, audt=28199060 atc=28199496 tb=83848 sb=65416 eds=4800000 abps=4 sf=1
802008-09-25 18:52:51.948 AO: audio waiting for space on soundcard: have 120 need 6144
812008-09-25 18:52:51.957 SetAudiotime set=1222393971.957715, audt=28199069 atc=28199496 tb=82084 sb=63652 eds=4800000 abps=4 sf=1
822008-09-25 18:52:51.957 AO: audio waiting for space on soundcard: have 1884 need 6144
832008-09-25 18:52:51.959 GetAudiotime now=1222393971.959468, set=1222393971.957715, ret=1, audt=28199069 sf=1
842008-09-25 18:52:51.959 NVP: A/V Divergence: 2.45034, Rate: 0.761614, Warpfactor: 0.997002, warpfactor_avg: 0.999999
852008-09-25 18:52:51.962 AFD: video timecode 2537968508 2537968508 28199650 28199633
862008-09-25 18:52:51.962 SetAudiotime set=1222393971.962924, audt=28199074 atc=28199496 tb=81084 sb=62652 eds=4800000 abps=4 sf=1
872008-09-25 18:52:51.963 AO: audio waiting for space on soundcard: have 2884 need 6144
882008-09-25 18:52:51.968 SetAudiotime set=1222393971.968127, audt=28199079 atc=28199496 tb=80084 sb=61652 eds=4800000 abps=4 sf=1
892008-09-25 18:52:51.968 AO: audio waiting for space on soundcard: have 3884 need 6144
902008-09-25 18:52:51.974 SetAudiotime set=1222393971.974377, audt=28199086 atc=28199496 tb=78884 sb=60452 eds=4800000 abps=4 sf=1
912008-09-25 18:52:51.974 AO: audio waiting for space on soundcard: have 5084 need 6144
922008-09-25 18:52:51.976 GetAudiotime now=1222393971.976179, set=1222393971.974377, ret=1, audt=28199086 sf=1
932008-09-25 18:52:51.976 NVP: A/V Divergence: 3.02158, Rate: 0.57124, Warpfactor: 0.997501, warpfactor_avg: 0.999999
942008-09-25 18:52:51.979 AFD: video timecode 2537970010 2537970010 28199666 28199650
952008-09-25 18:52:51.979 SetAudiotime set=1222393971.979514, audt=28199091 atc=28199496 tb=77900 sb=59468 eds=4800000 abps=4 sf=1
962008-09-25 18:52:51.979 AO: audio waiting for space on soundcard: have 6068 need 6144
972008-09-25 18:52:51.984 SetAudiotime set=1222393971.984716, audt=28199096 atc=28199496 tb=76900 sb=58468 eds=4800000 abps=4 sf=1
982008-09-25 18:52:51.984 GetAudiotime now=1222393971.984771, set=1222393971.984716, ret=0, audt=28199096 sf=1
992008-09-25 18:52:51.984 AO: Broadcasting free space avail
1002008-09-25 18:52:51.984 WriteAudio: Preparing 6144 bytes (1536 frames)
1012008-09-25 18:52:51.984 SetAudiotime set=1222393971.984907, audt=28199096 atc=28199496 tb=76864 sb=64576 eds=4800000 abps=4 sf=1
1022008-09-25 18:52:51.984 AO: audio waiting for space on soundcard: have 960 need 6144
1032008-09-25 18:52:51.990 SetAudiotime set=1222393971.990011, audt=28199101 atc=28199496 tb=75884 sb=63596 eds=4800000 abps=4 sf=1
1042008-09-25 18:52:51.990 AO: audio waiting for space on soundcard: have 1940 need 6144
1052008-09-25 18:52:51.995 SetAudiotime set=1222393971.995119, audt=28199106 atc=28199496 tb=74900 sb=62612 eds=4800000 abps=4 sf=1
1062008-09-25 18:52:51.995 AO: audio waiting for space on soundcard: have 2924 need 6144
1072008-09-25 18:52:52.000 SetAudiotime set=1222393972.246, audt=28199112 atc=28199496 tb=73916 sb=61628 eds=4800000 abps=4 sf=1
1082008-09-25 18:52:52.000 AO: audio waiting for space on soundcard: have 3908 need 6144
1092008-09-25 18:52:52.006 SetAudiotime set=1222393972.6258, audt=28199118 atc=28199496 tb=72764 sb=60476 eds=4800000 abps=4 sf=1
1102008-09-25 18:52:52.006 AO: audio waiting for space on soundcard: have 5060 need 6144
1112008-09-25 18:52:52.009 NVP: Video is 3.02158 frames ahead of audio,
112                        doubling video frame interval to slow down.
1132008-09-25 18:52:52.009 GetAudiotime now=1222393972.9528, set=1222393972.6258, ret=3, audt=28199118 sf=1
1142008-09-25 18:52:52.009 NVP: A/V Divergence: 3.18024, Rate: 0.158665, Warpfactor: 0.997999, warpfactor_avg: 0.999999
1152008-09-25 18:52:52.011 SetAudiotime set=1222393972.11409, audt=28199123 atc=28199496 tb=71776 sb=59488 eds=4800000 abps=4 sf=1
1162008-09-25 18:52:52.011 AO: audio waiting for space on soundcard: have 6048 need 6144
1172008-09-25 18:52:52.012 AFD: video timecode 2537976016 2537971511 28199683 28199666
1182008-09-25 18:52:52.016 SetAudiotime set=1222393972.16627, audt=28199128 atc=28199496 tb=70772 sb=58484 eds=4800000 abps=4 sf=1
1192008-09-25 18:52:52.016 GetAudiotime now=1222393972.16699, set=1222393972.16627, ret=0, audt=28199128 sf=1
1202008-09-25 18:52:52.016 AO: Broadcasting free space avail
1212008-09-25 18:52:52.016 WriteAudio: Preparing 6144 bytes (1536 frames)
1222008-09-25 18:52:52.016 SetAudiotime set=1222393972.16839, audt=28199128 atc=28199496 tb=70732 sb=64588 eds=4800000 abps=4 sf=1
1232008-09-25 18:52:52.016 AO: audio waiting for space on soundcard: have 948 need 6144
1242008-09-25 18:52:52.021 SetAudiotime set=1222393972.21944, audt=28199133 atc=28199496 tb=69752 sb=63608 eds=4800000 abps=4 sf=1
1252008-09-25 18:52:52.022 AO: audio waiting for space on soundcard: have 1928 need 6144
1262008-09-25 18:52:52.027 SetAudiotime set=1222393972.27048, audt=28199138 atc=28199496 tb=68772 sb=62628 eds=4800000 abps=4 sf=1
1272008-09-25 18:52:52.027 AO: audio waiting for space on soundcard: have 2908 need 6144
1282008-09-25 18:52:52.032 SetAudiotime set=1222393972.32159, audt=28199143 atc=28199496 tb=67788 sb=61644 eds=4800000 abps=4 sf=1
1292008-09-25 18:52:52.032 AO: audio waiting for space on soundcard: have 3892 need 6144
1302008-09-25 18:52:52.037 SetAudiotime set=1222393972.37257, audt=28199149 atc=28199496 tb=66812 sb=60668 eds=4800000 abps=4 sf=1
1312008-09-25 18:52:52.037 AO: audio waiting for space on soundcard: have 4868 need 6144
1322008-09-25 18:52:52.042 SetAudiotime set=1222393972.42355, audt=28199154 atc=28199496 tb=65832 sb=59688 eds=4800000 abps=4 sf=1
1332008-09-25 18:52:52.042 AO: audio waiting for space on soundcard: have 5848 need 6144
1342008-09-25 18:52:52.042 NVP: Video is 3.18024 frames ahead of audio,
135                        doubling video frame interval to slow down.
1362008-09-25 18:52:52.042 GetAudiotime now=1222393972.42833, set=1222393972.42355, ret=0, audt=28199154 sf=1
1372008-09-25 18:52:52.042 NVP: A/V Divergence: 3.05952, Rate: -0.120722, Warpfactor: 0.998498, warpfactor_avg: 0.999999
1382008-09-25 18:52:52.046 AFD: video timecode 2537973013 2537973013 28199700 28199683
1392008-09-25 18:52:52.047 SetAudiotime set=1222393972.47476, audt=28199159 atc=28199496 tb=64848 sb=58704 eds=4800000 abps=4 sf=1
1402008-09-25 18:52:52.047 GetAudiotime now=1222393972.47550, set=1222393972.47476, ret=0, audt=28199159 sf=1
1412008-09-25 18:52:52.047 AO: Broadcasting free space avail
1422008-09-25 18:52:52.047 WriteAudio: Preparing 6144 bytes (1536 frames)
1432008-09-25 18:52:52.047 SetAudiotime set=1222393972.47689, audt=28199159 atc=28199496 tb=64808 sb=64808 eds=4800000 abps=4 sf=1
1442008-09-25 18:52:52.049 SetAudiotime set=1222393972.49757, audt=28199161 atc=28199496 tb=64412 sb=64412 eds=4800000 abps=4 sf=1
1452008-09-25 18:52:52.051 SetAudiotime set=1222393972.51829, audt=28199163 atc=28199496 tb=64012 sb=64012 eds=4800000 abps=4 sf=1
1462008-09-25 18:52:52.053 SetAudiotime set=1222393972.53897, audt=28199165 atc=28199496 tb=63616 sb=63616 eds=4800000 abps=4 sf=1
1472008-09-25 18:52:52.055 SetAudiotime set=1222393972.55988, audt=28199167 atc=28199496 tb=63212 sb=63212 eds=4800000 abps=4 sf=1
1482008-09-25 18:52:52.058 SetAudiotime set=1222393972.58054, audt=28199169 atc=28199496 tb=62816 sb=62816 eds=4800000 abps=4 sf=1
1492008-09-25 18:52:52.060 SetAudiotime set=1222393972.60122, audt=28199171 atc=28199496 tb=62420 sb=62420 eds=4800000 abps=4 sf=1
1502008-09-25 18:52:52.062 SetAudiotime set=1222393972.62198, audt=28199173 atc=28199496 tb=62020 sb=62020 eds=4800000 abps=4 sf=1
1512008-09-25 18:52:52.064 SetAudiotime set=1222393972.64263, audt=28199176 atc=28199496 tb=61624 sb=61624 eds=4800000 abps=4 sf=1
1522008-09-25 18:52:52.066 SetAudiotime set=1222393972.66328, audt=28199178 atc=28199496 tb=61228 sb=61228 eds=4800000 abps=4 sf=1
1532008-09-25 18:52:52.068 SetAudiotime set=1222393972.68393, audt=28199180 atc=28199496 tb=60832 sb=60832 eds=4800000 abps=4 sf=1
1542008-09-25 18:52:52.070 SetAudiotime set=1222393972.70457, audt=28199182 atc=28199496 tb=60436 sb=60436 eds=4800000 abps=4 sf=1
1552008-09-25 18:52:52.072 SetAudiotime set=1222393972.72520, audt=28199184 atc=28199496 tb=60040 sb=60040 eds=4800000 abps=4 sf=1
1562008-09-25 18:52:52.074 SetAudiotime set=1222393972.74583, audt=28199186 atc=28199496 tb=59644 sb=59644 eds=4800000 abps=4 sf=1
1572008-09-25 18:52:52.076 NVP: Video is 3.05952 frames ahead of audio,
158                        doubling video frame interval to slow down.
1592008-09-25 18:52:52.076 GetAudiotime now=1222393972.76169, set=1222393972.74583, ret=1, audt=28199186 sf=1
1602008-09-25 18:52:52.076 NVP: A/V Divergence: 2.72919, Rate: -0.330336, Warpfactor: 0.998998, warpfactor_avg: 0.999999
1612008-09-25 18:52:52.076 SetAudiotime set=1222393972.76655, audt=28199188 atc=28199496 tb=59244 sb=59244 eds=4800000 abps=4 sf=1
1622008-09-25 18:52:52.078 SetAudiotime set=1222393972.78792, audt=28199190 atc=28199496 tb=58836 sb=58836 eds=4800000 abps=4 sf=1
1632008-09-25 18:52:52.079 AFD: video timecode 2537974514 2537974514 28199716 28199700
1642008-09-25 18:52:52.080 SetAudiotime set=1222393972.80971, audt=28199192 atc=28199496 tb=58416 sb=58416 eds=4800000 abps=4 sf=1
1652008-09-25 18:52:52.083 SetAudiotime set=1222393972.83058, audt=28199194 atc=28199496 tb=58016 sb=58016 eds=4800000 abps=4 sf=1
1662008-09-25 18:52:52.085 SetAudiotime set=1222393972.85139, audt=28199196 atc=28199496 tb=57616 sb=57616 eds=4800000 abps=4 sf=1
1672008-09-25 18:52:52.087 SetAudiotime set=1222393972.87215, audt=28199198 atc=28199496 tb=57216 sb=57216 eds=4800000 abps=4 sf=1
1682008-09-25 18:52:52.089 SetAudiotime set=1222393972.89293, audt=28199201 atc=28199496 tb=56820 sb=56820 eds=4800000 abps=4 sf=1
1692008-09-25 18:52:52.091 SetAudiotime set=1222393972.91365, audt=28199203 atc=28199496 tb=56420 sb=56420 eds=4800000 abps=4 sf=1
1702008-09-25 18:52:52.093 SetAudiotime set=1222393972.93437, audt=28199205 atc=28199496 tb=56024 sb=56024 eds=4800000 abps=4 sf=1
1712008-09-25 18:52:52.095 SetAudiotime set=1222393972.95508, audt=28199207 atc=28199496 tb=55624 sb=55624 eds=4800000 abps=4 sf=1
1722008-09-25 18:52:52.097 SetAudiotime set=1222393972.97578, audt=28199209 atc=28199496 tb=55228 sb=55228 eds=4800000 abps=4 sf=1
1732008-09-25 18:52:52.099 SetAudiotime set=1222393972.99648, audt=28199211 atc=28199496 tb=54832 sb=54832 eds=4800000 abps=4 sf=1
1742008-09-25 18:52:52.101 SetAudiotime set=1222393972.101719, audt=28199213 atc=28199496 tb=54432 sb=54432 eds=4800000 abps=4 sf=1
1752008-09-25 18:52:52.103 SetAudiotime set=1222393972.103792, audt=28199215 atc=28199496 tb=54036 sb=54036 eds=4800000 abps=4 sf=1
1762008-09-25 18:52:52.105 SetAudiotime set=1222393972.105864, audt=28199217 atc=28199496 tb=53636 sb=53636 eds=4800000 abps=4 sf=1
1772008-09-25 18:52:52.107 SetAudiotime set=1222393972.107932, audt=28199219 atc=28199496 tb=53240 sb=53240 eds=4800000 abps=4 sf=1
1782008-09-25 18:52:52.109 GetAudiotime now=1222393972.109450, set=1222393972.107932, ret=1, audt=28199219 sf=1
1792008-09-25 18:52:52.109 NVP: A/V Divergence: 2.24168, Rate: -0.487502, Warpfactor: 0.999497, warpfactor_avg: 0.999999
1802008-09-25 18:52:52.110 SetAudiotime set=1222393972.110007, audt=28199221 atc=28199496 tb=52840 sb=52840 eds=4800000 abps=4 sf=1
1812008-09-25 18:52:52.112 SetAudiotime set=1222393972.112158, audt=28199223 atc=28199496 tb=52428 sb=52428 eds=4800000 abps=4 sf=1
1822008-09-25 18:52:52.112 AFD: video timecode 2537980520 2537976016 28199733 28199716
1832008-09-25 18:52:52.114 SetAudiotime set=1222393972.114328, audt=28199226 atc=28199496 tb=52012 sb=52012 eds=4800000 abps=4 sf=1
1842008-09-25 18:52:52.116 SetAudiotime set=1222393972.116412, audt=28199228 atc=28199496 tb=51612 sb=51612 eds=4800000 abps=4 sf=1
1852008-09-25 18:52:52.118 SetAudiotime set=1222393972.118558, audt=28199230 atc=28199496 tb=51200 sb=51200 eds=4800000 abps=4 sf=1
1862008-09-25 18:52:52.120 SetAudiotime set=1222393972.120625, audt=28199232 atc=28199496 tb=50804 sb=50804 eds=4800000 abps=4 sf=1
1872008-09-25 18:52:52.122 SetAudiotime set=1222393972.122690, audt=28199234 atc=28199496 tb=50408 sb=50408 eds=4800000 abps=4 sf=1
1882008-09-25 18:52:52.124 SetAudiotime set=1222393972.124757, audt=28199236 atc=28199496 tb=50008 sb=50008 eds=4800000 abps=4 sf=1
1892008-09-25 18:52:52.126 SetAudiotime set=1222393972.126824, audt=28199238 atc=28199496 tb=49612 sb=49612 eds=4800000 abps=4 sf=1
1902008-09-25 18:52:52.128 SetAudiotime set=1222393972.128891, audt=28199240 atc=28199496 tb=49216 sb=49216 eds=4800000 abps=4 sf=1
1912008-09-25 18:52:52.130 SetAudiotime set=1222393972.130957, audt=28199242 atc=28199496 tb=48820 sb=48820 eds=4800000 abps=4 sf=1
1922008-09-25 18:52:52.133 SetAudiotime set=1222393972.133022, audt=28199244 atc=28199496 tb=48424 sb=48424 eds=4800000 abps=4 sf=1
1932008-09-25 18:52:52.135 SetAudiotime set=1222393972.135088, audt=28199246 atc=28199496 tb=48024 sb=48024 eds=4800000 abps=4 sf=1
1942008-09-25 18:52:52.137 SetAudiotime set=1222393972.137168, audt=28199248 atc=28199496 tb=47628 sb=47628 eds=4800000 abps=4 sf=1
1952008-09-25 18:52:52.139 SetAudiotime set=1222393972.139232, audt=28199251 atc=28199496 tb=47228 sb=47228 eds=4800000 abps=4 sf=1
1962008-09-25 18:52:52.141 SetAudiotime set=1222393972.141295, audt=28199253 atc=28199496 tb=46832 sb=46832 eds=4800000 abps=4 sf=1
1972008-09-25 18:52:52.142 GetAudiotime now=1222393972.142810, set=1222393972.141295, ret=1, audt=28199253 sf=1
1982008-09-25 18:52:52.142 NVP: A/V Divergence: 1.60631, Rate: -0.635377, Warpfactor: 0.999997, warpfactor_avg: 0.999999
1992008-09-25 18:52:52.143 SetAudiotime set=1222393972.143926, audt=28199255 atc=28199496 tb=46328 sb=46328 eds=4800000 abps=4 sf=1
2002008-09-25 18:52:52.145 AFD: video timecode 2537977517 2537977517 28199750 28199733
2012008-09-25 18:52:52.146 SetAudiotime set=1222393972.146097, audt=28199257 atc=28199496 tb=45912 sb=45912 eds=4800000 abps=4 sf=1
2022008-09-25 18:52:52.148 SetAudiotime set=1222393972.148196, audt=28199259 atc=28199496 tb=45508 sb=45508 eds=4800000 abps=4 sf=1
2032008-09-25 18:52:52.150 SetAudiotime set=1222393972.150267, audt=28199262 atc=28199496 tb=45112 sb=45112 eds=4800000 abps=4 sf=1
2042008-09-25 18:52:52.152 SetAudiotime set=1222393972.152361, audt=28199264 atc=28199496 tb=44708 sb=44708 eds=4800000 abps=4 sf=1
2052008-09-25 18:52:52.154 SetAudiotime set=1222393972.154426, audt=28199266 atc=28199496 tb=44312 sb=44312 eds=4800000 abps=4 sf=1
2062008-09-25 18:52:52.156 SetAudiotime set=1222393972.156492, audt=28199268 atc=28199496 tb=43916 sb=43916 eds=4800000 abps=4 sf=1
2072008-09-25 18:52:52.158 SetAudiotime set=1222393972.158571, audt=28199270 atc=28199496 tb=43516 sb=43516 eds=4800000 abps=4 sf=1
2082008-09-25 18:52:52.159 GetAudiotime now=1222393972.159514, set=1222393972.158571, ret=0, audt=28199270 sf=1
2092008-09-25 18:52:52.159 NVP: A/V Divergence: 1.14476, Rate: -0.461548, Warpfactor: 1.0005, warpfactor_avg: 0.999999
2102008-09-25 18:52:52.161 SetAudiotime set=1222393972.161246, audt=28199273 atc=28199496 tb=43004 sb=43004 eds=4800000 abps=4 sf=1
2112008-09-25 18:52:52.162 AFD: video timecode 2537979019 2537979019 28199766 28199750
2122008-09-25 18:52:52.163 SetAudiotime set=1222393972.163428, audt=28199275 atc=28199496 tb=42584 sb=42584 eds=4800000 abps=4 sf=1
2132008-09-25 18:52:52.165 SetAudiotime set=1222393972.165512, audt=28199277 atc=28199496 tb=42184 sb=42184 eds=4800000 abps=4 sf=1
2142008-09-25 18:52:52.167 SetAudiotime set=1222393972.167604, audt=28199279 atc=28199496 tb=41780 sb=41780 eds=4800000 abps=4 sf=1
2152008-09-25 18:52:52.169 SetAudiotime set=1222393972.169672, audt=28199281 atc=28199496 tb=41384 sb=41384 eds=4800000 abps=4 sf=1
2162008-09-25 18:52:52.171 SetAudiotime set=1222393972.171738, audt=28199283 atc=28199496 tb=40988 sb=40988 eds=4800000 abps=4 sf=1
2172008-09-25 18:52:52.173 SetAudiotime set=1222393972.173807, audt=28199285 atc=28199496 tb=40592 sb=40592 eds=4800000 abps=4 sf=1
2182008-09-25 18:52:52.175 SetAudiotime set=1222393972.175871, audt=28199287 atc=28199496 tb=40196 sb=40196 eds=4800000 abps=4 sf=1
2192008-09-25 18:52:52.176 GetAudiotime now=1222393972.176180, set=1222393972.175871, ret=0, audt=28199287 sf=1
2202008-09-25 18:52:52.176 NVP: A/V Divergence: 0.798597, Rate: -0.346161, Warpfactor: 1.001, warpfactor_avg: 0.999999
2212008-09-25 18:52:52.178 SetAudiotime set=1222393972.178571, audt=28199290 atc=28199496 tb=39676 sb=39676 eds=4800000 abps=4 sf=1
2222008-09-25 18:52:52.179 AFD: video timecode 2537985025 2537980520 28199783 28199766
2232008-09-25 18:52:52.180 SetAudiotime set=1222393972.180741, audt=28199292 atc=28199496 tb=39260 sb=39260 eds=4800000 abps=4 sf=1
2242008-09-25 18:52:52.182 SetAudiotime set=1222393972.182826, audt=28199294 atc=28199496 tb=38860 sb=38860 eds=4800000 abps=4 sf=1
2252008-09-25 18:52:52.184 SetAudiotime set=1222393972.184894, audt=28199296 atc=28199496 tb=38460 sb=38460 eds=4800000 abps=4 sf=1
2262008-09-25 18:52:52.186 SetAudiotime set=1222393972.186961, audt=28199298 atc=28199496 tb=38064 sb=38064 eds=4800000 abps=4 sf=1
2272008-09-25 18:52:52.189 SetAudiotime set=1222393972.189026, audt=28199300 atc=28199496 tb=37668 sb=37668 eds=4800000 abps=4 sf=1
2282008-09-25 18:52:52.191 SetAudiotime set=1222393972.191092, audt=28199302 atc=28199496 tb=37272 sb=37272 eds=4800000 abps=4 sf=1
2292008-09-25 18:52:52.192 GetAudiotime now=1222393972.192880, set=1222393972.191092, ret=1, audt=28199302 sf=1
2302008-09-25 18:52:52.193 NVP: A/V Divergence: 0.538992, Rate: -0.259606, Warpfactor: 1.0015, warpfactor_avg: 0.999999
2312008-09-25 18:52:52.193 SetAudiotime set=1222393972.193166, audt=28199304 atc=28199496 tb=36872 sb=36872 eds=4800000 abps=4 sf=1
2322008-09-25 18:52:52.195 SetAudiotime set=1222393972.195255, audt=28199307 atc=28199496 tb=36472 sb=36472 eds=4800000 abps=4 sf=1
2332008-09-25 18:52:52.196 AFD: video timecode 2537982022 2537982022 28199800 28199783
2342008-09-25 18:52:52.197 SetAudiotime set=1222393972.197428, audt=28199309 atc=28199496 tb=36056 sb=36056 eds=4800000 abps=4 sf=1
2352008-09-25 18:52:52.199 SetAudiotime set=1222393972.199512, audt=28199311 atc=28199496 tb=35656 sb=35656 eds=4800000 abps=4 sf=1
2362008-09-25 18:52:52.201 SetAudiotime set=1222393972.201581, audt=28199313 atc=28199496 tb=35256 sb=35256 eds=4800000 abps=4 sf=1
2372008-09-25 18:52:52.203 SetAudiotime set=1222393972.203648, audt=28199315 atc=28199496 tb=34860 sb=34860 eds=4800000 abps=4 sf=1
2382008-09-25 18:52:52.205 SetAudiotime set=1222393972.205713, audt=28199317 atc=28199496 tb=34464 sb=34464 eds=4800000 abps=4 sf=1
2392008-09-25 18:52:52.207 SetAudiotime set=1222393972.207779, audt=28199319 atc=28199496 tb=34068 sb=34068 eds=4800000 abps=4 sf=1
2402008-09-25 18:52:52.209 GetAudiotime now=1222393972.209567, set=1222393972.207779, ret=1, audt=28199319 sf=1
2412008-09-25 18:52:52.209 NVP: A/V Divergence: 0.344303, Rate: -0.194689, Warpfactor: 1.0012, warpfactor_avg: 0.999999
2422008-09-25 18:52:52.209 SetAudiotime set=1222393972.209846, audt=28199321 atc=28199496 tb=33672 sb=33672 eds=4800000 abps=4 sf=1
2432008-09-25 18:52:52.211 SetAudiotime set=1222393972.211947, audt=28199323 atc=28199496 tb=33268 sb=33268 eds=4800000 abps=4 sf=1
2442008-09-25 18:52:52.212 AFD: video timecode 2537983523 2537983523 28199816 28199800
2452008-09-25 18:52:52.214 SetAudiotime set=1222393972.214143, audt=28199325 atc=28199496 tb=32844 sb=32844 eds=4800000 abps=4 sf=1
2462008-09-25 18:52:52.216 SetAudiotime set=1222393972.216229, audt=28199328 atc=28199496 tb=32444 sb=32444 eds=4800000 abps=4 sf=1
2472008-09-25 18:52:52.218 SetAudiotime set=1222393972.218326, audt=28199330 atc=28199496 tb=32044 sb=32044 eds=4800000 abps=4 sf=1
2482008-09-25 18:52:52.220 SetAudiotime set=1222393972.220400, audt=28199332 atc=28199496 tb=31644 sb=31644 eds=4800000 abps=4 sf=1
2492008-09-25 18:52:52.222 SetAudiotime set=1222393972.222470, audt=28199334 atc=28199496 tb=31248 sb=31248 eds=4800000 abps=4 sf=1
2502008-09-25 18:52:52.224 SetAudiotime set=1222393972.224542, audt=28199336 atc=28199496 tb=30848 sb=30848 eds=4800000 abps=4 sf=1
2512008-09-25 18:52:52.226 GetAudiotime now=1222393972.226255, set=1222393972.224542, ret=1, audt=28199336 sf=1
2522008-09-25 18:52:52.226 NVP: A/V Divergence: 0.198286, Rate: -0.146017, Warpfactor: 1.00069, warpfactor_avg: 0.999999
2532008-09-25 18:52:52.226 SetAudiotime set=1222393972.226615, audt=28199338 atc=28199496 tb=30452 sb=30452 eds=4800000 abps=4 sf=1
2542008-09-25 18:52:52.228 SetAudiotime set=1222393972.228716, audt=28199340 atc=28199496 tb=30048 sb=30048 eds=4800000 abps=4 sf=1
2552008-09-25 18:52:52.229 AFD: video timecode 2537989529 2537985025 28199833 28199816
2562008-09-25 18:52:52.230 SetAudiotime set=1222393972.230897, audt=28199342 atc=28199496 tb=29628 sb=29628 eds=4800000 abps=4 sf=1
2572008-09-25 18:52:52.232 SetAudiotime set=1222393972.232989, audt=28199344 atc=28199496 tb=29228 sb=29228 eds=4800000 abps=4 sf=1
2582008-09-25 18:52:52.235 SetAudiotime set=1222393972.235063, audt=28199346 atc=28199496 tb=28828 sb=28828 eds=4800000 abps=4 sf=1
2592008-09-25 18:52:52.237 SetAudiotime set=1222393972.237135, audt=28199348 atc=28199496 tb=28432 sb=28432 eds=4800000 abps=4 sf=1
2602008-09-25 18:52:52.239 SetAudiotime set=1222393972.239209, audt=28199350 atc=28199496 tb=28032 sb=28032 eds=4800000 abps=4 sf=1
2612008-09-25 18:52:52.241 SetAudiotime set=1222393972.241287, audt=28199353 atc=28199496 tb=27632 sb=27632 eds=4800000 abps=4 sf=1
2622008-09-25 18:52:52.242 GetAudiotime now=1222393972.242967, set=1222393972.241287, ret=1, audt=28199353 sf=1
2632008-09-25 18:52:52.243 NVP: A/V Divergence: 0.0737877, Rate: -0.124498, Warpfactor: 1.00019, warpfactor_avg: 0.999999
2642008-09-25 18:52:52.243 SetAudiotime set=1222393972.243360, audt=28199355 atc=28199496 tb=27236 sb=27236 eds=4800000 abps=4 sf=1
2652008-09-25 18:52:52.245 SetAudiotime set=1222393972.245465, audt=28199357 atc=28199496 tb=26832 sb=26832 eds=4800000 abps=4 sf=1
2662008-09-25 18:52:52.246 AFD: video timecode 2537986526 2537986526 28199850 28199833
2672008-09-25 18:52:52.247 SetAudiotime set=1222393972.247649, audt=28199359 atc=28199496 tb=26412 sb=26412 eds=4800000 abps=4 sf=1
2682008-09-25 18:52:52.249 SetAudiotime set=1222393972.249830, audt=28199361 atc=28199496 tb=25992 sb=25992 eds=4800000 abps=4 sf=1
2692008-09-25 18:52:52.251 SetAudiotime set=1222393972.251905, audt=28199363 atc=28199496 tb=25596 sb=25596 eds=4800000 abps=4 sf=1
2702008-09-25 18:52:52.253 SetAudiotime set=1222393972.253973, audt=28199365 atc=28199496 tb=25196 sb=25196 eds=4800000 abps=4 sf=1
2712008-09-25 18:52:52.256 SetAudiotime set=1222393972.256038, audt=28199367 atc=28199496 tb=24800 sb=24800 eds=4800000 abps=4 sf=1
2722008-09-25 18:52:52.258 SetAudiotime set=1222393972.258103, audt=28199369 atc=28199496 tb=24404 sb=24404 eds=4800000 abps=4 sf=1
2732008-09-25 18:52:52.259 GetAudiotime now=1222393972.259549, set=1222393972.258103, ret=1, audt=28199369 sf=1
2742008-09-25 18:52:52.259 NVP: A/V Divergence: -0.00455554, Rate: -0.0783432, Warpfactor: 0.999695, warpfactor_avg: 0.999999
2752008-09-25 18:52:52.260 SetAudiotime set=1222393972.260183, audt=28199371 atc=28199496 tb=24004 sb=24004 eds=4800000 abps=4 sf=1
2762008-09-25 18:52:52.262 SetAudiotime set=1222393972.262316, audt=28199374 atc=28199496 tb=23596 sb=23596 eds=4800000 abps=4 sf=1
2772008-09-25 18:52:52.262 AFD: video timecode 2537988028 2537988028 28199866 28199850
2782008-09-25 18:52:52.264 SetAudiotime set=1222393972.264480, audt=28199376 atc=28199496 tb=23180 sb=23180 eds=4800000 abps=4 sf=1
2792008-09-25 18:52:52.266 SetAudiotime set=1222393972.266555, audt=28199378 atc=28199496 tb=22780 sb=22780 eds=4800000 abps=4 sf=1
2802008-09-25 18:52:52.268 SetAudiotime set=1222393972.268624, audt=28199380 atc=28199496 tb=22384 sb=22384 eds=4800000 abps=4 sf=1
2812008-09-25 18:52:52.270 SetAudiotime set=1222393972.270715, audt=28199382 atc=28199496 tb=21984 sb=21984 eds=4800000 abps=4 sf=1
2822008-09-25 18:52:52.272 SetAudiotime set=1222393972.272780, audt=28199384 atc=28199496 tb=21588 sb=21588 eds=4800000 abps=4 sf=1
2832008-09-25 18:52:52.274 SetAudiotime set=1222393972.274847, audt=28199386 atc=28199496 tb=21188 sb=21188 eds=4800000 abps=4 sf=1
2842008-09-25 18:52:52.276 GetAudiotime now=1222393972.276295, set=1222393972.274847, ret=1, audt=28199386 sf=1
2852008-09-25 18:52:52.276 NVP: A/V Divergence: -0.0633579, Rate: -0.0588024, Warpfactor: 0.999195, warpfactor_avg: 0.999999
2862008-09-25 18:52:52.276 SetAudiotime set=1222393972.276916, audt=28199388 atc=28199496 tb=20792 sb=20792 eds=4800000 abps=4 sf=1
2872008-09-25 18:52:52.279 SetAudiotime set=1222393972.279006, audt=28199390 atc=28199496 tb=20392 sb=20392 eds=4800000 abps=4 sf=1
2882008-09-25 18:52:52.280 AFD: video timecode 2537994034 2537989529 28199883 0
2892008-09-25 18:52:52.281 SetAudiotime set=1222393972.281140, audt=28199392 atc=28199496 tb=19980 sb=19980 eds=4800000 abps=4 sf=1
2902008-09-25 18:52:52.283 SetAudiotime set=1222393972.283221, audt=28199395 atc=28199496 tb=19580 sb=19580 eds=4800000 abps=4 sf=1
2912008-09-25 18:52:52.285 SetAudiotime set=1222393972.285291, audt=28199397 atc=28199496 tb=19184 sb=19184 eds=4800000 abps=4 sf=1
2922008-09-25 18:52:52.287 SetAudiotime set=1222393972.287358, audt=28199399 atc=28199496 tb=18788 sb=18788 eds=4800000 abps=4 sf=1
2932008-09-25 18:52:52.289 SetAudiotime set=1222393972.289424, audt=28199401 atc=28199496 tb=18392 sb=18392 eds=4800000 abps=4 sf=1
2942008-09-25 18:52:52.291 SetAudiotime set=1222393972.291496, audt=28199403 atc=28199496 tb=17992 sb=17992 eds=4800000 abps=4 sf=1
2952008-09-25 18:52:52.292 GetAudiotime now=1222393972.292967, set=1222393972.291496, ret=1, audt=28199403 sf=1
2962008-09-25 18:52:52.293 NVP: A/V Divergence: -0.1224, Rate: -0.0590421, Warpfactor: 0.998695, warpfactor_avg: 0.999999
2972008-09-25 18:52:52.293 SetAudiotime set=1222393972.293577, audt=28199405 atc=28199496 tb=17592 sb=17592 eds=4800000 abps=4 sf=1
2982008-09-25 18:52:52.295 SetAudiotime set=1222393972.295700, audt=28199407 atc=28199496 tb=17184 sb=17184 eds=4800000 abps=4 sf=1
2992008-09-25 18:52:52.296 AFD: video timecode 2537991031 2537991031 28199900 28199883
3002008-09-25 18:52:52.297 SetAudiotime set=1222393972.297879, audt=28199409 atc=28199496 tb=16768 sb=16768 eds=4800000 abps=4 sf=1
3012008-09-25 18:52:52.299 SetAudiotime set=1222393972.299973, audt=28199411 atc=28199496 tb=16364 sb=16364 eds=4800000 abps=4 sf=1
3022008-09-25 18:52:52.302 SetAudiotime set=1222393972.302046, audt=28199413 atc=28199496 tb=15968 sb=15968 eds=4800000 abps=4 sf=1
3032008-09-25 18:52:52.304 SetAudiotime set=1222393972.304120, audt=28199415 atc=28199496 tb=15568 sb=15568 eds=4800000 abps=4 sf=1
3042008-09-25 18:52:52.306 SetAudiotime set=1222393972.306199, audt=28199417 atc=28199496 tb=15168 sb=15168 eds=4800000 abps=4 sf=1
3052008-09-25 18:52:52.308 SetAudiotime set=1222393972.308269, audt=28199420 atc=28199496 tb=14772 sb=14772 eds=4800000 abps=4 sf=1
3062008-09-25 18:52:52.309 GetAudiotime now=1222393972.309644, set=1222393972.308269, ret=1, audt=28199420 sf=1
3072008-09-25 18:52:52.309 NVP: A/V Divergence: -0.166697, Rate: -0.0442966, Warpfactor: 0.998311, warpfactor_avg: 0.999999
3082008-09-25 18:52:52.310 SetAudiotime set=1222393972.310352, audt=28199422 atc=28199496 tb=14372 sb=14372 eds=4800000 abps=4 sf=1
3092008-09-25 18:52:52.312 SetAudiotime set=1222393972.312493, audt=28199424 atc=28199496 tb=13960 sb=13960 eds=4800000 abps=4 sf=1
3102008-09-25 18:52:52.313 AFD: video timecode 2537992532 2537992532 28199917 28199900
3112008-09-25 18:52:52.314 SetAudiotime set=1222393972.314673, audt=28199426 atc=28199496 tb=13544 sb=13544 eds=4800000 abps=4 sf=1
3122008-09-25 18:52:52.316 SetAudiotime set=1222393972.316759, audt=28199428 atc=28199496 tb=13140 sb=13140 eds=4800000 abps=4 sf=1
3132008-09-25 18:52:52.318 SetAudiotime set=1222393972.318833, audt=28199430 atc=28199496 tb=12744 sb=12744 eds=4800000 abps=4 sf=1
3142008-09-25 18:52:52.320 SetAudiotime set=1222393972.320927, audt=28199432 atc=28199496 tb=12340 sb=12340 eds=4800000 abps=4 sf=1
3152008-09-25 18:52:52.323 SetAudiotime set=1222393972.322997, audt=28199434 atc=28199496 tb=11944 sb=11944 eds=4800000 abps=4 sf=1
3162008-09-25 18:52:52.325 SetAudiotime set=1222393972.325069, audt=28199436 atc=28199496 tb=11548 sb=11548 eds=4800000 abps=4 sf=1
3172008-09-25 18:52:52.326 GetAudiotime now=1222393972.326329, set=1222393972.325069, ret=1, audt=28199436 sf=1
3182008-09-25 18:52:52.326 NVP: A/V Divergence: -0.184919, Rate: -0.0182221, Warpfactor: 0.998374, warpfactor_avg: 0.999999
3192008-09-25 18:52:52.327 SetAudiotime set=1222393972.327160, audt=28199438 atc=28199496 tb=11144 sb=11144 eds=4800000 abps=4 sf=1
3202008-09-25 18:52:52.329 SetAudiotime set=1222393972.329289, audt=28199441 atc=28199496 tb=10736 sb=10736 eds=4800000 abps=4 sf=1
3212008-09-25 18:52:52.329 AFD: video timecode 2537998538 2537994034 28199933 28199917
3222008-09-25 18:52:52.331 SetAudiotime set=1222393972.331457, audt=28199443 atc=28199496 tb=10320 sb=10320 eds=4800000 abps=4 sf=1
3232008-09-25 18:52:52.333 SetAudiotime set=1222393972.333536, audt=28199445 atc=28199496 tb=9920 sb=9920 eds=4800000 abps=4 sf=1
3242008-09-25 18:52:52.335 SetAudiotime set=1222393972.335609, audt=28199447 atc=28199496 tb=9524 sb=9524 eds=4800000 abps=4 sf=1
3252008-09-25 18:52:52.337 SetAudiotime set=1222393972.337680, audt=28199449 atc=28199496 tb=9124 sb=9124 eds=4800000 abps=4 sf=1
3262008-09-25 18:52:52.339 SetAudiotime set=1222393972.339750, audt=28199451 atc=28199496 tb=8728 sb=8728 eds=4800000 abps=4 sf=1
3272008-09-25 18:52:52.341 SetAudiotime set=1222393972.341820, audt=28199453 atc=28199496 tb=8328 sb=8328 eds=4800000 abps=4 sf=1
3282008-09-25 18:52:52.342 GetAudiotime now=1222393972.342563, set=1222393972.341820, ret=0, audt=28199453 sf=1
3292008-09-25 18:52:52.342 NVP: A/V Divergence: -0.198585, Rate: -0.0136666, Warpfactor: 0.998301, warpfactor_avg: 0.999999
3302008-09-25 18:52:52.343 SetAudiotime set=1222393972.343922, audt=28199455 atc=28199496 tb=7928 sb=7928 eds=4800000 abps=4 sf=1
3312008-09-25 18:52:52.345 AFD: video timecode 2537995535 2537995535 28199950 28199933
3322008-09-25 18:52:52.346 SetAudiotime set=1222393972.346107, audt=28199457 atc=28199496 tb=7508 sb=7508 eds=4800000 abps=4 sf=1
3332008-09-25 18:52:52.348 SetAudiotime set=1222393972.348208, audt=28199459 atc=28199496 tb=7104 sb=7104 eds=4800000 abps=4 sf=1
3342008-09-25 18:52:52.350 SetAudiotime set=1222393972.350285, audt=28199462 atc=28199496 tb=6704 sb=6704 eds=4800000 abps=4 sf=1
3352008-09-25 18:52:52.352 SetAudiotime set=1222393972.352374, audt=28199464 atc=28199496 tb=6304 sb=6304 eds=4800000 abps=4 sf=1
3362008-09-25 18:52:52.354 SetAudiotime set=1222393972.354446, audt=28199466 atc=28199496 tb=5904 sb=5904 eds=4800000 abps=4 sf=1
3372008-09-25 18:52:52.356 SetAudiotime set=1222393972.356515, audt=28199468 atc=28199496 tb=5508 sb=5508 eds=4800000 abps=4 sf=1
3382008-09-25 18:52:52.358 SetAudiotime set=1222393972.358587, audt=28199470 atc=28199496 tb=5112 sb=5112 eds=4800000 abps=4 sf=1
3392008-09-25 18:52:52.359 GetAudiotime now=1222393972.359207, set=1222393972.358587, ret=0, audt=28199470 sf=1
3402008-09-25 18:52:52.359 NVP: A/V Divergence: -0.208835, Rate: -0.01025, Warpfactor: 0.998246, warpfactor_avg: 0.999999
3412008-09-25 18:52:52.360 SetAudiotime set=1222393972.360688, audt=28199472 atc=28199496 tb=4708 sb=4708 eds=4800000 abps=4 sf=1
3422008-09-25 18:52:52.362 AFD: video timecode 2537997037 2537997037 28199967 28199950
3432008-09-25 18:52:52.362 SetAudiotime set=1222393972.362872, audt=28199474 atc=28199496 tb=4288 sb=4288 eds=4800000 abps=4 sf=1
3442008-09-25 18:52:52.364 SetAudiotime set=1222393972.364965, audt=28199476 atc=28199496 tb=3884 sb=3884 eds=4800000 abps=4 sf=1
3452008-09-25 18:52:52.367 SetAudiotime set=1222393972.367039, audt=28199478 atc=28199496 tb=3488 sb=3488 eds=4800000 abps=4 sf=1
3462008-09-25 18:52:52.369 SetAudiotime set=1222393972.369111, audt=28199480 atc=28199496 tb=3088 sb=3088 eds=4800000 abps=4 sf=1
3472008-09-25 18:52:52.371 SetAudiotime set=1222393972.371194, audt=28199482 atc=28199496 tb=2688 sb=2688 eds=4800000 abps=4 sf=1
3482008-09-25 18:52:52.373 SetAudiotime set=1222393972.373286, audt=28199485 atc=28199496 tb=2288 sb=2288 eds=4800000 abps=4 sf=1
3492008-09-25 18:52:52.375 SetAudiotime set=1222393972.375357, audt=28199487 atc=28199496 tb=1892 sb=1892 eds=4800000 abps=4 sf=1
3502008-09-25 18:52:52.375 GetAudiotime now=1222393972.375912, set=1222393972.375357, ret=0, audt=28199487 sf=1
3512008-09-25 18:52:52.376 NVP: A/V Divergence: -0.216568, Rate: -0.00773242, Warpfactor: 0.998204, warpfactor_avg: 0.999998
3522008-09-25 18:52:52.377 SetAudiotime set=1222393972.377451, audt=28199489 atc=28199496 tb=1488 sb=1488 eds=4800000 abps=4 sf=1
3532008-09-25 18:52:52.379 AFD: video timecode 2538003043 2537998538 28199983 28199967
3542008-09-25 18:52:52.379 SetAudiotime set=1222393972.379625, audt=28199491 atc=28199496 tb=1072 sb=1072 eds=4800000 abps=4 sf=1
3552008-09-25 18:52:52.381 SetAudiotime set=1222393972.381718, audt=28199493 atc=28199496 tb=668 sb=668 eds=4800000 abps=4 sf=1
3562008-09-25 18:52:52.383 SetAudiotime set=1222393972.383792, audt=28199495 atc=28199496 tb=272 sb=272 eds=4800000 abps=4 sf=1
3572008-09-25 18:52:52.385 SetAudiotime set=1222393972.385888, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3582008-09-25 18:52:52.387 SetAudiotime set=1222393972.387954, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3592008-09-25 18:52:52.390 SetAudiotime set=1222393972.390021, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3602008-09-25 18:52:52.392 SetAudiotime set=1222393972.392088, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3612008-09-25 18:52:52.392 GetAudiotime now=1222393972.392633, set=1222393972.392088, ret=0, audt=28199496 sf=1
3622008-09-25 18:52:52.392 NVP: A/V Divergence: -0.117425, Rate: 0.0991428, Warpfactor: 0.998703, warpfactor_avg: 0.999998
3632008-09-25 18:52:52.394 SetAudiotime set=1222393972.394177, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3642008-09-25 18:52:52.395 AFD: video timecode 2538000040 2538000040 28200000 28199983
3652008-09-25 18:52:52.396 SetAudiotime set=1222393972.396363, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3662008-09-25 18:52:52.398 SetAudiotime set=1222393972.398451, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3672008-09-25 18:52:52.400 SetAudiotime set=1222393972.400522, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3682008-09-25 18:52:52.402 SetAudiotime set=1222393972.402591, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3692008-09-25 18:52:52.404 SetAudiotime set=1222393972.404660, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3702008-09-25 18:52:52.406 SetAudiotime set=1222393972.406728, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3712008-09-25 18:52:52.408 SetAudiotime set=1222393972.408796, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3722008-09-25 18:52:52.409 GetAudiotime now=1222393972.409724, set=1222393972.408796, ret=0, audt=28199496 sf=1
3732008-09-25 18:52:52.409 NVP: A/V Divergence: 0.211593, Rate: 0.329018, Warpfactor: 0.999202, warpfactor_avg: 0.999998
3742008-09-25 18:52:52.410 SetAudiotime set=1222393972.410885, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3752008-09-25 18:52:52.412 AFD: video timecode 2538001541 2538001541 28200017 28200000
3762008-09-25 18:52:52.413 SetAudiotime set=1222393972.413067, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3772008-09-25 18:52:52.415 SetAudiotime set=1222393972.415166, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3782008-09-25 18:52:52.417 SetAudiotime set=1222393972.417238, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3792008-09-25 18:52:52.419 SetAudiotime set=1222393972.419309, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3802008-09-25 18:52:52.421 SetAudiotime set=1222393972.421379, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3812008-09-25 18:52:52.423 SetAudiotime set=1222393972.423446, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3822008-09-25 18:52:52.425 SetAudiotime set=1222393972.425514, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3832008-09-25 18:52:52.425 GetAudiotime now=1222393972.425961, set=1222393972.425514, ret=0, audt=28199496 sf=1
3842008-09-25 18:52:52.426 NVP: A/V Divergence: 0.713121, Rate: 0.501529, Warpfactor: 0.999702, warpfactor_avg: 0.999998
3852008-09-25 18:52:52.427 SetAudiotime set=1222393972.427622, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3862008-09-25 18:52:52.429 AFD: video timecode 2538007547 2538003043 28200033 28200017
3872008-09-25 18:52:52.429 SetAudiotime set=1222393972.429796, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3882008-09-25 18:52:52.431 SetAudiotime set=1222393972.431886, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3892008-09-25 18:52:52.433 SetAudiotime set=1222393972.433956, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3902008-09-25 18:52:52.436 SetAudiotime set=1222393972.436025, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3912008-09-25 18:52:52.438 SetAudiotime set=1222393972.438095, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3922008-09-25 18:52:52.440 SetAudiotime set=1222393972.440176, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3932008-09-25 18:52:52.442 SetAudiotime set=1222393972.442246, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3942008-09-25 18:52:52.443 GetAudiotime now=1222393972.443094, set=1222393972.442246, ret=0, audt=28199496 sf=1
3952008-09-25 18:52:52.443 NVP: A/V Divergence: 1.32902, Rate: 0.615896, Warpfactor: 1.0002, warpfactor_avg: 0.999998
3962008-09-25 18:52:52.444 SetAudiotime set=1222393972.444328, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3972008-09-25 18:52:52.446 AFD: video timecode 2538004544 2538004544 28200050 28200033
3982008-09-25 18:52:52.446 SetAudiotime set=1222393972.446516, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
3992008-09-25 18:52:52.448 SetAudiotime set=1222393972.448605, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4002008-09-25 18:52:52.450 SetAudiotime set=1222393972.450679, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4012008-09-25 18:52:52.452 SetAudiotime set=1222393972.452765, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4022008-09-25 18:52:52.454 SetAudiotime set=1222393972.454835, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4032008-09-25 18:52:52.456 SetAudiotime set=1222393972.456903, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4042008-09-25 18:52:52.458 SetAudiotime set=1222393972.458972, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4052008-09-25 18:52:52.459 GetAudiotime now=1222393972.459343, set=1222393972.458972, ret=0, audt=28199496 sf=1
4062008-09-25 18:52:52.459 NVP: A/V Divergence: 2.04574, Rate: 0.716718, Warpfactor: 1.0007, warpfactor_avg: 0.999998
4072008-09-25 18:52:52.461 SetAudiotime set=1222393972.461058, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4082008-09-25 18:52:52.462 AFD: video timecode 2538006046 2538006046 28200067 28200050
4092008-09-25 18:52:52.463 SetAudiotime set=1222393972.463258, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4102008-09-25 18:52:52.465 SetAudiotime set=1222393972.465347, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4112008-09-25 18:52:52.467 SetAudiotime set=1222393972.467418, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4122008-09-25 18:52:52.469 SetAudiotime set=1222393972.469488, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4132008-09-25 18:52:52.471 SetAudiotime set=1222393972.471557, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4142008-09-25 18:52:52.473 SetAudiotime set=1222393972.473626, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4152008-09-25 18:52:52.475 SetAudiotime set=1222393972.475695, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4162008-09-25 18:52:52.477 SetAudiotime set=1222393972.477765, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4172008-09-25 18:52:52.479 SetAudiotime set=1222393972.479833, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4182008-09-25 18:52:52.481 SetAudiotime set=1222393972.481926, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4192008-09-25 18:52:52.483 SetAudiotime set=1222393972.483995, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4202008-09-25 18:52:52.486 SetAudiotime set=1222393972.486065, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4212008-09-25 18:52:52.488 SetAudiotime set=1222393972.488133, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4222008-09-25 18:52:52.490 SetAudiotime set=1222393972.490200, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4232008-09-25 18:52:52.492 SetAudiotime set=1222393972.492265, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4242008-09-25 18:52:52.493 GetAudiotime now=1222393972.493138, set=1222393972.492265, ret=0, audt=28199496 sf=1
4252008-09-25 18:52:52.493 NVP: A/V Divergence: 2.83798, Rate: 0.792244, Warpfactor: 1.0012, warpfactor_avg: 0.999998
4262008-09-25 18:52:52.494 SetAudiotime set=1222393972.494342, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4272008-09-25 18:52:52.496 SetAudiotime set=1222393972.496497, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4282008-09-25 18:52:52.496 AFD: video timecode 2538012052 2538007547 28200083 28200067
4292008-09-25 18:52:52.498 SetAudiotime set=1222393972.498649, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4302008-09-25 18:52:52.500 SetAudiotime set=1222393972.500716, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4312008-09-25 18:52:52.502 SetAudiotime set=1222393972.502783, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4322008-09-25 18:52:52.504 SetAudiotime set=1222393972.504847, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4332008-09-25 18:52:52.506 SetAudiotime set=1222393972.506910, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4342008-09-25 18:52:52.508 SetAudiotime set=1222393972.508970, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4352008-09-25 18:52:52.509 GetAudiotime now=1222393972.509372, set=1222393972.508970, ret=0, audt=28199496 sf=1
4362008-09-25 18:52:52.509 NVP: A/V Divergence: 3.68693, Rate: 0.848948, Warpfactor: 1.0017, warpfactor_avg: 0.999999
4372008-09-25 18:52:52.511 SetAudiotime set=1222393972.511045, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4382008-09-25 18:52:52.512 AFD: video timecode 2538009049 2538009049 28200100 28200083
4392008-09-25 18:52:52.513 SetAudiotime set=1222393972.513233, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4402008-09-25 18:52:52.515 SetAudiotime set=1222393972.515318, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4412008-09-25 18:52:52.517 SetAudiotime set=1222393972.517383, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4422008-09-25 18:52:52.519 SetAudiotime set=1222393972.519448, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4432008-09-25 18:52:52.521 SetAudiotime set=1222393972.521514, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4442008-09-25 18:52:52.523 SetAudiotime set=1222393972.523581, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4452008-09-25 18:52:52.525 SetAudiotime set=1222393972.525647, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4462008-09-25 18:52:52.527 SetAudiotime set=1222393972.527716, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4472008-09-25 18:52:52.529 SetAudiotime set=1222393972.529781, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4482008-09-25 18:52:52.531 SetAudiotime set=1222393972.531847, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4492008-09-25 18:52:52.533 SetAudiotime set=1222393972.533911, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4502008-09-25 18:52:52.535 SetAudiotime set=1222393972.535976, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4512008-09-25 18:52:52.538 SetAudiotime set=1222393972.538041, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4522008-09-25 18:52:52.540 SetAudiotime set=1222393972.540108, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4532008-09-25 18:52:52.542 SetAudiotime set=1222393972.542215, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4542008-09-25 18:52:52.542 NVP: Video is 3.68693 frames ahead of audio,
455                        doubling video frame interval to slow down.
4562008-09-25 18:52:52.542 GetAudiotime now=1222393972.542862, set=1222393972.542215, ret=0, audt=28199496 sf=1
4572008-09-25 18:52:52.542 NVP: A/V Divergence: 4.56339, Rate: 0.876461, Warpfactor: 1.0022, warpfactor_avg: 0.999999
4582008-09-25 18:52:52.545 SetAudiotime set=1222393972.545301, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4592008-09-25 18:52:52.546 AFD: video timecode 2538010550 2538010550 28200117 28200100
4602008-09-25 18:52:52.547 SetAudiotime set=1222393972.547471, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4612008-09-25 18:52:52.549 SetAudiotime set=1222393972.549553, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4622008-09-25 18:52:52.551 SetAudiotime set=1222393972.551620, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4632008-09-25 18:52:52.553 SetAudiotime set=1222393972.553689, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4642008-09-25 18:52:52.555 SetAudiotime set=1222393972.555755, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4652008-09-25 18:52:52.557 SetAudiotime set=1222393972.557819, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4662008-09-25 18:52:52.559 SetAudiotime set=1222393972.559884, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4672008-09-25 18:52:52.561 SetAudiotime set=1222393972.561948, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4682008-09-25 18:52:52.564 SetAudiotime set=1222393972.564012, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4692008-09-25 18:52:52.566 SetAudiotime set=1222393972.566076, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4702008-09-25 18:52:52.568 SetAudiotime set=1222393972.568152, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4712008-09-25 18:52:52.570 SetAudiotime set=1222393972.570218, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4722008-09-25 18:52:52.572 SetAudiotime set=1222393972.572282, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4732008-09-25 18:52:52.574 SetAudiotime set=1222393972.574344, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4742008-09-25 18:52:52.576 NVP: Video is 4.56339 frames ahead of audio,
475                        doubling video frame interval to slow down.
4762008-09-25 18:52:52.576 GetAudiotime now=1222393972.576180, set=1222393972.574344, ret=1, audt=28199496 sf=1
4772008-09-25 18:52:52.576 NVP: A/V Divergence: 5.46053, Rate: 0.897141, Warpfactor: 1.0027, warpfactor_avg: 0.999999
4782008-09-25 18:52:52.576 SetAudiotime set=1222393972.576411, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4792008-09-25 18:52:52.579 AFD: video timecode 2538016556 2538012052 28200133 28200117
4802008-09-25 18:52:52.579 SetAudiotime set=1222393972.579353, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4812008-09-25 18:52:52.581 SetAudiotime set=1222393972.581611, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4822008-09-25 18:52:52.583 SetAudiotime set=1222393972.583676, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4832008-09-25 18:52:52.585 SetAudiotime set=1222393972.585741, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4842008-09-25 18:52:52.587 SetAudiotime set=1222393972.587806, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4852008-09-25 18:52:52.589 SetAudiotime set=1222393972.589870, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4862008-09-25 18:52:52.591 SetAudiotime set=1222393972.591959, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4872008-09-25 18:52:52.594 SetAudiotime set=1222393972.594023, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4882008-09-25 18:52:52.596 SetAudiotime set=1222393972.596088, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4892008-09-25 18:52:52.598 SetAudiotime set=1222393972.598163, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4902008-09-25 18:52:52.600 SetAudiotime set=1222393972.600250, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4912008-09-25 18:52:52.602 SetAudiotime set=1222393972.602314, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4922008-09-25 18:52:52.604 SetAudiotime set=1222393972.604377, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4932008-09-25 18:52:52.606 SetAudiotime set=1222393972.606440, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4942008-09-25 18:52:52.608 SetAudiotime set=1222393972.608502, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
4952008-09-25 18:52:52.609 NVP: Video is 5.46053 frames ahead of audio,
496                        doubling video frame interval to slow down.
4972008-09-25 18:52:52.609 GetAudiotime now=1222393972.609565, set=1222393972.608502, ret=1, audt=28199496 sf=1
4982008-09-25 18:52:52.609 NVP: A/V Divergence: 6.38812, Rate: 0.927591, Warpfactor: 1.00321, warpfactor_avg: 0.999999
4992008-09-25 18:52:52.612 SetAudiotime set=1222393972.612254, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5002008-09-25 18:52:52.612 AFD: video timecode 2538013553 2538013553 28200150 28200133
5012008-09-25 18:52:52.614 SetAudiotime set=1222393972.614418, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5022008-09-25 18:52:52.616 SetAudiotime set=1222393972.616486, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5032008-09-25 18:52:52.618 SetAudiotime set=1222393972.618550, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5042008-09-25 18:52:52.620 SetAudiotime set=1222393972.620614, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5052008-09-25 18:52:52.622 SetAudiotime set=1222393972.622675, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5062008-09-25 18:52:52.624 SetAudiotime set=1222393972.624746, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5072008-09-25 18:52:52.626 SetAudiotime set=1222393972.626866, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5082008-09-25 18:52:52.628 SetAudiotime set=1222393972.628931, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5092008-09-25 18:52:52.630 SetAudiotime set=1222393972.630996, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5102008-09-25 18:52:52.633 SetAudiotime set=1222393972.633060, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5112008-09-25 18:52:52.635 SetAudiotime set=1222393972.635125, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5122008-09-25 18:52:52.637 SetAudiotime set=1222393972.637200, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5132008-09-25 18:52:52.639 SetAudiotime set=1222393972.639266, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5142008-09-25 18:52:52.641 SetAudiotime set=1222393972.641332, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5152008-09-25 18:52:52.642 NVP: Video is 6.38812 frames ahead of audio,
516                        doubling video frame interval to slow down.
5172008-09-25 18:52:52.642 GetAudiotime now=1222393972.642901, set=1222393972.641332, ret=1, audt=28199496 sf=1
5182008-09-25 18:52:52.642 NVP: A/V Divergence: 7.32356, Rate: 0.935443, Warpfactor: 1.00371, warpfactor_avg: 0.999999
5192008-09-25 18:52:52.645 SetAudiotime set=1222393972.645566, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5202008-09-25 18:52:52.645 AFD: video timecode 2538015055 2538015055 28200167 28200150
5212008-09-25 18:52:52.647 SetAudiotime set=1222393972.647852, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5222008-09-25 18:52:52.649 SetAudiotime set=1222393972.649920, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5232008-09-25 18:52:52.651 SetAudiotime set=1222393972.651987, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5242008-09-25 18:52:52.654 SetAudiotime set=1222393972.654057, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5252008-09-25 18:52:52.656 SetAudiotime set=1222393972.656121, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5262008-09-25 18:52:52.658 SetAudiotime set=1222393972.658209, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5272008-09-25 18:52:52.660 SetAudiotime set=1222393972.660294, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5282008-09-25 18:52:52.662 SetAudiotime set=1222393972.662359, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5292008-09-25 18:52:52.664 SetAudiotime set=1222393972.664423, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5302008-09-25 18:52:52.666 SetAudiotime set=1222393972.666486, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5312008-09-25 18:52:52.668 SetAudiotime set=1222393972.668550, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5322008-09-25 18:52:52.670 SetAudiotime set=1222393972.670616, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5332008-09-25 18:52:52.672 SetAudiotime set=1222393972.672679, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5342008-09-25 18:52:52.674 SetAudiotime set=1222393972.674740, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5352008-09-25 18:52:52.676 NVP: Video is 7.32356 frames ahead of audio,
536                        doubling video frame interval to slow down.
5372008-09-25 18:52:52.676 GetAudiotime now=1222393972.676265, set=1222393972.674740, ret=1, audt=28199496 sf=1
5382008-09-25 18:52:52.676 NVP: A/V Divergence: 8.27993, Rate: 0.956363, Warpfactor: 1.00421, warpfactor_avg: 0.999999
5392008-09-25 18:52:52.679 SetAudiotime set=1222393972.679344, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5402008-09-25 18:52:52.679 AFD: video timecode 2538021061 2538016556 28200183 28200167
5412008-09-25 18:52:52.681 SetAudiotime set=1222393972.681509, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5422008-09-25 18:52:52.683 SetAudiotime set=1222393972.683577, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5432008-09-25 18:52:52.685 SetAudiotime set=1222393972.685643, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5442008-09-25 18:52:52.687 SetAudiotime set=1222393972.687707, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5452008-09-25 18:52:52.689 SetAudiotime set=1222393972.689773, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5462008-09-25 18:52:52.691 SetAudiotime set=1222393972.691837, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5472008-09-25 18:52:52.693 SetAudiotime set=1222393972.693903, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5482008-09-25 18:52:52.695 SetAudiotime set=1222393972.695968, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5492008-09-25 18:52:52.698 SetAudiotime set=1222393972.698032, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5502008-09-25 18:52:52.700 SetAudiotime set=1222393972.700096, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5512008-09-25 18:52:52.702 SetAudiotime set=1222393972.702170, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5522008-09-25 18:52:52.704 SetAudiotime set=1222393972.704235, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5532008-09-25 18:52:52.706 SetAudiotime set=1222393972.706300, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5542008-09-25 18:52:52.708 SetAudiotime set=1222393972.708360, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5552008-09-25 18:52:52.709 NVP: Video is 8.27993 frames ahead of audio,
556                        doubling video frame interval to slow down.
5572008-09-25 18:52:52.709 GetAudiotime now=1222393972.709669, set=1222393972.708360, ret=1, audt=28199496 sf=1
5582008-09-25 18:52:52.709 NVP: A/V Divergence: 9.25193, Rate: 0.972007, Warpfactor: 1.00471, warpfactor_avg: 0.999999
5592008-09-25 18:52:52.712 AFD: video timecode 2538018058 2538018058 28200200 28200183
5602008-09-25 18:52:52.712 SetAudiotime set=1222393972.712620, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5612008-09-25 18:52:52.714 SetAudiotime set=1222393972.714874, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5622008-09-25 18:52:52.716 SetAudiotime set=1222393972.716940, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5632008-09-25 18:52:52.719 SetAudiotime set=1222393972.719031, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5642008-09-25 18:52:52.721 SetAudiotime set=1222393972.721094, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5652008-09-25 18:52:52.723 SetAudiotime set=1222393972.723171, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5662008-09-25 18:52:52.725 SetAudiotime set=1222393972.725236, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5672008-09-25 18:52:52.727 SetAudiotime set=1222393972.727304, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5682008-09-25 18:52:52.729 SetAudiotime set=1222393972.729368, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5692008-09-25 18:52:52.731 SetAudiotime set=1222393972.731433, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5702008-09-25 18:52:52.733 SetAudiotime set=1222393972.733496, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5712008-09-25 18:52:52.735 SetAudiotime set=1222393972.735561, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5722008-09-25 18:52:52.737 SetAudiotime set=1222393972.737626, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5732008-09-25 18:52:52.739 SetAudiotime set=1222393972.739690, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5742008-09-25 18:52:52.741 SetAudiotime set=1222393972.741752, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5752008-09-25 18:52:52.742 NVP: Video is 9.25193 frames ahead of audio,
576                        doubling video frame interval to slow down.
5772008-09-25 18:52:52.743 GetAudiotime now=1222393972.743061, set=1222393972.741752, ret=1, audt=28199496 sf=1
5782008-09-25 18:52:52.743 NVP: A/V Divergence: 10.2207, Rate: 0.968771, Warpfactor: 1.00521, warpfactor_avg: 0.999999
5792008-09-25 18:52:52.746 AFD: video timecode 2538019559 2538019559 28200217 28200200
5802008-09-25 18:52:52.746 SetAudiotime set=1222393972.746236, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5812008-09-25 18:52:52.748 SetAudiotime set=1222393972.748518, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5822008-09-25 18:52:52.750 SetAudiotime set=1222393972.750725, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5832008-09-25 18:52:52.752 SetAudiotime set=1222393972.752796, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5842008-09-25 18:52:52.754 SetAudiotime set=1222393972.754861, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5852008-09-25 18:52:52.756 SetAudiotime set=1222393972.756925, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5862008-09-25 18:52:52.758 SetAudiotime set=1222393972.758990, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5872008-09-25 18:52:52.761 SetAudiotime set=1222393972.761054, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5882008-09-25 18:52:52.763 SetAudiotime set=1222393972.763117, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5892008-09-25 18:52:52.765 SetAudiotime set=1222393972.765193, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5902008-09-25 18:52:52.767 SetAudiotime set=1222393972.767258, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5912008-09-25 18:52:52.769 SetAudiotime set=1222393972.769323, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5922008-09-25 18:52:52.771 SetAudiotime set=1222393972.771386, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5932008-09-25 18:52:52.773 SetAudiotime set=1222393972.773448, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5942008-09-25 18:52:52.775 SetAudiotime set=1222393972.775509, audt=28199496 atc=28199496 tb=0 sb=0 eds=4800000 abps=4 sf=1
5952008-09-25 18:52:52.776 NVP: Video is 10.2207 frames ahead of audio,
596                        doubling video frame interval to slow down.
5972008-09-25 18:52:52.776 GetAudiotime now=1222393972.776367, set=1222393972.775509, ret=0, audt=28199496 sf=1
5982008-09-25 18:52:52.776 NVP: A/V Divergence: 11.217, Rate: 0.996344, Warpfactor: 1.00572, warpfactor_avg: 0.999999
5992008-09-25 18:52:52.776 AFD: audio timecode 2537954657 2537954657 28199496 28199528
6002008-09-25 18:52:52.776 GetAudiotime now=1222393972.776826, set=1222393972.775509, ret=1, audt=28199496 sf=1
6012008-09-25 18:52:52.776 AO: _AddSamples samples=1536 bytes=6144, used=1, free=1535999, timecode=28199496 needsupmix 0
6022008-09-25 18:52:52.779 SetAudiotime set=1222393972.779920, audt=28199496 atc=28199528 tb=6144 sb=0 eds=4800000 abps=4 sf=1
6032008-09-25 18:52:52.780 AFD: video timecode 2538025565 2538021061 28200234 28200217
6042008-09-25 18:52:52.780 AFD: audio timecode 2537957537 2537957537 28199528 28199560
6052008-09-25 18:52:52.780 GetAudiotime now=1222393972.780639, set=1222393972.779920, ret=0, audt=28199496 sf=1
6062008-09-25 18:52:52.780 AO: _AddSamples samples=1536 bytes=6144, used=6145, free=1529855, timecode=28199528 needsupmix 0
6072008-09-25 18:52:52.781 AFD: audio timecode 2537960417 2537960417 28199560 28199592
6082008-09-25 18:52:52.781 GetAudiotime now=1222393972.781388, set=1222393972.779920, ret=1, audt=28199496 sf=1
6092008-09-25 18:52:52.781 AO: _AddSamples samples=1536 bytes=6144, used=12289, free=1523711, timecode=28199560 needsupmix 0
6102008-09-25 18:52:52.781 AFD: audio timecode 2537963297 2537963297 28199592 28199624
6112008-09-25 18:52:52.781 GetAudiotime now=1222393972.781827, set=1222393972.779920, ret=1, audt=28199496 sf=1
6122008-09-25 18:52:52.781 AO: _AddSamples samples=1536 bytes=6144, used=18433, free=1517567, timecode=28199592 needsupmix 0
6132008-09-25 18:52:52.782 AFD: audio timecode 2537966177 2537966177 28199624 28199656
6142008-09-25 18:52:52.782 GetAudiotime now=1222393972.782485, set=1222393972.779920, ret=2, audt=28199496 sf=1
6152008-09-25 18:52:52.782 AO: _AddSamples samples=1536 bytes=6144, used=24577, free=1511423, timecode=28199624 needsupmix 0
6162008-09-25 18:52:52.783 AFD: audio timecode 2537969057 2537969057 28199656 28199688
6172008-09-25 18:52:52.783 GetAudiotime now=1222393972.783093, set=1222393972.779920, ret=3, audt=28199496 sf=1
6182008-09-25 18:52:52.783 AO: _AddSamples samples=1536 bytes=6144, used=30721, free=1505279, timecode=28199656 needsupmix 0
6192008-09-25 18:52:52.783 AFD: audio timecode 2537971937 2537971937 28199688 28199720
6202008-09-25 18:52:52.783 GetAudiotime now=1222393972.783538, set=1222393972.779920, ret=3, audt=28199496 sf=1
6212008-09-25 18:52:52.783 AO: _AddSamples samples=1536 bytes=6144, used=36865, free=1499135, timecode=28199688 needsupmix 0
6222008-09-25 18:52:52.784 AFD: audio timecode 2537974817 2537974817 28199720 28199752
6232008-09-25 18:52:52.784 GetAudiotime now=1222393972.784170, set=1222393972.779920, ret=4, audt=28199496 sf=1
6242008-09-25 18:52:52.784 AO: _AddSamples samples=1536 bytes=6144, used=43009, free=1492991, timecode=28199720 needsupmix 0
6252008-09-25 18:52:52.784 AFD: audio timecode 2537977697 2537977697 28199752 28199784
6262008-09-25 18:52:52.784 GetAudiotime now=1222393972.784663, set=1222393972.779920, ret=4, audt=28199496 sf=1
6272008-09-25 18:52:52.784 AO: _AddSamples samples=1536 bytes=6144, used=49153, free=1486847, timecode=28199752 needsupmix 0
6282008-09-25 18:52:52.785 AFD: audio timecode 2537980577 2537980577 28199784 28199816
6292008-09-25 18:52:52.785 GetAudiotime now=1222393972.785236, set=1222393972.779920, ret=5, audt=28199496 sf=1
6302008-09-25 18:52:52.785 AO: _AddSamples samples=1536 bytes=6144, used=55297, free=1480703, timecode=28199784 needsupmix 0
6312008-09-25 18:52:52.785 AFD: audio timecode 2537983457 2537983457 28199816 28199848
6322008-09-25 18:52:52.785 GetAudiotime now=1222393972.785821, set=1222393972.779920, ret=5, audt=28199496 sf=1
6332008-09-25 18:52:52.785 AO: _AddSamples samples=1536 bytes=6144, used=61441, free=1474559, timecode=28199816 needsupmix 0
6342008-09-25 18:52:52.786 AFD: audio timecode 2537986337 2537986337 28199848 28199880
6352008-09-25 18:52:52.786 GetAudiotime now=1222393972.786422, set=1222393972.779920, ret=6, audt=28199496 sf=1
6362008-09-25 18:52:52.786 AO: _AddSamples samples=1536 bytes=6144, used=67585, free=1468415, timecode=28199848 needsupmix 0
6372008-09-25 18:52:52.786 AFD: audio timecode 2537989217 2537989217 28199880 28199912
6382008-09-25 18:52:52.786 GetAudiotime now=1222393972.786970, set=1222393972.779920, ret=7, audt=28199496 sf=1
6392008-09-25 18:52:52.787 AO: _AddSamples samples=1536 bytes=6144, used=73729, free=1462271, timecode=28199880 needsupmix 0
6402008-09-25 18:52:52.787 AFD: audio timecode 2537992097 2537992097 28199912 28199944
6412008-09-25 18:52:52.787 GetAudiotime now=1222393972.787521, set=1222393972.779920, ret=7, audt=28199496 sf=1
6422008-09-25 18:52:52.787 AO: _AddSamples samples=1536 bytes=6144, used=79873, free=1456127, timecode=28199912 needsupmix 0
6432008-09-25 18:52:52.788 AFD: audio timecode 2537994977 2537994977 28199944 28199976
6442008-09-25 18:52:52.788 GetAudiotime now=1222393972.788318, set=1222393972.779920, ret=8, audt=28199496 sf=1
6452008-09-25 18:52:52.788 AO: _AddSamples samples=1536 bytes=6144, used=86017, free=1449983, timecode=28199944 needsupmix 0
6462008-09-25 18:52:52.788 AFD: audio timecode 2537997857 2537997857 28199976 28200008
6472008-09-25 18:52:52.788 GetAudiotime now=1222393972.788802, set=1222393972.779920, ret=8, audt=28199496 sf=1
6482008-09-25 18:52:52.788 AO: _AddSamples samples=1536 bytes=6144, used=92161, free=1443839, timecode=28199976 needsupmix 0
6492008-09-25 18:52:52.789 AFD: audio timecode 2538000737 2538000737 28200008 28200040
6502008-09-25 18:52:52.789 GetAudiotime now=1222393972.789421, set=1222393972.779920, ret=9, audt=28199496 sf=1
6512008-09-25 18:52:52.789 AO: _AddSamples samples=1536 bytes=6144, used=98305, free=1437695, timecode=28200008 needsupmix 0
6522008-09-25 18:52:52.790 AFD: audio timecode 2538003617 2538003617 28200040 28200072
6532008-09-25 18:52:52.790 GetAudiotime now=1222393972.790101, set=1222393972.779920, ret=10, audt=28199496 sf=1
6542008-09-25 18:52:52.790 AO: _AddSamples samples=1536 bytes=6144, used=104449, free=1431551, timecode=28200040 needsupmix 0
6552008-09-25 18:52:52.790 AFD: audio timecode 2538006497 2538006497 28200072 28200104
6562008-09-25 18:52:52.790 GetAudiotime now=1222393972.790995, set=1222393972.779920, ret=11, audt=28199496 sf=1
6572008-09-25 18:52:52.791 AO: _AddSamples samples=1536 bytes=6144, used=110593, free=1425407, timecode=28200072 needsupmix 0
6582008-09-25 18:52:52.791 AFD: audio timecode 2538009377 2538009377 28200104 28200136
6592008-09-25 18:52:52.791 GetAudiotime now=1222393972.791807, set=1222393972.779920, ret=11, audt=28199496 sf=1
6602008-09-25 18:52:52.791 AO: _AddSamples samples=1536 bytes=6144, used=116737, free=1419263, timecode=28200104 needsupmix 0
6612008-09-25 18:52:52.792 AFD: audio timecode 2538012257 2538012257 28200136 28200168
6622008-09-25 18:52:52.792 GetAudiotime now=1222393972.792339, set=1222393972.779920, ret=12, audt=28199496 sf=1
6632008-09-25 18:52:52.792 AO: _AddSamples samples=1536 bytes=6144, used=122881, free=1413119, timecode=28200136 needsupmix 0
6642008-09-25 18:52:52.792 AFD: audio timecode 2538015137 2538015137 28200168 28200200
6652008-09-25 18:52:52.792 GetAudiotime now=1222393972.792891, set=1222393972.779920, ret=12, audt=28199496 sf=1
6662008-09-25 18:52:52.792 AO: _AddSamples samples=1536 bytes=6144, used=129025, free=1406975, timecode=28200168 needsupmix 0
6672008-09-25 18:52:52.793 AFD: audio timecode 2538018017 2538018017 28200200 28200232
6682008-09-25 18:52:52.793 GetAudiotime now=1222393972.793293, set=1222393972.779920, ret=13, audt=28199496 sf=1
6692008-09-25 18:52:52.793 AO: _AddSamples samples=1536 bytes=6144, used=135169, free=1400831, timecode=28200200 needsupmix 0
6702008-09-25 18:52:52.793 AFD: audio timecode 2538020897 2538020897 28200232 28200264
6712008-09-25 18:52:52.793 GetAudiotime now=1222393972.793906, set=1222393972.779920, ret=13, audt=28199496 sf=1
6722008-09-25 18:52:52.793 AO: _AddSamples samples=1536 bytes=6144, used=141313, free=1394687, timecode=28200232 needsupmix 0
6732008-09-25 18:52:52.794 AFD: audio timecode 2538023777 2538023777 28200264 28200296
6742008-09-25 18:52:52.794 GetAudiotime now=1222393972.794574, set=1222393972.779920, ret=14, audt=28199496 sf=1
6752008-09-25 18:52:52.794 AO: _AddSamples samples=1536 bytes=6144, used=147457, free=1388543, timecode=28200264 needsupmix 0
6762008-09-25 18:52:52.795 AFD: audio timecode 2538026657 2538026657 28200296 28200328
6772008-09-25 18:52:52.795 GetAudiotime now=1222393972.795102, set=1222393972.779920, ret=15, audt=28199496 sf=1
6782008-09-25 18:52:52.795 AO: _AddSamples samples=1536 bytes=6144, used=153601, free=1382399, timecode=28200296 needsupmix 0
6792008-09-25 18:52:52.795 AFD: audio timecode 2538029537 2538029537 28200328 28200360
6802008-09-25 18:52:52.795 GetAudiotime now=1222393972.795805, set=1222393972.779920, ret=15, audt=28199496 sf=1
6812008-09-25 18:52:52.795 AO: _AddSamples samples=1536 bytes=6144, used=159745, free=1376255, timecode=28200328 needsupmix 0
6822008-09-25 18:52:52.795 GetAudiotime now=1222393972.795964, set=1222393972.779920, ret=16, audt=28199496 sf=1
6832008-09-25 18:52:52.796 AO: Broadcasting free space avail
6842008-09-25 18:52:52.796 WriteAudio: Preparing 6144 bytes (1536 frames)
6852008-09-25 18:52:52.796 WriteAudio: buffer underrun
6862008-09-25 18:52:52.798 SetAudiotime set=1222393972.798151, audt=28199528 atc=28200360 tb=159744 sb=0 eds=4800000 abps=4 sf=1
6872008-09-25 18:52:52.798 GetAudiotime now=1222393972.798215, set=1222393972.798151, ret=0, audt=28199528 sf=1
6882008-09-25 18:52:52.798 AO: Broadcasting free space avail
6892008-09-25 18:52:52.798 WriteAudio: Preparing 6144 bytes (1536 frames)
6902008-09-25 18:52:52.798 SetAudiotime set=1222393972.798334, audt=28199560 atc=28200360 tb=153600 sb=0 eds=4800000 abps=4 sf=1