Ticket #1965: abandon-play.txt

File abandon-play.txt, 27.2 KB (added by kkuphal, 18 years ago)

Frontend logs

Line 
12006-06-17 23:25:38.370 Using runtime prefix = /usr
2200mythtv: could not connect to socket
3mythtv: Connection refused
4lirc_init failed for mythtv, see preceding messages
5Could not initialize /dev/input/js0
6open: No such file or directory
7ioctl JSIOCGAXES: Bad file descriptor
8no record for '/block/hdc/device' in database
9no record for '/block/hdc/queue' in database
10no record for '/block/sda/device' in database
11no record for '/block/sda/queue' in database
12no record for '/block/sdb/device' in database
13no record for '/block/sdb/queue' in database
14no record for '/block/sdc/device' in database
15no record for '/block/sdc/queue' in database
16no record for '/block/sdd/device' in database
17no record for '/block/sdd/queue' in database
18mount: No medium found
19mount: No medium found
20mount: No medium found
21mount: No medium found
22mount: No medium found
23mount: No medium found
24mount: No medium found
25mount: No medium found
26[mpeg2video @ 0x3cb03a4]mb incr damaged
27[mpeg2video @ 0x3cb03a4]ac-tex damaged at 22 22
28[mpeg2video @ 0x3cb03a4]ac-tex damaged at 1 23
29[mpeg2video @ 0x3cb03a4]ac-tex damaged at 30 24
30[mpeg2video @ 0x3cb03a4]invalid cbp at 25 25
31[mpeg2video @ 0x3cb03a4]ac-tex damaged at 3 26
32[mpeg2video @ 0x3cb03a4]invalid cbp at 27 28
33[mpeg2video @ 0x3cb03a4]ac-tex damaged at 11 29
34[mpeg2video @ 0x3cb03a4]invalid mb type in P Frame at 5 27
35[mpeg2video @ 0x3cb03a4]end mismatch left=811 347188
36[mpeg2video @ 0x3cb03a4]ac-tex damaged at 32 29
37gin.
382006-06-17 23:25:39.814 Registering MythDVD DVD Media Handler as a media handler ext()
392006-06-17 23:25:40.027 Registering MythDVD VCD Media Handler as a media handler ext()
402006-06-17 23:25:40.069 Registering MythGallery Media Handler 1/2 as a media handler ext()
412006-06-17 23:25:40.069 Registering MythGallery Media Handler 2/2 as a media handler ext(gif,jpg,png)
422006-06-17 23:25:40.069 MonitorRegisterExtensions(0x100, gif,jpg,png)
432006-06-17 23:25:40.179 Using NV NPOT texture extension
44adding: 1,0,0 -- DVD-ROM SD-616 
45adding: ATA:1,0,0 -- DVD-ROM SD-616 
46adding: ATAPI:0,0,0 -- DVD-ROM SD-616 
472006-06-17 23:25:40.370 Registering MythMusic Media Handler 1/2 as a media handler ext()
482006-06-17 23:25:40.371 Registering MythMusic Media Handler 2/2 as a media handler ext(ogg,mp3,aac,flac)
492006-06-17 23:25:40.371 MonitorRegisterExtensions(0x40, ogg,mp3,aac,flac)
50SIP listening on IP Address 192.168.1.101:5060 NAT address 192.168.1.101
51SIP: Cannot register; proxy, username or password not set
522006-06-17 23:25:40.751 Starting media monitor.
532006-06-17 23:25:40.872 Executing '/usr/bin/pmount /dev/sda'
542006-06-17 23:25:41.140 Failed to mount /dev/sda.
552006-06-17 23:25:41.143 Media status changed...  New status is: MEDIASTAT_NOTMOUNTED old status was MEDIASTAT_UNPLUGGED
562006-06-17 23:25:41.144 Executing '/usr/bin/pmount /dev/sdb'
572006-06-17 23:25:41.351 Failed to mount /dev/sdb.
582006-06-17 23:25:41.354 Media status changed...  New status is: MEDIASTAT_NOTMOUNTED old status was MEDIASTAT_UNPLUGGED
592006-06-17 23:25:41.355 Executing '/usr/bin/pmount /dev/sdc'
602006-06-17 23:25:41.556 Failed to mount /dev/sdc.
612006-06-17 23:25:41.559 Media status changed...  New status is: MEDIASTAT_NOTMOUNTED old status was MEDIASTAT_UNPLUGGED
622006-06-17 23:25:41.561 Executing '/usr/bin/pmount /dev/sdd'
632006-06-17 23:25:41.759 Failed to mount /dev/sdd.
642006-06-17 23:25:41.763 Media status changed...  New status is: MEDIASTAT_NOTMOUNTED old status was MEDIASTAT_UNPLUGGED
652006-06-17 23:25:44.830 XMLParse::LoadTheme using /usr/share/mythtv/themes/MythCenter/ui.xml
662006-06-17 23:25:45.538 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
672006-06-17 23:25:45.540 Using protocol version 30
682006-06-17 23:25:58.790 New DB connection, total: 2
692006-06-17 23:25:58.792 Connected to database 'mythconverg' at host: mythtv
702006-06-17 23:25:59.567 Unable to find image file: file not found.png
712006-06-17 23:25:59.567 Starting preview generator
722006-06-17 23:25:59.584 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
732006-06-17 23:25:59.587 Using protocol version 30
742006-06-17 23:26:00.119 Unable to find image file: file not found.png
752006-06-17 23:26:00.119 Starting preview generator
762006-06-17 23:26:00.121 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
772006-06-17 23:26:00.125 Preview: previewThreadDone took 9ms
782006-06-17 23:26:00.127 Using protocol version 30
792006-06-17 23:26:00.646 Unable to find image file: file not found.png
802006-06-17 23:26:00.646 Starting preview generator
812006-06-17 23:26:00.648 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
822006-06-17 23:26:00.650 Using protocol version 30
832006-06-17 23:26:00.653 Preview: previewThreadDone took 7ms
842006-06-17 23:26:01.117 PlaybackBox::play(): Error, file not found file not found
852006-06-17 23:26:02.049 Unable to find image file: file not found.png
862006-06-17 23:26:02.049 Starting preview generator
872006-06-17 23:26:02.053 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
882006-06-17 23:26:02.056 Using protocol version 30
892006-06-17 23:26:02.056 Preview: previewThreadDone took 8ms
902006-06-17 23:26:02.576 Unable to find image file: file not found.png
912006-06-17 23:26:02.576 Starting preview generator
922006-06-17 23:26:02.578 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
932006-06-17 23:26:02.580 Using protocol version 30
942006-06-17 23:26:02.583 Preview: previewThreadDone took 7ms
952006-06-17 23:26:03.096 Unable to find image file: file not found.png
962006-06-17 23:26:03.096 PlaybackBox Error: Attempted to generate preview for 'file not found.png' 5 times, giving up.
972006-06-17 23:26:03.104 Preview: previewThreadDone took 8ms
982006-06-17 23:26:34.807 XMLParse::LoadTheme using /usr/share/mythtv/themes/MythCenter/ui.xml
992006-06-17 23:26:39.802 Starting preview generator
1002006-06-17 23:26:39.974 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): OpenFile(/usr/local/media.local/8901_20060617231500.mpg, 0)
1012006-06-17 23:26:39.980 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): CalcReadAheadThresh(4000 KB)
102                         -> threshhold(146 KB) min read(32 KB) blk size(64 KB)
1030: start_time: 7889.658 duration: 3.453
1041: start_time: 7889.658 duration: 3.453
1052: start_time: 7889.658 duration: 3.453
106stream: start_time: 87662.868 duration: 38.372 bitrate=2022 kb/s
1072006-06-17 23:26:43.554 AFD: Stream #0, has id 0x2624 codec id MPEG2VIDEO, type Video, bitrate 15000000 at 0x0x8a95b30
1082006-06-17 23:26:43.568 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
1092006-06-17 23:26:43.568 AFD: Looking for decoder for MPEG2VIDEO
1102006-06-17 23:26:43.568 AFD: Opened codec 0x99ea890, id(MPEG2VIDEO) type(Video)
1112006-06-17 23:26:43.568 AFD: Stream #1, has id 0x2625 codec id AC3, type Audio, bitrate 0 at 0x0x9a886f0
1122006-06-17 23:26:43.569 AFD: Looking for decoder for AC3
1132006-06-17 23:26:43.610 AFD: Opened codec 0x99f5b80, id(AC3) type(Audio)
1142006-06-17 23:26:43.610 AFD: Stream #2, has id 0x2627 codec id AC3, type Audio, bitrate 0 at 0x0x8cd21b0
1152006-06-17 23:26:43.610 AFD: Looking for decoder for AC3
1162006-06-17 23:26:43.611 AFD: Opened codec 0x99f30e0, id(AC3) type(Audio)
1172006-06-17 23:26:43.611 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): CalcReadAheadThresh(15000 KB)
118                         -> threshhold(549 KB) min read(32 KB) blk size(256 KB)
1192006-06-17 23:26:43.619 Dec: Trying to select track (w/lang)
1202006-06-17 23:26:43.619 Dec: Selecting first track
1212006-06-17 23:26:43.619 Dec: Selected track #1 in the Unknown language(0)
1222006-06-17 23:26:43.619 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
1232006-06-17 23:26:43.622 Position map filled from DB to: 717
1242006-06-17 23:26:43.622 SyncPositionMap prerecorded, from DB: 26 entries
1252006-06-17 23:26:43.622 SyncPositionMap, new totframes: 717, new length: 23, posMap size: 26
1262006-06-17 23:26:43.622 AFD: Position map found
1272006-06-17 23:26:43.623 AFD: Successfully opened decoder for file: "/usr/local/media.local/8901_20060617231500.mpg". novideo(0)
1282006-06-17 23:26:43.640 VideoOutputNull()
1292006-06-17 23:26:43.640 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
1302006-06-17 23:26:43.641 Video Rect    left: 11, top: 10, width: 507, height: 461, aspect: 1.33333
1312006-06-17 23:26:43.641 Created data @0xb7b4bcb0->0xb7ba89b2
1322006-06-17 23:26:43.643 Created data @0xb2ba3020->0xb2bffd22
1332006-06-17 23:26:43.644 Created data @0xb2b46020->0xb2ba2d22
1342006-06-17 23:26:43.645 Created data @0xb2ae9020->0xb2b45d22
1352006-06-17 23:26:43.647 Created data @0xb2a8c020->0xb2ae8d22
1362006-06-17 23:26:43.648 Created data @0xb2a2f020->0xb2a8bd22
1372006-06-17 23:26:43.649 Created data @0xb29d2020->0xb2a2ed22
1382006-06-17 23:26:43.650 Created data @0xb2975020->0xb29d1d22
1392006-06-17 23:26:43.652 Created data @0xb2918020->0xb2974d22
1402006-06-17 23:26:43.653 Created data @0xb28bb020->0xb2917d22
1412006-06-17 23:26:43.654 Created data @0xb285e020->0xb28bad22
1422006-06-17 23:26:43.655 Created data @0xb2801020->0xb285dd22
1432006-06-17 23:26:43.657 Created data @0xb27a4020->0xb2800d22
1442006-06-17 23:26:43.658 Created data @0xb2747020->0xb27a3d22
1452006-06-17 23:26:43.659 Created data @0xb26ea020->0xb2746d22
1462006-06-17 23:26:43.660 Created data @0xb268d020->0xb26e9d22
1472006-06-17 23:26:43.662 Created data @0xb2630020->0xb268cd22
1482006-06-17 23:26:43.663 Created data @0xb25d3020->0xb262fd22
1492006-06-17 23:26:43.664 Created data @0xb2576020->0xb25d2d22
1502006-06-17 23:26:43.665 Created data @0xb2519020->0xb2575d22
1512006-06-17 23:26:43.667 Created data @0xb24bc020->0xb2518d22
1522006-06-17 23:26:43.668 Created data @0xb245f020->0xb24bbd22
1532006-06-17 23:26:43.669 Created data @0xb2402020->0xb245ed22
1542006-06-17 23:26:43.670 Created data @0xb23a5020->0xb2401d22
1552006-06-17 23:26:43.672 Created data @0xb2348020->0xb23a4d22
1562006-06-17 23:26:43.673 Created data @0xb22eb020->0xb2347d22
1572006-06-17 23:26:43.674 Created data @0xb228e020->0xb22ead22
1582006-06-17 23:26:43.675 Created data @0xb2231020->0xb228dd22
1592006-06-17 23:26:43.677 Created data @0xb21d4020->0xb2230d22
1602006-06-17 23:26:43.678 Created data @0xb2177020->0xb21d3d22
1612006-06-17 23:26:43.679 Created data @0xb211a020->0xb2176d22
1622006-06-17 23:26:43.680 Created data @0xb20bd020->0xb2119d22
1632006-06-17 23:26:43.681 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
1642006-06-17 23:26:43.681 Video Rect    left: 11, top: 10, width: 507, height: 461, aspect: 1.33333
1652006-06-17 23:26:43.682 NVP: ClearAfterSeek(1)
1662006-06-17 23:26:43.712 AFD: DoFastForward(357 (1), do discard frames)
1672006-06-17 23:26:43.712 Dec: DoFastForward(357 (1), do discard frames)
1682006-06-17 23:26:43.713 AFD: SeekReset(381, 0, do flush, do discard)
1692006-06-17 23:26:43.713 AFD: SeekReset() flushing
1702006-06-17 23:26:43.713 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
1712006-06-17 23:26:43.713 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
1722006-06-17 23:26:43.713 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
1732006-06-17 23:26:43.714 NVP: ClearAfterSeek(0)
1742006-06-17 23:26:43.740 ~VideoOutputNull()
1752006-06-17 23:26:43.760 Preview Warning: Failed to save preview.
176                        You may need to check user and group ownership
177                        on your frontend and backend for quicker previews.
178
179                        Attempting to regenerate preview on backend.
180
1812006-06-17 23:26:43.766 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
1822006-06-17 23:26:43.767 Using protocol version 30
1832006-06-17 23:26:44.021 Starting preview generator
1842006-06-17 23:26:44.041 RingBuf(/usr/local/media.local/8901_20060617232700.mpg): OpenFile(/usr/local/media.local/8901_20060617232700.mpg, 0)
1852006-06-17 23:26:44.046 RingBuf(/usr/local/media.local/8901_20060617232700.mpg): CalcReadAheadThresh(4000 KB)
186                         -> threshhold(146 KB) min read(32 KB) blk size(64 KB)
1870: start_time: 7951.149 duration: 0.248
1881: start_time: 7951.149 duration: 0.248
1892: start_time: 7951.149 duration: 0.248
190stream: start_time: 88346.100 duration: 2.753 bitrate=1552 kb/s
1912006-06-17 23:26:47.154 AFD: Stream #0, has id 0x2624 codec id MPEG2VIDEO, type Video, bitrate 15000000 at 0x0x9a8f940
1922006-06-17 23:26:47.154 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
1932006-06-17 23:26:47.154 AFD: Looking for decoder for MPEG2VIDEO
1942006-06-17 23:26:47.154 AFD: Opened codec 0x9a638f0, id(MPEG2VIDEO) type(Video)
1952006-06-17 23:26:47.155 AFD: Stream #1, has id 0x2625 codec id AC3, type Audio, bitrate 0 at 0x0x8bc92c0
1962006-06-17 23:26:47.155 AFD: Looking for decoder for AC3
1972006-06-17 23:26:47.155 AFD: Opened codec 0x9a51bb0, id(AC3) type(Audio)
1982006-06-17 23:26:47.156 AFD: Stream #2, has id 0x2627 codec id AC3, type Audio, bitrate 0 at 0x0x99f4350
1992006-06-17 23:26:47.156 AFD: Looking for decoder for AC3
2002006-06-17 23:26:47.156 AFD: Opened codec 0x99ea890, id(AC3) type(Audio)
2012006-06-17 23:26:47.156 RingBuf(/usr/local/media.local/8901_20060617232700.mpg): CalcReadAheadThresh(15000 KB)
202                         -> threshhold(549 KB) min read(32 KB) blk size(256 KB)
2032006-06-17 23:26:47.157 Dec: Trying to select track (w/lang)
2042006-06-17 23:26:47.157 Dec: Selecting first track
2052006-06-17 23:26:47.157 Dec: Selected track #1 in the Unknown language(0)
2062006-06-17 23:26:47.157 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2072006-06-17 23:26:47.159 Position map filled from DB to: 150
2082006-06-17 23:26:47.159 SyncPositionMap prerecorded, from DB: 6 entries
2092006-06-17 23:26:47.159 SyncPositionMap, new totframes: 150, new length: 5, posMap size: 6
2102006-06-17 23:26:47.159 AFD: Position map found
2112006-06-17 23:26:47.159 AFD: Successfully opened decoder for file: "/usr/local/media.local/8901_20060617232700.mpg". novideo(0)
2122006-06-17 23:26:47.163 VideoOutputNull()
2132006-06-17 23:26:47.163 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
2142006-06-17 23:26:47.163 Video Rect    left: 11, top: 10, width: 507, height: 461, aspect: 1.33333
2152006-06-17 23:26:47.165 Created data @0xb2ba3020->0xb2bffd22
2162006-06-17 23:26:47.166 Created data @0xb2b46020->0xb2ba2d22
2172006-06-17 23:26:47.167 Created data @0xb2ae9020->0xb2b45d22
2182006-06-17 23:26:47.168 Created data @0xb2a8c020->0xb2ae8d22
2192006-06-17 23:26:47.170 Created data @0xb2a2f020->0xb2a8bd22
2202006-06-17 23:26:47.171 Created data @0xb29d2020->0xb2a2ed22
2212006-06-17 23:26:47.172 Created data @0xb2975020->0xb29d1d22
2222006-06-17 23:26:47.173 Created data @0xb2918020->0xb2974d22
2232006-06-17 23:26:47.175 Created data @0xb28bb020->0xb2917d22
2242006-06-17 23:26:47.176 Created data @0xb285e020->0xb28bad22
2252006-06-17 23:26:47.177 Created data @0xb2801020->0xb285dd22
2262006-06-17 23:26:47.178 Created data @0xb27a4020->0xb2800d22
2272006-06-17 23:26:47.180 Created data @0xb2747020->0xb27a3d22
2282006-06-17 23:26:47.181 Created data @0xb26ea020->0xb2746d22
2292006-06-17 23:26:47.182 Created data @0xb268d020->0xb26e9d22
2302006-06-17 23:26:47.183 Created data @0xb2630020->0xb268cd22
2312006-06-17 23:26:47.185 Created data @0xb25d3020->0xb262fd22
2322006-06-17 23:26:47.186 Created data @0xb2576020->0xb25d2d22
2332006-06-17 23:26:47.187 Created data @0xb2519020->0xb2575d22
2342006-06-17 23:26:47.188 Created data @0xb24bc020->0xb2518d22
2352006-06-17 23:26:47.190 Created data @0xb245f020->0xb24bbd22
2362006-06-17 23:26:47.191 Created data @0xb2402020->0xb245ed22
2372006-06-17 23:26:47.192 Created data @0xb23a5020->0xb2401d22
2382006-06-17 23:26:47.193 Created data @0xb2348020->0xb23a4d22
2392006-06-17 23:26:47.195 Created data @0xb22eb020->0xb2347d22
2402006-06-17 23:26:47.196 Created data @0xb228e020->0xb22ead22
2412006-06-17 23:26:47.197 Created data @0xb2231020->0xb228dd22
2422006-06-17 23:26:47.198 Created data @0xb21d4020->0xb2230d22
2432006-06-17 23:26:47.199 Created data @0xb2177020->0xb21d3d22
2442006-06-17 23:26:47.201 Created data @0xb211a020->0xb2176d22
2452006-06-17 23:26:47.202 Created data @0xb20bd020->0xb2119d22
2462006-06-17 23:26:47.203 Created data @0xb2060020->0xb20bcd22
2472006-06-17 23:26:47.204 Display Rect  left: 0, top: 0, width: 0, height: 0, aspect: 1.33333
2482006-06-17 23:26:47.204 Video Rect    left: 11, top: 10, width: 507, height: 461, aspect: 1.33333
2492006-06-17 23:26:47.204 NVP: ClearAfterSeek(1)
2502006-06-17 23:26:47.225 AFD: DoFastForward(74 (1), do discard frames)
2512006-06-17 23:26:47.225 Dec: DoFastForward(74 (1), do discard frames)
2522006-06-17 23:26:47.225 AFD: SeekReset(90, 0, do flush, do discard)
2532006-06-17 23:26:47.225 AFD: SeekReset() flushing
2542006-06-17 23:26:47.225 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
2552006-06-17 23:26:47.226 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
2562006-06-17 23:26:47.226 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
2572006-06-17 23:26:47.226 NVP: ClearAfterSeek(0)
2582006-06-17 23:26:48.464 ~VideoOutputNull()
2592006-06-17 23:26:48.490 Preview Warning: Failed to save preview.
260                        You may need to check user and group ownership
261                        on your frontend and backend for quicker previews.
262
263                        Attempting to regenerate preview on backend.
264
2652006-06-17 23:26:48.491 Preview: previewThreadDone took 8ms
2662006-06-17 23:26:48.492 Connecting to backend server: 192.168.1.100:6543 (try 1 of 5)
2672006-06-17 23:26:48.494 Using protocol version 30
2682006-06-17 23:26:50.476 Preview: previewThreadDone took 8ms
2692006-06-17 23:26:50.482 TV: Attempting to change from None to WatchingRecording
2702006-06-17 23:26:50.483 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): OpenFile(/usr/local/media.local/8901_20060617231500.mpg, 12)
2712006-06-17 23:26:50.484 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): CalcReadAheadThresh(4000 KB)
272                         -> threshhold(146 KB) min read(32 KB) blk size(64 KB)
2732006-06-17 23:26:50.487 TV Error: Couldn't find recorder for in-progress recording
2742006-06-17 23:26:51.620 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): Waited 1.0 seconds for data to become available...
2752006-06-17 23:26:52.629 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): Waited 2.0 seconds for data to become available...
2760: start_time: 7889.658 duration: 3.453
2771: start_time: 7889.658 duration: 3.453
2782: start_time: 7889.658 duration: 3.453
279stream: start_time: 87662.868 duration: 38.372 bitrate=2022 kb/s
2802006-06-17 23:26:53.649 AFD: Stream #0, has id 0x2624 codec id MPEG2VIDEO, type Video, bitrate 15000000 at 0x0x8a95a10
2812006-06-17 23:26:53.682 detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
2822006-06-17 23:26:53.683 AFD: Looking for decoder for MPEG2VIDEO
2832006-06-17 23:26:53.683 AFD: Opened codec 0x99f30e0, id(MPEG2VIDEO) type(Video)
2842006-06-17 23:26:53.683 AFD: Stream #1, has id 0x2625 codec id AC3, type Audio, bitrate 0 at 0x0x9aae460
2852006-06-17 23:26:53.683 AFD: Looking for decoder for AC3
2862006-06-17 23:26:53.684 AFD: Opened codec 0x99f5b80, id(AC3) type(Audio)
2872006-06-17 23:26:53.684 AFD: Stream #2, has id 0x2627 codec id AC3, type Audio, bitrate 0 at 0x0x9a64690
2882006-06-17 23:26:53.684 AFD: Looking for decoder for AC3
2892006-06-17 23:26:53.685 AFD: Opened codec 0x9a51bb0, id(AC3) type(Audio)
2902006-06-17 23:26:53.685 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): CalcReadAheadThresh(15000 KB)
291                         -> threshhold(549 KB) min read(32 KB) blk size(256 KB)
2922006-06-17 23:26:53.686 Opening audio device 'default'.
2932006-06-17 23:26:53.861 Dec: Trying to select track (w/lang)
2942006-06-17 23:26:53.862 Dec: Selecting first track
2952006-06-17 23:26:53.863 Dec: Selected track #1 in the Unknown language(0)
2962006-06-17 23:26:53.863 Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2972006-06-17 23:26:53.866 Position map filled from DB to: 717
2982006-06-17 23:26:53.866 SyncPositionMap prerecorded, from DB: 26 entries
2992006-06-17 23:26:53.866 SyncPositionMap, new totframes: 717, new length: 23, posMap size: 26
3002006-06-17 23:26:53.867 AFD: Position map found
3012006-06-17 23:26:53.867 AFD: Successfully opened decoder for file: "/usr/local/media.local/8901_20060617231500.mpg". novideo(0)
3022006-06-17 23:26:53.870 VideoOutputXv: ctor
3032006-06-17 23:26:53.872 Over/underscan. V: 0.02, H: 0.02, XOff: 0, YOff: 0
3042006-06-17 23:26:53.872 Display Rect  left: 0, top: 0, width: 1024, height: 768, aspect: 1.33333
3052006-06-17 23:26:53.872 Video Rect    left: 11, top: 10, width: 507, height: 461, aspect: 1.33333
3062006-06-17 23:26:53.873 VideoOutputXv: Pixel dimensions: Screen 1024x768, window 1024x768
3072006-06-17 23:26:53.873 VideoOutputXv: Estimated display dimensions: 203x152 mm  Aspect: 1.33553
3082006-06-17 23:26:53.873 VideoOutputXv: Estimated window dimensions: 203x152 mm  Aspect: 1.33553
3092006-06-17 23:26:53.875 VideoOutputXv: XvMCTex: Init failed
3102006-06-17 23:26:53.876 VideoOutputXv: @ j=3 Looking for flag[s]: XvInputMask XvImageMask
3112006-06-17 23:26:53.876 VideoOutputXv: Adaptor#0: NV17 Video Overlay has flag[s]: XvInputMask XvImageMask
3122006-06-17 23:26:53.876 VideoOutputXv: Grabbed xv port 240
3132006-06-17 23:26:53.877 VideoOutputXv: XVideo surface found on port 240
3142006-06-17 23:26:53.877 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Overlay'
3152006-06-17 23:26:53.877 VideoOutputXv: XVideo Format #0 is 'YUY2'
3162006-06-17 23:26:53.878 VideoOutputXv: XVideo Format #1 is 'YV12'
3172006-06-17 23:26:53.878 VideoOutputXv: XVideo Format #2 is 'UYVY'
3182006-06-17 23:26:53.878 VideoOutputXv: XVideo Format #3 is 'I420'
3192006-06-17 23:26:53.878 VideoOutputXv: Using XVideo Format 'I420'
3202006-06-17 23:26:53.878 VideoOutputXv: CreateShmImages(32): video_dim: 528x480
3212006-06-17 23:26:53.926 Display Rect  left: 0, top: 0, width: 1024, height: 768, aspect: 1.33333
3222006-06-17 23:26:53.927 Video Rect    left: 11, top: 10, width: 507, height: 461, aspect: 1.33333
3232006-06-17 23:26:54.568 OSDTypePositionImage::AddPosition[0](95x281  1, 1)
3242006-06-17 23:26:54.568 OSDTypePositionImage::AddPosition[1](95x311  1, 1)
3252006-06-17 23:26:54.568 OSDTypePositionImage::AddPosition[2](95x341  1, 1)
3262006-06-17 23:26:54.568 OSDTypePositionImage::AddPosition[3](95x371  1, 1)
3272006-06-17 23:26:56.338 NVP: ClearAfterSeek(1)
3282006-06-17 23:26:56.339 VideoOutputXv: ClearAfterSeek()
3292006-06-17 23:26:56.339 VideoOutputXv: DiscardFrames(0)
3302006-06-17 23:26:56.339 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3312006-06-17 23:26:56.339 VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3322006-06-17 23:26:56.339 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3332006-06-17 23:26:56.341 The realtime priority setting is not enabled.
3342006-06-17 23:26:56.343 TV: StartPlayer(): took 5843 ms to start player.
3352006-06-17 23:26:56.345 TV: Changing from None to WatchingPreRecorded
3362006-06-17 23:26:56.350 Using deinterlace method kerneldeint
3372006-06-17 23:26:56.455 nVidiaVideoSync: VBlank ioctl did not work, unimplemented in this driver?
3382006-06-17 23:26:56.456 DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
3392006-06-17 23:26:56.459 OpenGLVideoSync: GLX extensions: GLX_EXT_visual_info GLX_EXT_visual_rating GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGI_video_sync GLX_SGI_swap_control GLX_ARB_multisample GLX_NV_float_buffer GLX_ARB_get_proc_address
3402006-06-17 23:26:56.460 OpenGLVideoSync: x,y -> 513, 385
3412006-06-17 23:26:56.507 Using OpenGLVideoSync
3422006-06-17 23:26:56.518 Using audio as timebase
3432006-06-17 23:26:56.518 Video timing method: SGI OpenGL
3442006-06-17 23:26:56.518 Refresh rate: 11765, frame interval: 33366
3452006-06-17 23:26:56.529 NVP: Waiting for prebuffer.. 0 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3462006-06-17 23:26:56.671 NVP: Waiting for prebuffer.. 1 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3472006-06-17 23:26:56.812 NVP: Waiting for prebuffer.. 2 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3482006-06-17 23:26:56.953 NVP: Waiting for prebuffer.. 3 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3492006-06-17 23:26:57.094 NVP: Waiting for prebuffer.. 4 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3502006-06-17 23:26:57.235 NVP: Waiting for prebuffer.. 5 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3512006-06-17 23:26:57.376 NVP: Waiting for prebuffer.. 6 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3522006-06-17 23:26:57.518 NVP: Waiting for prebuffer.. 7 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3532006-06-17 23:26:57.659 NVP: Waiting for prebuffer.. 8 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3542006-06-17 23:26:57.800 NVP: Waiting for prebuffer.. 9 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3552006-06-17 23:26:57.936 NVP: Prebuffer wait timed out 10 times.
3562006-06-17 23:26:57.941 NVP: Waiting for prebuffer.. 0 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3572006-06-17 23:26:57.992 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): Waited 1.0 seconds for data to become available...
3582006-06-17 23:26:58.082 NVP: Waiting for prebuffer.. 1 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3592006-06-17 23:26:58.223 NVP: Waiting for prebuffer.. 2 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3602006-06-17 23:26:58.365 NVP: Waiting for prebuffer.. 3 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3612006-06-17 23:26:58.506 NVP: Waiting for prebuffer.. 4 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3622006-06-17 23:26:58.647 NVP: Waiting for prebuffer.. 5 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3632006-06-17 23:26:58.788 NVP: Waiting for prebuffer.. 6 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3642006-06-17 23:26:58.929 NVP: Waiting for prebuffer.. 7 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3652006-06-17 23:26:59.001 RingBuf(/usr/local/media.local/8901_20060617231500.mpg): Waited 2.0 seconds for data to become available...
3662006-06-17 23:26:59.070 NVP: Waiting for prebuffer.. 8 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3672006-06-17 23:26:59.212 NVP: Waiting for prebuffer.. 9 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3682006-06-17 23:26:59.348 NVP: Prebuffer wait timed out 10 times.
3692006-06-17 23:26:59.353 NVP: Waiting for prebuffer.. 0 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3702006-06-17 23:26:59.494 NVP: Waiting for prebuffer.. 1 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3712006-06-17 23:26:59.635 NVP: Waiting for prebuffer.. 2 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3722006-06-17 23:26:59.776 NVP: Waiting for prebuffer.. 3 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3732006-06-17 23:26:59.918 NVP: Waiting for prebuffer.. 4 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3742006-06-17 23:27:00.059 NVP: Waiting for prebuffer.. 5 uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3752006-06-17 23:27:00.077 Resyncing position map. posmapStarted = 1 livetv(0) watchingRec(0)
3762006-06-17 23:27:00.077 NVP: Exited decoder loop.
3772006-06-17 23:27:00.202 VideoOutputXv: dtor
3782006-06-17 23:27:00.202 VideoOutputXv: DiscardFrames(1)
3792006-06-17 23:27:00.202 VideoBuffers::DiscardFrames(1): uLAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3802006-06-17 23:27:00.202 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3812006-06-17 23:27:00.202 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3822006-06-17 23:27:00.203 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3832006-06-17 23:27:00.203 VideoOutputXv: DiscardFrames(1)
3842006-06-17 23:27:00.203 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA
3852006-06-17 23:27:00.203 VideoBuffers::DiscardFrames(): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3862006-06-17 23:27:00.203 VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done
3872006-06-17 23:27:00.203 VideoOutputXv: DiscardFrames() 3: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA -- done()
3882006-06-17 23:27:00.207 VideoOutputXv: Closing XVideo port 240
3892006-06-17 23:27:00.227 TV Error: nvp->IsPlaying() timed out
3902006-06-17 23:27:00.228 TV: Attempting to change from WatchingPreRecorded to None
3912006-06-17 23:27:00.228 TV: StopStuff() -- begin
3922006-06-17 23:27:00.228 TV: StopStuff(): stopping ring buffer[s]
3932006-06-17 23:27:00.238 TV: StopStuff(): stopping player[s] (1/2)
3942006-06-17 23:27:00.239 TV: StopStuff(): stopping player[s] (2/2)
3952006-06-17 23:27:00.290 TV: StopStuff() -- end
3962006-06-17 23:27:00.290 TV: Changing from WatchingPreRecorded to None