Ticket #2396: myth_workingresolution.txt

File myth_workingresolution.txt, 99.4 KB (added by anonymous, 14 years ago)

Recorded at 704x496... works just fine

Line 
12006-09-16 03:39:40.191 Using runtime prefix = /usr/local
22006-09-16 03:39:40.225 DPMS is active.
32006-09-16 03:39:40.285 New DB connection, total: 1
42006-09-16 03:39:40.314 Connected to database 'mythconverg' at host: localhost
52006-09-16 03:39:40.320 Total desktop dim: 720x576, with 1 screen[s].
62006-09-16 03:39:40.330 Using screen 0, 720x576 at 0,0
72006-09-16 03:39:40.588 user: 1000 effective user: 1000 before privileged thread
82006-09-16 03:39:40.590 user: 1000 effective user: 1000 after privileged thread
92006-09-16 03:39:40.594 Current Schema Version: 1160
102006-09-16 03:39:40.596 mythfrontend version: 0.20.20060828-3 www.mythtv.org
112006-09-16 03:39:40.596 Enabled verbose msgs: all nodatabase
122006-09-16 03:39:40.622 user: 1000 effective user: 1000 run_priv_thread
132006-09-16 03:39:41.324 max_width: 720 max_height: 576
142006-09-16 03:39:41.692 Total desktop dim: 720x576, with 1 screen[s].
152006-09-16 03:39:41.695 Using screen 0, 720x576 at 0,0
162006-09-16 03:39:41.697 Switching to square mode (Titivillus)
17__driCreateNewScreen_20050727 - succeeded
182006-09-16 03:39:41.839 Using the Qt painter
192006-09-16 03:39:42.932 New DB connection, total: 2
202006-09-16 03:39:42.934 Connected to database 'mythconverg' at host: localhost
212006-09-16 03:39:42.937 /home/mythtv/.mythtv/joystickmenurc not found.
222006-09-16 03:39:42.937 Joystick disabled.
232006-09-16 03:39:43.260 Loading from: /usr/local/share/mythtv/themes/default/base.xml
242006-09-16 03:39:44.991 Registering Internal as a media playback plugin.
252006-09-16 03:39:45.122 Registering MythDVD DVD Media Handler as a media handler ext()
262006-09-16 03:39:45.126 Registering MythDVD VCD Media Handler as a media handler ext()
272006-09-16 03:39:45.521 generating cache image for: /usr/local/share/mythtv/themes/default/blank.png
282006-09-16 03:39:58.016 MythSocket(84bd718:11): new socket
292006-09-16 03:39:58.026 Connecting to backend server: 192.168.178.31:6543 (try 1 of 5)
302006-09-16 03:39:58.027 MythSocket(8540c48:12): new socket
312006-09-16 03:39:58.028 MythSocket(8540c48:12): attempting connect() to (192.168.178.31:6543)
322006-09-16 03:39:58.029 MythSocket(8540c48:12): state change Idle -> Connected
332006-09-16 03:39:58.030 write -> 12 21      MYTH_PROTO_VERSION 30
342006-09-16 03:39:58.033 read  <- 12 13      ACCEPT[]:[]30
352006-09-16 03:39:58.033 Using protocol version 30
362006-09-16 03:39:58.034 write -> 12 17      ANN Monitor pvr 0
372006-09-16 03:39:58.036 read  <- 12 2       OK
382006-09-16 03:39:58.036 MythSocket(84bd718:11): attempting connect() to (192.168.178.31:6543)
392006-09-16 03:39:58.037 MythSocket(84bd718:11): state change Idle -> Connected
402006-09-16 03:39:58.037 write -> 11 17      ANN Monitor pvr 1
412006-09-16 03:39:58.041 read  <- 11 2       OK
422006-09-16 03:39:58.042 MythSocket(84bd718:11): UpRef: 1
432006-09-16 03:39:58.042 write -> 12 29      GET_NEXT_FREE_RECORDER[]:[]-1
442006-09-16 03:39:58.043 MythSocket: readyread thread start
452006-09-16 03:39:58.045 read  <- 12 29      1[]:[]192.168.178.31[]:[]6543
462006-09-16 03:39:58.053 TV: Attempting to change from None to WatchingLiveTV
472006-09-16 03:39:58.054 MythSocket(85375c8:15): new socket
482006-09-16 03:39:58.055 MythSocket(85375c8:15): attempting connect() to (192.168.178.31:6543)
492006-09-16 03:39:58.055 MythSocket(85375c8:15): state change Idle -> Connected
502006-09-16 03:39:58.056 write -> 15 21      MYTH_PROTO_VERSION 30
512006-09-16 03:39:58.058 read  <- 15 13      ACCEPT[]:[]30
522006-09-16 03:39:58.059 Using protocol version 30
532006-09-16 03:39:58.059 write -> 15 18      ANN Playback pvr 0
542006-09-16 03:39:58.062 read  <- 15 2       OK
552006-09-16 03:39:58.063 write -> 15 72      QUERY_RECORDER 1[]:[]SPAWN_LIVETV[]:[]live-pvr-2006-09-16T03:39:5...
562006-09-16 03:39:58.609 MythSocket(84bd718:11): socket is readable
572006-09-16 03:39:58.610 MythSocket(84bd718:11): cb->readyRead()
582006-09-16 03:39:58.610 read  <- 11 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
592006-09-16 03:39:58.637 MythSocket(84bd718:11): socket is readable
602006-09-16 03:39:58.638 MythSocket(84bd718:11): cb->readyRead()
612006-09-16 03:39:58.638 read  <- 11 78      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-pvr-2006-09-16T03:39...
622006-09-16 03:39:58.674 read  <- 15 2       ok
632006-09-16 03:39:58.678 LiveTVChain(live-pvr-2006-09-16T03:39:58): ReloadAll(): Added new recording
642006-09-16 03:39:58.690 RingBuf(/mnt/recordings/7_20060916033958.mpg): OpenFile(/mnt/recordings/7_20060916033958.mpg, 12)
652006-09-16 03:39:59.376 RingBuf(/mnt/recordings/7_20060916033958.mpg): CalcReadAheadThresh(4000 KB)
66                         -> threshhold(146 KB) min read(32 KB) blk size(64 KB)
672006-09-16 03:39:59.377 write -> 15 33      QUERY_RECORDER 1[]:[]IS_RECORDING
682006-09-16 03:39:59.378 read  <- 15 1       1
692006-09-16 03:39:59.379 write -> 15 33      QUERY_RECORDER 1[]:[]IS_RECORDING
702006-09-16 03:39:59.380 read  <- 15 1       1
712006-09-16 03:39:59.380 TV: StartRecorder(): took 3 ms to start recorder.
722006-09-16 03:39:59.380 write -> 15 34      QUERY_RECORDER 1[]:[]GET_FRAMERATE
732006-09-16 03:39:59.388 DPMS Deactivated
742006-09-16 03:39:59.392 read  <- 15 2       25
752006-09-16 03:39:59.443 write -> 12 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
762006-09-16 03:39:59.445 read  <- 12 2       OK
772006-09-16 03:39:59.469 MythSocket(84bd718:11): socket is readable
782006-09-16 03:39:59.469 MythSocket(84bd718:11): cb->readyRead()
792006-09-16 03:39:59.470 read  <- 11 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
802006-09-16 03:39:59.530 TV: Output filters for this channel are: ''
812006-09-16 03:39:59.625 AFD: Stream #0, has id 0x480 codec id MPEG2VIDEO, type Video, bitrate 6000000 at 0x0x84ee1e0
822006-09-16 03:39:59.639 VideoOutputXv: XvMC version: 1.1
832006-09-16 03:39:59.640 XvMCSurfaceTypes::find(w 704, h 496, chroma 1, vld 1, idct 0, mpeg2, sub-width 0, sub-height 0, disp, p<= 68, 680 <=p, port, surfNum)
842006-09-16 03:39:59.641 Trying XvMC port 68
852006-09-16 03:39:59.643 Found a suitable XvMC surface 0
862006-09-16 03:39:59.645 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask
872006-09-16 03:39:59.646 VideoOutputXv: Adaptor#0: XV_SWOV has flag[s]: XvInputMask XvImageMask
882006-09-16 03:39:59.646 XvMCSurfaceTypes::find(w 704, h 496, chroma 1, vld 1, idct 0, mpeg2, sub-width 0, sub-height 0, disp, p<= 68, 680 <=p, port, surfNum)
892006-09-16 03:39:59.647 Trying XvMC port 68
902006-09-16 03:39:59.647 Found a suitable XvMC surface 0
912006-09-16 03:39:59.648 VideoOutputXv: Grabbed xv port 68
922006-09-16 03:39:59.648 VideoOutputXv: XvMC surface found with VLD support on port 68
932006-09-16 03:39:59.656 VideoOutputXv: Closing XVideo port 68
942006-09-16 03:39:59.658 detectInterlace(Detect Scan, Interlaced Scan, 25, 496) ->Interlaced Scan
952006-09-16 03:39:59.658 AFD: Looking for decoder for MPEG2VIDEO_XVMC_VLD
962006-09-16 03:39:59.659 AFD: Opened codec 0x8e919f0, id(MPEG2VIDEO_XVMC_VLD) type(Video)
972006-09-16 03:39:59.659 AFD: Stream #1, has id 0x448 codec id MP2, type Audio, bitrate 224000 at 0x0x8e91d40
982006-09-16 03:39:59.659 AFD: Looking for decoder for MP2
992006-09-16 03:39:59.826 AFD: Opened codec 0x8e91df0, id(MP2) type(Audio)
1002006-09-16 03:39:59.826 AFD: Audio Track #1 is A/V stream #1 and has 2 channels in the Unknown language(0).
1012006-09-16 03:39:59.827 RingBuf(/mnt/recordings/7_20060916033958.mpg): CalcReadAheadThresh(6224 KB)
102                         -> threshhold(227 KB) min read(32 KB) blk size(128 KB)
1032006-09-16 03:39:59.828 AFD: Selected track 1: Unknown MP2 2ch (A/V Stream #1)
1042006-09-16 03:39:59.828 AFD: Initializing audio parms from audio track #1
1052006-09-16 03:39:59.833 AFD: Audio format changed
106                        from id(NONE)    -1Hz -1ch   0bps    ; id(NONE)    -1Hz -1ch   0bps   
107                        to   id( MP2) 48000Hz  2ch  16bps    ; id( MP2) 48000Hz  2ch  16bps   
1082006-09-16 03:39:59.851 AO: Killing AudioOutputDSP
1092006-09-16 03:39:59.852 Opening OSS audio device '/dev/dsp'.
1102006-09-16 03:39:59.866 AO: Audio fragment size: 4096
1112006-09-16 03:39:59.870 AO: Audio Stretch Factor: 1
1122006-09-16 03:39:59.871 AO: Ending reconfigure
1132006-09-16 03:39:59.871 Dec: Trying to select track (w/lang)
1142006-09-16 03:39:59.871 Dec: Selecting first track
1152006-09-16 03:39:59.873 Dec: Selected track #1 in the Unknown language(0)
1162006-09-16 03:39:59.873 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(0)
1172006-09-16 03:39:59.880 Position map filled from DB to: 1
1182006-09-16 03:39:59.881 SyncPositionMap watchingrecording, from DB: 1 entries
1192006-09-16 03:39:59.881 write -> 15 39      QUERY_RECORDER 1[]:[]GET_FRAMES_WRITTEN
1202006-09-16 03:39:59.883 read  <- 15 8       0[]:[]12
1212006-09-16 03:39:59.883 Filling position map from 2 to 1
1222006-09-16 03:39:59.884 write -> 15 50      QUERY_RECORDER 1[]:[]FILL_POSITION_MAP[]:[]2[]:[]1
1232006-09-16 03:39:59.885 read  <- 15 2       ok
1242006-09-16 03:39:59.885 Position map filled from Encoder to: 1
1252006-09-16 03:39:59.885 SyncPositionMap watchingrecording total: 1 entries
1262006-09-16 03:39:59.886 SyncPositionMap, new totframes: 12, new length: 0, posMap size: 1
127Input #0, mpeg, from '/mnt/recordings/7_20060916033958.mpg':
128  Duration: N/A, bitrate: N/A
129  Stream #0.0[0x1e0], 1/90000: Video: mpegvideo_xvmc_vld, yuv420p, 704x496, 1/25, 6000 kb/s, 25.00 fps(r)
130  Stream #0.1[0x1c0], 1/90000: Audio: mp2, 48000 Hz, stereo, 224 kb/s
1312006-09-16 03:39:59.887 AFD: Partial position map found
1322006-09-16 03:39:59.887 AFD: Successfully opened decoder for file: "/mnt/recordings/7_20060916033958.mpg". novideo(0)
1332006-09-16 03:39:59.899 AO: kickoffOutputAudioLoop: pid = 8850
1342006-09-16 03:39:59.900 AO: OutputAudioLoop: Play Event
1352006-09-16 03:39:59.900 AO: Broadcasting free space avail
1362006-09-16 03:39:59.978 VideoOutputXv: ctor
1372006-09-16 03:39:59.981 Over/underscan. V: 0, H: 0, XOff: 0, YOff: 0
1382006-09-16 03:39:59.982 Snapping width to avoid scaling: width: 704, left: 8
1392006-09-16 03:39:59.982 Display Rect  left: 8, top: 0, width: 704, height: 576, aspect: 1.33333
1402006-09-16 03:39:59.982 Video Rect    left: 0, top: 0, width: 704, height: 496, aspect: 1.33333
1412006-09-16 03:39:59.983 VideoOutputXv: Pixel dimensions: Screen 720x576, window 720x576
1422006-09-16 03:39:59.983 VideoOutputXv: Estimated display dimensions: 244x195 mm  Aspect: 1.25128
1432006-09-16 03:39:59.985 VideoOutputXv: Estimated window dimensions: 244x195 mm  Aspect: 1.25128
1442006-09-16 03:39:59.988 VideoOutputXv: XvMCTex: Init failed
1452006-09-16 03:39:59.988 VideoOutputXv: Number of bits per pixel is 16,
146                        but we only support ARGB 32 bbp for ChromaKeyOSD.
1472006-09-16 03:39:59.989 VideoOutputXv: @ j=0 Looking for flag[s]: XvInputMask
1482006-09-16 03:39:59.990 VideoOutputXv: Adaptor#0: XV_SWOV has flag[s]: XvInputMask XvImageMask
1492006-09-16 03:39:59.994 XvMCSurfaceTypes::find(w 704, h 496, chroma 1, vld 1, idct 0, mpeg2, sub-width 0, sub-height 0, disp, p<= 68, 680 <=p, port, surfNum)
1502006-09-16 03:39:59.995 Trying XvMC port 68
1512006-09-16 03:39:59.996 Found a suitable XvMC surface 0
1522006-09-16 03:39:59.996 VideoOutputXv: Grabbed xv port 68
1532006-09-16 03:39:59.997 VideoOutputXv: XvMC surface found with VLD support on port 68
1542006-09-16 03:39:59.997 VideoOutputXv: XvMC Adaptor Name: 'XV_SWOV'
1552006-09-16 03:40:00.017 Snapping width to avoid scaling: width: 704, left: 8
1562006-09-16 03:40:00.017 Display Rect  left: 8, top: 0, width: 704, height: 576, aspect: 1.25128
1572006-09-16 03:40:00.018 Video Rect    left: 0, top: 0, width: 704, height: 496, aspect: 1.33333
1582006-09-16 03:40:00.052 AO: OutputAudioLoop: audio paused
1592006-09-16 03:40:00.052 AO: 65536 bytes free on soundcard
1602006-09-16 03:40:00.061 AO: 63072 bytes free on soundcard
1612006-09-16 03:40:00.068 AO: 60320 bytes free on soundcard
1622006-09-16 03:40:00.077 AO: 62048 bytes free on soundcard
1632006-09-16 03:40:00.084 AO: 59264 bytes free on soundcard
1642006-09-16 03:40:00.094 AO: 61216 bytes free on soundcard
1652006-09-16 03:40:00.100 AO: 62336 bytes free on soundcard
1662006-09-16 03:40:00.109 AO: 60000 bytes free on soundcard
1672006-09-16 03:40:00.116 AO: 61280 bytes free on soundcard
1682006-09-16 03:40:00.125 AO: 63136 bytes free on soundcard
1692006-09-16 03:40:00.132 AO: 60256 bytes free on soundcard
1702006-09-16 03:40:00.141 AO: 62080 bytes free on soundcard
1712006-09-16 03:40:00.148 AO: 59296 bytes free on soundcard
1722006-09-16 03:40:00.160 AO: 61600 bytes free on soundcard
1732006-09-16 03:40:00.167 AO: 58976 bytes free on soundcard
1742006-09-16 03:40:00.178 AO: 60928 bytes free on soundcard
1752006-09-16 03:40:00.185 AO: 62368 bytes free on soundcard
1762006-09-16 03:40:00.194 AO: 60032 bytes free on soundcard
1772006-09-16 03:40:00.200 AO: 61056 bytes free on soundcard
1782006-09-16 03:40:00.210 AO: 63104 bytes free on soundcard
1792006-09-16 03:40:00.216 AO: 60032 bytes free on soundcard
1802006-09-16 03:40:00.226 AO: 62048 bytes free on soundcard
1812006-09-16 03:40:00.232 AO: 59008 bytes free on soundcard
1822006-09-16 03:40:00.240 AO: 60544 bytes free on soundcard
1832006-09-16 03:40:00.248 AO: 62048 bytes free on soundcard
1842006-09-16 03:40:00.256 AO: 59552 bytes free on soundcard
1852006-09-16 03:40:00.264 AO: 61088 bytes free on soundcard
1862006-09-16 03:40:00.272 AO: 62624 bytes free on soundcard
1872006-09-16 03:40:00.280 AO: 60032 bytes free on soundcard
1882006-09-16 03:40:00.288 AO: 61568 bytes free on soundcard
1892006-09-16 03:40:00.297 AO: 59232 bytes free on soundcard
1902006-09-16 03:40:00.304 AO: 60544 bytes free on soundcard
1912006-09-16 03:40:00.313 AO: 62336 bytes free on soundcard
1922006-09-16 03:40:00.320 AO: 59520 bytes free on soundcard
1932006-09-16 03:40:00.331 AO: 61664 bytes free on soundcard
1942006-09-16 03:40:00.336 AO: 58496 bytes free on soundcard
1952006-09-16 03:40:00.346 AO: 60544 bytes free on soundcard
1962006-09-16 03:40:00.352 AO: 61568 bytes free on soundcard
1972006-09-16 03:40:00.361 AO: 59008 bytes free on soundcard
1982006-09-16 03:40:00.368 AO: 60576 bytes free on soundcard
1992006-09-16 03:40:00.377 AO: 62432 bytes free on soundcard
2002006-09-16 03:40:00.384 AO: 59520 bytes free on soundcard
2012006-09-16 03:40:00.392 AO: 61056 bytes free on soundcard
2022006-09-16 03:40:00.400 AO: 62592 bytes free on soundcard
2032006-09-16 03:40:00.408 AO: 60032 bytes free on soundcard
2042006-09-16 03:40:00.416 AO: 61568 bytes free on soundcard
2052006-09-16 03:40:00.424 AO: 59008 bytes free on soundcard
2062006-09-16 03:40:00.434 AO: 61056 bytes free on soundcard
2072006-09-16 03:40:00.440 AO: 62080 bytes free on soundcard
2082006-09-16 03:40:00.450 AO: 60000 bytes free on soundcard
2092006-09-16 03:40:00.458 AO: 61440 bytes free on soundcard
2102006-09-16 03:40:00.465 AO: 58688 bytes free on soundcard
2112006-09-16 03:40:00.472 AO: 60096 bytes free on soundcard
2122006-09-16 03:40:00.482 AO: 61984 bytes free on soundcard
2132006-09-16 03:40:00.488 AO: 59104 bytes free on soundcard
2142006-09-16 03:40:00.500 AO: 60960 bytes free on soundcard
2152006-09-16 03:40:00.508 AO: 62912 bytes free on soundcard
2162006-09-16 03:40:00.516 AO: 60384 bytes free on soundcard
2172006-09-16 03:40:00.524 AO: 61856 bytes free on soundcard
2182006-09-16 03:40:00.534 AO: 59776 bytes free on soundcard
2192006-09-16 03:40:00.540 AO: 60800 bytes free on soundcard
2202006-09-16 03:40:00.548 AO: 62368 bytes free on soundcard
2212006-09-16 03:40:00.556 AO: 59808 bytes free on soundcard
2222006-09-16 03:40:00.564 AO: 61312 bytes free on soundcard
2232006-09-16 03:40:00.572 AO: 62880 bytes free on soundcard
2242006-09-16 03:40:00.580 AO: 60320 bytes free on soundcard
2252006-09-16 03:40:00.588 AO: 61856 bytes free on soundcard
2262006-09-16 03:40:00.596 AO: 59296 bytes free on soundcard
2272006-09-16 03:40:00.604 AO: 60864 bytes free on soundcard
2282006-09-16 03:40:00.612 AO: 62368 bytes free on soundcard
2292006-09-16 03:40:00.619 OSD: InitCC708() -- begin
2302006-09-16 03:40:00.620 AO: 59808 bytes free on soundcard
2312006-09-16 03:40:00.628 AO: 61376 bytes free on soundcard
2322006-09-16 03:40:00.637 AO: 63072 bytes free on soundcard
2332006-09-16 03:40:00.644 AO: 60288 bytes free on soundcard
2342006-09-16 03:40:00.654 AO: 62368 bytes free on soundcard
2352006-09-16 03:40:00.660 AO: 59296 bytes free on soundcard
2362006-09-16 03:40:00.670 AO: 61280 bytes free on soundcard
2372006-09-16 03:40:00.676 AO: 62368 bytes free on soundcard
2382006-09-16 03:40:00.684 AO: 59872 bytes free on soundcard
2392006-09-16 03:40:00.692 AO: 61312 bytes free on soundcard
2402006-09-16 03:40:00.700 AO: 62912 bytes free on soundcard
2412006-09-16 03:40:00.709 AO: 60608 bytes free on soundcard
2422006-09-16 03:40:00.716 AO: 61984 bytes free on soundcard
2432006-09-16 03:40:00.724 AO: 59328 bytes free on soundcard
2442006-09-16 03:40:00.732 AO: 60864 bytes free on soundcard
2452006-09-16 03:40:00.740 AO: 62336 bytes free on soundcard
2462006-09-16 03:40:00.748 AO: 59840 bytes free on soundcard
2472006-09-16 03:40:00.756 AO: 61344 bytes free on soundcard
2482006-09-16 03:40:00.764 AO: 62912 bytes free on soundcard
2492006-09-16 03:40:00.773 AO: 60512 bytes free on soundcard
2502006-09-16 03:40:00.781 AO: 62048 bytes free on soundcard
2512006-09-16 03:40:00.791 AO: 59904 bytes free on soundcard
2522006-09-16 03:40:00.796 AO: 60864 bytes free on soundcard
2532006-09-16 03:40:00.807 AO: 63008 bytes free on soundcard
2542006-09-16 03:40:00.816 AO: 60576 bytes free on soundcard
2552006-09-16 03:40:00.824 AO: 62080 bytes free on soundcard
2562006-09-16 03:40:00.832 AO: 59520 bytes free on soundcard
2572006-09-16 03:40:00.840 AO: 61184 bytes free on soundcard
2582006-09-16 03:40:00.848 AO: 62592 bytes free on soundcard
2592006-09-16 03:40:00.856 AO: 60096 bytes free on soundcard
2602006-09-16 03:40:00.864 AO: 61600 bytes free on soundcard
2612006-09-16 03:40:00.872 AO: 59040 bytes free on soundcard
2622006-09-16 03:40:00.880 AO: 60576 bytes free on soundcard
2632006-09-16 03:40:00.889 AO: 62272 bytes free on soundcard
2642006-09-16 03:40:00.896 AO: 59552 bytes free on soundcard
2652006-09-16 03:40:00.905 AO: 61440 bytes free on soundcard
2662006-09-16 03:40:00.912 AO: 58528 bytes free on soundcard
2672006-09-16 03:40:00.924 AO: 60800 bytes free on soundcard
2682006-09-16 03:40:00.932 AO: 62368 bytes free on soundcard
2692006-09-16 03:40:00.940 AO: 59840 bytes free on soundcard
2702006-09-16 03:40:00.948 AO: 61344 bytes free on soundcard
2712006-09-16 03:40:00.957 AO: 63168 bytes free on soundcard
2722006-09-16 03:40:00.964 AO: 60320 bytes free on soundcard
2732006-09-16 03:40:00.972 AO: 61920 bytes free on soundcard
2742006-09-16 03:40:00.980 AO: 59328 bytes free on soundcard
2752006-09-16 03:40:00.988 AO: 60896 bytes free on soundcard
2762006-09-16 03:40:01.001 AO: 63360 bytes free on soundcard
2772006-09-16 03:40:01.008 AO: 60608 bytes free on soundcard
2782006-09-16 03:40:01.017 AO: 62336 bytes free on soundcard
2792006-09-16 03:40:01.024 AO: 59552 bytes free on soundcard
2802006-09-16 03:40:01.036 AO: 61984 bytes free on soundcard
2812006-09-16 03:40:01.044 AO: 59296 bytes free on soundcard
2822006-09-16 03:40:01.053 AO: 61184 bytes free on soundcard
2832006-09-16 03:40:01.060 AO: 62368 bytes free on soundcard
2842006-09-16 03:40:01.069 AO: 60160 bytes free on soundcard
2852006-09-16 03:40:01.076 AO: 61344 bytes free on soundcard
2862006-09-16 03:40:01.086 AO: 63392 bytes free on soundcard
2872006-09-16 03:40:01.092 AO: 60352 bytes free on soundcard
2882006-09-16 03:40:01.101 AO: 62048 bytes free on soundcard
2892006-09-16 03:40:01.108 AO: 59296 bytes free on soundcard
2902006-09-16 03:40:01.117 AO: 61088 bytes free on soundcard
2912006-09-16 03:40:01.124 AO: 62368 bytes free on soundcard
2922006-09-16 03:40:01.136 AO: 60736 bytes free on soundcard
2932006-09-16 03:40:01.145 AO: 62400 bytes free on soundcard
2942006-09-16 03:40:01.153 AO: 59808 bytes free on soundcard
2952006-09-16 03:40:01.160 AO: 61120 bytes free on soundcard
2962006-09-16 03:40:01.170 AO: 63040 bytes free on soundcard
2972006-09-16 03:40:01.180 AO: 60864 bytes free on soundcard
2982006-09-16 03:40:01.188 AO: 62368 bytes free on soundcard
2992006-09-16 03:40:01.196 AO: 59808 bytes free on soundcard
3002006-09-16 03:40:01.204 AO: 61344 bytes free on soundcard
3012006-09-16 03:40:01.212 AO: 62912 bytes free on soundcard
3022006-09-16 03:40:01.220 AO: 60320 bytes free on soundcard
3032006-09-16 03:40:01.228 AO: 61856 bytes free on soundcard
3042006-09-16 03:40:01.236 AO: 59328 bytes free on soundcard
3052006-09-16 03:40:01.244 AO: 60864 bytes free on soundcard
3062006-09-16 03:40:01.253 AO: 62624 bytes free on soundcard
3072006-09-16 03:40:01.260 AO: 59840 bytes free on soundcard
3082006-09-16 03:40:01.268 AO: 61344 bytes free on soundcard
3092006-09-16 03:40:01.276 AO: 62880 bytes free on soundcard
3102006-09-16 03:40:01.286 AO: 60480 bytes free on soundcard
3112006-09-16 03:40:01.292 AO: 61856 bytes free on soundcard
3122006-09-16 03:40:01.300 AO: 59296 bytes free on soundcard
3132006-09-16 03:40:01.308 AO: 60864 bytes free on soundcard
3142006-09-16 03:40:01.316 AO: 62368 bytes free on soundcard
3152006-09-16 03:40:01.324 AO: 59808 bytes free on soundcard
3162006-09-16 03:40:01.332 AO: 61376 bytes free on soundcard
3172006-09-16 03:40:01.340 AO: 62880 bytes free on soundcard
3182006-09-16 03:40:01.348 AO: 60320 bytes free on soundcard
3192006-09-16 03:40:01.356 AO: 61888 bytes free on soundcard
3202006-09-16 03:40:01.364 AO: 59296 bytes free on soundcard
3212006-09-16 03:40:01.373 AO: 61184 bytes free on soundcard
3222006-09-16 03:40:01.380 AO: 62400 bytes free on soundcard
3232006-09-16 03:40:01.391 AO: 60544 bytes free on soundcard
3242006-09-16 03:40:01.400 AO: 62112 bytes free on soundcard
3252006-09-16 03:40:01.409 AO: 59808 bytes free on soundcard
3262006-09-16 03:40:01.410 OSD: InitCC708() -- end
3272006-09-16 03:40:01.416 AO: 61120 bytes free on soundcard
3282006-09-16 03:40:01.428 AO: 63456 bytes free on soundcard
3292006-09-16 03:40:01.436 AO: 60896 bytes free on soundcard
3302006-09-16 03:40:01.444 AO: 62432 bytes free on soundcard
3312006-09-16 03:40:01.452 AO: 59840 bytes free on soundcard
3322006-09-16 03:40:01.460 AO: 61504 bytes free on soundcard
3332006-09-16 03:40:01.468 AO: 58784 bytes free on soundcard
3342006-09-16 03:40:01.476 AO: 60416 bytes free on soundcard
3352006-09-16 03:40:01.486 AO: 62368 bytes free on soundcard
3362006-09-16 03:40:01.492 AO: 59360 bytes free on soundcard
3372006-09-16 03:40:01.500 AO: 60896 bytes free on soundcard
3382006-09-16 03:40:01.509 AO: 62688 bytes free on soundcard
3392006-09-16 03:40:01.516 AO: 59808 bytes free on soundcard
3402006-09-16 03:40:01.525 AO: 61568 bytes free on soundcard
3412006-09-16 03:40:01.532 AO: 58784 bytes free on soundcard
3422006-09-16 03:40:01.540 AO: 60384 bytes free on soundcard
3432006-09-16 03:40:01.548 AO: 61888 bytes free on soundcard
3442006-09-16 03:40:01.556 AO: 59360 bytes free on soundcard
3452006-09-16 03:40:01.564 AO: 60864 bytes free on soundcard
3462006-09-16 03:40:01.572 AO: 62464 bytes free on soundcard
3472006-09-16 03:40:01.580 AO: 59840 bytes free on soundcard
3482006-09-16 03:40:01.589 AO: 61568 bytes free on soundcard
3492006-09-16 03:40:01.596 AO: 58816 bytes free on soundcard
3502006-09-16 03:40:01.608 AO: 61120 bytes free on soundcard
3512006-09-16 03:40:01.616 AO: 62656 bytes free on soundcard
3522006-09-16 03:40:01.624 AO: 60192 bytes free on soundcard
3532006-09-16 03:40:01.632 AO: 61632 bytes free on soundcard
3542006-09-16 03:40:01.643 AO: 59680 bytes free on soundcard
3552006-09-16 03:40:01.648 AO: 60608 bytes free on soundcard
3562006-09-16 03:40:01.659 AO: 62752 bytes free on soundcard
3572006-09-16 03:40:01.664 AO: 59552 bytes free on soundcard
3582006-09-16 03:40:01.675 AO: 61760 bytes free on soundcard
3592006-09-16 03:40:01.680 AO: 58560 bytes free on soundcard
3602006-09-16 03:40:01.692 AO: 60928 bytes free on soundcard
3612006-09-16 03:40:01.700 AO: 62400 bytes free on soundcard
3622006-09-16 03:40:01.711 AO: 60512 bytes free on soundcard
3632006-09-16 03:40:01.720 AO: 62176 bytes free on soundcard
3642006-09-16 03:40:01.728 AO: 59616 bytes free on soundcard
3652006-09-16 03:40:01.736 AO: 61088 bytes free on soundcard
3662006-09-16 03:40:01.745 AO: 62944 bytes free on soundcard
3672006-09-16 03:40:01.753 AO: 60416 bytes free on soundcard
3682006-09-16 03:40:01.760 AO: 61632 bytes free on soundcard
3692006-09-16 03:40:01.768 AO: 59072 bytes free on soundcard
3702006-09-16 03:40:01.777 AO: 60928 bytes free on soundcard
3712006-09-16 03:40:01.784 AO: 62112 bytes free on soundcard
3722006-09-16 03:40:01.794 AO: 59936 bytes free on soundcard
3732006-09-16 03:40:01.800 AO: 61088 bytes free on soundcard
3742006-09-16 03:40:01.810 AO: 63008 bytes free on soundcard
3752006-09-16 03:40:01.816 AO: 60096 bytes free on soundcard
3762006-09-16 03:40:01.824 AO: 61664 bytes free on soundcard
3772006-09-16 03:40:01.832 AO: 59072 bytes free on soundcard
3782006-09-16 03:40:01.840 AO: 60608 bytes free on soundcard
3792006-09-16 03:40:01.848 AO: 62144 bytes free on soundcard
3802006-09-16 03:40:01.856 AO: 59584 bytes free on soundcard
3812006-09-16 03:40:01.864 AO: 61120 bytes free on soundcard
3822006-09-16 03:40:01.872 AO: 62656 bytes free on soundcard
3832006-09-16 03:40:01.881 AO: 60352 bytes free on soundcard
3842006-09-16 03:40:01.888 AO: 61632 bytes free on soundcard
3852006-09-16 03:40:01.897 AO: 59296 bytes free on soundcard
3862006-09-16 03:40:01.904 AO: 60608 bytes free on soundcard
3872006-09-16 03:40:01.917 AO: 63168 bytes free on soundcard
3882006-09-16 03:40:01.924 AO: 60352 bytes free on soundcard
3892006-09-16 03:40:01.932 AO: 61920 bytes free on soundcard
3902006-09-16 03:40:01.940 AO: 59392 bytes free on soundcard
3912006-09-16 03:40:01.948 AO: 60928 bytes free on soundcard
3922006-09-16 03:40:01.956 AO: 62400 bytes free on soundcard
3932006-09-16 03:40:01.966 AO: 60224 bytes free on soundcard
3942006-09-16 03:40:01.972 AO: 61376 bytes free on soundcard
3952006-09-16 03:40:01.980 AO: 62976 bytes free on soundcard
3962006-09-16 03:40:01.988 AO: 60384 bytes free on soundcard
3972006-09-16 03:40:01.996 AO: 61952 bytes free on soundcard
3982006-09-16 03:40:02.004 AO: 59328 bytes free on soundcard
3992006-09-16 03:40:02.012 AO: 60992 bytes free on soundcard
4002006-09-16 03:40:02.020 AO: 62400 bytes free on soundcard
4012006-09-16 03:40:02.028 AO: 59904 bytes free on soundcard
4022006-09-16 03:40:02.037 AO: 61696 bytes free on soundcard
4032006-09-16 03:40:02.044 AO: 58976 bytes free on soundcard
4042006-09-16 03:40:02.052 AO: 60384 bytes free on soundcard
4052006-09-16 03:40:02.061 AO: 61952 bytes free on soundcard
4062006-09-16 03:40:02.068 AO: 59392 bytes free on soundcard
4072006-09-16 03:40:02.076 AO: 60928 bytes free on soundcard
4082006-09-16 03:40:02.086 AO: 62816 bytes free on soundcard
4092006-09-16 03:40:02.092 AO: 59904 bytes free on soundcard
4102006-09-16 03:40:02.100 AO: 61408 bytes free on soundcard
4112006-09-16 03:40:02.108 AO: 62976 bytes free on soundcard
4122006-09-16 03:40:02.116 AO: 60352 bytes free on soundcard
4132006-09-16 03:40:02.124 AO: 61952 bytes free on soundcard
4142006-09-16 03:40:02.132 AO: 59360 bytes free on soundcard
4152006-09-16 03:40:02.140 AO: 60960 bytes free on soundcard
4162006-09-16 03:40:02.148 AO: 62400 bytes free on soundcard
4172006-09-16 03:40:02.156 AO: 59904 bytes free on soundcard
4182006-09-16 03:40:02.164 AO: 61376 bytes free on soundcard
4192006-09-16 03:40:02.172 AO: 62976 bytes free on soundcard
4202006-09-16 03:40:02.180 AO: 60384 bytes free on soundcard
4212006-09-16 03:40:02.188 AO: 61952 bytes free on soundcard
4222006-09-16 03:40:02.196 AO: 59360 bytes free on soundcard
4232006-09-16 03:40:02.204 AO: 60960 bytes free on soundcard
4242006-09-16 03:40:02.216 AO: 63296 bytes free on soundcard
4252006-09-16 03:40:02.224 AO: 60608 bytes free on soundcard
4262006-09-16 03:40:02.234 AO: 62624 bytes free on soundcard
4272006-09-16 03:40:02.240 AO: 59648 bytes free on soundcard
4282006-09-16 03:40:02.251 AO: 61824 bytes free on soundcard
4292006-09-16 03:40:02.260 AO: 59328 bytes free on soundcard
4302006-09-16 03:40:02.269 AO: 61152 bytes free on soundcard
4312006-09-16 03:40:02.276 AO: 62432 bytes free on soundcard
4322006-09-16 03:40:02.285 AO: 60096 bytes free on soundcard
4332006-09-16 03:40:02.292 AO: 61504 bytes free on soundcard
4342006-09-16 03:40:02.300 AO: 58912 bytes free on soundcard
4352006-09-16 03:40:02.308 AO: 60384 bytes free on soundcard
4362006-09-16 03:40:02.316 AO: 61952 bytes free on soundcard
4372006-09-16 03:40:02.324 AO: 59328 bytes free on soundcard
4382006-09-16 03:40:02.335 AO: 61504 bytes free on soundcard
4392006-09-16 03:40:02.340 AO: 58304 bytes free on soundcard
4402006-09-16 03:40:02.348 AO: 59904 bytes free on soundcard
4412006-09-16 03:40:02.356 AO: 61408 bytes free on soundcard
4422006-09-16 03:40:02.364 AO: 62976 bytes free on soundcard
4432006-09-16 03:40:02.372 AO: 60352 bytes free on soundcard
4442006-09-16 03:40:02.380 AO: 61952 bytes free on soundcard
4452006-09-16 03:40:02.388 AO: 59328 bytes free on soundcard
4462006-09-16 03:40:02.396 AO: 60928 bytes free on soundcard
4472006-09-16 03:40:02.404 AO: 62432 bytes free on soundcard
4482006-09-16 03:40:02.412 AO: 59872 bytes free on soundcard
4492006-09-16 03:40:02.420 AO: 61408 bytes free on soundcard
4502006-09-16 03:40:02.428 AO: 62944 bytes free on soundcard
4512006-09-16 03:40:02.436 AO: 60352 bytes free on soundcard
4522006-09-16 03:40:02.444 AO: 61952 bytes free on soundcard
4532006-09-16 03:40:02.455 AO: 59904 bytes free on soundcard
4542006-09-16 03:40:02.460 AO: 60896 bytes free on soundcard
4552006-09-16 03:40:02.471 AO: 62976 bytes free on soundcard
4562006-09-16 03:40:02.476 AO: 59872 bytes free on soundcard
4572006-09-16 03:40:02.487 AO: 62080 bytes free on soundcard
4582006-09-16 03:40:02.496 AO: 59648 bytes free on soundcard
4592006-09-16 03:40:02.504 AO: 61216 bytes free on soundcard
4602006-09-16 03:40:02.512 AO: 62752 bytes free on soundcard
4612006-09-16 03:40:02.520 AO: 60128 bytes free on soundcard
4622006-09-16 03:40:02.528 AO: 61728 bytes free on soundcard
4632006-09-16 03:40:02.539 AO: 59712 bytes free on soundcard
4642006-09-16 03:40:02.545 AO: 60832 bytes free on soundcard
4652006-09-16 03:40:02.555 AO: 62816 bytes free on soundcard
4662006-09-16 03:40:02.560 AO: 59680 bytes free on soundcard
4672006-09-16 03:40:02.568 AO: 61152 bytes free on soundcard
4682006-09-16 03:40:02.576 AO: 62720 bytes free on soundcard
4692006-09-16 03:40:02.584 AO: 60128 bytes free on soundcard
4702006-09-16 03:40:02.592 AO: 61728 bytes free on soundcard
4712006-09-16 03:40:02.600 AO: 59104 bytes free on soundcard
4722006-09-16 03:40:02.608 AO: 60704 bytes free on soundcard
4732006-09-16 03:40:02.616 AO: 62176 bytes free on soundcard
4742006-09-16 03:40:02.624 AO: 59616 bytes free on soundcard
4752006-09-16 03:40:02.632 AO: 61152 bytes free on soundcard
4762006-09-16 03:40:02.641 AO: 62848 bytes free on soundcard
4772006-09-16 03:40:02.648 AO: 60128 bytes free on soundcard
4782006-09-16 03:40:02.656 AO: 61792 bytes free on soundcard
4792006-09-16 03:40:02.664 AO: 59136 bytes free on soundcard
4802006-09-16 03:40:02.672 AO: 60704 bytes free on soundcard
4812006-09-16 03:40:02.680 AO: 62176 bytes free on soundcard
4822006-09-16 03:40:02.692 AO: 60352 bytes free on soundcard
4832006-09-16 03:40:02.700 AO: 61920 bytes free on soundcard
4842006-09-16 03:40:02.710 AO: 59872 bytes free on soundcard
4852006-09-16 03:40:02.716 AO: 60928 bytes free on soundcard
4862006-09-16 03:40:02.729 AO: 63232 bytes free on soundcard
4872006-09-16 03:40:02.731 NVP: ClearAfterSeek(1)
4882006-09-16 03:40:02.731 VideoOutputXv: ClearAfterSeek()
4892006-09-16 03:40:02.732 VideoOutputXv: DiscardFrames(0)
4902006-09-16 03:40:02.732 VideoOutputXv: DiscardFrames() 1: AAAAAAAAAAAAAAAA
4912006-09-16 03:40:02.733 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAA -- done()
4922006-09-16 03:40:02.733 VideoOutputXv: DiscardFrames(1)
4932006-09-16 03:40:02.734 VideoOutputXv: DiscardFrames() 1: AAAAAAAAAAAAAAAA
4942006-09-16 03:40:02.734 VideoOutputXv: DiscardFrames() 2: AAAAAAAAAAAAAAAA
4952006-09-16 03:40:02.734 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAA -- done()
4962006-09-16 03:40:02.736 TV: StartPlayer(): took 3201 ms to start player.
4972006-09-16 03:40:02.736 TV: Changing from None to WatchingLiveTV
4982006-09-16 03:40:02.737 AO: OutputAudioLoop: audio paused
4992006-09-16 03:40:02.737 AO: 60928 bytes free on soundcard
5002006-09-16 03:40:02.745 AO: 62400 bytes free on soundcard
5012006-09-16 03:40:02.747 write -> 15 35      QUERY_RECORDER 1[]:[]FRONTEND_READY
5022006-09-16 03:40:02.749 read  <- 15 2       ok
5032006-09-16 03:40:02.749 write -> 15 30      QUERY_RECORDER 1[]:[]GET_INPUT
5042006-09-16 03:40:02.750 read  <- 15 10      television
5052006-09-16 03:40:02.752 AO: 59648 bytes free on soundcard
5062006-09-16 03:40:02.760 AO: 61184 bytes free on soundcard
5072006-09-16 03:40:02.762 The realtime priority setting is not enabled.
5082006-09-16 03:40:02.768 AO: 62720 bytes free on soundcard
5092006-09-16 03:40:02.776 AO: 60128 bytes free on soundcard
5102006-09-16 03:40:02.784 AO: 61760 bytes free on soundcard
5112006-09-16 03:40:02.792 AO: 59104 bytes free on soundcard
5122006-09-16 03:40:02.800 AO: 60704 bytes free on soundcard
5132006-09-16 03:40:02.808 AO: 62176 bytes free on soundcard
5142006-09-16 03:40:02.816 AO: 59648 bytes free on soundcard
5152006-09-16 03:40:02.825 AO: 61440 bytes free on soundcard
5162006-09-16 03:40:02.833 AO: 58912 bytes free on soundcard
5172006-09-16 03:40:02.840 AO: 60160 bytes free on soundcard
5182006-09-16 03:40:02.848 AO: 61728 bytes free on soundcard
5192006-09-16 03:40:03.198 AO: 65536 bytes free on soundcard
5202006-09-16 03:40:03.208 AO: 63232 bytes free on soundcard
5212006-09-16 03:40:03.230 AO: 63456 bytes free on soundcard
5222006-09-16 03:40:03.237 AO: 60576 bytes free on soundcard
5232006-09-16 03:40:03.244 AO: 61952 bytes free on soundcard
5242006-09-16 03:40:03.254 AO: 59776 bytes free on soundcard
5252006-09-16 03:40:03.260 AO: 60960 bytes free on soundcard
5262006-09-16 03:40:03.268 AO: 62560 bytes free on soundcard
5272006-09-16 03:40:03.276 AO: 59936 bytes free on soundcard
5282006-09-16 03:40:03.277 nVidiaVideoSync: Could not open device /dev/nvidia0, No such device or address
5292006-09-16 03:40:03.292 AO: 62944 bytes free on soundcard
5302006-09-16 03:40:03.303 AO: 61024 bytes free on soundcard
5312006-09-16 03:40:03.304 AFD: video timecode 90039 79239 880 612
5322006-09-16 03:40:03.311 AFD: audio timecode 81011 81011 900 924
5332006-09-16 03:40:03.311 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=900
5342006-09-16 03:40:03.314 AFD: audio timecode 83171 83171 924 948
5352006-09-16 03:40:03.314 AO: _AddSamples bytes=4608, used=4609, free=763391, timecode=924
5362006-09-16 03:40:03.317 AO: 63776 bytes free on soundcard
5372006-09-16 03:40:03.322 AFD: audio timecode 85331 85331 948 972
5382006-09-16 03:40:03.322 AO: _AddSamples bytes=4608, used=9217, free=758783, timecode=948
5392006-09-16 03:40:03.324 AFD: audio timecode 87491 87491 972 996
5402006-09-16 03:40:03.324 AO: _AddSamples bytes=4608, used=13825, free=754175, timecode=972
5412006-09-16 03:40:03.328 AO: 61696 bytes free on soundcard
5422006-09-16 03:40:03.342 AO: 60320 bytes free on soundcard
5432006-09-16 03:40:03.348 AO: 61472 bytes free on soundcard
5442006-09-16 03:40:03.348 AFD: video timecode 82839 82839 920 996
5452006-09-16 03:40:03.358 AFD: audio timecode 89651 89651 996 1020
5462006-09-16 03:40:03.358 AO: _AddSamples bytes=4608, used=18433, free=749567, timecode=996
5472006-09-16 03:40:03.361 AO: 59872 bytes free on soundcard
5482006-09-16 03:40:03.369 AO: 61312 bytes free on soundcard
5492006-09-16 03:40:03.375 Using audio as timebase
5502006-09-16 03:40:03.375 Video timing method: DRM
5512006-09-16 03:40:03.375 Refresh rate: 20000, frame interval: 40000
5522006-09-16 03:40:03.376 AO: 62720 bytes free on soundcard
5532006-09-16 03:40:03.380 AFD: video timecode 86439 86439 960 1020
5542006-09-16 03:40:03.381 AFD: audio timecode 91811 91811 1020 1044
5552006-09-16 03:40:03.382 AO: _AddSamples bytes=4608, used=23041, free=744959, timecode=1020
5562006-09-16 03:40:03.383 AFD: audio timecode 93971 93971 1044 1068
5572006-09-16 03:40:03.384 AO: _AddSamples bytes=4608, used=27649, free=740351, timecode=1044
5582006-09-16 03:40:03.388 AO: 60960 bytes free on soundcard
5592006-09-16 03:40:03.399 AO: 63136 bytes free on soundcard
5602006-09-16 03:40:03.404 AFD: video timecode 100839 90039 1000 1068
5612006-09-16 03:40:03.407 AFD: audio timecode 96131 96131 1068 1092
5622006-09-16 03:40:03.408 AO: _AddSamples bytes=4608, used=32257, free=735743, timecode=1068
5632006-09-16 03:40:03.409 AFD: audio timecode 98291 98291 1092 1116
5642006-09-16 03:40:03.409 AO: _AddSamples bytes=4608, used=36865, free=731135, timecode=1092
5652006-09-16 03:40:03.412 AO: 61472 bytes free on soundcard
5662006-09-16 03:40:03.427 AO: 60160 bytes free on soundcard
5672006-09-16 03:40:03.432 AFD: video timecode 93639 93639 1040 1116
5682006-09-16 03:40:03.436 AO: 61952 bytes free on soundcard
5692006-09-16 03:40:03.440 AFD: audio timecode 100451 100451 1116 1140
5702006-09-16 03:40:03.440 AO: _AddSamples bytes=4608, used=41473, free=726527, timecode=1116
5712006-09-16 03:40:03.452 AO: 60960 bytes free on soundcard
5722006-09-16 03:40:03.460 AO: 62496 bytes free on soundcard
5732006-09-16 03:40:03.464 AFD: video timecode 97239 97239 1080 1140
5742006-09-16 03:40:03.472 AFD: audio timecode 102611 102611 1140 1164
5752006-09-16 03:40:03.472 AO: _AddSamples bytes=4608, used=46081, free=721919, timecode=1140
5762006-09-16 03:40:03.474 AFD: audio timecode 104771 104771 1164 1188
5772006-09-16 03:40:03.474 AO: _AddSamples bytes=4608, used=50689, free=717311, timecode=1164
5782006-09-16 03:40:03.476 AO: 61440 bytes free on soundcard
5792006-09-16 03:40:03.487 AO: 59392 bytes free on soundcard
5802006-09-16 03:40:03.500 AO: 61952 bytes free on soundcard
5812006-09-16 03:40:03.508 AO: 59392 bytes free on soundcard
5822006-09-16 03:40:03.512 AFD: video timecode 111638 100839 1120 1188
5832006-09-16 03:40:03.513 AFD: audio timecode 106931 106931 1188 1212
5842006-09-16 03:40:03.514 AO: _AddSamples bytes=4608, used=55297, free=712703, timecode=1188
5852006-09-16 03:40:03.517 AFD: audio timecode 109090 109090 1212 1236
5862006-09-16 03:40:03.519 AO: _AddSamples bytes=4608, used=59905, free=708095, timecode=1212
5872006-09-16 03:40:03.522 AO: 62080 bytes free on soundcard
5882006-09-16 03:40:03.532 AO: 59904 bytes free on soundcard
5892006-09-16 03:40:03.544 AO: 62176 bytes free on soundcard
5902006-09-16 03:40:03.544 NVP: A/V Divergence: 0, Rate: 0, Warpfactor: 1, warpfactor_avg: 1
5912006-09-16 03:40:03.548 AFD: video timecode 104439 104439 1160 1236
5922006-09-16 03:40:03.553 AFD: audio timecode 111250 111250 1236 1260
5932006-09-16 03:40:03.553 AO: _AddSamples bytes=4608, used=64513, free=703487, timecode=1236
5942006-09-16 03:40:03.557 AO: OutputAudioLoop: Play Event
5952006-09-16 03:40:03.557 AO: Broadcasting free space avail
5962006-09-16 03:40:03.557 AO: Broadcasting free space avail
5972006-09-16 03:40:03.558 AO: Broadcasting free space avail
5982006-09-16 03:40:03.558 AO: Broadcasting free space avail
5992006-09-16 03:40:03.558 AO: Broadcasting free space avail
6002006-09-16 03:40:03.558 AO: Broadcasting free space avail
6012006-09-16 03:40:03.559 AO: Broadcasting free space avail
6022006-09-16 03:40:03.559 AO: Broadcasting free space avail
6032006-09-16 03:40:03.559 AO: Broadcasting free space avail
6042006-09-16 03:40:03.560 AO: Broadcasting free space avail
6052006-09-16 03:40:03.560 AO: Broadcasting free space avail
6062006-09-16 03:40:03.560 AO: Broadcasting free space avail
6072006-09-16 03:40:03.560 AO: Broadcasting free space avail
6082006-09-16 03:40:03.561 AO: Broadcasting free space avail
6092006-09-16 03:40:03.561 AO: audio waiting for space on soundcard: have 4032 need 4096
6102006-09-16 03:40:03.579 AO: Broadcasting free space avail
6112006-09-16 03:40:03.580 AO: audio waiting for space on soundcard: have 3520 need 4096
6122006-09-16 03:40:03.584 AFD: video timecode 108038 108038 1200 1260
6132006-09-16 03:40:03.589 AFD: audio timecode 113410 113410 1260 1284
6142006-09-16 03:40:03.590 AO: _AddSamples bytes=4608, used=7681, free=760319, timecode=1260
6152006-09-16 03:40:03.594 AFD: audio timecode 115570 115570 1284 1308
6162006-09-16 03:40:03.594 AO: _AddSamples bytes=4608, used=12289, free=755711, timecode=1284
6172006-09-16 03:40:03.595 AFD: HandleGopStart: gopset not set, syncing positionMap
6182006-09-16 03:40:03.595 Resyncing position map. posmapStarted = 0 livetv(1) watchingRec(1)
6192006-09-16 03:40:03.599 AO: Broadcasting free space avail
6202006-09-16 03:40:03.599 AO: audio waiting for space on soundcard: have 3264 need 4096
6212006-09-16 03:40:03.605 Position map filled from DB to: 6
6222006-09-16 03:40:03.605 SyncPositionMap watchingrecording, from DB: 6 entries
6232006-09-16 03:40:03.605 write -> 15 39      QUERY_RECORDER 1[]:[]GET_FRAMES_WRITTEN
6242006-09-16 03:40:03.609 read  <- 15 9       0[]:[]108
6252006-09-16 03:40:03.609 Filling position map from 7 to 9
6262006-09-16 03:40:03.610 write -> 15 50      QUERY_RECORDER 1[]:[]FILL_POSITION_MAP[]:[]7[]:[]9
6272006-09-16 03:40:03.611 read  <- 15 85      0[]:[]7[]:[]0[]:[]2316288[]:[]0[]:[]8[]:[]0[]:[]2697216[]:[]0[]:[...
6282006-09-16 03:40:03.612 Position map filled from Encoder to: 9
6292006-09-16 03:40:03.612 SyncPositionMap watchingrecording total: 9 entries
6302006-09-16 03:40:03.612 SyncPositionMap, new totframes: 108, new length: 4, posMap size: 9
6312006-09-16 03:40:03.613 AFD: HandleGopStart: Initial key frame distance: 12.
6322006-09-16 03:40:03.616 AO: Broadcasting free space avail
6332006-09-16 03:40:03.616 AO: audio waiting for space on soundcard: have 2368 need 4096
6342006-09-16 03:40:03.632 AO: Broadcasting free space avail
6352006-09-16 03:40:03.632 AO: audio waiting for space on soundcard: have 1344 need 4096
6362006-09-16 03:40:03.644 AO: audio waiting for space on soundcard: have 3552 need 4096
6372006-09-16 03:40:03.664 AO: Broadcasting free space avail
6382006-09-16 03:40:03.664 AO: audio waiting for buffer to fill: have 512 want 4096
6392006-09-16 03:40:03.665 AO: Broadcasting free space avail
6402006-09-16 03:40:03.672 AO: audio waiting for buffer to fill: have 512 want 4096
6412006-09-16 03:40:03.672 AO: Broadcasting free space avail
6422006-09-16 03:40:03.678 AFD: video timecode 122438 111638 1240 1308
6432006-09-16 03:40:03.680 AFD: audio timecode 117730 117730 1308 1332
6442006-09-16 03:40:03.681 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=1308
6452006-09-16 03:40:03.682 AFD: audio timecode 119890 119890 1332 1356
6462006-09-16 03:40:03.683 AO: _AddSamples bytes=4608, used=5121, free=762879, timecode=1332
6472006-09-16 03:40:03.686 AO: Broadcasting free space avail
6482006-09-16 03:40:03.686 AO: audio waiting for space on soundcard: have 3488 need 4096
6492006-09-16 03:40:03.696 AO: Broadcasting free space avail
6502006-09-16 03:40:03.696 AO: audio waiting for buffer to fill: have 1536 want 4096
6512006-09-16 03:40:03.696 AO: Broadcasting free space avail
6522006-09-16 03:40:03.709 AO: audio waiting for buffer to fill: have 1536 want 4096
6532006-09-16 03:40:03.710 AO: Broadcasting free space avail
6542006-09-16 03:40:03.717 AO: audio waiting for buffer to fill: have 1536 want 4096
6552006-09-16 03:40:03.717 AO: Broadcasting free space avail
6562006-09-16 03:40:03.724 AFD: video timecode 115238 115238 1280 1356
6572006-09-16 03:40:03.727 AFD: audio timecode 122050 122050 1356 1380
6582006-09-16 03:40:03.728 AO: _AddSamples bytes=4608, used=1537, free=766463, timecode=1356
6592006-09-16 03:40:03.730 AO: Broadcasting free space avail
6602006-09-16 03:40:03.731 AO: audio waiting for buffer to fill: have 2048 want 4096
6612006-09-16 03:40:03.731 AO: Broadcasting free space avail
6622006-09-16 03:40:03.744 AO: audio waiting for buffer to fill: have 2048 want 4096
6632006-09-16 03:40:03.744 AO: Broadcasting free space avail
6642006-09-16 03:40:03.747 NVP: A/V Divergence: -0.775, Rate: -0.775, Warpfactor: 0.9995, warpfactor_avg: 1
6652006-09-16 03:40:03.752 AO: audio waiting for buffer to fill: have 2048 want 4096
6662006-09-16 03:40:03.752 AO: Broadcasting free space avail
6672006-09-16 03:40:03.752 AFD: video timecode 118838 118838 1320 1380
6682006-09-16 03:40:03.754 AFD: audio timecode 124210 124210 1380 1404
6692006-09-16 03:40:03.754 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=1380
6702006-09-16 03:40:03.756 AFD: audio timecode 126370 126370 1404 1428
6712006-09-16 03:40:03.756 AO: _AddSamples bytes=4608, used=6657, free=761343, timecode=1404
6722006-09-16 03:40:03.761 AO: Broadcasting free space avail
6732006-09-16 03:40:03.761 AO: Broadcasting free space avail
6742006-09-16 03:40:03.761 AO: audio waiting for buffer to fill: have 3072 want 4096
6752006-09-16 03:40:03.762 AO: Broadcasting free space avail
6762006-09-16 03:40:03.776 AO: audio waiting for buffer to fill: have 3072 want 4096
6772006-09-16 03:40:03.776 AO: Broadcasting free space avail
6782006-09-16 03:40:03.788 AO: audio waiting for buffer to fill: have 3072 want 4096
6792006-09-16 03:40:03.792 AO: Broadcasting free space avail
6802006-09-16 03:40:03.792 AFD: video timecode 133238 122438 1360 1428
6812006-09-16 03:40:03.796 AFD: audio timecode 128530 128530 1428 1452
6822006-09-16 03:40:03.796 AO: _AddSamples bytes=4608, used=3073, free=764927, timecode=1428
6832006-09-16 03:40:03.798 AFD: audio timecode 130690 130690 1452 1476
6842006-09-16 03:40:03.800 AO: _AddSamples bytes=4608, used=7681, free=760319, timecode=1452
6852006-09-16 03:40:03.806 AO: Broadcasting free space avail
6862006-09-16 03:40:03.806 AO: Broadcasting free space avail
6872006-09-16 03:40:03.807 AO: audio waiting for space on soundcard: have 2080 need 4096
6882006-09-16 03:40:03.823 AO: Broadcasting free space avail
6892006-09-16 03:40:03.823 AO: Broadcasting free space avail
6902006-09-16 03:40:03.828 AO: Broadcasting free space avail
6912006-09-16 03:40:03.833 AFD: video timecode 126038 126038 1400 1476
6922006-09-16 03:40:03.841 AFD: audio timecode 132850 132850 1476 1500
6932006-09-16 03:40:03.841 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=1476
6942006-09-16 03:40:03.840 AO: Broadcasting free space avail
6952006-09-16 03:40:03.848 AO: Broadcasting free space avail
6962006-09-16 03:40:03.855 AO: audio waiting for buffer to fill: have 512 want 4096
6972006-09-16 03:40:03.855 AO: Broadcasting free space avail
6982006-09-16 03:40:03.859 NVP: A/V Divergence: -2.08125, Rate: -1.30625, Warpfactor: 0.999, warpfactor_avg: 1
6992006-09-16 03:40:03.860 AO: audio waiting for buffer to fill: have 512 want 4096
7002006-09-16 03:40:03.860 AO: Broadcasting free space avail
7012006-09-16 03:40:03.880 AO: audio waiting for buffer to fill: have 512 want 4096
7022006-09-16 03:40:03.880 AO: Broadcasting free space avail
7032006-09-16 03:40:03.892 AO: audio waiting for buffer to fill: have 512 want 4096
7042006-09-16 03:40:03.892 AO: Broadcasting free space avail
7052006-09-16 03:40:03.893 AFD: video timecode 129638 129638 1440 1500
7062006-09-16 03:40:03.901 AFD: audio timecode 135010 135010 1500 1524
7072006-09-16 03:40:03.901 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=1500
7082006-09-16 03:40:03.906 AO: Broadcasting free space avail
7092006-09-16 03:40:03.906 AO: audio waiting for buffer to fill: have 1024 want 4096
7102006-09-16 03:40:03.906 AO: Broadcasting free space avail
7112006-09-16 03:40:03.903 AFD: audio timecode 137170 137170 1524 1548
7122006-09-16 03:40:03.907 AO: _AddSamples bytes=4608, used=1025, free=766975, timecode=1524
7132006-09-16 03:40:03.910 NVP: A/V Divergence: -3.21718, Rate: -1.13593, Warpfactor: 0.998501, warpfactor_avg: 1
7142006-09-16 03:40:03.916 AO: Broadcasting free space avail
7152006-09-16 03:40:03.917 AO: audio waiting for buffer to fill: have 1536 want 4096
7162006-09-16 03:40:03.917 AO: Broadcasting free space avail
7172006-09-16 03:40:03.932 AO: audio waiting for buffer to fill: have 1536 want 4096
7182006-09-16 03:40:03.932 AO: Broadcasting free space avail
7192006-09-16 03:40:03.941 AO: audio waiting for buffer to fill: have 1536 want 4096
7202006-09-16 03:40:03.942 AO: Broadcasting free space avail
7212006-09-16 03:40:03.944 AFD: video timecode 144038 133238 1480 1548
7222006-09-16 03:40:03.948 AO: audio waiting for buffer to fill: have 1536 want 4096
7232006-09-16 03:40:03.948 AO: Broadcasting free space avail
7242006-09-16 03:40:03.955 AFD: audio timecode 139330 139330 1548 1572
7252006-09-16 03:40:03.955 AO: _AddSamples bytes=4608, used=1537, free=766463, timecode=1548
7262006-09-16 03:40:03.959 AFD: audio timecode 141490 141490 1572 1596
7272006-09-16 03:40:03.959 AO: _AddSamples bytes=4608, used=6145, free=761855, timecode=1572
7282006-09-16 03:40:03.960 AO: Broadcasting free space avail
7292006-09-16 03:40:03.961 AO: Broadcasting free space avail
7302006-09-16 03:40:03.961 AO: audio waiting for buffer to fill: have 2560 want 4096
7312006-09-16 03:40:03.961 AO: Broadcasting free space avail
7322006-09-16 03:40:03.962 NVP: Video is 3.21718 frames behind audio (too slow), skipping A/V wait.
7332006-09-16 03:40:03.967 NVP: A/V Divergence: -4.16913, Rate: -0.95195, Warpfactor: 0.998001, warpfactor_avg: 1
7342006-09-16 03:40:03.968 AO: audio waiting for buffer to fill: have 2560 want 4096
7352006-09-16 03:40:03.969 AO: Broadcasting free space avail
7362006-09-16 03:40:03.978 AO: audio waiting for buffer to fill: have 2560 want 4096
7372006-09-16 03:40:03.979 AO: Broadcasting free space avail
7382006-09-16 03:40:03.991 AO: audio waiting for buffer to fill: have 2560 want 4096
7392006-09-16 03:40:03.991 AO: Broadcasting free space avail
7402006-09-16 03:40:03.997 AO: audio waiting for buffer to fill: have 2560 want 4096
7412006-09-16 03:40:03.997 AO: Broadcasting free space avail
7422006-09-16 03:40:03.970 NVP: Video is 4.16913 frames behind audio (too slow), skipping A/V wait.
7432006-09-16 03:40:04.012 AFD: video timecode 136838 136838 1520 1596
7442006-09-16 03:40:04.014 AFD: audio timecode 143650 143650 1596 1620
7452006-09-16 03:40:04.014 AO: _AddSamples bytes=4608, used=2561, free=765439, timecode=1596
7462006-09-16 03:40:04.015 AO: Broadcasting free space avail
7472006-09-16 03:40:04.015 AO: audio waiting for buffer to fill: have 3072 want 4096
7482006-09-16 03:40:04.015 AO: Broadcasting free space avail
7492006-09-16 03:40:04.020 AO: audio waiting for buffer to fill: have 3072 want 4096
7502006-09-16 03:40:04.020 AO: Broadcasting free space avail
7512006-09-16 03:40:04.028 AO: audio waiting for buffer to fill: have 3072 want 4096
7522006-09-16 03:40:04.028 AO: Broadcasting free space avail
7532006-09-16 03:40:04.030 NVP: A/V Divergence: -4.84557, Rate: -0.67645, Warpfactor: 0.997502, warpfactor_avg: 0.999999
7542006-09-16 03:40:04.033 NVP: Video is 4.84557 frames behind audio (too slow), skipping A/V wait.
7552006-09-16 03:40:04.036 AO: audio waiting for buffer to fill: have 3072 want 4096
7562006-09-16 03:40:04.036 AO: Broadcasting free space avail
7572006-09-16 03:40:04.050 AO: audio waiting for buffer to fill: have 3072 want 4096
7582006-09-16 03:40:04.051 AO: Broadcasting free space avail
7592006-09-16 03:40:04.062 AO: audio waiting for buffer to fill: have 3072 want 4096
7602006-09-16 03:40:04.062 AO: Broadcasting free space avail
7612006-09-16 03:40:04.069 AFD: video timecode 140438 140438 1560 1620
7622006-09-16 03:40:04.071 AFD: audio timecode 145810 145810 1620 1644
7632006-09-16 03:40:04.071 AO: _AddSamples bytes=4608, used=3073, free=764927, timecode=1620
7642006-09-16 03:40:04.078 AFD: audio timecode 147970 147970 1644 1668
7652006-09-16 03:40:04.079 AO: _AddSamples bytes=4608, used=7681, free=760319, timecode=1644
7662006-09-16 03:40:04.080 AO: Broadcasting free space avail
7672006-09-16 03:40:04.082 AO: Broadcasting free space avail
7682006-09-16 03:40:04.083 AO: Broadcasting free space avail
7692006-09-16 03:40:04.083 AO: Broadcasting free space avail
7702006-09-16 03:40:04.084 NVP: A/V Divergence: -5.32793, Rate: -0.48235, Warpfactor: 0.997004, warpfactor_avg: 0.999999
7712006-09-16 03:40:04.088 AO: Broadcasting free space avail
7722006-09-16 03:40:04.089 NVP: Video is 5.32793 frames behind audio (too slow), skipping A/V wait.
7732006-09-16 03:40:04.095 NVP: A/V Divergence: -5.78968, Rate: -0.46175, Warpfactor: 0.996505, warpfactor_avg: 0.999999
7742006-09-16 03:40:04.096 AO: Broadcasting free space avail
7752006-09-16 03:40:04.110 AO: Broadcasting free space avail
7762006-09-16 03:40:04.116 AFD: video timecode 154838 144038 1600 1668
7772006-09-16 03:40:04.117 AFD: audio timecode 150130 150130 1668 1692
7782006-09-16 03:40:04.118 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=1668
7792006-09-16 03:40:04.119 AFD: audio timecode 152290 152290 1692 1716
7802006-09-16 03:40:04.120 AO: _AddSamples bytes=4608, used=4609, free=763391, timecode=1692
7812006-09-16 03:40:04.123 AO: Broadcasting free space avail
7822006-09-16 03:40:04.123 AO: Broadcasting free space avail
7832006-09-16 03:40:04.124 AO: audio waiting for buffer to fill: have 1024 want 4096
7842006-09-16 03:40:04.124 AO: Broadcasting free space avail
7852006-09-16 03:40:04.137 AO: audio waiting for buffer to fill: have 1024 want 4096
7862006-09-16 03:40:04.138 AO: Broadcasting free space avail
7872006-09-16 03:40:04.144 AO: audio waiting for buffer to fill: have 1024 want 4096
7882006-09-16 03:40:04.144 AO: Broadcasting free space avail
7892006-09-16 03:40:04.148 AFD: video timecode 147638 147638 1640 1716
7902006-09-16 03:40:04.151 AFD: audio timecode 154450 154450 1716 1740
7912006-09-16 03:40:04.155 AO: _AddSamples bytes=4608, used=1025, free=766975, timecode=1716
7922006-09-16 03:40:04.156 AO: Broadcasting free space avail
7932006-09-16 03:40:04.156 AO: audio waiting for buffer to fill: have 1536 want 4096
7942006-09-16 03:40:04.156 AO: Broadcasting free space avail
7952006-09-16 03:40:04.158 NVP: Video is 5.78968 frames behind audio (too slow), skipping A/V wait.
7962006-09-16 03:40:04.164 AO: audio waiting for buffer to fill: have 1536 want 4096
7972006-09-16 03:40:04.165 AO: Broadcasting free space avail
7982006-09-16 03:40:04.167 NVP: A/V Divergence: -6.31725, Rate: -0.527575, Warpfactor: 0.996007, warpfactor_avg: 0.999999
7992006-09-16 03:40:04.173 AO: audio waiting for buffer to fill: have 1536 want 4096
8002006-09-16 03:40:04.173 AO: Broadcasting free space avail
8012006-09-16 03:40:04.177 NVP: Video is 6.31725 frames behind audio (too slow), skipping A/V wait.
8022006-09-16 03:40:04.180 AO: audio waiting for buffer to fill: have 1536 want 4096
8032006-09-16 03:40:04.181 AO: Broadcasting free space avail
8042006-09-16 03:40:04.190 AO: audio waiting for buffer to fill: have 1536 want 4096
8052006-09-16 03:40:04.191 AO: Broadcasting free space avail
8062006-09-16 03:40:04.203 AO: audio waiting for buffer to fill: have 1536 want 4096
8072006-09-16 03:40:04.203 AO: Broadcasting free space avail
8082006-09-16 03:40:04.208 AFD: video timecode 151238 151238 1680 1740
8092006-09-16 03:40:04.210 AFD: audio timecode 156610 156610 1740 1764
8102006-09-16 03:40:04.210 AO: _AddSamples bytes=4608, used=1537, free=766463, timecode=1740
8112006-09-16 03:40:04.212 AO: Broadcasting free space avail
8122006-09-16 03:40:04.212 AO: audio waiting for buffer to fill: have 2048 want 4096
8132006-09-16 03:40:04.212 AO: Broadcasting free space avail
8142006-09-16 03:40:04.211 AFD: audio timecode 158770 158770 1764 1788
8152006-09-16 03:40:04.213 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=1764
8162006-09-16 03:40:04.214 NVP: A/V Divergence: -6.58168, Rate: -0.264425, Warpfactor: 0.995509, warpfactor_avg: 0.999999
8172006-09-16 03:40:04.215 NVP: Video is 6.58168 frames behind audio (too slow), skipping A/V wait.
8182006-09-16 03:40:04.220 NVP: A/V Divergence: -6.7675, Rate: -0.185825, Warpfactor: 0.995011, warpfactor_avg: 0.999998
8192006-09-16 03:40:04.227 AO: Broadcasting free space avail
8202006-09-16 03:40:04.227 AO: audio waiting for buffer to fill: have 2560 want 4096
8212006-09-16 03:40:04.228 AO: Broadcasting free space avail
8222006-09-16 03:40:04.230 NVP: Video is 6.7675 frames behind audio (too slow), skipping A/V wait.
8232006-09-16 03:40:04.235 NVP: A/V Divergence: -6.75063, Rate: 0.016875, Warpfactor: 0.994513, warpfactor_avg: 0.999998
8242006-09-16 03:40:04.240 AO: audio waiting for buffer to fill: have 2560 want 4096
8252006-09-16 03:40:04.240 AO: Broadcasting free space avail
8262006-09-16 03:40:04.250 AO: audio waiting for buffer to fill: have 2560 want 4096
8272006-09-16 03:40:04.251 AO: Broadcasting free space avail
8282006-09-16 03:40:04.251 NVP: Video is 6.75063 frames behind audio (too slow), skipping A/V wait.
8292006-09-16 03:40:04.255 NVP: A/V Divergence: -6.6192, Rate: 0.131425, Warpfactor: 0.994016, warpfactor_avg: 0.999997
8302006-09-16 03:40:04.257 AO: audio waiting for buffer to fill: have 2560 want 4096
8312006-09-16 03:40:04.257 AO: Broadcasting free space avail
8322006-09-16 03:40:04.259 NVP: Video is 6.6192 frames behind audio (too slow), skipping A/V wait.
8332006-09-16 03:40:04.269 NVP: A/V Divergence: -6.3269, Rate: 0.2923, Warpfactor: 0.993519, warpfactor_avg: 0.999997
8342006-09-16 03:40:04.271 AO: audio waiting for buffer to fill: have 2560 want 4096
8352006-09-16 03:40:04.272 AO: Broadcasting free space avail
8362006-09-16 03:40:04.274 NVP: Video is 6.3269 frames behind audio (too slow), skipping A/V wait.
8372006-09-16 03:40:04.283 NVP: A/V Divergence: -5.94518, Rate: 0.381725, Warpfactor: 0.993022, warpfactor_avg: 0.999996
8382006-09-16 03:40:04.285 AO: audio waiting for buffer to fill: have 2560 want 4096
8392006-09-16 03:40:04.286 AO: Broadcasting free space avail
8402006-09-16 03:40:04.293 AO: audio waiting for buffer to fill: have 2560 want 4096
8412006-09-16 03:40:04.293 AO: Broadcasting free space avail
8422006-09-16 03:40:04.294 NVP: Video is 5.94518 frames behind audio (too slow), skipping A/V wait.
8432006-09-16 03:40:04.304 NVP: A/V Divergence: -5.53387, Rate: 0.4113, Warpfactor: 0.992526, warpfactor_avg: 0.999996
8442006-09-16 03:40:04.309 AO: audio waiting for buffer to fill: have 2560 want 4096
8452006-09-16 03:40:04.309 AO: Broadcasting free space avail
8462006-09-16 03:40:04.321 AO: audio waiting for buffer to fill: have 2560 want 4096
8472006-09-16 03:40:04.322 AO: Broadcasting free space avail
8482006-09-16 03:40:04.332 AO: audio waiting for buffer to fill: have 2560 want 4096
8492006-09-16 03:40:04.333 AO: Broadcasting free space avail
8502006-09-16 03:40:04.336 NVP: Video is 5.53387 frames behind audio (too slow), skipping A/V wait.
8512006-09-16 03:40:04.340 AFD: video timecode 165638 154838 1720 1788
8522006-09-16 03:40:04.343 AFD: audio timecode 160930 160930 1788 1812
8532006-09-16 03:40:04.350 NVP: A/V Divergence: -5.2379, Rate: 0.295975, Warpfactor: 0.99203, warpfactor_avg: 0.999995
8542006-09-16 03:40:04.343 AO: _AddSamples bytes=4608, used=2561, free=765439, timecode=1788
8552006-09-16 03:40:04.352 AFD: audio timecode 163090 163090 1812 1836
8562006-09-16 03:40:04.352 AO: _AddSamples bytes=4608, used=7169, free=760831, timecode=1812
8572006-09-16 03:40:04.360 AO: Broadcasting free space avail
8582006-09-16 03:40:04.361 AO: Broadcasting free space avail
8592006-09-16 03:40:04.361 AO: audio waiting for buffer to fill: have 3584 want 4096
8602006-09-16 03:40:04.362 AO: Broadcasting free space avail
8612006-09-16 03:40:04.363 NVP: Video is 5.2379 frames behind audio (too slow), skipping A/V wait.
8622006-09-16 03:40:04.366 NVP: A/V Divergence: -4.92842, Rate: 0.309475, Warpfactor: 0.991534, warpfactor_avg: 0.999995
8632006-09-16 03:40:04.377 AO: audio waiting for buffer to fill: have 3584 want 4096
8642006-09-16 03:40:04.377 AO: Broadcasting free space avail
8652006-09-16 03:40:04.391 AO: audio waiting for buffer to fill: have 3584 want 4096
8662006-09-16 03:40:04.391 AO: Broadcasting free space avail
8672006-09-16 03:40:04.395 NVP: Video is 4.92842 frames behind audio (too slow), skipping A/V wait.
8682006-09-16 03:40:04.400 AFD: video timecode 158438 158438 1760 1836
8692006-09-16 03:40:04.404 AFD: audio timecode 165250 165250 1836 1860
8702006-09-16 03:40:04.405 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=1836
8712006-09-16 03:40:04.407 AO: Broadcasting free space avail
8722006-09-16 03:40:04.407 AO: Broadcasting free space avail
8732006-09-16 03:40:04.407 AO: Broadcasting free space avail
8742006-09-16 03:40:04.411 NVP: A/V Divergence: -4.6588, Rate: 0.269625, Warpfactor: 0.991038, warpfactor_avg: 0.999994
8752006-09-16 03:40:04.416 AO: Broadcasting free space avail
8762006-09-16 03:40:04.425 AO: Broadcasting free space avail
8772006-09-16 03:40:04.426 NVP: Video is 4.6588 frames behind audio (too slow), skipping A/V wait.
8782006-09-16 03:40:04.433 NVP: A/V Divergence: -4.3941, Rate: 0.2647, Warpfactor: 0.990542, warpfactor_avg: 0.999994
8792006-09-16 03:40:04.434 AO: Broadcasting free space avail
8802006-09-16 03:40:04.443 AO: Broadcasting free space avail
8812006-09-16 03:40:04.444 NVP: Video is 4.3941 frames behind audio (too slow), skipping A/V wait.
8822006-09-16 03:40:04.448 NVP: A/V Divergence: -4.05807, Rate: 0.336025, Warpfactor: 0.990047, warpfactor_avg: 0.999993
8832006-09-16 03:40:04.449 AO: Broadcasting free space avail
8842006-09-16 03:40:04.464 AO: Broadcasting free space avail
8852006-09-16 03:40:04.475 AO: Broadcasting free space avail
8862006-09-16 03:40:04.476 AFD: video timecode 162038 162038 1800 1860
8872006-09-16 03:40:04.479 AFD: audio timecode 167410 167410 1860 1884
8882006-09-16 03:40:04.481 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=1860
8892006-09-16 03:40:04.483 AFD: audio timecode 169570 169570 1884 1908
8902006-09-16 03:40:04.483 AO: _AddSamples bytes=4608, used=4609, free=763391, timecode=1884
8912006-09-16 03:40:04.489 AO: Broadcasting free space avail
8922006-09-16 03:40:04.489 AO: Broadcasting free space avail
8932006-09-16 03:40:04.490 AO: audio waiting for buffer to fill: have 1024 want 4096
8942006-09-16 03:40:04.490 AO: Broadcasting free space avail
8952006-09-16 03:40:04.504 AO: audio waiting for buffer to fill: have 1024 want 4096
8962006-09-16 03:40:04.505 AO: Broadcasting free space avail
8972006-09-16 03:40:04.512 AFD: video timecode 176438 165638 1840 1908
8982006-09-16 03:40:04.514 AFD: audio timecode 171730 171730 1908 1932
8992006-09-16 03:40:04.514 AO: _AddSamples bytes=4608, used=1025, free=766975, timecode=1908
9002006-09-16 03:40:04.516 AO: Broadcasting free space avail
9012006-09-16 03:40:04.516 AO: audio waiting for buffer to fill: have 1536 want 4096
9022006-09-16 03:40:04.517 AO: Broadcasting free space avail
9032006-09-16 03:40:04.519 AFD: audio timecode 173889 173889 1932 1956
9042006-09-16 03:40:04.520 AO: _AddSamples bytes=4608, used=1537, free=766463, timecode=1932
9052006-09-16 03:40:04.532 AO: Broadcasting free space avail
9062006-09-16 03:40:04.533 AO: audio waiting for buffer to fill: have 2048 want 4096
9072006-09-16 03:40:04.533 AO: Broadcasting free space avail
9082006-09-16 03:40:04.543 AO: audio waiting for buffer to fill: have 2048 want 4096
9092006-09-16 03:40:04.544 AO: Broadcasting free space avail
9102006-09-16 03:40:04.544 NVP: Video is 4.05807 frames behind audio (too slow), skipping A/V wait.
9112006-09-16 03:40:04.548 AFD: video timecode 169238 169238 1880 1956
9122006-09-16 03:40:04.550 AFD: audio timecode 176049 176049 1956 1980
9132006-09-16 03:40:04.550 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=1956
9142006-09-16 03:40:04.558 NVP: A/V Divergence: -4.18105, Rate: -0.122975, Warpfactor: 0.989552, warpfactor_avg: 0.999992
9152006-09-16 03:40:04.563 AO: Broadcasting free space avail
9162006-09-16 03:40:04.563 AO: audio waiting for buffer to fill: have 2560 want 4096
9172006-09-16 03:40:04.564 AO: Broadcasting free space avail
9182006-09-16 03:40:04.567 NVP: Video is 4.18105 frames behind audio (too slow), skipping A/V wait.
9192006-09-16 03:40:04.572 NVP: A/V Divergence: -4.16703, Rate: 0.014025, Warpfactor: 0.989057, warpfactor_avg: 0.999992
9202006-09-16 03:40:04.576 AO: audio waiting for buffer to fill: have 2560 want 4096
9212006-09-16 03:40:04.577 AO: Broadcasting free space avail
9222006-09-16 03:40:04.581 NVP: Video is 4.16703 frames behind audio (too slow), skipping A/V wait.
9232006-09-16 03:40:04.586 NVP: A/V Divergence: -3.994, Rate: 0.173025, Warpfactor: 0.988562, warpfactor_avg: 0.999991
9242006-09-16 03:40:04.588 AO: audio waiting for buffer to fill: have 2560 want 4096
9252006-09-16 03:40:04.589 AO: Broadcasting free space avail
9262006-09-16 03:40:04.594 NVP: Video is 3.994 frames behind audio (too slow), skipping A/V wait.
9272006-09-16 03:40:04.601 AO: audio waiting for buffer to fill: have 2560 want 4096
9282006-09-16 03:40:04.602 AO: Broadcasting free space avail
9292006-09-16 03:40:04.599 NVP: A/V Divergence: -3.6955, Rate: 0.2985, Warpfactor: 0.988068, warpfactor_avg: 0.99999
9302006-09-16 03:40:04.611 AO: audio waiting for buffer to fill: have 2560 want 4096
9312006-09-16 03:40:04.611 AO: Broadcasting free space avail
9322006-09-16 03:40:04.625 AO: audio waiting for buffer to fill: have 2560 want 4096
9332006-09-16 03:40:04.625 AO: Broadcasting free space avail
9342006-09-16 03:40:04.630 NVP: Video is 3.6955 frames behind audio (too slow), skipping A/V wait.
9352006-09-16 03:40:04.632 AO: audio waiting for buffer to fill: have 2560 want 4096
9362006-09-16 03:40:04.632 AO: Broadcasting free space avail
9372006-09-16 03:40:04.636 AFD: video timecode 172838 172838 1920 1980
9382006-09-16 03:40:04.637 AFD: audio timecode 178209 178209 1980 2004
9392006-09-16 03:40:04.638 AO: _AddSamples bytes=4608, used=2561, free=765439, timecode=1980
9402006-09-16 03:40:04.647 NVP: A/V Divergence: -3.44662, Rate: 0.248875, Warpfactor: 0.987574, warpfactor_avg: 0.999989
9412006-09-16 03:40:04.648 AFD: audio timecode 180369 180369 2004 2028
9422006-09-16 03:40:04.648 AO: _AddSamples bytes=4608, used=7169, free=760831, timecode=2004
9432006-09-16 03:40:04.651 AO: Broadcasting free space avail
9442006-09-16 03:40:04.655 AO: Broadcasting free space avail
9452006-09-16 03:40:04.656 AO: audio waiting for buffer to fill: have 3584 want 4096
9462006-09-16 03:40:04.656 AO: Broadcasting free space avail
9472006-09-16 03:40:04.657 NVP: Video is 3.44662 frames behind audio (too slow), skipping A/V wait.
9482006-09-16 03:40:04.666 NVP: A/V Divergence: -3.1412, Rate: 0.305425, Warpfactor: 0.98708, warpfactor_avg: 0.999988
9492006-09-16 03:40:04.668 AO: audio waiting for buffer to fill: have 3584 want 4096
9502006-09-16 03:40:04.669 AO: Broadcasting free space avail
9512006-09-16 03:40:04.670 NVP: Video is 3.1412 frames behind audio (too slow), skipping A/V wait.
9522006-09-16 03:40:04.671 NVP: prebuffering pause
9532006-09-16 03:40:04.671 NVP: Waiting for prebuffer.. 0 AAAAAAAADAALDALA
9542006-09-16 03:40:04.688 AO: OutputAudioLoop: audio paused
9552006-09-16 03:40:04.689 AO: 63776 bytes free on soundcard
9562006-09-16 03:40:04.699 AO: 61600 bytes free on soundcard
9572006-09-16 03:40:04.699 AFD: video timecode 187238 176438 1960 2028
9582006-09-16 03:40:04.701 AFD: audio timecode 182529 182529 2028 2052
9592006-09-16 03:40:04.701 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=2028
9602006-09-16 03:40:04.703 AFD: audio timecode 184689 184689 2052 2076
9612006-09-16 03:40:04.703 AO: _AddSamples bytes=4608, used=8193, free=759807, timecode=2052
9622006-09-16 03:40:04.713 AO: 60352 bytes free on soundcard
9632006-09-16 03:40:04.723 AO: 62272 bytes free on soundcard
9642006-09-16 03:40:04.739 NVP: A/V Divergence: -2.7434, Rate: 0.3978, Warpfactor: 0.986587, warpfactor_avg: 0.999987
9652006-09-16 03:40:04.732 AFD: video timecode 180038 180038 2000 2076
9662006-09-16 03:40:04.744 AO: OutputAudioLoop: Play Event
9672006-09-16 03:40:04.745 AO: Broadcasting free space avail
9682006-09-16 03:40:04.749 AO: Broadcasting free space avail
9692006-09-16 03:40:04.749 AO: Broadcasting free space avail
9702006-09-16 03:40:04.749 AO: audio waiting for buffer to fill: have 512 want 4096
9712006-09-16 03:40:04.750 AO: Broadcasting free space avail
9722006-09-16 03:40:04.752 AFD: audio timecode 186849 186849 2076 2100
9732006-09-16 03:40:04.753 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=2076
9742006-09-16 03:40:04.761 AO: Broadcasting free space avail
9752006-09-16 03:40:04.761 AO: audio waiting for buffer to fill: have 1024 want 4096
9762006-09-16 03:40:04.761 AO: Broadcasting free space avail
9772006-09-16 03:40:04.764 NVP: A/V Divergence: -2.33255, Rate: 0.41085, Warpfactor: 0.986093, warpfactor_avg: 0.999987
9782006-09-16 03:40:04.777 AO: audio waiting for buffer to fill: have 1024 want 4096
9792006-09-16 03:40:04.778 AO: Broadcasting free space avail
9802006-09-16 03:40:04.787 AO: audio waiting for buffer to fill: have 1024 want 4096
9812006-09-16 03:40:04.787 AO: Broadcasting free space avail
9822006-09-16 03:40:04.792 AFD: video timecode 183638 183638 2040 2100
9832006-09-16 03:40:04.794 AFD: audio timecode 189009 189009 2100 2124
9842006-09-16 03:40:04.794 AO: _AddSamples bytes=4608, used=1025, free=766975, timecode=2100
9852006-09-16 03:40:04.795 AFD: audio timecode 191169 191169 2124 2148
9862006-09-16 03:40:04.797 AO: _AddSamples bytes=4608, used=5633, free=762367, timecode=2124
9872006-09-16 03:40:04.797 AO: Broadcasting free space avail
9882006-09-16 03:40:04.797 AO: Broadcasting free space avail
9892006-09-16 03:40:04.798 AO: audio waiting for buffer to fill: have 2048 want 4096
9902006-09-16 03:40:04.798 AO: Broadcasting free space avail
9912006-09-16 03:40:04.802 NVP: A/V Divergence: -1.9744, Rate: 0.35815, Warpfactor: 0.986586, warpfactor_avg: 0.999986
9922006-09-16 03:40:04.806 AO: audio waiting for buffer to fill: have 2048 want 4096
9932006-09-16 03:40:04.806 AO: Broadcasting free space avail
9942006-09-16 03:40:04.807 NVP: prebuffering pause
9952006-09-16 03:40:04.807 NVP: Waiting for prebuffer.. 0 AAALAAAAAADDAALA
9962006-09-16 03:40:04.813 AO: OutputAudioLoop: audio paused
9972006-09-16 03:40:04.814 AO: 50944 bytes free on soundcard
9982006-09-16 03:40:04.820 AO: 52128 bytes free on soundcard
9992006-09-16 03:40:04.828 AO: 53632 bytes free on soundcard
10002006-09-16 03:40:04.832 AFD: video timecode 198038 187238 2080 2148
10012006-09-16 03:40:04.835 AFD: audio timecode 193329 193329 2148 2172
10022006-09-16 03:40:04.835 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=2148
10032006-09-16 03:40:04.836 AFD: audio timecode 195489 195489 2172 2196
10042006-09-16 03:40:04.837 AO: _AddSamples bytes=4608, used=6657, free=761343, timecode=2172
10052006-09-16 03:40:04.844 AO: 56736 bytes free on soundcard
10062006-09-16 03:40:04.855 AO: 58848 bytes free on soundcard
10072006-09-16 03:40:04.861 AFD: video timecode 190838 190838 2120 2196
10082006-09-16 03:40:04.863 AFD: audio timecode 197649 197649 2196 2220
10092006-09-16 03:40:04.863 AO: _AddSamples bytes=4608, used=11265, free=756735, timecode=2196
10102006-09-16 03:40:04.865 AO: 60800 bytes free on soundcard
10112006-09-16 03:40:04.871 NVP: A/V Divergence: -1.5683, Rate: 0.4061, Warpfactor: 0.98708, warpfactor_avg: 0.999985
10122006-09-16 03:40:04.872 AO: OutputAudioLoop: Play Event
10132006-09-16 03:40:04.872 AO: Broadcasting free space avail
10142006-09-16 03:40:04.873 AO: Broadcasting free space avail
10152006-09-16 03:40:04.873 AO: Broadcasting free space avail
10162006-09-16 03:40:04.873 AO: audio waiting for buffer to fill: have 3584 want 4096
10172006-09-16 03:40:04.874 AO: Broadcasting free space avail
10182006-09-16 03:40:04.882 NVP: A/V Divergence: -1.45123, Rate: 0.117075, Warpfactor: 0.987573, warpfactor_avg: 0.999984
10192006-09-16 03:40:04.886 AO: audio waiting for buffer to fill: have 3584 want 4096
10202006-09-16 03:40:04.887 AO: Broadcasting free space avail
10212006-09-16 03:40:04.897 AO: audio waiting for buffer to fill: have 3584 want 4096
10222006-09-16 03:40:04.898 AO: Broadcasting free space avail
10232006-09-16 03:40:04.909 AO: audio waiting for buffer to fill: have 3584 want 4096
10242006-09-16 03:40:04.910 AO: Broadcasting free space avail
10252006-09-16 03:40:04.916 AFD: video timecode 194438 194438 2160 2220
10262006-09-16 03:40:04.919 AFD: audio timecode 199809 199809 2220 2244
10272006-09-16 03:40:04.927 NVP: A/V Divergence: -1.33215, Rate: 0.119075, Warpfactor: 0.988067, warpfactor_avg: 0.999983
10282006-09-16 03:40:04.920 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=2220
10292006-09-16 03:40:04.929 AFD: audio timecode 201969 201969 2244 2268
10302006-09-16 03:40:04.929 AO: _AddSamples bytes=4608, used=8193, free=759807, timecode=2244
10312006-09-16 03:40:04.935 AO: Broadcasting free space avail
10322006-09-16 03:40:04.935 AO: Broadcasting free space avail
10332006-09-16 03:40:04.935 AO: Broadcasting free space avail
10342006-09-16 03:40:04.938 NVP: prebuffering pause
10352006-09-16 03:40:04.939 NVP: Waiting for prebuffer.. 0 AAALAALAAAAAADDA
10362006-09-16 03:40:04.936 AO: audio waiting for buffer to fill: have 512 want 4096
10372006-09-16 03:40:04.939 AO: Broadcasting free space avail
10382006-09-16 03:40:04.946 AO: OutputAudioLoop: audio paused
10392006-09-16 03:40:04.947 AO: 51936 bytes free on soundcard
10402006-09-16 03:40:04.952 AO: 52896 bytes free on soundcard
10412006-09-16 03:40:04.961 AO: 54656 bytes free on soundcard
10422006-09-16 03:40:04.968 AO: 55968 bytes free on soundcard
10432006-09-16 03:40:04.972 AFD: video timecode 208837 198038 2200 2268
10442006-09-16 03:40:04.974 AFD: audio timecode 204129 204129 2268 2292
10452006-09-16 03:40:04.974 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=2268
10462006-09-16 03:40:04.982 AFD: audio timecode 206289 206289 2292 2316
10472006-09-16 03:40:04.983 AO: _AddSamples bytes=4608, used=5121, free=762879, timecode=2292
10482006-09-16 03:40:04.988 AO: 59808 bytes free on soundcard
10492006-09-16 03:40:05.004 AO: 62912 bytes free on soundcard
10502006-09-16 03:40:05.008 AFD: video timecode 201638 201638 2240 2316
10512006-09-16 03:40:05.009 AFD: audio timecode 208449 208449 2316 2340
10522006-09-16 03:40:05.010 AO: _AddSamples bytes=4608, used=9729, free=758271, timecode=2316
10532006-09-16 03:40:05.019 AO: 61632 bytes free on soundcard
10542006-09-16 03:40:05.021 NVP: A/V Divergence: -1.1616, Rate: 0.17055, Warpfactor: 0.988561, warpfactor_avg: 0.999982
10552006-09-16 03:40:05.032 AO: OutputAudioLoop: Play Event
10562006-09-16 03:40:05.033 AO: Broadcasting free space avail
10572006-09-16 03:40:05.033 AO: Broadcasting free space avail
10582006-09-16 03:40:05.033 AO: Broadcasting free space avail
10592006-09-16 03:40:05.034 AO: audio waiting for buffer to fill: have 2048 want 4096
10602006-09-16 03:40:05.034 AO: Broadcasting free space avail
10612006-09-16 03:40:05.046 AO: audio waiting for buffer to fill: have 2048 want 4096
10622006-09-16 03:40:05.047 AO: Broadcasting free space avail
10632006-09-16 03:40:05.056 AO: audio waiting for buffer to fill: have 2048 want 4096
10642006-09-16 03:40:05.057 AO: Broadcasting free space avail
10652006-09-16 03:40:05.058 AFD: video timecode 205238 205238 2280 2340
10662006-09-16 03:40:05.059 AFD: audio timecode 210609 210609 2340 2364
10672006-09-16 03:40:05.060 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=2340
10682006-09-16 03:40:05.067 AFD: audio timecode 212769 212769 2364 2388
10692006-09-16 03:40:05.068 AO: _AddSamples bytes=4608, used=6657, free=761343, timecode=2364
10702006-09-16 03:40:05.076 AO: Broadcasting free space avail
10712006-09-16 03:40:05.077 AO: Broadcasting free space avail
10722006-09-16 03:40:05.077 AO: audio waiting for buffer to fill: have 3072 want 4096
10732006-09-16 03:40:05.077 AO: Broadcasting free space avail
10742006-09-16 03:40:05.089 AO: audio waiting for buffer to fill: have 3072 want 4096
10752006-09-16 03:40:05.089 AO: Broadcasting free space avail
10762006-09-16 03:40:05.092 AFD: video timecode 219637 208837 2320 2388
10772006-09-16 03:40:05.094 AFD: audio timecode 214929 214929 2388 2412
10782006-09-16 03:40:05.094 AO: _AddSamples bytes=4608, used=3073, free=764927, timecode=2388
10792006-09-16 03:40:05.096 AFD: audio timecode 217089 217089 2412 2436
10802006-09-16 03:40:05.096 AO: _AddSamples bytes=4608, used=7681, free=760319, timecode=2412
10812006-09-16 03:40:05.101 NVP: A/V Divergence: -1.46495, Rate: -0.30335, Warpfactor: 0.988067, warpfactor_avg: 0.999982
10822006-09-16 03:40:05.102 AO: Broadcasting free space avail
10832006-09-16 03:40:05.102 AO: Broadcasting free space avail
10842006-09-16 03:40:05.103 AO: Broadcasting free space avail
10852006-09-16 03:40:05.103 AO: Broadcasting free space avail
10862006-09-16 03:40:05.110 NVP: A/V Divergence: -1.5362, Rate: -0.07125, Warpfactor: 0.987573, warpfactor_avg: 0.999981
10872006-09-16 03:40:05.118 AO: Broadcasting free space avail
10882006-09-16 03:40:05.138 AO: Broadcasting free space avail
10892006-09-16 03:40:05.144 AFD: video timecode 212437 212437 2360 2436
10902006-09-16 03:40:05.149 AO: Broadcasting free space avail
10912006-09-16 03:40:05.153 NVP: A/V Divergence: -1.5709, Rate: -0.0347, Warpfactor: 0.987136, warpfactor_avg: 0.99998
10922006-09-16 03:40:05.155 AFD: audio timecode 219249 219249 2436 2460
10932006-09-16 03:40:05.156 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=2436
10942006-09-16 03:40:05.159 AO: Broadcasting free space avail
10952006-09-16 03:40:05.160 AO: audio waiting for buffer to fill: have 512 want 4096
10962006-09-16 03:40:05.160 AO: Broadcasting free space avail
10972006-09-16 03:40:05.170 NVP: A/V Divergence: -1.45942, Rate: 0.111475, Warpfactor: 0.98763, warpfactor_avg: 0.999979
10982006-09-16 03:40:05.174 AO: audio waiting for buffer to fill: have 512 want 4096
10992006-09-16 03:40:05.174 AO: Broadcasting free space avail
11002006-09-16 03:40:05.176 NVP: prebuffering pause
11012006-09-16 03:40:05.177 NVP: Waiting for prebuffer.. 0 AAAALDdAALAAAAAA
11022006-09-16 03:40:05.188 AO: OutputAudioLoop: audio paused
11032006-09-16 03:40:05.189 AO: 53280 bytes free on soundcard
11042006-09-16 03:40:05.196 AO: 54816 bytes free on soundcard
11052006-09-16 03:40:05.203 AFD: video timecode 216037 216037 2400 2460
11062006-09-16 03:40:05.205 AFD: audio timecode 221409 221409 2460 2484
11072006-09-16 03:40:05.205 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=2460
11082006-09-16 03:40:05.206 AFD: audio timecode 223569 223569 2484 2508
11092006-09-16 03:40:05.207 AO: _AddSamples bytes=4608, used=5121, free=762879, timecode=2484
11102006-09-16 03:40:05.208 AO: 57024 bytes free on soundcard
11112006-09-16 03:40:05.224 AO: 60064 bytes free on soundcard
11122006-09-16 03:40:05.236 AFD: video timecode 230437 219637 2440 2508
11132006-09-16 03:40:05.240 AFD: audio timecode 225729 225729 2508 2532
11142006-09-16 03:40:05.240 AO: _AddSamples bytes=4608, used=9729, free=758271, timecode=2508
11152006-09-16 03:40:05.242 AFD: audio timecode 227889 227889 2532 2556
11162006-09-16 03:40:05.242 AO: _AddSamples bytes=4608, used=14337, free=753663, timecode=2532
11172006-09-16 03:40:05.233 AO: 61920 bytes free on soundcard
11182006-09-16 03:40:05.250 NVP: A/V Divergence: -1.21955, Rate: 0.239875, Warpfactor: 0.988124, warpfactor_avg: 0.999978
11192006-09-16 03:40:05.258 AO: OutputAudioLoop: Play Event
11202006-09-16 03:40:05.259 AO: Broadcasting free space avail
11212006-09-16 03:40:05.259 AO: Broadcasting free space avail
11222006-09-16 03:40:05.259 AO: Broadcasting free space avail
11232006-09-16 03:40:05.260 AO: Broadcasting free space avail
11242006-09-16 03:40:05.260 AO: audio waiting for buffer to fill: have 2560 want 4096
11252006-09-16 03:40:05.260 AO: Broadcasting free space avail
11262006-09-16 03:40:05.274 AO: audio waiting for buffer to fill: have 2560 want 4096
11272006-09-16 03:40:05.274 AO: Broadcasting free space avail
11282006-09-16 03:40:05.286 AO: audio waiting for buffer to fill: have 2560 want 4096
11292006-09-16 03:40:05.286 AO: Broadcasting free space avail
11302006-09-16 03:40:05.292 AFD: video timecode 223237 223237 2480 2556
11312006-09-16 03:40:05.294 AFD: audio timecode 230049 230049 2556 2580
11322006-09-16 03:40:05.294 AO: _AddSamples bytes=4608, used=2561, free=765439, timecode=2556
11332006-09-16 03:40:05.296 AO: Broadcasting free space avail
11342006-09-16 03:40:05.296 AO: audio waiting for buffer to fill: have 3072 want 4096
11352006-09-16 03:40:05.297 AO: Broadcasting free space avail
11362006-09-16 03:40:05.301 NVP: A/V Divergence: -1.20215, Rate: 0.0174, Warpfactor: 0.988618, warpfactor_avg: 0.999978
11372006-09-16 03:40:05.308 AO: audio waiting for buffer to fill: have 3072 want 4096
11382006-09-16 03:40:05.309 AO: Broadcasting free space avail
11392006-09-16 03:40:05.319 AO: audio waiting for buffer to fill: have 3072 want 4096
11402006-09-16 03:40:05.319 AO: Broadcasting free space avail
11412006-09-16 03:40:05.324 AFD: video timecode 226837 226837 2520 2580
11422006-09-16 03:40:05.329 AFD: audio timecode 232208 232208 2580 2604
11432006-09-16 03:40:05.330 AO: _AddSamples bytes=4608, used=3073, free=764927, timecode=2580
11442006-09-16 03:40:05.331 AFD: audio timecode 234368 234368 2604 2628
11452006-09-16 03:40:05.345 NVP: A/V Divergence: -1.3016, Rate: -0.09945, Warpfactor: 0.988769, warpfactor_avg: 0.999977
11462006-09-16 03:40:05.332 AO: Broadcasting free space avail
11472006-09-16 03:40:05.350 AO: audio waiting for buffer to fill: have 3584 want 4096
11482006-09-16 03:40:05.350 AO: Broadcasting free space avail
11492006-09-16 03:40:05.353 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=2604
11502006-09-16 03:40:05.361 AO: Broadcasting free space avail
11512006-09-16 03:40:05.361 AO: Broadcasting free space avail
11522006-09-16 03:40:05.362 AO: Broadcasting free space avail
11532006-09-16 03:40:05.377 AO: Broadcasting free space avail
11542006-09-16 03:40:05.386 AO: Broadcasting free space avail
11552006-09-16 03:40:05.389 AFD: video timecode 241237 230437 2560 2628
11562006-09-16 03:40:05.390 AFD: audio timecode 236528 236528 2628 2652
11572006-09-16 03:40:05.391 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=2628
11582006-09-16 03:40:05.394 AFD: audio timecode 238688 238688 2652 2676
11592006-09-16 03:40:05.395 AO: _AddSamples bytes=4608, used=4609, free=763391, timecode=2652
11602006-09-16 03:40:05.400 AO: Broadcasting free space avail
11612006-09-16 03:40:05.401 AO: Broadcasting free space avail
11622006-09-16 03:40:05.401 AO: audio waiting for buffer to fill: have 1024 want 4096
11632006-09-16 03:40:05.401 AO: Broadcasting free space avail
11642006-09-16 03:40:05.409 AO: audio waiting for buffer to fill: have 1024 want 4096
11652006-09-16 03:40:05.410 AO: Broadcasting free space avail
11662006-09-16 03:40:05.418 NVP: A/V Divergence: -1.3512, Rate: -0.0496, Warpfactor: 0.988771, warpfactor_avg: 0.999976
11672006-09-16 03:40:05.419 AO: audio waiting for buffer to fill: have 1024 want 4096
11682006-09-16 03:40:05.420 AO: Broadcasting free space avail
11692006-09-16 03:40:05.436 AO: audio waiting for buffer to fill: have 1024 want 4096
11702006-09-16 03:40:05.444 AO: Broadcasting free space avail
11712006-09-16 03:40:05.449 AFD: video timecode 234037 234037 2600 2676
11722006-09-16 03:40:05.451 AFD: audio timecode 240848 240848 2676 2700
11732006-09-16 03:40:05.455 NVP: A/V Divergence: -1.54465, Rate: -0.19345, Warpfactor: 0.988276, warpfactor_avg: 0.999975
11742006-09-16 03:40:05.452 AO: _AddSamples bytes=4608, used=1025, free=766975, timecode=2676
11752006-09-16 03:40:05.457 AO: Broadcasting free space avail
11762006-09-16 03:40:05.458 AO: audio waiting for buffer to fill: have 1536 want 4096
11772006-09-16 03:40:05.458 AO: Broadcasting free space avail
11782006-09-16 03:40:05.472 AO: audio waiting for buffer to fill: have 1536 want 4096
11792006-09-16 03:40:05.473 AO: Broadcasting free space avail
11802006-09-16 03:40:05.488 AO: audio waiting for buffer to fill: have 1536 want 4096
11812006-09-16 03:40:05.489 AO: Broadcasting free space avail
11822006-09-16 03:40:05.492 AFD: video timecode 237637 237637 2640 2700
11832006-09-16 03:40:05.494 AFD: audio timecode 243008 243008 2700 2724
11842006-09-16 03:40:05.494 AO: _AddSamples bytes=4608, used=1537, free=766463, timecode=2700
11852006-09-16 03:40:05.501 NVP: A/V Divergence: -1.68348, Rate: -0.138825, Warpfactor: 0.987782, warpfactor_avg: 0.999974
11862006-09-16 03:40:05.503 AFD: audio timecode 245168 245168 2724 2748
11872006-09-16 03:40:05.504 AO: _AddSamples bytes=4608, used=6145, free=761855, timecode=2724
11882006-09-16 03:40:05.508 AO: Broadcasting free space avail
11892006-09-16 03:40:05.509 AO: Broadcasting free space avail
11902006-09-16 03:40:05.509 AO: audio waiting for buffer to fill: have 2560 want 4096
11912006-09-16 03:40:05.509 AO: Broadcasting free space avail
11922006-09-16 03:40:05.527 NVP: A/V Divergence: -1.86885, Rate: -0.185375, Warpfactor: 0.987288, warpfactor_avg: 0.999974
11932006-09-16 03:40:05.528 AO: audio waiting for buffer to fill: have 2560 want 4096
11942006-09-16 03:40:05.528 AO: Broadcasting free space avail
11952006-09-16 03:40:05.544 AO: audio waiting for buffer to fill: have 2560 want 4096
11962006-09-16 03:40:05.545 AO: Broadcasting free space avail
11972006-09-16 03:40:05.553 AO: audio waiting for buffer to fill: have 2560 want 4096
11982006-09-16 03:40:05.554 AO: Broadcasting free space avail
11992006-09-16 03:40:05.556 AFD: video timecode 252037 241237 2680 2748
12002006-09-16 03:40:05.558 AFD: audio timecode 247328 247328 2748 2772
12012006-09-16 03:40:05.558 AO: _AddSamples bytes=4608, used=2561, free=765439, timecode=2748
12022006-09-16 03:40:05.559 AFD: audio timecode 249488 249488 2772 2796
12032006-09-16 03:40:05.560 AO: _AddSamples bytes=4608, used=7169, free=760831, timecode=2772
12042006-09-16 03:40:05.570 AO: Broadcasting free space avail
12052006-09-16 03:40:05.571 AO: Broadcasting free space avail
12062006-09-16 03:40:05.571 AO: audio waiting for buffer to fill: have 3584 want 4096
12072006-09-16 03:40:05.571 AO: Broadcasting free space avail
12082006-09-16 03:40:05.573 NVP: A/V Divergence: -2.00163, Rate: -0.132775, Warpfactor: 0.986794, warpfactor_avg: 0.999973
12092006-09-16 03:40:05.580 AO: audio waiting for buffer to fill: have 3584 want 4096
12102006-09-16 03:40:05.581 AO: Broadcasting free space avail
12112006-09-16 03:40:05.591 AO: audio waiting for buffer to fill: have 3584 want 4096
12122006-09-16 03:40:05.591 AO: Broadcasting free space avail
12132006-09-16 03:40:05.596 AFD: video timecode 244837 244837 2720 2796
12142006-09-16 03:40:05.599 AFD: audio timecode 251648 251648 2796 2820
12152006-09-16 03:40:05.600 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=2796
12162006-09-16 03:40:05.602 AO: Broadcasting free space avail
12172006-09-16 03:40:05.602 AO: Broadcasting free space avail
12182006-09-16 03:40:05.602 AO: Broadcasting free space avail
12192006-09-16 03:40:05.615 AO: Broadcasting free space avail
12202006-09-16 03:40:05.629 AO: Broadcasting free space avail
12212006-09-16 03:40:05.639 NVP: A/V Divergence: -1.98245, Rate: 0.019175, Warpfactor: 0.986301, warpfactor_avg: 0.999972
12222006-09-16 03:40:05.643 AO: Broadcasting free space avail
12232006-09-16 03:40:05.645 NVP: prebuffering pause
12242006-09-16 03:40:05.645 NVP: Waiting for prebuffer.. 0 LAAAAAAAAAAAADLd
12252006-09-16 03:40:05.648 AO: OutputAudioLoop: audio paused
12262006-09-16 03:40:05.648 AO: 64128 bytes free on soundcard
12272006-09-16 03:40:05.659 AFD: video timecode 248437 248437 2760 2820
12282006-09-16 03:40:05.661 AFD: audio timecode 253808 253808 2820 2844
12292006-09-16 03:40:05.662 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=2820
12302006-09-16 03:40:05.663 AFD: audio timecode 255968 255968 2844 2868
12312006-09-16 03:40:05.663 AO: _AddSamples bytes=4608, used=4609, free=763391, timecode=2844
12322006-09-16 03:40:05.664 AO: 63072 bytes free on soundcard
12332006-09-16 03:40:05.680 AO: 61984 bytes free on soundcard
12342006-09-16 03:40:05.695 AO: 60828 bytes free on soundcard
12352006-09-16 03:40:05.696 AFD: video timecode 262837 252037 2800 2868
12362006-09-16 03:40:05.704 AFD: audio timecode 258128 258128 2868 2892
12372006-09-16 03:40:05.705 AO: _AddSamples bytes=4608, used=9217, free=758783, timecode=2868
12382006-09-16 03:40:05.709 AFD: audio timecode 260288 260288 2892 2916
12392006-09-16 03:40:05.709 AO: _AddSamples bytes=4608, used=13825, free=754175, timecode=2892
12402006-09-16 03:40:05.711 AO: 63872 bytes free on soundcard
12412006-09-16 03:40:05.713 NVP: A/V Divergence: -2.04308, Rate: -0.060625, Warpfactor: 0.985808, warpfactor_avg: 0.999971
12422006-09-16 03:40:05.720 AO: OutputAudioLoop: Play Event
12432006-09-16 03:40:05.721 AO: Broadcasting free space avail
12442006-09-16 03:40:05.721 AO: Broadcasting free space avail
12452006-09-16 03:40:05.721 AO: Broadcasting free space avail
12462006-09-16 03:40:05.722 AO: Broadcasting free space avail
12472006-09-16 03:40:05.722 AO: audio waiting for buffer to fill: have 2048 want 4096
12482006-09-16 03:40:05.722 AO: Broadcasting free space avail
12492006-09-16 03:40:05.741 AO: audio waiting for buffer to fill: have 2048 want 4096
12502006-09-16 03:40:05.742 AO: Broadcasting free space avail
12512006-09-16 03:40:05.747 NVP: A/V Divergence: -1.78855, Rate: 0.254525, Warpfactor: 0.986301, warpfactor_avg: 0.99997
12522006-09-16 03:40:05.750 AO: audio waiting for buffer to fill: have 2048 want 4096
12532006-09-16 03:40:05.750 AO: Broadcasting free space avail
12542006-09-16 03:40:05.751 NVP: prebuffering pause
12552006-09-16 03:40:05.751 NVP: Waiting for prebuffer.. 0 dLALAAAAAAAAAAAA
12562006-09-16 03:40:05.764 AO: OutputAudioLoop: audio paused
12572006-09-16 03:40:05.765 AO: 53664 bytes free on soundcard
12582006-09-16 03:40:05.772 AO: 55072 bytes free on soundcard
12592006-09-16 03:40:05.772 AFD: video timecode 255637 255637 2840 2916
12602006-09-16 03:40:05.774 AFD: audio timecode 262448 262448 2916 2940
12612006-09-16 03:40:05.774 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=2916
12622006-09-16 03:40:05.788 AO: 58208 bytes free on soundcard
12632006-09-16 03:40:05.799 AO: 60352 bytes free on soundcard
12642006-09-16 03:40:05.803 AFD: video timecode 259237 259237 2880 2940
12652006-09-16 03:40:05.806 AFD: audio timecode 264608 264608 2940 2964
12662006-09-16 03:40:05.807 AO: _AddSamples bytes=4608, used=6657, free=761343, timecode=2940
12672006-09-16 03:40:05.811 NVP: A/V Divergence: -1.5289, Rate: 0.25965, Warpfactor: 0.986794, warpfactor_avg: 0.999969
12682006-09-16 03:40:05.813 AFD: audio timecode 266768 266768 2964 2988
12692006-09-16 03:40:05.813 AO: _AddSamples bytes=4608, used=11265, free=756735, timecode=2964
12702006-09-16 03:40:05.819 AO: OutputAudioLoop: Play Event
12712006-09-16 03:40:05.825 AO: Broadcasting free space avail
12722006-09-16 03:40:05.825 AO: Broadcasting free space avail
12732006-09-16 03:40:05.826 AO: Broadcasting free space avail
12742006-09-16 03:40:05.826 AO: audio waiting for buffer to fill: have 3584 want 4096
12752006-09-16 03:40:05.826 AO: Broadcasting free space avail
12762006-09-16 03:40:05.844 AO: audio waiting for buffer to fill: have 3584 want 4096
12772006-09-16 03:40:05.845 AO: Broadcasting free space avail
12782006-09-16 03:40:05.855 AO: audio waiting for buffer to fill: have 3584 want 4096
12792006-09-16 03:40:05.856 AO: Broadcasting free space avail
12802006-09-16 03:40:05.860 AFD: video timecode 273637 262837 2920 2988
12812006-09-16 03:40:05.862 AFD: audio timecode 268928 268928 2988 3012
12822006-09-16 03:40:05.862 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=2988
12832006-09-16 03:40:05.871 NVP: A/V Divergence: -1.55292, Rate: -0.024025, Warpfactor: 0.987287, warpfactor_avg: 0.999968
12842006-09-16 03:40:05.875 AFD: audio timecode 271088 271088 3012 3036
12852006-09-16 03:40:05.872 AO: Broadcasting free space avail
12862006-09-16 03:40:05.877 AO: Broadcasting free space avail
12872006-09-16 03:40:05.877 AO: Broadcasting free space avail
12882006-09-16 03:40:05.880 AO: _AddSamples bytes=4608, used=1, free=767999, timecode=3012
12892006-09-16 03:40:05.894 AO: Broadcasting free space avail
12902006-09-16 03:40:05.895 AO: audio waiting for buffer to fill: have 512 want 4096
12912006-09-16 03:40:05.895 AO: Broadcasting free space avail
12922006-09-16 03:40:05.907 NVP: A/V Divergence: -1.65217, Rate: -0.09925, Warpfactor: 0.986794, warpfactor_avg: 0.999967
12932006-09-16 03:40:05.910 AO: audio waiting for buffer to fill: have 512 want 4096
12942006-09-16 03:40:05.910 AO: Broadcasting free space avail
12952006-09-16 03:40:05.912 NVP: prebuffering pause
12962006-09-16 03:40:05.912 NVP: Waiting for prebuffer.. 0 AdAALLAAAAAAAAAA
12972006-09-16 03:40:05.916 AO: OutputAudioLoop: audio paused
12982006-09-16 03:40:05.916 AO: 58240 bytes free on soundcard
12992006-09-16 03:40:05.924 AO: 59680 bytes free on soundcard
13002006-09-16 03:40:05.932 AO: 61248 bytes free on soundcard
13012006-09-16 03:40:05.933 AFD: video timecode 266437 266437 2960 3036
13022006-09-16 03:40:05.935 AFD: audio timecode 273248 273248 3036 3060
13032006-09-16 03:40:05.935 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=3036
13042006-09-16 03:40:05.948 AO: 64320 bytes free on soundcard
13052006-09-16 03:40:05.966 AO: 63744 bytes free on soundcard
13062006-09-16 03:40:05.967 AFD: video timecode 270037 270037 3000 3060
13072006-09-16 03:40:05.971 AFD: audio timecode 275408 275408 3060 3084
13082006-09-16 03:40:05.972 AO: _AddSamples bytes=4608, used=5121, free=762879, timecode=3060
13092006-09-16 03:40:05.975 AFD: audio timecode 277568 277568 3084 3108
13102006-09-16 03:40:05.975 AO: _AddSamples bytes=4608, used=9729, free=758271, timecode=3084
13112006-09-16 03:40:05.976 AO: 61504 bytes free on soundcard
13122006-09-16 03:40:05.982 NVP: A/V Divergence: -1.67663, Rate: -0.02445, Warpfactor: 0.986359, warpfactor_avg: 0.999966
13132006-09-16 03:40:05.990 AO: OutputAudioLoop: Play Event
13142006-09-16 03:40:05.991 AO: Broadcasting free space avail
13152006-09-16 03:40:05.991 AO: Broadcasting free space avail
13162006-09-16 03:40:05.991 AO: Broadcasting free space avail
13172006-09-16 03:40:05.992 AO: audio waiting for buffer to fill: have 2048 want 4096
13182006-09-16 03:40:05.992 AO: Broadcasting free space avail
13192006-09-16 03:40:06.010 NVP: A/V Divergence: -1.5512, Rate: 0.125425, Warpfactor: 0.986852, warpfactor_avg: 0.999966
13202006-09-16 03:40:06.011 AO: audio waiting for buffer to fill: have 2048 want 4096
13212006-09-16 03:40:06.011 AO: Broadcasting free space avail
13222006-09-16 03:40:06.013 NVP: prebuffering pause
13232006-09-16 03:40:06.013 NVP: Waiting for prebuffer.. 0 ADAAALDAAAAALAAA
13242006-09-16 03:40:06.020 AO: OutputAudioLoop: audio paused
13252006-09-16 03:40:06.020 AO: 53632 bytes free on soundcard
13262006-09-16 03:40:06.030 AO: 55488 bytes free on soundcard
13272006-09-16 03:40:06.030 AFD: video timecode 284437 273637 3040 3108
13282006-09-16 03:40:06.032 AFD: audio timecode 279728 279728 3108 3132
13292006-09-16 03:40:06.032 AO: _AddSamples bytes=4608, used=2049, free=765951, timecode=3108
13302006-09-16 03:40:06.034 AFD: audio timecode 281888 281888 3132 3156
13312006-09-16 03:40:06.034 AO: _AddSamples bytes=4608, used=6657, free=761343, timecode=3132
13322006-09-16 03:40:06.044 AO: 58176 bytes free on soundcard
13332006-09-16 03:40:06.059 AO: 61088 bytes free on soundcard
13342006-09-16 03:40:06.060 AFD: video timecode 277237 277237 3080 3156
13352006-09-16 03:40:06.063 AFD: audio timecode 284048 284048 3156 3180
13362006-09-16 03:40:06.064 AO: _AddSamples bytes=4608, used=11265, free=756735, timecode=3156
13372006-09-16 03:40:06.070 NVP: A/V Divergence: -1.33215, Rate: 0.21905, Warpfactor: 0.987346, warpfactor_avg: 0.999965
13382006-09-16 03:40:06.072 AO: OutputAudioLoop: Play Event
13392006-09-16 03:40:06.082 AO: Broadcasting free space avail
13402006-09-16 03:40:06.083 AO: Broadcasting free space avail
13412006-09-16 03:40:06.083 AO: Broadcasting free space avail
13422006-09-16 03:40:06.083 AO: audio waiting for buffer to fill: have 3584 want 4096
13432006-09-16 03:40:06.083 AO: Broadcasting free space avail
13442006-09-16 03:40:06.091 AO: audio waiting for buffer to fill: have 3584 want 4096
13452006-09-16 03:40:06.091 AO: Broadcasting free space avail
13462006-09-16 03:40:06.102 AO: audio waiting for buffer to fill: have 3584 want 4096
13472006-09-16 03:40:06.102 AO: Broadcasting free space avail
13482006-09-16 03:40:06.112 AO: audio waiting for buffer to fill: have 3584 want 4096
13492006-09-16 03:40:06.113 AO: Broadcasting free space avail
13502006-09-16 03:40:06.120 AO: audio waiting for buffer to fill: have 3584 want 4096
13512006-09-16 03:40:06.120 AO: Broadcasting free space avail
13522006-09-16 03:40:06.121 AFD: video timecode 280837 280837 3120 3180
13532006-09-16 03:40:06.124 AFD: audio timecode 286208 286208 3180 3204
13542006-09-16 03:40:06.125 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=3180
13552006-09-16 03:40:06.126 AFD: audio timecode 288368 288368 3204 3228
13562006-09-16 03:40:06.127 AO: _AddSamples bytes=4608, used=8193, free=759807, timecode=3204
13572006-09-16 03:40:06.131 NVP: A/V Divergence: -1.4241, Rate: -0.09195, Warpfactor: 0.987837, warpfactor_avg: 0.999964
13582006-09-16 03:40:06.137 AO: Broadcasting free space avail
13592006-09-16 03:40:06.138 AO: Broadcasting free space avail
13602006-09-16 03:40:06.138 AO: Broadcasting free space avail
13612006-09-16 03:40:06.138 AO: audio waiting for buffer to fill: have 512 want 4096
13622006-09-16 03:40:06.139 AO: Broadcasting free space avail
13632006-09-16 03:40:06.153 AO: audio waiting for buffer to fill: have 512 want 4096
13642006-09-16 03:40:06.153 AO: Broadcasting free space avail
13652006-09-16 03:40:06.167 AO: audio waiting for buffer to fill: have 512 want 4096
13662006-09-16 03:40:06.168 AO: Broadcasting free space avail
13672006-09-16 03:40:06.172 AFD: video timecode 295237 284437 3160 3228
13682006-09-16 03:40:06.175 AFD: audio timecode 290528 290528 3228 3252
13692006-09-16 03:40:06.175 AO: _AddSamples bytes=4608, used=513, free=767487, timecode=3228
13702006-09-16 03:40:06.176 AO: Broadcasting free space avail
13712006-09-16 03:40:06.176 AO: audio waiting for buffer to fill: have 1024 want 4096
13722006-09-16 03:40:06.177 AO: Broadcasting free space avail
13732006-09-16 03:40:06.182 NVP: A/V Divergence: -1.53682, Rate: -0.112725, Warpfactor: 0.987343, warpfactor_avg: 0.999963
13742006-09-16 03:40:06.184 AFD: audio timecode 292688 292688 3252 3276
13752006-09-16 03:40:06.185 AO: _AddSamples bytes=4608, used=1025, free=766975, timecode=3252
13762006-09-16 03:40:06.192 AO: Broadcasting free space avail
13772006-09-16 03:40:06.199 NVP: A/V Divergence: -1.72135, Rate: -0.184525, Warpfactor: 0.986849, warpfactor_avg: 0.999962
13782006-09-16 03:40:06.195 AO: audio waiting for buffer to fill: have 1536 want 4096
13792006-09-16 03:40:06.202 AO: Broadcasting free space avail
13802006-09-16 03:40:06.203 NVP: prebuffering pause
13812006-09-16 03:40:06.204 NVP: Waiting for prebuffer.. 0 AAAAAAAAAALLdAAA
13822006-09-16 03:40:06.217 AO: OutputAudioLoop: audio paused
13832006-09-16 03:40:06.218 AO: 58752 bytes free on soundcard
13842006-09-16 03:40:06.224 AO: 59968 bytes free on soundcard
13852006-09-16 03:40:06.230 AFD: video timecode 288037 288037 3200 3276
13862006-09-16 03:40:06.232 AFD: audio timecode 294848 294848 3276 3300
13872006-09-16 03:40:06.233 AO: _AddSamples bytes=4608, used=1537, free=766463, timecode=3276
13882006-09-16 03:40:06.240 AO: 63072 bytes free on soundcard
13892006-09-16 03:40:06.248 AO: 60512 bytes free on soundcard
13902006-09-16 03:40:06.252 AFD: video timecode 291637 291637 3240 3300
13912006-09-16 03:40:06.255 AFD: audio timecode 297008 297008 3300 3324
13922006-09-16 03:40:06.260 AO: _AddSamples bytes=4608, used=6145, free=761855, timecode=3300
13932006-09-16 03:40:06.261 AFD: audio timecode 299168 299168 3324 3348
13942006-09-16 03:40:06.262 AO: _AddSamples bytes=4608, used=10753, free=757247, timecode=3324
13952006-09-16 03:40:06.264 AO: OutputAudioLoop: Play Event
13962006-09-16 03:40:06.265 AO: Broadcasting free space avail
13972006-09-16 03:40:06.265 AO: Broadcasting free space avail
13982006-09-16 03:40:06.265 AO: Broadcasting free space avail
13992006-09-16 03:40:06.265 AO: audio waiting for buffer to fill: have 3072 want 4096
14002006-09-16 03:40:06.266 AO: Broadcasting free space avail
14012006-09-16 03:40:06.259 NVP: A/V Divergence: -1.6535, Rate: 0.06785, Warpfactor: 0.987277, warpfactor_avg: 0.999961
14022006-09-16 03:40:06.272 NVP: A/V Divergence: -1.62762, Rate: 0.025875, Warpfactor: 0.987148, warpfactor_avg: 0.99996
14032006-09-16 03:40:06.273 AO: audio waiting for buffer to fill: have 3072 want 4096
14042006-09-16 03:40:06.273 AO: Broadcasting free space avail
14052006-09-16 03:40:06.289 AO: audio waiting for buffer to fill: have 3072 want 4096
14062006-09-16 03:40:06.289 AO: Broadcasting free space avail
14072006-09-16 03:40:06.301 AO: audio waiting for buffer to fill: have 3072 want 4096
14082006-09-16 03:40:06.302 AO: Broadcasting free space avail
14092006-09-16 03:40:06.306 TV: Attempting to change from WatchingLiveTV to None
14102006-09-16 03:40:06.306 TV: StopStuff() -- begin
14112006-09-16 03:40:06.306 TV: StopStuff(): stopping ring buffer[s]
14122006-09-16 03:40:06.308 AFD: video timecode 306037 295237 3280 3348
14132006-09-16 03:40:06.310 AFD: audio timecode 301328 301328 3348 3372
14142006-09-16 03:40:06.310 AO: _AddSamples bytes=4608, used=3073, free=764927, timecode=3348
14152006-09-16 03:40:06.312 AO: Broadcasting free space avail
14162006-09-16 03:40:06.312 AO: audio waiting for buffer to fill: have 3584 want 4096
14172006-09-16 03:40:06.315 AO: Broadcasting free space avail
14182006-09-16 03:40:06.316 TV: StopStuff(): stopping player[s] (1/2)
14192006-09-16 03:40:06.316 TV: StopStuff(): stopping recorder[s]
14202006-09-16 03:40:06.316 write -> 15 32      QUERY_RECORDER 1[]:[]STOP_LIVETV
14212006-09-16 03:40:06.319 AFD: audio timecode 303487 303487 3372 3396
14222006-09-16 03:40:06.320 AO: _AddSamples bytes=4608, used=3585, free=764415, timecode=3372
14232006-09-16 03:40:06.320 NVP: Exited decoder loop.
14242006-09-16 03:40:06.326 AO: Broadcasting free space avail
14252006-09-16 03:40:06.327 AO: Broadcasting free space avail
14262006-09-16 03:40:06.327 AO: Broadcasting free space avail
14272006-09-16 03:40:06.331 VideoOutputXv: dtor
14282006-09-16 03:40:06.331 VideoOutputXv: DiscardFrames(1)
14292006-09-16 03:40:06.332 VideoOutputXv: DiscardFrames() 1: AAAAAAADAAuAALAA
14302006-09-16 03:40:06.333 VideoOutputXv: DiscardFrames() 2: AAAAAAADAAdAADAA
14312006-09-16 03:40:06.333 VideoOutputXv: Frame c is in use by avlib and so is being held for later discarding.
14322006-09-16 03:40:06.333 VideoOutputXv: Frame c is in use by avlib and so is being held for later discarding.
14332006-09-16 03:40:06.334 VideoOutputXv: DiscardFrames() 3: AAAAAAADAAdAAAAA -- done()
14342006-09-16 03:40:06.334 VideoOutputXv: DiscardFrames(1)
14352006-09-16 03:40:06.334 VideoOutputXv: DiscardFrames() 1: AAAAAAADAAdAAAAA
14362006-09-16 03:40:06.335 VideoOutputXv: Frame c is in use by avlib and so is being held for later discarding.
14372006-09-16 03:40:06.335 VideoOutputXv: DiscardFrames() 2: AAAAAAADAAdAAAAA
14382006-09-16 03:40:06.335 VideoOutputXv: Frame c is in use by avlib and so is being held for later discarding.
14392006-09-16 03:40:06.335 VideoOutputXv: DiscardFrames() 3: AAAAAAADAAdAAAAA -- done()
14402006-09-16 03:40:06.336 AO: Broadcasting free space avail
14412006-09-16 03:40:06.344 AO: Broadcasting free space avail
14422006-09-16 03:40:06.349 VideoOutputXv: Closing XVideo port 68
14432006-09-16 03:40:06.353 AO: Broadcasting free space avail
14442006-09-16 03:40:06.356 AO: Killing AudioOutputDSP
14452006-09-16 03:40:06.360 AO: OutputAudioLoop: Stop Event
14462006-09-16 03:40:06.360 AO: kickoffOutputAudioLoop exiting
14472006-09-16 03:40:06.383 MythSocket(84bd718:11): socket is readable
14482006-09-16 03:40:06.384 MythSocket(84bd718:11): cb->readyRead()
14492006-09-16 03:40:06.384 read  <- 11 48      BACKEND_MESSAGE[]:[]DONE_RECORDING 1 7[]:[]empty
14502006-09-16 03:40:06.472 MythSocket(84bd718:11): socket is readable
14512006-09-16 03:40:06.472 MythSocket(84bd718:11): cb->readyRead()
14522006-09-16 03:40:06.473 read  <- 11 78      BACKEND_MESSAGE[]:[]LIVETV_CHAIN UPDATE live-pvr-2006-09-16T03:39...
14532006-09-16 03:40:06.481 MythSocket(84bd718:11): socket is readable
14542006-09-16 03:40:06.482 MythSocket(84bd718:11): cb->readyRead()
14552006-09-16 03:40:06.482 read  <- 11 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
14562006-09-16 03:40:06.485 read  <- 15 2       ok
14572006-09-16 03:40:06.485 TV: StopStuff(): stopping player[s] (2/2)
14582006-09-16 03:40:06.489 write -> 12 33      MESSAGE[]:[]RECORDING_LIST_CHANGE
14592006-09-16 03:40:06.491 read  <- 12 2       OK
14602006-09-16 03:40:06.595 MythSocket(85375c8:15): DownRef: -1
14612006-09-16 03:40:06.595 MythSocket(85375c8:15): state change Connected -> Idle
14622006-09-16 03:40:06.596 MythSocket(85375c8:-1): delete socket
14632006-09-16 03:40:06.537 MythSocket(84bd718:11): socket is readable
14642006-09-16 03:40:06.597 MythSocket(84bd718:11): cb->readyRead()
14652006-09-16 03:40:06.598 read  <- 11 51      BACKEND_MESSAGE[]:[]RECORDING_LIST_CHANGE[]:[]empty
14662006-09-16 03:40:06.608 TV: StopStuff() -- end
14672006-09-16 03:40:06.609 TV: Changing from WatchingLiveTV to None
14682006-09-16 03:40:06.618 DPMS Reactivated.
14692006-09-16 03:40:08.117 write -> 12 31      QUERY_IS_ACTIVE_BACKEND[]:[]pvr
14702006-09-16 03:40:08.119 read  <- 12 4       TRUE
14712006-09-16 03:40:09.677 MythSocket(8540c48:12): DownRef: -1
14722006-09-16 03:40:09.678 MythSocket(8540c48:12): state change Connected -> Idle
14732006-09-16 03:40:09.678 MythSocket(8540c48:-1): delete socket
14742006-09-16 03:40:09.679 MythSocket(84bd718:11): DownRef: 0
14752006-09-16 03:40:09.685 MythSocket(84bd718:11): DownRef: -1
14762006-09-16 03:40:09.685 MythSocket(84bd718:11): state change Connected -> Idle
14772006-09-16 03:40:09.686 MythSocket(84bd718:-1): delete socket
14782006-09-16 03:40:09.858 MythSocket: readyread thread exit