Ticket #3046: mythtv hang.txt

File mythtv hang.txt, 57.2 KB (added by anonymous, 17 years ago)
Line 
12007-02-08 22:40:14.687 Using runtime prefix = /usr
22007-02-08 22:40:14.692 DPMS is disabled.
32007-02-08 22:40:14.705 New DB connection, total: 1
42007-02-08 22:40:14.710 Connected to database 'mythconverg' at host: localhost
52007-02-08 22:40:14.712 Total desktop dim: 1360x768, with 1 screen[s].
62007-02-08 22:40:14.714 Using screen 0, 1360x768 at 0,0
72007-02-08 22:40:14.772 user: 115 effective user: 115 before privileged thread
82007-02-08 22:40:14.772 user: 115 effective user: 115 after privileged thread
92007-02-08 22:40:14.773 Current Schema Version: 1178
102007-02-08 22:40:14.773 mythfrontend version: 0.20.20070124-1 www.mythtv.org
112007-02-08 22:40:14.773 Enabled verbose msgs:  important general playback
122007-02-08 22:40:14.776 user: 115 effective user: 115 run_priv_thread
132007-02-08 22:40:15.291 Connecting to lcd server: localhost:6545 (try 1 of 10)
142007-02-08 22:40:15.458 max_width: 1360 max_height: 768
152007-02-08 22:40:15.537 Total desktop dim: 1360x768, with 1 screen[s].
162007-02-08 22:40:15.538 Using screen 0, 1360x768 at 0,0
172007-02-08 22:40:15.540 Switching to square mode (G.A.N.T.)
182007-02-08 22:40:15.571 Using the Qt painter
192007-02-08 22:40:15.573 New DB connection, total: 2
202007-02-08 22:40:15.574 Joystick disabled.
212007-02-08 22:40:15.574 Connected to database 'mythconverg' at host: localhost
222007-02-08 22:40:15.575 lirc init success using configuration file: /home/mythtv/.mythtv/lircrc
232007-02-08 22:40:16.068 Loading from: /usr/share/mythtv/themes/G.A.N.T./base.xml
242007-02-08 22:40:16.142 Loading from: /usr/share/mythtv/themes/default/base.xml
252007-02-08 22:40:16.181 Registering Internal as a media playback plugin.
262007-02-08 22:40:16.201 Unable to initialize plugin 'mythdvd'.
272007-02-08 22:40:16.216 Registering MythGallery Media Handler 1/2 as a media handler ext()
282007-02-08 22:40:16.217 Registering MythGallery Media Handler 2/2 as a media handler ext(gif,jpg,png)
29adding: ATA:0,0,0 -- DVD_RW ND-3550A
30adding: ATAPI:0,0,0 -- DVD_RW ND-3550A
312007-02-08 22:40:17.841 Registering MythMusic Media Handler 1/2 as a media handler ext()
322007-02-08 22:40:17.841 Registering MythMusic Media Handler 2/2 as a media handler ext(ogg,mp3,aac,flac)
332007-02-08 22:40:17.874 Registering MythDVD DVD Media Handler as a media handler ext()
342007-02-08 22:40:17.874 Registering MythDVD VCD Media Handler as a media handler ext()
352007-02-08 22:40:27.930 XMLParse::LoadTheme using /usr/share/mythtv/themes/G.A.N.T./ui.xml
362007-02-08 22:40:28.307 Connecting to backend server: 192.168.0.2:6543 (try 1 of 5)
372007-02-08 22:40:28.308 Using protocol version 32
382007-02-08 22:40:29.854 RingBuf(/store/mythtv/1004_20070208182900.mpg): OpenFile(/store/mythtv/1004_20070208182900.mpg, 1)
392007-02-08 22:40:29.854 RingBuf(/store/mythtv/1004_20070208182900.mpg): CalcReadAheadThresh(3086457344 KB)
40                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
410: start_time: 7149.412 duration: 8589.931
421: start_time: 7149.381 duration: 0.022
432: start_time: 7149.367 duration: 0.032
443: start_time: 7149.367 duration: 8589.975
454: start_time: 7149.367 duration: 8589.975
465: start_time: 7149.367 duration: 8589.975
476: start_time: 7149.367 duration: 8589.975
487: start_time: 7149.367 duration: 8589.975
49stream: start_time: 79437.413 duration: 95444.171 bitrate=0 kb/s
502007-02-08 22:40:29.899 AFD: Stream #0, has id 0x2829 codec id MPEG2VIDEO, type Video, bitrate 10000000 at 0x0x8250e60
512007-02-08 22:40:29.901 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
522007-02-08 22:40:29.901 AFD: Looking for decoder for MPEG2VIDEO
532007-02-08 22:40:29.901 AFD: Opened codec 0x8322ab0, id(MPEG2VIDEO) type(Video)
542007-02-08 22:40:29.901 AFD: Stream #1, has id 0x2830 codec id MP3, type Audio, bitrate 192000 at 0x0x88797c0
552007-02-08 22:40:29.901 AFD: Looking for decoder for MP3
562007-02-08 22:40:29.901 AFD: Opened codec 0x8252110, id(MP3) type(Audio)
572007-02-08 22:40:29.901 AFD: Stream #2, has id 0x2832 codec id MP3, type Audio, bitrate 64000 at 0x0x82489b0
582007-02-08 22:40:29.901 AFD: Looking for decoder for MP3
592007-02-08 22:40:29.901 AFD: Opened codec 0x8252f50, id(MP3) type(Audio)
602007-02-08 22:40:29.901 AFD: Stream #3, has id 0x2831 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x0x88ca000
612007-02-08 22:40:29.902 AFD: subtitle codec (Subtitle)
622007-02-08 22:40:29.902 AFD: Looking for decoder for DVB_SUBTITLE
632007-02-08 22:40:29.902 AFD: Opened codec 0x889fc10, id(DVB_SUBTITLE) type(Subtitle)
642007-02-08 22:40:29.902 AFD: Subtitle track #1 is A/V stream #3 and is in the English language(6647399).
652007-02-08 22:40:29.902 AFD: Stream #4, has id 0x2170 codec id DSMCC_B, type Data, bitrate 0 at 0x0x88c8f10
662007-02-08 22:40:29.902 AFD: data codec (Data)
672007-02-08 22:40:29.902 AFD: Stream #5, has id 0x2372 codec id DSMCC_B, type Data, bitrate 0 at 0x0x8321e00
682007-02-08 22:40:29.902 AFD: data codec (Data)
692007-02-08 22:40:29.902 AFD: Stream #6, has id 0x2371 codec id DSMCC_B, type Data, bitrate 0 at 0x0x827dbf0
702007-02-08 22:40:29.902 AFD: data codec (Data)
712007-02-08 22:40:29.902 AFD: Stream #7, has id 0x2373 codec id DSMCC_B, type Data, bitrate 0 at 0x0x88b7c30
722007-02-08 22:40:29.902 AFD: data codec (Data)
732007-02-08 22:40:29.902 RingBuf(/store/mythtv/1004_20070208182900.mpg): CalcReadAheadThresh(3065011816 KB)
74                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
752007-02-08 22:40:29.903 Dec: Selected track #1 in the English language(6647399)
762007-02-08 22:40:29.903 Dec: Trying to select track (w/lang)
772007-02-08 22:40:29.903 Dec: Selecting first track
782007-02-08 22:40:29.903 Dec: Selected track #1 in the Unknown language(0)
792007-02-08 22:40:29.903 AFD: Recording has no position -- using libavformat seeking.
802007-02-08 22:40:29.903 AFD: Successfully opened decoder for file: "/store/mythtv/1004_20070208182900.mpg". novideo(0)
812007-02-08 22:40:29.912 VideoOutputNull()
822007-02-08 22:40:29.912 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
832007-02-08 22:40:29.912 Video Rect    left: 0, top: 0, width: 704, height: 576, aspect: 1.77778
842007-02-08 22:40:29.912 Created data @0xa8d9c020->0xa8e30822
852007-02-08 22:40:29.912 Created data @0xa8d07020->0xa8d9b822
862007-02-08 22:40:29.912 Created data @0xa8c72020->0xa8d06822
872007-02-08 22:40:29.913 Created data @0xa8bdd020->0xa8c71822
882007-02-08 22:40:29.913 Created data @0xa8b48020->0xa8bdc822
892007-02-08 22:40:29.913 Created data @0xa8ab3020->0xa8b47822
902007-02-08 22:40:29.913 Created data @0xa8a1e020->0xa8ab2822
912007-02-08 22:40:29.913 Created data @0xa886b020->0xa88ff822
922007-02-08 22:40:29.913 Created data @0xa87d6020->0xa886a822
932007-02-08 22:40:29.913 Created data @0xa8741020->0xa87d5822
942007-02-08 22:40:29.913 Created data @0xa86ac020->0xa8740822
952007-02-08 22:40:29.913 Created data @0xa8617020->0xa86ab822
962007-02-08 22:40:29.913 Created data @0xa8582020->0xa8616822
972007-02-08 22:40:29.913 Created data @0xa844e020->0xa84e2822
982007-02-08 22:40:29.913 Created data @0xa83b9020->0xa844d822
992007-02-08 22:40:29.913 Created data @0xa8324020->0xa83b8822
1002007-02-08 22:40:29.913 Created data @0xa828f020->0xa8323822
1012007-02-08 22:40:29.914 Created data @0xa81fa020->0xa828e822
1022007-02-08 22:40:29.914 Created data @0xa8165020->0xa81f9822
1032007-02-08 22:40:29.914 Created data @0xa80d0020->0xa8164822
1042007-02-08 22:40:29.914 Created data @0xa803b020->0xa80cf822
1052007-02-08 22:40:29.914 Created data @0xa7fa6020->0xa803a822
1062007-02-08 22:40:29.914 Created data @0xa7f11020->0xa7fa5822
1072007-02-08 22:40:29.914 Created data @0xa7e7c020->0xa7f10822
1082007-02-08 22:40:29.914 Created data @0xa7de7020->0xa7e7b822
1092007-02-08 22:40:29.914 Created data @0xa7d52020->0xa7de6822
1102007-02-08 22:40:29.914 Created data @0xa7cbd020->0xa7d51822
1112007-02-08 22:40:29.914 Created data @0xa7c28020->0xa7cbc822
1122007-02-08 22:40:29.914 Created data @0xa7b93020->0xa7c27822
1132007-02-08 22:40:29.914 Created data @0xa7afe020->0xa7b92822
1142007-02-08 22:40:29.914 Created data @0xa7a69020->0xa7afd822
1152007-02-08 22:40:29.914 Created data @0xa79d4020->0xa7a68822
1162007-02-08 22:40:29.935 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
1172007-02-08 22:40:29.935 Video Rect    left: 0, top: 0, width: 704, height: 576, aspect: 1.77778
1182007-02-08 22:40:29.936 NVP: ClearAfterSeek(1)
1192007-02-08 22:40:29.938 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAL
1202007-02-08 22:40:29.966 AFD: HandleGopStart: gopset not set, syncing positionMap
1212007-02-08 22:40:29.967 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
1222007-02-08 22:40:29.967 AFD: HandleGopStart: Initial key frame distance: 15.
1232007-02-08 22:40:30.160 NVP: Exited decoder loop.
1242007-02-08 22:40:30.180 ~VideoOutputNull()
1252007-02-08 22:40:30.697 RingBuf(/store/mythtv/1004_20070208182900.mpg): OpenFile(/store/mythtv/1004_20070208182900.mpg, 1)
1262007-02-08 22:40:30.698 RingBuf(/store/mythtv/1004_20070208182900.mpg): CalcReadAheadThresh(3030781632 KB)
127                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
1280: start_time: 7149.412 duration: 8589.931
1291: start_time: 7149.381 duration: 0.022
1302: start_time: 7149.367 duration: 0.032
1313: start_time: 7149.367 duration: 8589.975
1324: start_time: 7149.367 duration: 8589.975
1335: start_time: 7149.367 duration: 8589.975
1346: start_time: 7149.367 duration: 8589.975
1357: start_time: 7149.367 duration: 8589.975
136stream: start_time: 79437.413 duration: 95444.171 bitrate=0 kb/s
1372007-02-08 22:40:30.713 AFD: Stream #0, has id 0x2829 codec id MPEG2VIDEO, type Video, bitrate 10000000 at 0x0x88797c0
1382007-02-08 22:40:30.713 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
1392007-02-08 22:40:30.713 AFD: Looking for decoder for MPEG2VIDEO
1402007-02-08 22:40:30.713 AFD: Opened codec 0x8322ab0, id(MPEG2VIDEO) type(Video)
1412007-02-08 22:40:30.713 AFD: Stream #1, has id 0x2830 codec id MP3, type Audio, bitrate 192000 at 0x0x88b6a50
1422007-02-08 22:40:30.713 AFD: Looking for decoder for MP3
1432007-02-08 22:40:30.713 AFD: Opened codec 0x8252f50, id(MP3) type(Audio)
1442007-02-08 22:40:30.714 AFD: Stream #2, has id 0x2832 codec id MP3, type Audio, bitrate 64000 at 0x0x8239ac0
1452007-02-08 22:40:30.714 AFD: Looking for decoder for MP3
1462007-02-08 22:40:30.714 AFD: Opened codec 0x8220650, id(MP3) type(Audio)
1472007-02-08 22:40:30.714 AFD: Stream #3, has id 0x2831 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x0x82209e0
1482007-02-08 22:40:30.714 AFD: subtitle codec (Subtitle)
1492007-02-08 22:40:30.714 AFD: Looking for decoder for DVB_SUBTITLE
1502007-02-08 22:40:30.714 AFD: Opened codec 0x8219cf0, id(DVB_SUBTITLE) type(Subtitle)
1512007-02-08 22:40:30.714 AFD: Subtitle track #1 is A/V stream #3 and is in the English language(6647399).
1522007-02-08 22:40:30.714 AFD: Stream #4, has id 0x2170 codec id DSMCC_B, type Data, bitrate 0 at 0x0x821a050
1532007-02-08 22:40:30.714 AFD: data codec (Data)
1542007-02-08 22:40:30.714 AFD: Stream #5, has id 0x2372 codec id DSMCC_B, type Data, bitrate 0 at 0x0x8968af0
1552007-02-08 22:40:30.714 AFD: data codec (Data)
1562007-02-08 22:40:30.714 AFD: Stream #6, has id 0x2371 codec id DSMCC_B, type Data, bitrate 0 at 0x0x8220c10
1572007-02-08 22:40:30.715 AFD: data codec (Data)
1582007-02-08 22:40:30.715 AFD: Stream #7, has id 0x2373 codec id DSMCC_B, type Data, bitrate 0 at 0x0x827ca80
1592007-02-08 22:40:30.715 AFD: data codec (Data)
1602007-02-08 22:40:30.715 RingBuf(/store/mythtv/1004_20070208182900.mpg): CalcReadAheadThresh(3065011816 KB)
161                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
1622007-02-08 22:40:30.715 Dec: Selected track #1 in the English language(6647399)
1632007-02-08 22:40:30.715 Dec: Trying to select track (w/lang)
1642007-02-08 22:40:30.715 Dec: Selecting first track
1652007-02-08 22:40:30.715 Dec: Selected track #1 in the Unknown language(0)
1662007-02-08 22:40:30.715 AFD: Recording has no position -- using libavformat seeking.
1672007-02-08 22:40:30.715 AFD: Successfully opened decoder for file: "/store/mythtv/1004_20070208182900.mpg". novideo(0)
1682007-02-08 22:40:30.716 VideoOutputNull()
1692007-02-08 22:40:30.716 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
1702007-02-08 22:40:30.716 Video Rect    left: 0, top: 0, width: 704, height: 576, aspect: 1.77778
1712007-02-08 22:40:30.716 Created data @0xa8d9c020->0xa8e30822
1722007-02-08 22:40:30.716 Created data @0xa8d07020->0xa8d9b822
1732007-02-08 22:40:30.716 Created data @0xa8c72020->0xa8d06822
1742007-02-08 22:40:30.716 Created data @0xa8bdd020->0xa8c71822
1752007-02-08 22:40:30.716 Created data @0xa8b48020->0xa8bdc822
1762007-02-08 22:40:30.716 Created data @0xa8ab3020->0xa8b47822
1772007-02-08 22:40:30.716 Created data @0xa8a1e020->0xa8ab2822
1782007-02-08 22:40:30.716 Created data @0xa886b020->0xa88ff822
1792007-02-08 22:40:30.716 Created data @0xa87d6020->0xa886a822
1802007-02-08 22:40:30.717 Created data @0xa8741020->0xa87d5822
1812007-02-08 22:40:30.717 Created data @0xa86ac020->0xa8740822
1822007-02-08 22:40:30.717 Created data @0xa8617020->0xa86ab822
1832007-02-08 22:40:30.717 Created data @0xa8582020->0xa8616822
1842007-02-08 22:40:30.717 Created data @0xa844e020->0xa84e2822
1852007-02-08 22:40:30.717 Created data @0xa83b9020->0xa844d822
1862007-02-08 22:40:30.717 Created data @0xa8324020->0xa83b8822
1872007-02-08 22:40:30.717 Created data @0xa828f020->0xa8323822
1882007-02-08 22:40:30.717 Created data @0xa81fa020->0xa828e822
1892007-02-08 22:40:30.717 Created data @0xa8165020->0xa81f9822
1902007-02-08 22:40:30.717 Created data @0xa80d0020->0xa8164822
1912007-02-08 22:40:30.717 Created data @0xa803b020->0xa80cf822
1922007-02-08 22:40:30.717 Created data @0xa7fa6020->0xa803a822
1932007-02-08 22:40:30.717 Created data @0xa7f11020->0xa7fa5822
1942007-02-08 22:40:30.718 Created data @0xa7e7c020->0xa7f10822
1952007-02-08 22:40:30.718 Created data @0xa7de7020->0xa7e7b822
1962007-02-08 22:40:30.718 Created data @0xa7d52020->0xa7de6822
1972007-02-08 22:40:30.718 Created data @0xa7cbd020->0xa7d51822
1982007-02-08 22:40:30.718 Created data @0xa7c28020->0xa7cbc822
1992007-02-08 22:40:30.718 Created data @0xa7b93020->0xa7c27822
2002007-02-08 22:40:30.718 Created data @0xa7afe020->0xa7b92822
2012007-02-08 22:40:30.718 Created data @0xa7a69020->0xa7afd822
2022007-02-08 22:40:30.718 Created data @0xa79d4020->0xa7a68822
2032007-02-08 22:40:30.739 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
2042007-02-08 22:40:30.739 Video Rect    left: 0, top: 0, width: 704, height: 576, aspect: 1.77778
2052007-02-08 22:40:30.739 NVP: ClearAfterSeek(1)
2062007-02-08 22:40:30.741 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAL
2072007-02-08 22:40:30.770 AFD: HandleGopStart: gopset not set, syncing positionMap
2082007-02-08 22:40:30.770 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2092007-02-08 22:40:30.771 AFD: HandleGopStart: Initial key frame distance: 15.
2102007-02-08 22:40:33.437 NVP: Exited decoder loop.
2112007-02-08 22:40:33.465 ~VideoOutputNull()
2122007-02-08 22:40:33.938 RingBuf(/store/mythtv/8302_20070207185900.mpg): OpenFile(/store/mythtv/8302_20070207185900.mpg, 1)
2132007-02-08 22:40:33.938 RingBuf(/store/mythtv/8302_20070207185900.mpg): CalcReadAheadThresh(2828444608 KB)
214                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2150: start_time: 4201.140 duration: 8589.931
2161: start_time: 4201.123 duration: -9223372036854.775
2172: start_time: 4201.118 duration: 0.017
2183: start_time: 4201.111 duration: 0.025
2194: start_time: 4201.111 duration: 8589.960
220stream: start_time: 46679.011 duration: 95443.998 bitrate=0 kb/s
2212007-02-08 22:40:33.953 AFD: Stream #0, has id 0x5100 codec id MPEG2VIDEO, type Video, bitrate 7980000 at 0x0x88797c0
2222007-02-08 22:40:33.953 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
2232007-02-08 22:40:33.953 AFD: Looking for decoder for MPEG2VIDEO
2242007-02-08 22:40:33.953 AFD: Opened codec 0x8322ab0, id(MPEG2VIDEO) type(Video)
2252007-02-08 22:40:33.953 AFD: Stream #1, has id 0x5101 codec id MP3, type Audio, bitrate 256000 at 0x0x827dbf0
2262007-02-08 22:40:33.953 AFD: Looking for decoder for MP3
2272007-02-08 22:40:33.953 AFD: Opened codec 0x8252f50, id(MP3) type(Audio)
2282007-02-08 22:40:33.953 AFD: Stream #2, has id 0x5102 codec id MP3, type Audio, bitrate 256000 at 0x0x8321e00
2292007-02-08 22:40:33.954 AFD: Looking for decoder for MP3
2302007-02-08 22:40:33.954 AFD: Opened codec 0x8220650, id(MP3) type(Audio)
2312007-02-08 22:40:33.954 AFD: Stream #3, has id 0x5103 codec id DVB_VBI, type Data, bitrate 0 at 0x0x82209e0
2322007-02-08 22:40:33.954 AFD: Teletext caption #1 is in the English language on page 8 136.
2332007-02-08 22:40:33.954 AFD: data codec (Data)
2342007-02-08 22:40:33.954 AFD: Stream #4, has id 0x5104 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x0x821a050
2352007-02-08 22:40:33.954 AFD: subtitle codec (Subtitle)
2362007-02-08 22:40:33.954 AFD: Looking for decoder for DVB_SUBTITLE
2372007-02-08 22:40:33.954 AFD: Opened codec 0x8968790, id(DVB_SUBTITLE) type(Subtitle)
2382007-02-08 22:40:33.954 AFD: Subtitle track #1 is A/V stream #4 and is in the English language(6647399).
2392007-02-08 22:40:33.954 RingBuf(/store/mythtv/8302_20070207185900.mpg): CalcReadAheadThresh(3065011816 KB)
240                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2412007-02-08 22:40:33.954 Dec: Selected track #1 in the English language(6647399)
2422007-02-08 22:40:33.954 Dec: Trying to select track (w/lang)
2432007-02-08 22:40:33.955 Dec: Selecting first track
2442007-02-08 22:40:33.955 Dec: Selected track #1 in the Unknown language(0)
2452007-02-08 22:40:33.955 Dec: Selected track #1 in the English language(6647399)
2462007-02-08 22:40:33.955 AFD: Recording has no position -- using libavformat seeking.
2472007-02-08 22:40:33.955 AFD: Successfully opened decoder for file: "/store/mythtv/8302_20070207185900.mpg". novideo(0)
2482007-02-08 22:40:33.955 VideoOutputNull()
2492007-02-08 22:40:33.955 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
2502007-02-08 22:40:33.955 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
2512007-02-08 22:40:33.955 Created data @0xa8d18020->0xa8dafe22
2522007-02-08 22:40:33.955 Created data @0xa8c80020->0xa8d17e22
2532007-02-08 22:40:33.956 Created data @0xa8be8020->0xa8c7fe22
2542007-02-08 22:40:33.956 Created data @0xa8b50020->0xa8be7e22
2552007-02-08 22:40:33.956 Created data @0xa8ab8020->0xa8b4fe22
2562007-02-08 22:40:33.956 Created data @0xa8a20020->0xa8ab7e22
2572007-02-08 22:40:33.956 Created data @0xa8868020->0xa88ffe22
2582007-02-08 22:40:33.956 Created data @0xa87d0020->0xa8867e22
2592007-02-08 22:40:33.956 Created data @0xa8738020->0xa87cfe22
2602007-02-08 22:40:33.956 Created data @0xa86a0020->0xa8737e22
2612007-02-08 22:40:33.956 Created data @0xa8608020->0xa869fe22
2622007-02-08 22:40:33.956 Created data @0xa8570020->0xa8607e22
2632007-02-08 22:40:33.956 Created data @0xa844b020->0xa84e2e22
2642007-02-08 22:40:33.956 Created data @0xa83b3020->0xa844ae22
2652007-02-08 22:40:33.956 Created data @0xa831b020->0xa83b2e22
2662007-02-08 22:40:33.956 Created data @0xa8283020->0xa831ae22
2672007-02-08 22:40:33.957 Created data @0xa81eb020->0xa8282e22
2682007-02-08 22:40:33.957 Created data @0xa8153020->0xa81eae22
2692007-02-08 22:40:33.957 Created data @0xa80bb020->0xa8152e22
2702007-02-08 22:40:33.957 Created data @0xa8023020->0xa80bae22
2712007-02-08 22:40:33.957 Created data @0xa7f8b020->0xa8022e22
2722007-02-08 22:40:33.957 Created data @0xa7ef3020->0xa7f8ae22
2732007-02-08 22:40:33.957 Created data @0xa7e5b020->0xa7ef2e22
2742007-02-08 22:40:33.957 Created data @0xa7dc3020->0xa7e5ae22
2752007-02-08 22:40:33.957 Created data @0xa7d2b020->0xa7dc2e22
2762007-02-08 22:40:33.957 Created data @0xa7c93020->0xa7d2ae22
2772007-02-08 22:40:33.957 Created data @0xa7bfb020->0xa7c92e22
2782007-02-08 22:40:33.957 Created data @0xa7b63020->0xa7bfae22
2792007-02-08 22:40:33.957 Created data @0xa7acb020->0xa7b62e22
2802007-02-08 22:40:33.957 Created data @0xa7a33020->0xa7acae22
2812007-02-08 22:40:33.958 Created data @0xa799b020->0xa7a32e22
2822007-02-08 22:40:33.958 Created data @0xa70a6020->0xa713de22
2832007-02-08 22:40:33.978 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
2842007-02-08 22:40:33.978 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
2852007-02-08 22:40:33.979 NVP: ClearAfterSeek(1)
2862007-02-08 22:40:33.979 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2872007-02-08 22:40:34.023 AFD: HandleGopStart: gopset not set, syncing positionMap
2882007-02-08 22:40:34.023 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2892007-02-08 22:40:34.023 AFD: HandleGopStart: Initial key frame distance: 15.
2902007-02-08 22:40:34.741 NVP: Exited decoder loop.
2912007-02-08 22:40:34.761 ~VideoOutputNull()
2922007-02-08 22:40:35.770 RingBuf(/store/mythtv/8302_20070204195900.mpg): OpenFile(/store/mythtv/8302_20070204195900.mpg, 1)
2932007-02-08 22:40:35.770 RingBuf(/store/mythtv/8302_20070204195900.mpg): CalcReadAheadThresh(3031346496 KB)
294                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
2950: start_time: 6967.332 duration: 8589.931
2961: start_time: 6967.307 duration: 0.035
2972: start_time: 6967.301 duration: 0.035
2983: start_time: 6967.304 duration: 0.043
2994: start_time: 6967.301 duration: 8589.962
300stream: start_time: 77414.461 duration: 95444.021 bitrate=0 kb/s
3012007-02-08 22:40:35.783 AFD: Stream #0, has id 0x5100 codec id MPEG2VIDEO, type Video, bitrate 7980000 at 0x0x88797c0
3022007-02-08 22:40:35.783 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
3032007-02-08 22:40:35.783 AFD: Looking for decoder for MPEG2VIDEO
3042007-02-08 22:40:35.783 AFD: Opened codec 0x8322ab0, id(MPEG2VIDEO) type(Video)
3052007-02-08 22:40:35.783 AFD: Stream #1, has id 0x5101 codec id MP3, type Audio, bitrate 256000 at 0x0x82212f0
3062007-02-08 22:40:35.783 AFD: Looking for decoder for MP3
3072007-02-08 22:40:35.784 AFD: Opened codec 0x8252f50, id(MP3) type(Audio)
3082007-02-08 22:40:35.784 AFD: Stream #2, has id 0x5102 codec id MP3, type Audio, bitrate 256000 at 0x0x88b6a50
3092007-02-08 22:40:35.784 AFD: Looking for decoder for MP3
3102007-02-08 22:40:35.784 AFD: Opened codec 0x8220650, id(MP3) type(Audio)
3112007-02-08 22:40:35.784 AFD: Stream #3, has id 0x5103 codec id DVB_VBI, type Data, bitrate 0 at 0x0x82209e0
3122007-02-08 22:40:35.784 AFD: Teletext caption #1 is in the English language on page 8 136.
3132007-02-08 22:40:35.784 AFD: data codec (Data)
3142007-02-08 22:40:35.784 AFD: Stream #4, has id 0x5104 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x0x821a050
3152007-02-08 22:40:35.784 AFD: subtitle codec (Subtitle)
3162007-02-08 22:40:35.784 AFD: Looking for decoder for DVB_SUBTITLE
3172007-02-08 22:40:35.784 AFD: Opened codec 0x8968790, id(DVB_SUBTITLE) type(Subtitle)
3182007-02-08 22:40:35.784 AFD: Subtitle track #1 is A/V stream #4 and is in the English language(6647399).
3192007-02-08 22:40:35.784 RingBuf(/store/mythtv/8302_20070204195900.mpg): CalcReadAheadThresh(3065011816 KB)
320                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
3212007-02-08 22:40:35.785 Dec: Selected track #1 in the English language(6647399)
3222007-02-08 22:40:35.785 Dec: Trying to select track (w/lang)
3232007-02-08 22:40:35.785 Dec: Selecting first track
3242007-02-08 22:40:35.785 Dec: Selected track #1 in the Unknown language(0)
3252007-02-08 22:40:35.785 Dec: Selected track #1 in the English language(6647399)
3262007-02-08 22:40:35.785 AFD: Recording has no position -- using libavformat seeking.
3272007-02-08 22:40:35.785 AFD: Successfully opened decoder for file: "/store/mythtv/8302_20070204195900.mpg". novideo(0)
3282007-02-08 22:40:35.785 VideoOutputNull()
3292007-02-08 22:40:35.785 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
3302007-02-08 22:40:35.785 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
3312007-02-08 22:40:35.786 Created data @0xa8d18020->0xa8dafe22
3322007-02-08 22:40:35.786 Created data @0xa8c80020->0xa8d17e22
3332007-02-08 22:40:35.786 Created data @0xa8be8020->0xa8c7fe22
3342007-02-08 22:40:35.786 Created data @0xa8b50020->0xa8be7e22
3352007-02-08 22:40:35.786 Created data @0xa8ab8020->0xa8b4fe22
3362007-02-08 22:40:35.786 Created data @0xa8a20020->0xa8ab7e22
3372007-02-08 22:40:35.786 Created data @0xa8868020->0xa88ffe22
3382007-02-08 22:40:35.786 Created data @0xa87d0020->0xa8867e22
3392007-02-08 22:40:35.786 Created data @0xa8738020->0xa87cfe22
3402007-02-08 22:40:35.786 Created data @0xa86a0020->0xa8737e22
3412007-02-08 22:40:35.786 Created data @0xa8608020->0xa869fe22
3422007-02-08 22:40:35.786 Created data @0xa8570020->0xa8607e22
3432007-02-08 22:40:35.786 Created data @0xa844b020->0xa84e2e22
3442007-02-08 22:40:35.786 Created data @0xa83b3020->0xa844ae22
3452007-02-08 22:40:35.787 Created data @0xa831b020->0xa83b2e22
3462007-02-08 22:40:35.787 Created data @0xa8283020->0xa831ae22
3472007-02-08 22:40:35.787 Created data @0xa81eb020->0xa8282e22
3482007-02-08 22:40:35.787 Created data @0xa8153020->0xa81eae22
3492007-02-08 22:40:35.787 Created data @0xa80bb020->0xa8152e22
3502007-02-08 22:40:35.787 Created data @0xa8023020->0xa80bae22
3512007-02-08 22:40:35.787 Created data @0xa7f8b020->0xa8022e22
3522007-02-08 22:40:35.787 Created data @0xa7ef3020->0xa7f8ae22
3532007-02-08 22:40:35.787 Created data @0xa7e5b020->0xa7ef2e22
3542007-02-08 22:40:35.787 Created data @0xa7dc3020->0xa7e5ae22
3552007-02-08 22:40:35.787 Created data @0xa7d2b020->0xa7dc2e22
3562007-02-08 22:40:35.787 Created data @0xa7c93020->0xa7d2ae22
3572007-02-08 22:40:35.787 Created data @0xa7bfb020->0xa7c92e22
3582007-02-08 22:40:35.787 Created data @0xa7b63020->0xa7bfae22
3592007-02-08 22:40:35.787 Created data @0xa7acb020->0xa7b62e22
3602007-02-08 22:40:35.788 Created data @0xa7a33020->0xa7acae22
3612007-02-08 22:40:35.788 Created data @0xa799b020->0xa7a32e22
3622007-02-08 22:40:35.788 Created data @0xa70a6020->0xa713de22
3632007-02-08 22:40:35.808 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
3642007-02-08 22:40:35.808 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
3652007-02-08 22:40:35.809 NVP: ClearAfterSeek(1)
3662007-02-08 22:40:35.809 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3672007-02-08 22:40:35.844 AFD: HandleGopStart: gopset not set, syncing positionMap
3682007-02-08 22:40:35.844 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
3692007-02-08 22:40:35.844 AFD: HandleGopStart: Initial key frame distance: 15.
3702007-02-08 22:40:36.027 NVP: Exited decoder loop.
3712007-02-08 22:40:36.027 TV: Attempting to change from None to WatchingPreRecorded
3722007-02-08 22:40:36.028 RingBuf(/store/mythtv/8302_20070204195900.mpg): OpenFile(/store/mythtv/8302_20070204195900.mpg, 12)
3732007-02-08 22:40:36.028 RingBuf(/store/mythtv/8302_20070204195900.mpg): CalcReadAheadThresh(143111456 KB)
374                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
3752007-02-08 22:40:36.041 Avg read interval was 196 msec. 64K block size
3762007-02-08 22:40:36.049 Avg read interval was 196 msec. 64K block size
3772007-02-08 22:40:36.061 ~VideoOutputNull()
3782007-02-08 22:40:36.073 Avg read interval was 197 msec. 96K block size
3792007-02-08 22:40:36.089 Avg read interval was 196 msec. 64K block size
3802007-02-08 22:40:36.113 Avg read interval was 197 msec. 96K block size
3810: start_time: 6967.332 duration: 8589.931
3821: start_time: 6967.307 duration: 0.035
3832: start_time: 6967.301 duration: 0.035
3843: start_time: 6967.304 duration: 0.043
3854: start_time: 6967.301 duration: 8589.962
386stream: start_time: 77414.461 duration: 95444.021 bitrate=0 kb/s
3872007-02-08 22:40:36.122 AFD: Stream #0, has id 0x5100 codec id MPEG2VIDEO, type Video, bitrate 7980000 at 0x0x8225ec0
3882007-02-08 22:40:36.124 detectInterlace(Detect Scan, Interlaced Scan, 25, 576) ->Interlaced Scan
3892007-02-08 22:40:36.124 AFD: Looking for decoder for MPEG2VIDEO
3902007-02-08 22:40:36.125 AFD: Opened codec 0x89f56e0, id(MPEG2VIDEO) type(Video)
3912007-02-08 22:40:36.125 AFD: Stream #1, has id 0x5101 codec id MP3, type Audio, bitrate 256000 at 0x0x8968af0
3922007-02-08 22:40:36.125 AFD: Looking for decoder for MP3
3932007-02-08 22:40:36.125 AFD: Opened codec 0x89f5bf0, id(MP3) type(Audio)
3942007-02-08 22:40:36.125 AFD: Stream #2, has id 0x5102 codec id MP3, type Audio, bitrate 256000 at 0x0x89dd3c0
3952007-02-08 22:40:36.125 AFD: Looking for decoder for MP3
3962007-02-08 22:40:36.125 AFD: Opened codec 0x89f6100, id(MP3) type(Audio)
3972007-02-08 22:40:36.125 AFD: Stream #3, has id 0x5103 codec id DVB_VBI, type Data, bitrate 0 at 0x0x89f6620
3982007-02-08 22:40:36.125 AFD: Teletext caption #1 is in the English language on page 8 136.
3992007-02-08 22:40:36.125 AFD: data codec (Data)
4002007-02-08 22:40:36.125 AFD: Stream #4, has id 0x5104 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x0x89f6c30
4012007-02-08 22:40:36.125 AFD: subtitle codec (Subtitle)
4022007-02-08 22:40:36.126 AFD: Looking for decoder for DVB_SUBTITLE
4032007-02-08 22:40:36.126 AFD: Opened codec 0x89f6d20, id(DVB_SUBTITLE) type(Subtitle)
4042007-02-08 22:40:36.126 AFD: Subtitle track #1 is A/V stream #4 and is in the English language(6647399).
4052007-02-08 22:40:36.126 RingBuf(/store/mythtv/8302_20070204195900.mpg): CalcReadAheadThresh(3065011816 KB)
406                         -> threshhold(64 KB) min read(0 KB) blk size(32 KB)
4072007-02-08 22:40:36.128 Opening OSS audio device '/dev/dsp'.
4082007-02-08 22:40:36.129 Avg read interval was 196 msec. 64K block size
4092007-02-08 22:40:36.132 Dec: Selected track #1 in the English language(6647399)
4102007-02-08 22:40:36.132 Dec: Trying to select track (w/lang)
4112007-02-08 22:40:36.132 Dec: Selecting first track
4122007-02-08 22:40:36.132 Dec: Selected track #1 in the Unknown language(0)
4132007-02-08 22:40:36.132 Dec: Selected track #1 in the English language(6647399)
4142007-02-08 22:40:36.132 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
4152007-02-08 22:40:36.161 Avg read interval was 197 msec. 96K block size
4162007-02-08 22:40:36.193 Avg read interval was 197 msec. 128K block size
4172007-02-08 22:40:36.205 Position map filled from DB to: 94416
4182007-02-08 22:40:36.206 SyncPositionMap prerecorded, from DB: 7869 entries
4192007-02-08 22:40:36.206 SyncPositionMap, new totframes: 94416, new length: 3776, posMap size: 7869
4202007-02-08 22:40:36.207 AFD: Position map found
4212007-02-08 22:40:36.207 AFD: Successfully opened decoder for file: "/store/mythtv/8302_20070204195900.mpg". novideo(0)
4222007-02-08 22:40:36.208 VideoOutputXv: ctor
4232007-02-08 22:40:36.209 Over/underscan. V: 0, H: 0, XOff: 0, YOff: 0
4242007-02-08 22:40:36.209 Snapping height to avoid scaling: height: 576, top: 96
4252007-02-08 22:40:36.209 Display Rect  left: 0, top: 96, width: 1360, height: 576, aspect: 1.33333
4262007-02-08 22:40:36.209 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
4272007-02-08 22:40:36.209 VideoOutputXv: Pixel dimensions: Screen 1360x768, window 1360x768
4282007-02-08 22:40:36.210 VideoOutputXv: Estimated display dimensions: 705x390 mm  Aspect: 1.80769
4292007-02-08 22:40:36.210 VideoOutputXv: Estimated window dimensions: 705x390 mm  Aspect: 1.80769
4302007-02-08 22:40:36.211 VideoOutputXv: XvMCTex: Init failed
4312007-02-08 22:40:36.211 VideoOutputXv: @ j=3 Looking for flag[s]: XvInputMask XvImageMask
4322007-02-08 22:40:36.211 VideoOutputXv: Adaptor#0: Intel(R) Video Overlay has flag[s]: XvInputMask XvImageMask
4332007-02-08 22:40:36.211 VideoOutputXv: Grabbed xv port 73
4342007-02-08 22:40:36.211 VideoOutputXv: XVideo surface found on port 73
4352007-02-08 22:40:36.211 VideoOutputXv: XVideo Adaptor Name: 'Intel(R) Video Overlay'
4362007-02-08 22:40:36.212 VideoOutputXv: XVideo Format #0 is 'YUY2'
4372007-02-08 22:40:36.212 VideoOutputXv: XVideo Format #1 is 'YV12'
4382007-02-08 22:40:36.212 VideoOutputXv: XVideo Format #2 is 'I420'
4392007-02-08 22:40:36.212 VideoOutputXv: XVideo Format #3 is 'UYVY'
4402007-02-08 22:40:36.212 VideoOutputXv: Using XVideo Format 'I420'
4412007-02-08 22:40:36.212 VideoOutputXv: CreateShmImages(32): video_dim: 720x576
4422007-02-08 22:40:36.225 Avg read interval was 197 msec. 160K block size
4432007-02-08 22:40:36.248 Display Rect  left: 0, top: 0, width: 1360, height: 768, aspect: 1.77778
4442007-02-08 22:40:36.248 Video Rect    left: 0, top: 0, width: 720, height: 576, aspect: 1.77778
4452007-02-08 22:40:36.257 Avg read interval was 197 msec. 192K block size
4462007-02-08 22:40:36.289 Avg read interval was 197 msec. 224K block size
4472007-02-08 22:40:36.583 NVP: ClearAfterSeek(1)
4482007-02-08 22:40:36.583 VideoOutputXv: ClearAfterSeek()
4492007-02-08 22:40:36.583 VideoOutputXv: DiscardFrames(0)
4502007-02-08 22:40:36.583 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4512007-02-08 22:40:36.584 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4522007-02-08 22:40:36.584 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4532007-02-08 22:40:36.586 New DB connection, total: 3
4542007-02-08 22:40:36.586 The realtime priority setting is not enabled.
4552007-02-08 22:40:36.586 Connected to database 'mythconverg' at host: localhost
4562007-02-08 22:40:36.589 TV: StartPlayer(): took 551 ms to start player.
4572007-02-08 22:40:36.589 Using deinterlace method kerneldeint
4582007-02-08 22:40:36.590 TV: Changing from None to WatchingPreRecorded
4592007-02-08 22:40:36.591 nVidiaVideoSync: Could not open device /dev/nvidia0, No such file or directory
4602007-02-08 22:40:36.608 Using audio as timebase
4612007-02-08 22:40:36.608 Video timing method: DRM
4622007-02-08 22:40:36.608 Refresh rate: 16712, frame interval: 40000
4632007-02-08 22:40:36.625 NVP: Waiting for prebuffer.. 0 UUUUuUULuAAAAAAAAAAAAAAAAAAAAAA
4642007-02-08 22:40:36.673 Avg read interval was 183 msec. 256K block size
4652007-02-08 22:40:39.726 AFD: DoFastForward(7575 (105), do discard frames)
4662007-02-08 22:40:39.726 Dec: DoFastForward(7575 (105), do discard frames)
4672007-02-08 22:40:39.726 AFD: SeekReset(7584, 0, do flush, do discard)
4682007-02-08 22:40:39.726 AFD: SeekReset() flushing
4692007-02-08 22:40:39.726 VideoOutputXv: DiscardFrames(1)
4702007-02-08 22:40:39.726 VideoBuffers::DiscardFrames(1): UUUUAUUAUUUUUUUUUUUUUUUUUUUUUUU
4712007-02-08 22:40:39.726 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4722007-02-08 22:40:39.727 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4732007-02-08 22:40:39.727 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4742007-02-08 22:40:39.727 NVP: ClearAfterSeek(0)
4752007-02-08 22:40:39.733 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
4762007-02-08 22:40:39.749 Avg read interval was 197 msec. 64K block size
4772007-02-08 22:40:39.781 Avg read interval was 197 msec. 96K block size
4782007-02-08 22:40:39.813 Avg read interval was 197 msec. 128K block size
4792007-02-08 22:40:39.845 Avg read interval was 197 msec. 160K block size
4802007-02-08 22:40:39.877 Avg read interval was 197 msec. 192K block size
4812007-02-08 22:40:39.909 Avg read interval was 197 msec. 224K block size
4822007-02-08 22:40:39.941 Avg read interval was 197 msec. 256K block size
4832007-02-08 22:40:39.968 NVP: Video is 3.04658 frames ahead of audio,
484                        doubling video frame interval to slow down.
4852007-02-08 22:40:40.052 NVP: Video is 3.46618 frames ahead of audio,
486                        doubling video frame interval to slow down.
4872007-02-08 22:40:40.119 NVP: Video is 3.51213 frames ahead of audio,
488                        doubling video frame interval to slow down.
4892007-02-08 22:40:40.202 NVP: Video is 3.37783 frames ahead of audio,
490                        doubling video frame interval to slow down.
4912007-02-08 22:40:40.246 AFD: DoFastForward(15090 (7620), do discard frames)
4922007-02-08 22:40:40.246 Dec: DoFastForward(15090 (7620), do discard frames)
4932007-02-08 22:40:40.246 AFD: SeekReset(15096, 0, do flush, do discard)
4942007-02-08 22:40:40.246 AFD: SeekReset() flushing
4952007-02-08 22:40:40.246 VideoOutputXv: DiscardFrames(1)
4962007-02-08 22:40:40.246 VideoBuffers::DiscardFrames(1): UUUUAUUUUUAUUUUUUUUUUUUUUUUUUUU
4972007-02-08 22:40:40.246 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
4982007-02-08 22:40:40.247 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
4992007-02-08 22:40:40.247 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5002007-02-08 22:40:40.247 NVP: ClearAfterSeek(0)
5012007-02-08 22:40:40.252 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5022007-02-08 22:40:40.309 Avg read interval was 184 msec. 64K block size
5032007-02-08 22:40:40.333 Avg read interval was 197 msec. 96K block size
5042007-02-08 22:40:40.365 Avg read interval was 197 msec. 128K block size
5052007-02-08 22:40:40.397 Avg read interval was 197 msec. 160K block size
5062007-02-08 22:40:40.429 Avg read interval was 197 msec. 192K block size
5072007-02-08 22:40:40.461 Avg read interval was 197 msec. 224K block size
5082007-02-08 22:40:40.470 NVP: Video is 3.0021 frames ahead of audio,
509                        doubling video frame interval to slow down.
5102007-02-08 22:40:40.493 Avg read interval was 198 msec. 256K block size
5112007-02-08 22:40:40.525 Avg read interval was 197 msec. 288K block size
512'video_output' mean = '45333.52', std. dev. = '27503.98', fps = '22.06'
5132007-02-08 22:40:44.074 AFD: DoFastForward(22683 (15213), do discard frames)
5142007-02-08 22:40:44.074 Dec: DoFastForward(22683 (15213), do discard frames)
5152007-02-08 22:40:44.074 AFD: SeekReset(22692, 0, do flush, do discard)
5162007-02-08 22:40:44.074 AFD: SeekReset() flushing
5172007-02-08 22:40:44.074 VideoOutputXv: DiscardFrames(1)
5182007-02-08 22:40:44.074 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUUUUUUUUUUUUUAUUAUU
5192007-02-08 22:40:44.075 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5202007-02-08 22:40:44.075 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5212007-02-08 22:40:44.075 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5222007-02-08 22:40:44.075 NVP: ClearAfterSeek(0)
5232007-02-08 22:40:44.079 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5242007-02-08 22:40:44.133 Avg read interval was 180 msec. 64K block size
5252007-02-08 22:40:44.165 Avg read interval was 197 msec. 96K block size
5262007-02-08 22:40:44.197 Avg read interval was 197 msec. 128K block size
5272007-02-08 22:40:44.229 Avg read interval was 197 msec. 160K block size
5282007-02-08 22:40:44.261 Avg read interval was 197 msec. 192K block size
5292007-02-08 22:40:44.293 Avg read interval was 197 msec. 224K block size
5302007-02-08 22:40:44.325 Avg read interval was 197 msec. 256K block size
5312007-02-08 22:40:44.525 AFD: DoFastForward(30197 (22727), do discard frames)
5322007-02-08 22:40:44.525 Dec: DoFastForward(30197 (22727), do discard frames)
5332007-02-08 22:40:44.525 AFD: SeekReset(30204, 0, do flush, do discard)
5342007-02-08 22:40:44.525 AFD: SeekReset() flushing
5352007-02-08 22:40:44.525 VideoOutputXv: DiscardFrames(1)
5362007-02-08 22:40:44.525 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUUUUUUUUUUUUAAUUUUU
5372007-02-08 22:40:44.525 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5382007-02-08 22:40:44.525 Avg read interval was 192 msec. 64K block size
5392007-02-08 22:40:44.526 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5402007-02-08 22:40:44.526 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5412007-02-08 22:40:44.526 NVP: ClearAfterSeek(0)
5422007-02-08 22:40:44.530 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5432007-02-08 22:40:44.557 Avg read interval was 197 msec. 96K block size
5442007-02-08 22:40:44.589 Avg read interval was 197 msec. 128K block size
5452007-02-08 22:40:44.621 Avg read interval was 197 msec. 160K block size
5462007-02-08 22:40:44.653 Avg read interval was 197 msec. 192K block size
5472007-02-08 22:40:44.682 NVP: Video is 3.28105 frames ahead of audio,
548                        doubling video frame interval to slow down.
5492007-02-08 22:40:44.685 Avg read interval was 197 msec. 224K block size
5502007-02-08 22:40:44.717 Avg read interval was 197 msec. 256K block size
5512007-02-08 22:40:44.765 NVP: Video is 3.68578 frames ahead of audio,
552                        doubling video frame interval to slow down.
5532007-02-08 22:40:44.832 NVP: Video is 3.72058 frames ahead of audio,
554                        doubling video frame interval to slow down.
5552007-02-08 22:40:44.915 NVP: Video is 3.57792 frames ahead of audio,
556                        doubling video frame interval to slow down.
5572007-02-08 22:40:44.999 NVP: Video is 3.19592 frames ahead of audio,
558                        doubling video frame interval to slow down.
5592007-02-08 22:40:45.778 AFD: DoRewind(29850, do discard frames)
5602007-02-08 22:40:45.778 Dec: DoRewind(29850 (30256), do discard frames)
5612007-02-08 22:40:45.778 AFD: SeekReset(29844, 0, do flush, do discard)
5622007-02-08 22:40:45.779 AFD: SeekReset() flushing
5632007-02-08 22:40:45.779 VideoOutputXv: DiscardFrames(1)
5642007-02-08 22:40:45.779 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUAUUUUUUAUUUUUUUUUUU
5652007-02-08 22:40:45.779 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5662007-02-08 22:40:45.779 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5672007-02-08 22:40:45.779 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5682007-02-08 22:40:45.779 NVP: ClearAfterSeek(1)
5692007-02-08 22:40:45.779 VideoOutputXv: ClearAfterSeek()
5702007-02-08 22:40:45.779 VideoOutputXv: DiscardFrames(0)
5712007-02-08 22:40:45.779 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5722007-02-08 22:40:45.780 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5732007-02-08 22:40:45.780 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5742007-02-08 22:40:45.784 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5752007-02-08 22:40:45.830 AFD Error: Unknown decoding error
5762007-02-08 22:40:45.837 Avg read interval was 187 msec. 64K block size
5772007-02-08 22:40:45.861 Avg read interval was 197 msec. 96K block size
5782007-02-08 22:40:45.893 Avg read interval was 197 msec. 128K block size
5792007-02-08 22:40:45.925 Avg read interval was 197 msec. 160K block size
580'video_output' mean = '47128.53', std. dev. = '28270.02', fps = '21.22'
5812007-02-08 22:40:45.958 Avg read interval was 197 msec. 192K block size
5822007-02-08 22:40:45.989 Avg read interval was 197 msec. 224K block size
5832007-02-08 22:40:46.021 Avg read interval was 197 msec. 256K block size
5842007-02-08 22:40:46.065 AFD: DoRewind(29471, do discard frames)
5852007-02-08 22:40:46.065 Dec: DoRewind(29471 (29876), do discard frames)
5862007-02-08 22:40:46.065 AFD: SeekReset(29460, 0, do flush, do discard)
5872007-02-08 22:40:46.065 AFD: SeekReset() flushing
5882007-02-08 22:40:46.065 VideoOutputXv: DiscardFrames(1)
5892007-02-08 22:40:46.065 VideoBuffers::DiscardFrames(1): UUUUUUUUUUUUUUUAUUUAUUUUUUUUUUU
5902007-02-08 22:40:46.066 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5912007-02-08 22:40:46.066 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5922007-02-08 22:40:46.066 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5932007-02-08 22:40:46.066 NVP: ClearAfterSeek(1)
5942007-02-08 22:40:46.066 VideoOutputXv: ClearAfterSeek()
5952007-02-08 22:40:46.066 VideoOutputXv: DiscardFrames(0)
5962007-02-08 22:40:46.066 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
5972007-02-08 22:40:46.066 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
5982007-02-08 22:40:46.066 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
5992007-02-08 22:40:46.068 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6002007-02-08 22:40:46.109 Avg read interval was 182 msec. 64K block size
6012007-02-08 22:40:46.133 Avg read interval was 197 msec. 96K block size
6022007-02-08 22:40:46.165 Avg read interval was 197 msec. 128K block size
6032007-02-08 22:40:46.198 Avg read interval was 197 msec. 160K block size
6042007-02-08 22:40:46.229 Avg read interval was 197 msec. 192K block size
6052007-02-08 22:40:46.261 Avg read interval was 197 msec. 224K block size
6062007-02-08 22:40:46.293 Avg read interval was 197 msec. 256K block size
6072007-02-08 22:40:46.297 AFD: DoRewind(29086, do discard frames)
6082007-02-08 22:40:46.297 Dec: DoRewind(29086 (29481), do discard frames)
6092007-02-08 22:40:46.297 AFD: SeekReset(29076, 0, do flush, do discard)
6102007-02-08 22:40:46.297 AFD: SeekReset() flushing
6112007-02-08 22:40:46.297 VideoOutputXv: DiscardFrames(1)
6122007-02-08 22:40:46.297 VideoBuffers::DiscardFrames(1): UUUAAUAUUAUAAAAAAAUUUUUUUUUUUUA
6132007-02-08 22:40:46.298 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6142007-02-08 22:40:46.298 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6152007-02-08 22:40:46.298 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6162007-02-08 22:40:46.298 NVP: ClearAfterSeek(1)
6172007-02-08 22:40:46.298 VideoOutputXv: ClearAfterSeek()
6182007-02-08 22:40:46.298 VideoOutputXv: DiscardFrames(0)
6192007-02-08 22:40:46.298 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6202007-02-08 22:40:46.298 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6212007-02-08 22:40:46.298 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6222007-02-08 22:40:46.302 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6232007-02-08 22:40:46.310 Avg read interval was 197 msec. 64K block size
6242007-02-08 22:40:46.333 Avg read interval was 197 msec. 96K block size
6252007-02-08 22:40:46.365 Avg read interval was 197 msec. 128K block size
6262007-02-08 22:40:46.397 Avg read interval was 197 msec. 160K block size
6272007-02-08 22:40:46.403 NVP: Video is 3.24875 frames ahead of audio,
628                        doubling video frame interval to slow down.
6292007-02-08 22:40:46.429 Avg read interval was 197 msec. 192K block size
6302007-02-08 22:40:46.461 Avg read interval was 197 msec. 224K block size
6312007-02-08 22:40:46.470 NVP: Video is 3.8553 frames ahead of audio,
632                        doubling video frame interval to slow down.
6332007-02-08 22:40:46.493 Avg read interval was 197 msec. 256K block size
6342007-02-08 22:40:46.517 AFD: DoRewind(28702, do discard frames)
6352007-02-08 22:40:46.517 Dec: DoRewind(28702 (29101), do discard frames)
6362007-02-08 22:40:46.517 AFD: SeekReset(28692, 0, do flush, do discard)
6372007-02-08 22:40:46.517 AFD: SeekReset() flushing
6382007-02-08 22:40:46.517 VideoOutputXv: DiscardFrames(1)
6392007-02-08 22:40:46.517 VideoBuffers::DiscardFrames(1): UUUAUAUAAUAAUUUUUUUUUUUUUAUAUUU
6402007-02-08 22:40:46.518 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6412007-02-08 22:40:46.518 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6422007-02-08 22:40:46.518 Avg read interval was 197 msec. 64K block size
6432007-02-08 22:40:46.518 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6442007-02-08 22:40:46.518 NVP: ClearAfterSeek(1)
6452007-02-08 22:40:46.518 VideoOutputXv: ClearAfterSeek()
6462007-02-08 22:40:46.518 VideoOutputXv: DiscardFrames(0)
6472007-02-08 22:40:46.518 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6482007-02-08 22:40:46.518 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
6492007-02-08 22:40:46.518 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
6502007-02-08 22:40:46.519 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6512007-02-08 22:40:46.526 AFD Error: Unknown decoding error
6522007-02-08 22:40:46.549 Avg read interval was 197 msec. 96K block size
6532007-02-08 22:40:46.581 Avg read interval was 197 msec. 128K block size
6542007-02-08 22:40:46.613 Avg read interval was 197 msec. 160K block size
6552007-02-08 22:40:46.645 Avg read interval was 197 msec. 192K block size
6562007-02-08 22:40:46.678 Avg read interval was 197 msec. 224K block size
6572007-02-08 22:40:46.686 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6582007-02-08 22:40:46.853 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6592007-02-08 22:40:47.020 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6602007-02-08 22:40:47.188 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6612007-02-08 22:40:47.355 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6622007-02-08 22:40:47.522 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6632007-02-08 22:40:47.689 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6642007-02-08 22:40:47.856 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6652007-02-08 22:40:48.023 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6662007-02-08 22:40:48.185 NVP: Prebuffer wait timed out 10 times.
6672007-02-08 22:40:48.190 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6682007-02-08 22:40:48.358 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6692007-02-08 22:40:48.525 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6702007-02-08 22:40:48.692 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6712007-02-08 22:40:48.859 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6722007-02-08 22:40:49.026 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6732007-02-08 22:40:49.193 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6742007-02-08 22:40:49.360 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6752007-02-08 22:40:49.528 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6762007-02-08 22:40:49.695 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6772007-02-08 22:40:49.858 NVP: Prebuffer wait timed out 10 times.
6782007-02-08 22:40:49.862 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6792007-02-08 22:40:50.029 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6802007-02-08 22:40:50.196 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6812007-02-08 22:40:50.363 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6822007-02-08 22:40:50.530 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6832007-02-08 22:40:50.697 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6842007-02-08 22:40:50.865 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6852007-02-08 22:40:51.032 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6862007-02-08 22:40:51.199 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6872007-02-08 22:40:51.366 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6882007-02-08 22:40:51.530 NVP: Prebuffer wait timed out 10 times.
6892007-02-08 22:40:51.533 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6902007-02-08 22:40:51.700 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6912007-02-08 22:40:51.867 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6922007-02-08 22:40:52.035 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6932007-02-08 22:40:52.202 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6942007-02-08 22:40:52.369 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6952007-02-08 22:40:52.536 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6962007-02-08 22:40:52.703 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6972007-02-08 22:40:52.870 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6982007-02-08 22:40:53.037 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
6992007-02-08 22:40:53.202 NVP: Prebuffer wait timed out 10 times.
7002007-02-08 22:40:53.204 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7012007-02-08 22:40:53.372 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7022007-02-08 22:40:53.539 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7032007-02-08 22:40:53.706 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7042007-02-08 22:40:53.873 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7052007-02-08 22:40:54.040 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7062007-02-08 22:40:54.207 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7072007-02-08 22:40:54.374 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7082007-02-08 22:40:54.542 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7092007-02-08 22:40:54.709 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7102007-02-08 22:40:54.870 NVP: Prebuffer wait timed out 10 times.
7112007-02-08 22:40:54.876 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7122007-02-08 22:40:55.043 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7132007-02-08 22:40:55.210 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7142007-02-08 22:40:55.377 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7152007-02-08 22:40:55.544 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7162007-02-08 22:40:55.711 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7172007-02-08 22:40:55.879 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7182007-02-08 22:40:56.046 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7192007-02-08 22:40:56.213 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7202007-02-08 22:40:56.380 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7212007-02-08 22:40:56.542 NVP: Prebuffer wait timed out 10 times.
7222007-02-08 22:40:56.547 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7232007-02-08 22:40:56.714 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7242007-02-08 22:40:56.881 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7252007-02-08 22:40:57.049 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7262007-02-08 22:40:57.216 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7272007-02-08 22:40:57.383 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7282007-02-08 22:40:57.550 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7292007-02-08 22:40:57.717 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7302007-02-08 22:40:57.884 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7312007-02-08 22:40:58.051 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7322007-02-08 22:40:58.214 NVP: Prebuffer wait timed out 10 times.
7332007-02-08 22:40:58.219 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7342007-02-08 22:40:58.386 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7352007-02-08 22:40:58.553 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7362007-02-08 22:40:58.720 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7372007-02-08 22:40:58.887 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7382007-02-08 22:40:59.054 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7392007-02-08 22:40:59.221 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7402007-02-08 22:40:59.388 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7412007-02-08 22:40:59.556 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7422007-02-08 22:40:59.723 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7432007-02-08 22:40:59.886 NVP: Prebuffer wait timed out 10 times.
7442007-02-08 22:40:59.890 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7452007-02-08 22:41:00.057 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7462007-02-08 22:41:00.224 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7472007-02-08 22:41:00.391 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7482007-02-08 22:41:00.558 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7492007-02-08 22:41:00.726 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7502007-02-08 22:41:00.893 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7512007-02-08 22:41:01.060 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7522007-02-08 22:41:01.227 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7532007-02-08 22:41:01.394 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7542007-02-08 22:41:01.558 NVP: Prebuffer wait timed out 10 times.
7552007-02-08 22:41:01.561 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7562007-02-08 22:41:01.728 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7572007-02-08 22:41:01.895 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7582007-02-08 22:41:02.063 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7592007-02-08 22:41:02.230 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7602007-02-08 22:41:02.397 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7612007-02-08 22:41:02.564 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7622007-02-08 22:41:02.731 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7632007-02-08 22:41:02.898 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7642007-02-08 22:41:03.065 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7652007-02-08 22:41:03.226 NVP: Prebuffer wait timed out 10 times.
7662007-02-08 22:41:03.233 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7672007-02-08 22:41:03.400 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7682007-02-08 22:41:03.567 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7692007-02-08 22:41:03.734 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7702007-02-08 22:41:03.901 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7712007-02-08 22:41:04.068 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7722007-02-08 22:41:04.235 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7732007-02-08 22:41:04.403 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7742007-02-08 22:41:04.570 NVP: Waiting for prebuffer.. 8 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7752007-02-08 22:41:04.737 NVP: Waiting for prebuffer.. 9 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7762007-02-08 22:41:04.899 NVP: Prebuffer wait timed out 10 times.
7772007-02-08 22:41:04.904 NVP: Waiting for prebuffer.. 0 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7782007-02-08 22:41:05.071 NVP: Waiting for prebuffer.. 1 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7792007-02-08 22:41:05.238 NVP: Waiting for prebuffer.. 2 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7802007-02-08 22:41:05.405 NVP: Waiting for prebuffer.. 3 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7812007-02-08 22:41:05.572 NVP: Waiting for prebuffer.. 4 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7822007-02-08 22:41:05.740 NVP: Waiting for prebuffer.. 5 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7832007-02-08 22:41:05.907 NVP: Waiting for prebuffer.. 6 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
7842007-02-08 22:41:06.074 NVP: Waiting for prebuffer.. 7 AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA