Ticket #4768: backend3.txt

File backend3.txt, 27.0 KB (added by Mark Buechler <Mark.Buechler@…>, 16 years ago)

Backend 3

Line 
12008-02-24 18:33:51.400 SM(5)::Stop: begin
22008-02-24 18:33:51.403 TVRec(5): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady,
32008-02-24 18:33:51.407 SM(5)::Stop: end
42008-02-24 18:33:51.420 TVRec(5): FinishedRecording(Zoolander) in recgroup: LiveTV
52008-02-24 18:33:51.425 Chain: Updated endtime for '638_20080224183344' to 20080224183351
62008-02-24 18:33:51.432 Finished recording Zoolander: channel 638
72008-02-24 18:33:51.450 scheduler: Finished recording: Zoolander: channel 638
82008-02-24 18:33:51.476 Using profile 'Live TV' to record
92008-02-24 18:33:51.479 TVRec(5): SwitchLiveTVRingBuffer(discont 1, set_rec 0)
102008-02-24 18:33:51.481 TVRec(5): GetProgramRingBufferForLiveTV()
112008-02-24 18:33:52.552 TVRec(5): StartedRecording(0xa2130050) fn(/shares/recordings/LiveTV/638_20080224183351.mpg)
122008-02-24 18:33:52.562 TFW: Using io multiplier 3, min/max = 16384/131072
132008-02-24 18:33:52.580 TVRec(5): FinishedRecording(Zoolander) in recgroup: LiveTV
142008-02-24 18:33:52.584 Chain: Updated endtime for '638_20080224183344' to 20080224183352
152008-02-24 18:33:52.627 Finished recording Zoolander: channel 638
162008-02-24 18:33:52.638 Preview: 'myth://192.168.1.121:6543/638_20080224183344.mpg' is not local,
17                        replacing with '/shares/recordings/LiveTV/638_20080224183344.mpg', which is local.
182008-02-24 18:33:52.655 Chain: Appended@2 '638_20080224183351'
192008-02-24 18:33:52.695 RecBase(5:5): SetRingBuffer(0xb12ef718) '/shares/recordings/LiveTV/638_20080224183351.mpg'
202008-02-24 18:33:52.700 DVBRec(5:5): SetPAT(9499 on 0x21)
212008-02-24 18:33:52.703 CreatePATSingleProgram()
222008-02-24 18:33:52.704 PAT in input stream
232008-02-24 18:33:52.706 Program Association Table
24 PSIP tableID(0x0) length(37) extension(0x196)
25      version(20) current(1) section(0) last_section(0)
26         tsid: 406
27 programCount: 7
28  program number     0 has PID 0x  10   data  0x 0 0x 0 0xe0 0x10
29  program number  5352 has PID 0x  21   data  0x14 0xe8 0xe0 0x21
30  program number  5711 has PID 0x  21   data  0x16 0x4f 0xe0 0x21
31  program number  9499 has PID 0x  21   data  0x25 0x1b 0xe0 0x21
32  program number  9500 has PID 0x  21   data  0x25 0x1c 0xe0 0x21
33  program number  9508 has PID 0x  21   data  0x25 0x24 0xe0 0x21
34  program number  9509 has PID 0x  21   data  0x25 0x25 0xe0 0x21
35
362008-02-24 18:33:52.709 desired_program(9499) pid(0x21)
372008-02-24 18:33:52.711 pmt_pid(0x21)
382008-02-24 18:33:52.712 PAT for output stream
392008-02-24 18:33:52.714 Program Association Table
40 PSIP tableID(0x0) length(13) extension(0x196)
41      version(20) current(1) section(0) last_section(0)
42         tsid: 406
43 programCount: 1
44  program number     1 has PID 0x  21   data  0x 0 0x 1 0xe0 0x21
45
462008-02-24 18:33:52.717 DVBRec(5:5): SetPMT(9499)
472008-02-24 18:33:52.719 CreatePMTSingleProgram()
482008-02-24 18:33:52.721 PMT in input stream
492008-02-24 18:33:52.722 Program Map Table ver(2) pid(0x21) pnum(9499) len(65)
50
51 Stream #0 pid(0x1122) type(video-h264  0x1b)
52  Conditional Access: sid(0x1816) pid(0x28) data_size(0)
53  Conditional Access: sid(0x1810) pid(0x128) data_size(0)
54  Conditional Access: sid(0x1801) pid(0x128) data_size(0)
55 Stream #1 pid(0x1123) type(audio-ac3  0x81)
56  Conditional Access: sid(0x1816) pid(0x28) data_size(0)
57  Conditional Access: sid(0x1810) pid(0x128) data_size(0)
58  Conditional Access: sid(0x1801) pid(0x128) data_size(0)
59  ISO-639 Language: code(eng) canonical(eng) eng(English)
60
612008-02-24 18:33:52.725 PMT for output stream
622008-02-24 18:33:52.727 Program Map Table ver(2) pid(0x21) pnum(1) len(29)
63
64 Stream #0 pid(0x1122) type(video-h264  0x1b)
65 Stream #1 pid(0x1123) type(audio-ac3  0x81)
66  ISO-639 Language: code(eng) canonical(eng) eng(English)
67
682008-02-24 18:33:52.729 RecBase(5:5): SetRecording(0xb12ef5d0) title(Zoolander)
692008-02-24 18:33:52.736 DVBRec(5:5): Card opened successfully fd(-1)
702008-02-24 18:33:52.739 DVBSH(5): AddListener(0xa69c0948) -- begin
712008-02-24 18:33:52.741 DVBSH(5): AddListener(0xa69c0948) -- locked
722008-02-24 18:33:52.743 TVRec(5): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
732008-02-24 18:33:52.746 TVRec(5): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
742008-02-24 18:33:52.748 DVBSH(5): AddListener(0xa69c0948) -- end
752008-02-24 18:33:52.824 AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 15 min
762008-02-24 18:33:53.041 DevRdB(5): buffer size 65800 KB
772008-02-24 18:33:53.044 DVBSH(5): RunTS(): begin
782008-02-24 18:33:53.046 DVBSH(5): AddPIDFilter(0x0) priority 2
792008-02-24 18:33:53.048 PIDInfo(5): Opening filter for pid 0x0
802008-02-24 18:33:53.051 DVBSH(5): AddPIDFilter(0x10) priority 2
812008-02-24 18:33:53.053 PIDInfo(5): Opening filter for pid 0x10
822008-02-24 18:33:53.055 DVBSH(5): AddPIDFilter(0x11) priority 2
832008-02-24 18:33:53.056 PIDInfo(5): Opening filter for pid 0x11
842008-02-24 18:33:53.058 DVBSH(5): AddPIDFilter(0x14) priority 2
852008-02-24 18:33:53.060 PIDInfo(5): Opening filter for pid 0x14
862008-02-24 18:33:53.061 DVBSH(5): AddPIDFilter(0x21) priority 2
872008-02-24 18:33:53.063 PIDInfo(5): Opening filter for pid 0x21
882008-02-24 18:33:53.065 DVBSH(5): AddPIDFilter(0x1122) priority 3
892008-02-24 18:33:53.067 PIDInfo(5): Opening filter for pid 0x1122
902008-02-24 18:33:53.069 DVBSH(5): AddPIDFilter(0x1123) priority 3
912008-02-24 18:33:53.071 PIDInfo(5): Opening filter for pid 0x1123
922008-02-24 18:33:53.073 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x10, continuity counter: 14 (expected 7).
932008-02-24 18:33:53.075 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x11, continuity counter: 0 (expected 3).
942008-02-24 18:33:53.108 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x21, continuity counter: 13 (expected 4).
952008-02-24 18:33:53.157 PID 0x1123 Found Payload Start
962008-02-24 18:33:53.262 Using runtime prefix = /opt/mns/mythtv.15682, libdir = /opt/mns/mythtv.15682/lib
972008-02-24 18:33:53.269 Empty LocalHostName.
982008-02-24 18:33:53.271 Using localhost value of corbin2
992008-02-24 18:33:53.345 New DB connection, total: 1
1002008-02-24 18:33:53.367 Connected to database 'mythconverg' at host: corbin2
1012008-02-24 18:33:53.373 Closing DB connection named 'DBManager0'
1022008-02-24 18:33:53.377 Connected to database 'mythconverg' at host: corbin2
1032008-02-24 18:33:53.385 Current Schema Version: 1208
1042008-02-24 18:33:53.405 New DB connection, total: 2
1052008-02-24 18:33:53.408 Connected to database 'mythconverg' at host: corbin2
1062008-02-24 18:33:53.447 Preview Error: Previewer file '/shares/recordings/LiveTV/638_20080224183344.mpg' is not valid.
1072008-02-24 18:33:53.451 Preview Error: Run() file not local: '/shares/recordings/LiveTV/638_20080224183344.mpg'
1082008-02-24 18:33:53.482 Preview Error: Preview process not ok.
109                        fileinfo(/shares/recordings/LiveTV/638_20080224183344.mpg.png) exits: 0 readable: 0 size: 0
1102008-02-24 18:33:53.532 DVBRec(5:5): PID 0x1123 discontinuity detected
1112008-02-24 18:33:53.853 PID 0x1122 Found Payload Start
1122008-02-24 18:33:54.862 SM(3)::AddFlags: Seen(SDT,) Match() Wait()
1132008-02-24 18:33:54.869 DTVSM(3)::SetSDT(): tsid = 1 orig_net_id = 256
1142008-02-24 18:33:54.871 SM(3)::AddFlags: Seen() Match(SDT,) Wait()
1152008-02-24 18:33:54.872 SM(3)::RemoveFlags: Seen() Match() Wait(Pos,)
1162008-02-24 18:33:54.874 SM(3)::AddFlags: Seen(SDT,) Match() Wait()
1172008-02-24 18:33:54.876 DTVSM(3)::SetSDT(): tsid = 1 orig_net_id = 256
1182008-02-24 18:33:54.878 SM(3)::AddFlags: Seen() Match(SDT,) Wait()
1192008-02-24 18:33:54.880 SM(3)::RemoveFlags: Seen() Match() Wait(Pos,)
1202008-02-24 18:33:54.882 DVBSH(3): AddPIDFilter(0x12) priority 2
1212008-02-24 18:33:54.884 PIDInfo(3): Opening filter for pid 0x12
1222008-02-24 18:33:54.887 DVBSH(3): AddPIDFilter(0x300) priority 2
1232008-02-24 18:33:54.889 PIDInfo(3): Opening filter for pid 0x300
1242008-02-24 18:33:54.892 DVBSH(3): AddPIDFilter(0x441) priority 2
1252008-02-24 18:33:54.894 PIDInfo(3): Opening filter for pid 0x441
1262008-02-24 18:33:56.815 Scheduled 216 items in 8.2 = 0.54 match + 7.61 place
1272008-02-24 18:33:56.832 scheduler: Last message repeated 1 times: Finished recording: Zoolander: channel 638
1282008-02-24 18:33:56.849 scheduler: Scheduled items: Scheduled 216 items in 8.2 = 0.54 match + 7.61 place
1292008-02-24 18:33:58.752 DVBSH(3): RemovePIDFilter(0x12)
1302008-02-24 18:33:58.762 PIDInfo(3): Closing filter for pid 0x12
1312008-02-24 18:33:58.765 DVBSH(3): RemovePIDFilter(0x300)
1322008-02-24 18:33:58.766 PIDInfo(3): Closing filter for pid 0x300
1332008-02-24 18:33:58.769 DVBSH(3): RemovePIDFilter(0x441)
1342008-02-24 18:33:58.770 PIDInfo(3): Closing filter for pid 0x441
1352008-02-24 18:34:12.247 Expiring 10 MBytes for 1356 @ Sun Feb 24 18:00:00 2008 => Meet the Press
1362008-02-24 18:34:12.262 autoexpire: Expiring Program: Expiring 10 MBytes for 1356 @ Sun Feb 24 18:00:00 2008 => Meet the Press
1372008-02-24 18:34:12.264 Expiring 0 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1382008-02-24 18:34:12.280 autoexpire: Expiring Program: Expiring 0 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1392008-02-24 18:34:12.282 Expiring 2 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1402008-02-24 18:34:12.299 autoexpire: Expiring Program: Expiring 2 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1412008-02-24 18:34:12.301 Expiring 4 MBytes for 1356 @ Sun Feb 24 18:00:00 2008 => Meet the Press
1422008-02-24 18:34:12.316 autoexpire: Expiring Program: Expiring 4 MBytes for 1356 @ Sun Feb 24 18:00:00 2008 => Meet the Press
1432008-02-24 18:34:12.319 Expiring 0 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1442008-02-24 18:34:12.332 autoexpire: Expiring Program: Expiring 0 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1452008-02-24 18:34:12.334 Expiring 5 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1462008-02-24 18:34:12.349 autoexpire: Expiring Program: Expiring 5 MBytes for 50627 @ Sun Feb 24 18:00:00 2008 => Terminator... "Dungeons & Dragons"
1472008-02-24 18:34:13.513 DVBSH(5): AddPIDFilter(0x12) priority 2
1482008-02-24 18:34:13.518 PIDInfo(5): Opening filter for pid 0x12
1492008-02-24 18:34:13.522 DVBSH(5): AddPIDFilter(0x300) priority 2
1502008-02-24 18:34:13.523 PIDInfo(5): Opening filter for pid 0x300
1512008-02-24 18:34:13.526 DVBSH(5): AddPIDFilter(0x441) priority 2
1522008-02-24 18:34:13.527 PIDInfo(5): Opening filter for pid 0x441
1532008-02-24 18:34:15.550 TVRec(5): StopLiveTV(void) curRec: 0xa2130050 pseudoRec: 0
1542008-02-24 18:34:15.558 TVRec(5): Changing from WatchingLiveTV to None
1552008-02-24 18:34:15.562 TVRec(5): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
1562008-02-24 18:34:15.564 TVRec(5): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,)
1572008-02-24 18:34:15.589 DVBSH(5): RemoveListener(0xa69c0948) -- begin
1582008-02-24 18:34:15.591 DVBSH(5): RemoveListener(0xa69c0948) -- locked
1592008-02-24 18:34:15.613 DVBSH(5): RunTS(): shutdown
1602008-02-24 18:34:15.615 DVBSH(5): RemovePIDFilter(0x0)
1612008-02-24 18:34:15.617 PIDInfo(5): Closing filter for pid 0x0
1622008-02-24 18:34:15.619 DVBSH(5): RemovePIDFilter(0x10)
1632008-02-24 18:34:15.620 PIDInfo(5): Closing filter for pid 0x10
1642008-02-24 18:34:15.623 DVBSH(5): RemovePIDFilter(0x11)
1652008-02-24 18:34:15.627 PIDInfo(5): Closing filter for pid 0x11
1662008-02-24 18:34:15.629 DVBSH(5): RemovePIDFilter(0x12)
1672008-02-24 18:34:15.630 PIDInfo(5): Closing filter for pid 0x12
1682008-02-24 18:34:15.632 DVBSH(5): RemovePIDFilter(0x14)
1692008-02-24 18:34:15.634 PIDInfo(5): Closing filter for pid 0x14
1702008-02-24 18:34:15.636 DVBSH(5): RemovePIDFilter(0x21)
1712008-02-24 18:34:15.638 PIDInfo(5): Closing filter for pid 0x21
1722008-02-24 18:34:15.641 DVBSH(5): RemovePIDFilter(0x300)
1732008-02-24 18:34:15.643 PIDInfo(5): Closing filter for pid 0x300
1742008-02-24 18:34:15.645 DVBSH(5): RemovePIDFilter(0x441)
1752008-02-24 18:34:15.646 PIDInfo(5): Closing filter for pid 0x441
1762008-02-24 18:34:15.648 DVBSH(5): RemovePIDFilter(0x1122)
1772008-02-24 18:34:15.650 PIDInfo(5): Closing filter for pid 0x1122
1782008-02-24 18:34:15.651 DVBSH(4): AddPIDFilter(0x12) priority 2
1792008-02-24 18:34:15.654 DVBSH(5): RemovePIDFilter(0x1123)
1802008-02-24 18:34:15.656 PIDInfo(4): Opening filter for pid 0x12
1812008-02-24 18:34:15.659 PIDInfo(5): Closing filter for pid 0x1123
1822008-02-24 18:34:15.661 DVBSH(4): AddPIDFilter(0x300) priority 2
1832008-02-24 18:34:15.677 PIDInfo(4): Opening filter for pid 0x300
1842008-02-24 18:34:15.678 DVBSH(5): RunTS(): end
1852008-02-24 18:34:15.680 DVBSH(4): AddPIDFilter(0x441) priority 2
1862008-02-24 18:34:15.683 DVBSH(5): RemoveListener(0xa69c0948) -- end
1872008-02-24 18:34:15.684 PIDInfo(4): Opening filter for pid 0x441
1882008-02-24 18:34:15.686 DVBRec(5:5): Close() fd(-1) -- begin
1892008-02-24 18:34:15.694 DVBRec(5:5): Close() fd(-1) -- end
1902008-02-24 18:34:15.808 TVRec(5): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
1912008-02-24 18:34:15.821 TVRec(5): FinishedRecording(Zoolander) in recgroup: LiveTV
1922008-02-24 18:34:15.827 Chain: Updated endtime for '638_20080224183351' to 20080224183415
1932008-02-24 18:34:15.832 Finished recording Zoolander: channel 638
1942008-02-24 18:34:15.846 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x441, continuity counter: 0 (expected 14).
1952008-02-24 18:34:15.847 scheduler: Finished recording: Zoolander: channel 638
1962008-02-24 18:34:15.852 TVRec(5): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
1972008-02-24 18:34:15.854 TVRec(5): Tearing down RingBuffer
1982008-02-24 18:34:15.859 TVRec(5): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
1992008-02-24 18:34:16.351 DVBSH(4): RemovePIDFilter(0x12)
2002008-02-24 18:34:16.354 PIDInfo(4): Closing filter for pid 0x12
2012008-02-24 18:34:16.356 DVBSH(4): RemovePIDFilter(0x300)
2022008-02-24 18:34:16.359 PIDInfo(4): Closing filter for pid 0x300
2032008-02-24 18:34:16.361 DVBSH(4): RemovePIDFilter(0x441)
2042008-02-24 18:34:16.362 PIDInfo(4): Closing filter for pid 0x441
2052008-02-24 18:34:18.485 Getting next free recorder after : -1
2062008-02-24 18:34:18.488 Checking card 1. Best card so far -1
2072008-02-24 18:34:18.490 Checking card 2. Best card so far 2
2082008-02-24 18:34:18.491 Checking card 3. Best card so far 2
2092008-02-24 18:34:18.493 Checking card 4. Best card so far 4
2102008-02-24 18:34:18.495 Checking card 5. Best card so far 5
2112008-02-24 18:34:18.496 Checking card 12. Best card so far 5
2122008-02-24 18:34:18.498 Checking card 105. Best card so far 105
2132008-02-24 18:34:18.499 Checking card 205. Best card so far 205
2142008-02-24 18:34:18.501 Checking card 1000. Best card so far 1000
2152008-02-24 18:34:18.503 Checking card 1001. Best card so far 1001
2162008-02-24 18:34:18.508 MainServer::HandleAnnounce Playback
2172008-02-24 18:34:18.510 adding: pc4 as a client (events: 0)
2182008-02-24 18:34:18.517 TVRec(1001): Changing from None to WatchingLiveTV
2192008-02-24 18:34:18.520 TVRec(1001): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RingBufferReady,
2202008-02-24 18:34:18.523 TVRec(1001): Request: Program(no) channel() input() flags(LiveTV,)
2212008-02-24 18:34:18.529 TVRec(1001): Start channel: 356.
2222008-02-24 18:34:18.545 TVRec(1001): HW Tuner: 1001->1001
2232008-02-24 18:34:18.547 TVRec(1001): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
2242008-02-24 18:34:18.548 TVRec(1001): No recorder yet, calling TuningFrequency
2252008-02-24 18:34:18.554 Channel(/dev/video1): Device name 'WinTV PVR 500 (unit #2)' driver 'ivtv'.
2262008-02-24 18:34:19.681 ChannelBase(1001): Input #2: 'S-Video 1' schan(356) sourceid(1) ccid(1001)
2272008-02-24 18:34:19.683 ChannelBase(1001): Current Input #2: 'S-Video 1'
2282008-02-24 18:34:19.684 Global TVFormat Setting 'NTSC'
2292008-02-24 18:34:19.686 Channel(/dev/video1): Input #2: 'S-Video 1' schan(356) tun() v4l1(NTSC) v4l2(NTSC)
2302008-02-24 18:34:19.687 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(2)
2312008-02-24 18:34:19.689 Channel(/dev/video1)::SwitchToInput(in 2, '')
2322008-02-24 18:34:19.696 Channel(/dev/video1): SetInputAndFormat(2, NTSC) (v4l v2)
2332008-02-24 18:34:19.698 Channel(/dev/video1): SetChannelByString(356)
2342008-02-24 18:34:19.709 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(2)
2352008-02-24 18:34:19.711 External channel change: /usr/local/bin/RCA2.pl 356
2362008-02-24 18:34:19.717 Waiting for External Tuning program to exit
2373562008-02-24 18:34:19.938 DVBSH(3): AddPIDFilter(0x12) priority 2
2382008-02-24 18:34:19.943 PIDInfo(3): Opening filter for pid 0x12
2392008-02-24 18:34:19.945 DVBSH(3): AddPIDFilter(0x300) priority 2
2402008-02-24 18:34:19.947 PIDInfo(3): Opening filter for pid 0x300
2412008-02-24 18:34:19.948 DVBSH(3): AddPIDFilter(0x441) priority 2
2422008-02-24 18:34:19.950 PIDInfo(3): Opening filter for pid 0x441
2432008-02-24 18:34:20.625 DVBSH(3): RemovePIDFilter(0x12)
2442008-02-24 18:34:20.627 PIDInfo(3): Closing filter for pid 0x12
2452008-02-24 18:34:20.629 DVBSH(3): RemovePIDFilter(0x300)
2462008-02-24 18:34:20.630 PIDInfo(3): Closing filter for pid 0x300
2472008-02-24 18:34:20.632 DVBSH(3): RemovePIDFilter(0x441)
2482008-02-24 18:34:20.634 PIDInfo(3): Closing filter for pid 0x441
2492008-02-24 18:34:20.721 ret_pid(5116) child(5116) status(0x0)
2502008-02-24 18:34:20.723 External Tuning program no longer running
2512008-02-24 18:34:20.725 External Tuning program exited with no error
2522008-02-24 18:34:20.731 Channel(/dev/video1): InitPictureAttribute(brightness):  128
253                        [    0,  255] dflt(  128, 0.50, 128)
2542008-02-24 18:34:20.738 Channel(/dev/video1): InitPictureAttribute(  contrast):  63
255                        [    0,  127] dflt(   64, 0.50, 257)
2562008-02-24 18:34:20.744 Channel(/dev/video1): InitPictureAttribute(    colour):  63
257                        [    0,  127] dflt(   64, 0.50, 257)
2582008-02-24 18:34:20.752 Channel(/dev/video1): InitPictureAttribute(       hue):  0
259                        [ -128,  127] dflt(    0, 0.50, 128)
2602008-02-24 18:34:20.755 TVRec(1001): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,RingBufferReady,
2612008-02-24 18:34:20.756 TVRec(1001): SetFlags(NeedToStartRecorder,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady,
2622008-02-24 18:34:20.758 TVRec(1001): Starting Recorder
2632008-02-24 18:34:20.855 Using profile 'Live TV' to record
2642008-02-24 18:34:20.857 TVRec(1001): CreateLiveTVRingBuffer()
2652008-02-24 18:34:20.859 TVRec(1001): GetProgramRingBufferForLiveTV()
2662008-02-24 18:34:21.929 TVRec(1001): StartedRecording(0xa216df88) fn(/shares/recordings/LiveTV/1356_20080224183420.mpg)
2672008-02-24 18:34:21.939 TFW: Using io multiplier 3, min/max = 16384/131072
2682008-02-24 18:34:21.947 Chain: Appended@0 '1356_20080224183420'
2692008-02-24 18:34:21.953 TVRec(1001): SetFlags(RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady,
2702008-02-24 18:34:21.964 RecBase(1001:/dev/video1): SetRingBuffer(0xa902f7d0) '/shares/recordings/LiveTV/1356_20080224183420.mpg'
2712008-02-24 18:34:21.965 RecBase(1001:/dev/video1): SetRecording(0xa903c7a0) title(Meet the Press)
2722008-02-24 18:34:21.971 Channel(/dev/video1): InitPictureAttribute(brightness):  128
273                        [    0,  255] dflt(  128, 0.50, 128)
2742008-02-24 18:34:21.976 Channel(/dev/video1): InitPictureAttribute(  contrast):  63
275                        [    0,  127] dflt(   64, 0.50, 257)
2762008-02-24 18:34:21.982 Channel(/dev/video1): InitPictureAttribute(    colour):  63
277                        [    0,  127] dflt(   64, 0.50, 257)
2782008-02-24 18:34:21.989 Channel(/dev/video1): InitPictureAttribute(       hue):  0
279                        [ -128,  127] dflt(    0, 0.50, 128)
2802008-02-24 18:34:21.992 TVRec(1001): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady,
2812008-02-24 18:34:21.992 MPEGRec(/dev/video1): usingv4l2(1) has_v4l2_vbi(1) has_buggy_vbi(1)
2822008-02-24 18:34:22.022 MPEGRec(/dev/video1) Warning: Stream type 'MPEG-2 TS'
283                        is not supported by ivtv driver, using 'MPEG-2 PS' instead.
2842008-02-24 18:34:22.165 MPEGRec(/dev/video1) Warning: VBI recording with broken drivers.
285                        Upgrade to ivtv 0.10.0 if you experience problems.
2862008-02-24 18:34:22.258 MPEGRec(/dev/video1): VBI service: 4096, io size: 0
2872008-02-24 18:34:22.284 AutoExpire: CalcParams(): Max required Free Space: 6.0 GB w/freq: 15 min
2882008-02-24 18:34:22.284 TVRec(1001): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
2892008-02-24 18:34:22.292 TVRec(1001): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
2902008-02-24 18:34:24.738 TVRec(1001): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
2912008-02-24 18:34:28.608 TVRec(1001): StopLiveTV(void) curRec: 0xa216df88 pseudoRec: 0
2922008-02-24 18:34:28.618 TVRec(1001): Changing from WatchingLiveTV to None
2932008-02-24 18:34:28.620 TVRec(1001): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
2942008-02-24 18:34:28.622 TVRec(1001): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,)
2952008-02-24 18:34:28.752 TVRec(1001): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
2962008-02-24 18:34:28.783 TVRec(1001): FinishedRecording(Meet the Press) in recgroup: LiveTV
2972008-02-24 18:34:28.786 Chain: Updated endtime for '1356_20080224183420' to 20080224183428
2982008-02-24 18:34:28.800 Finished recording Meet the Press: channel 1356
2992008-02-24 18:34:28.811 scheduler: Finished recording: Meet the Press: channel 1356
3002008-02-24 18:34:28.815 TVRec(1001): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
3012008-02-24 18:34:28.817 TVRec(1001): Tearing down RingBuffer
3022008-02-24 18:34:28.820 TVRec(1001): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
3032008-02-24 18:34:29.014 MainServer::HandleAnnounce Playback
3042008-02-24 18:34:29.018 adding: pc4 as a client (events: 0)
3052008-02-24 18:34:29.024 TVRec(5): Changing from None to WatchingLiveTV
3062008-02-24 18:34:29.027 TVRec(5): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RingBufferReady,
3072008-02-24 18:34:29.028 TVRec(5): Request: Program(no) channel() input() flags(LiveTV,)
3082008-02-24 18:34:29.030 ChannelBase(5): Looking for startchannel '110' on input 'DiSEqC v1.3 Input 1'
3092008-02-24 18:34:29.065 ChannelBase(5): Found startchannel '110' on input 'DiSEqC v1.3 Input 2'
3102008-02-24 18:34:29.068 TVRec(5): HW Tuner: 5->5
3112008-02-24 18:34:29.070 TVRec(5): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
3122008-02-24 18:34:29.071 TVRec(5): No recorder yet, calling TuningFrequency
3132008-02-24 18:34:29.076 DVBChan(5:5): Opening DVB channel
3142008-02-24 18:34:29.077 DVBChan(5:5): SetChannelByString(110):
3152008-02-24 18:34:29.084 ChannelBase(5): Failed to find channel(110) on current input (DiSEqC v1.3 Input 5) of card (5).
3162008-02-24 18:34:29.090 ChannelBase(5): Found channel(110) on another input (DiSEqC v1.3 Input 2) of card (5).
3172008-02-24 18:34:29.114 DVBChan(5:5): 12296900 qpsk a auto auto a a auto a l
3182008-02-24 18:34:29.120 DiSEqCDevTree: Overriding voltage to 18V for faster rotor movement
3192008-02-24 18:34:29.140 DiSEqCDevTree: USALS Rotor - Goto -119 (Azimuth -45.8453)
3202008-02-24 18:34:29.143 DiSEqCDevTree: Sending DiSEqC Command: e0 31 6e d2 dd
3212008-02-24 18:34:29.346 DVBChan(5:5): Old Params: 12296900 t_8psk a auto auto a a auto a l
322                        DVBChan(5:5): New Params: 12296900 qpsk a auto auto a a auto a l
3232008-02-24 18:34:29.349 DVBChan(5:5): Tune(): Tuning to 1046900kHz
3242008-02-24 18:34:29.365 dvbchannel.cpp:wait_for_backend: Status:
3252008-02-24 18:34:29.367 DVBChan(5:5): Tune(): Frequency tuning successful.
3262008-02-24 18:34:29.368 DVBChan(5:5): SetChannelByString(110): Tuned to frequency.
3272008-02-24 18:34:29.370 TVRec(5): CreateLiveTVRingBuffer()
3282008-02-24 18:34:29.371 TVRec(5): GetProgramRingBufferForLiveTV()
3292008-02-24 18:34:30.456 TVRec(5): StartedRecording(0xb1341f00) fn(/shares/recordings/LiveTV/3110_20080224183429.mpg)
3302008-02-24 18:34:30.468 TFW: Using io multiplier 3, min/max = 16384/131072
3312008-02-24 18:34:30.481 Chain: Appended@1 '3110_20080224183429'
3322008-02-24 18:34:30.491 TVRec(5): Starting Signal Monitor
3332008-02-24 18:34:30.493 TVRec(5): SetupSignalMonitor(1, 1)
3342008-02-24 18:34:30.494 DVBChan(5:5): Opening DVB channel
3352008-02-24 18:34:30.510 DVBSM(5): Can measure Signal Strength
3362008-02-24 18:34:30.511 DVBSM(5): Can measure S/N
3372008-02-24 18:34:30.513 DVBSM(5): Can measure Bit Error Rate
3382008-02-24 18:34:30.515 DVBSM(5): Can count Uncorrected Blocks
3392008-02-24 18:34:30.517 SM(5)::RemoveFlags: Seen() Match() Wait()
3402008-02-24 18:34:30.518 DVBSM(5): DVBSignalMonitor::ctor initial flags Seen() Match() Wait(Sig,SNR,BER,UB,)
3412008-02-24 18:34:30.520 TVRec(5): Signal monitor successfully created
3422008-02-24 18:34:30.521 TVRec(5): Setting up table monitoring.
3432008-02-24 18:34:30.543 Using profile 'Live TV' to record
3442008-02-24 18:34:30.545 TVRec(5): DVB service_id 110 on net_id 4100 tsid 6
3452008-02-24 18:34:30.546 DTVSM(5)::SetDVBService(transport_id: 6, network_id: 4100, service_id: 110):
3462008-02-24 18:34:30.548 SM(5)::RemoveFlags: Seen(PMT,SDT,Crypt,) Match(PMT,SDT,Crypt,) Wait()
3472008-02-24 18:34:30.550 SM(5)::AddFlags: Seen() Match() Wait(PMT,NIT,)
3482008-02-24 18:34:30.551 SM(5)::AddFlags: Seen() Match() Wait(PMT,NIT,Pos,)
3492008-02-24 18:34:30.552 TVRec(5): Successfully set up DVB table monitoring.
3502008-02-24 18:34:30.554 SM(5)::Start: begin
3512008-02-24 18:34:30.556 DTVSM(5)::GetStatusList: WaitForPMT seen(0) matching(0)
3522008-02-24 18:34:30.557 SM(5)::Start: end
3532008-02-24 18:34:30.562 TVRec(5): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady,
3542008-02-24 18:34:30.565 TVRec(5): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady,
3552008-02-24 18:34:30.567 TVRec(5): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
3562008-02-24 18:34:30.568 TVRec(5): SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
3572008-02-24 18:34:30.569 DummyDTVRecorder -- started
3582008-02-24 18:34:30.571 TVRec(5): SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
3592008-02-24 18:34:30.573 TVRec(5): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
3602008-02-24 18:34:30.574 TVRec(5): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
3612008-02-24 18:34:30.578 TVRec(5): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
3622008-02-24 18:34:30.606 AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 15 min
3632008-02-24 18:34:34.776 DVBSM(5): UpdateValues -- Signal Locked
3642008-02-24 18:34:35.118 DVBSH(5): Retuning for rotor completion