Ticket #1619: log.txt

File log.txt, 37.7 KB (added by Mark.Buechler@…, 14 years ago)

backend log

Line 
1Flags: channel,record,siparser
2
3First entering LiveTV, channel tunes fine:
4
52006-04-02 14:59:15.266 DiSEqC(0): 1.3 Motor - Goto Angular Position -110
62006-04-02 14:59:15.284 DiSEqC(0): Sending 1.0 Command: e0 31 6e d2
72006-04-02 14:59:15.384 DiSEqC(0): Sending 1.3 Repeat Command: e0 31 6e d2 40
82006-04-02 14:59:16.124 DiSEqC(0): 1.1 Switch (4 ports) - Port 0 - Tone ON 13V
92006-04-02 14:59:16.142 DiSEqC(0): Sending 1.0 Command: e0 10 38 f1
102006-04-02 14:59:16.229 DiSEqC(0): Sending 1.3 Repeat Command: e0 10 38 f1  0
112006-04-02 14:59:16.462 DVB#0 Old Params: freq(0) type(QPSK)
122006-04-02 14:59:16.463 DVB#0 New Params: freq(12457000) type(QPSK)
132006-04-02 14:59:16.516 dvbchannel.cpp:wait_for_backend: Status:
142006-04-02 14:59:16.516 DVB#0 DVBChannel::Tune: Frequency tuning successful.
152006-04-02 14:59:16.516 DVB#0 Tuned to frequency for channel 9460.
162006-04-02 14:59:16.528 TVRec(4): SetFlags(RunMainLoop,) -> RunMainLoop,
172006-04-02 14:59:16.528 TVRec(4): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop,
182006-04-02 14:59:16.531 New DB scheduler connection
192006-04-02 14:59:16.533 Connected to database 'mythconverg' at host: pc4
202006-04-02 14:59:16.549 mythbackend version: 0.19.20060331-1 www.mythtv.org
212006-04-02 14:59:16.550 Enabled verbose msgs:  important general record channel siparser
222006-04-02 14:59:16.551 AutoExpire: Found 4 recorders w/max rate of 421 MiB/min
232006-04-02 14:59:16.561 AutoExpire: Required Free Space: 6.3 GB w/freq: 5 min
242006-04-02 14:59:18.560 Reschedule requested for id -1.
252006-04-02 14:59:21.302 Scheduled 34 items in 2.7 = 2.57 match + 0.17 place
262006-04-02 14:59:21.309 scheduler: Scheduled items: Scheduled 34 items in 2.7 = 2.57 match + 0.17 place
272006-04-02 14:59:21.317 Recording starts soon, AUTO-Startup assumed
282006-04-02 14:59:21.682 MainServer::HandleAnnounce Monitor
292006-04-02 14:59:21.682 adding: pc4 as a client (events: 0)
302006-04-02 14:59:21.684 mythbackend: Running housekeeping thread
312006-04-02 14:59:21.690 Getting next free recorder after : -1
322006-04-02 14:59:21.693 Checking card 1. Best card so far 1
332006-04-02 14:59:21.694 Checking card 2. Best card so far 2
342006-04-02 14:59:21.694 Checking card 3. Best card so far 3
352006-04-02 14:59:21.694 Checking card 4. Best card so far 4
362006-04-02 14:59:21.704 MainServer::HandleAnnounce Monitor
372006-04-02 14:59:21.704 adding: pc4 as a client (events: 1)
382006-04-02 14:59:21.717 MainServer::HandleAnnounce Playback
392006-04-02 14:59:21.717 adding: pc4 as a client (events: 0)
402006-04-02 14:59:21.729 TVRec(4): Changing from None to WatchingLiveTV
412006-04-02 14:59:21.730 TVRec(4): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,
422006-04-02 14:59:21.730 TVRec(4): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,
432006-04-02 14:59:21.730 TVRec(4): Request: Program(no) channel() input() flags(LiveTV,)
442006-04-02 14:59:21.730 TVRec(4): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,
452006-04-02 14:59:21.733 DVB#0 Opening DVB channel
462006-04-02 14:59:21.734 DVB#0 SetChannelByString(9460)
472006-04-02 14:59:21.734 DVB#0 SetChannelByString(9460): already on channel
482006-04-02 14:59:21.734 TVRec(4): CreateLiveTVRingBuffer()
492006-04-02 14:59:21.734 TVRec(4): GetProgramRingBufferForLiveTV()
502006-04-02 14:59:21.824 TVRec(4): StartedRecording(0x8203188) fn(/shares/recordings/corbin2/11460_20060402145921.mpg)
512006-04-02 14:59:21.838 Chain: Appended@0 '11460_20060402145921'
522006-04-02 14:59:21.851 RecBase(/dev/video): SetRingBuffer(0xafb123a8) '/shares/recordings/corbin2/11460_20060402145921.mpg'
532006-04-02 14:59:21.851 RecBase(/dev/video): SetRecording(0x8203188) title(SHO Me Now)
542006-04-02 14:59:21.852 TVRec(4): Starting Signal Monitor
552006-04-02 14:59:21.852 TVRec(4): SetupSignalMonitor(1, 1)
562006-04-02 14:59:21.853 DVB#0 Opening DVB channel
572006-04-02 14:59:21.879 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,BER,UB,)
582006-04-02 14:59:21.880 DVBSM(0)::constructor(): initial flags 0x7400000
592006-04-02 14:59:22.182 TVRec(4): Signal monitor successfully created
602006-04-02 14:59:22.183 TVRec(4): Setting up table monitoring.
612006-04-02 14:59:22.183 TVRec(4): MPEG program number: 9460
622006-04-02 14:59:22.185 DTVSM(0)::SetProgramNumber(9460):
632006-04-02 14:59:22.186 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
642006-04-02 14:59:22.186 SM(0)::AddFlags: Seen() Match() Wait(PMT,)
652006-04-02 14:59:22.186 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,)
662006-04-02 14:59:22.186 TVRec(4): Successfully set up MPEG table monitoring.
672006-04-02 14:59:22.187 SM(0)::Start: begin
682006-04-02 14:59:22.189 SM(0)::Start: end
692006-04-02 14:59:22.190 TVRec(4): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
702006-04-02 14:59:22.190 TVRec(4): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,
712006-04-02 14:59:22.190 TVRec(4): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,
722006-04-02 14:59:22.191 DummyDTVRecorder::StartRecording -- begin
732006-04-02 14:59:22.212 TVRec(4): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,
742006-04-02 14:59:22.212 DummyDTVRecorder -- started
752006-04-02 14:59:22.213 TVRec(4): SetFlags(RingBufferReady,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
762006-04-02 14:59:22.213 TVRec(4): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
772006-04-02 14:59:22.213 TVRec(4): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
782006-04-02 14:59:22.214 TVRec(4): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
792006-04-02 14:59:22.213 DVBSM(0)::UpdateValues: Signal Locked
802006-04-02 14:59:22.215 DVBSM(0)::UpdateValues: Waiting for table monitor to start
812006-04-02 14:59:22.217 DVBSM(0)::AddPIDFilter(0x0):
822006-04-02 14:59:22.217 DVBSM(0)::RemovePIDFilter(0x0):
832006-04-02 14:59:22.217 DVBSM(0)::UpdateValues: Table monitor started
842006-04-02 14:59:22.218 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0)
852006-04-02 14:59:22.233 DVBSM(0): RunTableMonitorTS(): begin (# of pids 1)
862006-04-02 14:59:22.234 DVBSM(0)::AddPIDFilter(0x0):
872006-04-02 14:59:22.254 DummyRec: Restart! Frames seen 12
882006-04-02 14:59:22.283 SM(0)::AddFlags: Seen(PAT,) Match() Wait()
892006-04-02 14:59:22.283 SM(0)::AddFlags: Seen() Match(PAT,) Wait()
902006-04-02 14:59:22.284 CreatePATSingleProgram()
912006-04-02 14:59:22.284 PAT in input stream
922006-04-02 14:59:22.284 Program Association Table
93 PSIP tableID(0x0) length(29) extension(0xd9)
94      version(1) current(1) section(0) last_section(0)
95         tsid: 217
96 programCount: 5
97  program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
98  program number 295 has PID 0x  21   data  0x1 0x39 0x224 0x33
99  program number 9421 has PID 0x  21   data  0x36 0x205 0x224 0x33
100  program number 9424 has PID 0x  21   data  0x36 0x208 0x224 0x33
101  program number 9460 has PID 0x  21   data  0x36 0x244 0x224 0x33
102
1032006-04-02 14:59:22.285 desired_program(9460) pid(0x21)
1042006-04-02 14:59:22.286 pmt_pid(0x21)
1052006-04-02 14:59:22.286 PAT for output stream
1062006-04-02 14:59:22.287 Program Association Table
107 PSIP tableID(0x0) length(13) extension(0xd9)
108      version(1) current(1) section(0) last_section(0)
109         tsid: 217
110 programCount: 1
111  program number 1 has PID 0x  21   data  0x0 0x1 0x224 0x33
112
1132006-04-02 14:59:22.289 DVBSM(0)::AddPIDFilter(0x21):
1142006-04-02 14:59:22.294 DummyRec: Restart! Frames seen 24
1152006-04-02 14:59:22.299 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
1162006-04-02 14:59:22.300 DTVSM(0) Error: Wrong PMT; pmt->pn(295) desired(9460)
1172006-04-02 14:59:22.300 CreatePMTSingleProgram()
1182006-04-02 14:59:22.300 PMT in input stream
1192006-04-02 14:59:22.301 Program Map Table ver(0) pid(0x21) pnum(295) len(41)
120
121 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
122  Conditional Access: sid(0x1810) pid(0x12b) data_size(0)
123  Conditional Access: sid(0x1801) pid(0x12b) data_size(0)
124 Stream #1 pid(0x1223) type(audio-ac3  0x129)
125  ISO-639 Language: code(eng) canonical(eng) eng(English)
126
1272006-04-02 14:59:22.302 PMT for output stream
1282006-04-02 14:59:22.302 Program Map Table ver(0) pid(0x21) pnum(1) len(23)
129
130 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
131 Stream #1 pid(0x1223) type(audio-ac3  0x129)
132
1332006-04-02 14:59:22.303 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
1342006-04-02 14:59:22.304 DTVSM(0) Error: Wrong PMT; pmt->pn(9421) desired(9460)
1352006-04-02 14:59:22.304 CreatePMTSingleProgram()
1362006-04-02 14:59:22.304 PMT in input stream
1372006-04-02 14:59:22.305 Program Map Table ver(0) pid(0x21) pnum(9421) len(41)
138
139 Stream #0 pid(0x1022) type(video-mpeg2  0x2)
140  Conditional Access: sid(0x1810) pid(0x123) data_size(0)
141  Conditional Access: sid(0x1801) pid(0x123) data_size(0)
142 Stream #1 pid(0x1023) type(audio-ac3  0x129)
143  ISO-639 Language: code(eng) canonical(eng) eng(English)
144
1452006-04-02 14:59:22.306 PMT for output stream
1462006-04-02 14:59:22.306 Program Map Table ver(0) pid(0x21) pnum(1) len(23)
147
148 Stream #0 pid(0x1022) type(video-mpeg2  0x2)
149 Stream #1 pid(0x1023) type(audio-ac3  0x129)
150
1512006-04-02 14:59:22.307 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
1522006-04-02 14:59:22.308 DTVSM(0) Error: Wrong PMT; pmt->pn(9424) desired(9460)
1532006-04-02 14:59:22.308 CreatePMTSingleProgram()
1542006-04-02 14:59:22.308 PMT in input stream
1552006-04-02 14:59:22.309 Program Map Table ver(0) pid(0x21) pnum(9424) len(41)
156
157 Stream #0 pid(0x1122) type(video-mpeg2  0x2)
158  Conditional Access: sid(0x1810) pid(0x130) data_size(0)
159  Conditional Access: sid(0x1801) pid(0x130) data_size(0)
160 Stream #1 pid(0x1123) type(audio-ac3  0x129)
161  ISO-639 Language: code(eng) canonical(eng) eng(English)
162
1632006-04-02 14:59:22.310 PMT for output stream
1642006-04-02 14:59:22.310 Program Map Table ver(0) pid(0x21) pnum(1) len(23)
165
166 Stream #0 pid(0x1122) type(video-mpeg2  0x2)
167 Stream #1 pid(0x1123) type(audio-ac3  0x129)
168
1692006-04-02 14:59:22.311 SM(0)::AddFlags: Seen(PMT,) Match() Wait()
1702006-04-02 14:59:22.311 SM(0)::AddFlags: Seen() Match(PMT,) Wait()
1712006-04-02 14:59:22.312 CreatePMTSingleProgram()
1722006-04-02 14:59:22.312 PMT in input stream
1732006-04-02 14:59:22.313 Program Map Table ver(0) pid(0x21) pnum(9460) len(41)
174
175 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
176  Conditional Access: sid(0x1810) pid(0x122) data_size(0)
177  Conditional Access: sid(0x1801) pid(0x122) data_size(0)
178 Stream #1 pid(0x1223) type(audio-ac3  0x129)
179  ISO-639 Language: code(eng) canonical(eng) eng(English)
180
1812006-04-02 14:59:22.314 PMT for output stream
1822006-04-02 14:59:22.314 Program Map Table ver(0) pid(0x21) pnum(1) len(23)
183
184 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
185 Stream #1 pid(0x1223) type(audio-ac3  0x129)
186
1872006-04-02 14:59:22.342 DummyRec: Restart! Frames seen 36
1882006-04-02 14:59:22.380 DummyRec: Restart! Frames seen 48
1892006-04-02 14:59:22.411 DummyRec: Restart! Frames seen 60
1902006-04-02 14:59:22.447 DummyRec: Restart! Frames seen 72
1912006-04-02 14:59:22.523 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1)
1922006-04-02 14:59:22.524 TVRec(4): Got good signal
1932006-04-02 14:59:22.524 TVRec(4): MPEG program num(9460)
1942006-04-02 14:59:22.525 TVRec(4): TeardownSignalMonitor() -- begin
1952006-04-02 14:59:22.525 DVBSM(0)::Stop: begin
1962006-04-02 14:59:22.525 SM(0)::Stop: begin
1972006-04-02 14:59:22.828 SM(0)::Stop: end
1982006-04-02 14:59:22.843 DVBSM(0): RunTableMonitorTS(): shutdown
1992006-04-02 14:59:22.843 DVBSM(0)::RemovePIDFilter(0x0):
2002006-04-02 14:59:22.843 DVBSM(0)::RemovePIDFilter(0x21):
2012006-04-02 14:59:22.846 DVBSM(0): RunTableMonitorTS(): end
2022006-04-02 14:59:22.846 DVBSM(0)::Stop: end
2032006-04-02 14:59:22.846 DVBSM(0)::Stop: begin
2042006-04-02 14:59:22.847 SM(0)::Stop: begin
2052006-04-02 14:59:22.847 SM(0)::Stop: end
2062006-04-02 14:59:22.847 DVBSM(0)::Stop: end
2072006-04-02 14:59:22.847 TVRec(4): TeardownSignalMonitor() -- end
2082006-04-02 14:59:22.847 TVRec(4): ClearFlags(WaitingForSignal,SignalMonitorRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2092006-04-02 14:59:22.848 SIParser: Setting ATSCStreamData
2102006-04-02 14:59:22.849 DVBSM(0)::Stop: begin
2112006-04-02 14:59:22.849 SM(0)::Stop: begin
2122006-04-02 14:59:22.849 SIParser: Setting DVBStreamData
2132006-04-02 14:59:22.849 SM(0)::Stop: end
2142006-04-02 14:59:22.849 DVBSM(0)::Stop: end
2152006-04-02 14:59:22.850 SM(0)::Stop: begin
2162006-04-02 14:59:22.850 SM(0)::Stop: end
2172006-04-02 14:59:22.854 SIParser: Added initial preferred language 'eng' with priority 1
2182006-04-02 14:59:22.854 DVB#0 DVB SI Table Parser Started
2192006-04-02 14:59:22.855 SIParser: ReinitSIParser(std dvb, service #9460)
2202006-04-02 14:59:22.855 SIParser: SetTableStandard(dvb)
2212006-04-02 14:59:22.855 SIParser: SetStreamData(0xafb13de0)
2222006-04-02 14:59:22.856 SIParser: Setting ATSCStreamData
2232006-04-02 14:59:22.856 SIParser: Making #9460 the requested MPEG program number
2242006-04-02 14:59:22.857 SIParser: PAT Version: 1  Tuned to TransportID: 217
2252006-04-02 14:59:22.857 SIParser: NIT Present on this transport  on PID 0x0
2262006-04-02 14:59:22.857 SIParser: PMT pn(9460) version(0) cnt(2) pid(0x21)
2272006-04-02 14:59:22.857 DVB#0 SetPMT(33) program number #9460, PCRPID(0x1222)
2282006-04-02 14:59:22.858 DVB#0 CA: SetPMT() program num #9460
2292006-04-02 14:59:22.858 DVB#0 SID: 9460 TID: 1 (4642 0) (4643 1)
2302006-04-02 14:59:22.859 DVBSIParser: Starting DVB Section Reader thread
2312006-04-02 14:59:22.859 DVBSIParser: Adding PID 0x   0 Filter 0x 0 Mask 0xff Buffer 40960
2322006-04-02 14:59:22.860 DVBSIParser: Adding PID 0x  21 Filter 0x 2 Mask 0xff Buffer 40960
2332006-04-02 14:59:22.861 DVBSIParser: Adding PID 0x  10 Filter 0x40 Mask 0xff Buffer 40960
2342006-04-02 14:59:22.864 TVRec(4): SetFlags(WaitingForSIParser,SIParserRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSIParser,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReady,
2352006-04-02 14:59:22.864 SIParser: PMT pn(295) version(0) cnt(2) pid(0x21)
2362006-04-02 14:59:22.865 TVRec(4): Got SIParser PMT
2372006-04-02 14:59:22.865 TVRec(4): ClearFlags(WaitingForSIParser,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReady,
2382006-04-02 14:59:22.865 TVRec(4): Starting Recorder
2392006-04-02 14:59:22.865 SIParser: PMT pn(9421) version(0) cnt(2) pid(0x21)
2402006-04-02 14:59:22.866 DummyDTVRecorder::StopRecordingThread(void)
2412006-04-02 14:59:22.866 SIParser: PMT pn(9424) version(0) cnt(2) pid(0x21)
2422006-04-02 14:59:22.866 SIParser: PMT pn(9460) version(0) cnt(2) pid(0x21)
2432006-04-02 14:59:22.867 DVB#0 SetPMT(33) program number #9460, PCRPID(0x1222)
2442006-04-02 14:59:22.873 DummyDTVRecorder::FinishRecording()
2452006-04-02 14:59:22.875 DummyDTVRecorder::StartRecording -- end
2462006-04-02 14:59:22.876 TVRec(4): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReady,
2472006-04-02 14:59:22.882 TVRec(4): FinishedRecording(SHO Me Now) in recgroup: LiveTV
2482006-04-02 14:59:22.884 Chain: Updated endtime for '11460_20060402145921' to 20060402145922
2492006-04-02 14:59:22.888 Finished recording SHO Me Now "Alfie": channel 11460
2502006-04-02 14:59:22.896 scheduler: Finished recording: SHO Me Now "Alfie": channel 11460
2512006-04-02 14:59:22.904 TVRec(4): Using profile 'Live TV' to record
2522006-04-02 14:59:22.904 TVRec(4): SwitchLiveTVRingBuffer(discont 1, set_rec 0)
2532006-04-02 14:59:22.904 TVRec(4): GetProgramRingBufferForLiveTV()
2542006-04-02 14:59:22.966 TVRec(4): FinishedRecording(SHO Me Now) in recgroup: LiveTV
2552006-04-02 14:59:22.968 Chain: Updated endtime for '11460_20060402145921' to 20060402145922
2562006-04-02 14:59:23.000 Finished recording SHO Me Now "Alfie": channel 11460
2572006-04-02 14:59:23.001 Preview: 'myth://192.168.1.121:6543/11460_20060402145921.mpg' is not local,
258                        replacing with '/shares/recordings/corbin2/11460_20060402145921.mpg', which is local.
2592006-04-02 14:59:23.013 Chain: Appended@1 '11460_20060402145922'
2602006-04-02 14:59:23.020 DummyDTVRecorder::StopRecordingThread(void)
2612006-04-02 14:59:23.022 TVRec(4): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReady,
2622006-04-02 14:59:23.022 DummyDTVRecorder::StopRecordingThread(void)
2632006-04-02 14:59:23.101 RecBase(0): SetRingBuffer(0xafb29408) '/shares/recordings/corbin2/11460_20060402145922.mpg'
2642006-04-02 14:59:23.101 RecBase(0): SetRecording(0xafb107a8) title(SHO Me Now)
2652006-04-02 14:59:23.104 DVB#0 CA: SetPMT() program num #9460
2662006-04-02 14:59:23.105 DVB#0 SID: 9460 TID: 1 (4642 0) (4643 1)
2672006-04-02 14:59:23.105 SIParser: PAT Version: 1  Tuned to TransportID: 217
2682006-04-02 14:59:23.106 CreatePATSingleProgram()
2692006-04-02 14:59:23.106 PAT in input stream
2702006-04-02 14:59:23.106 Program Association Table
271 PSIP tableID(0x0) length(29) extension(0xd9)
272      version(1) current(1) section(0) last_section(0)
273         tsid: 217
274 programCount: 5
275  program number 0 has PID 0x  10   data  0x0 0x0 0x224 0x16
276  program number 295 has PID 0x  21   data  0x1 0x39 0x224 0x33
277  program number 9421 has PID 0x  21   data  0x36 0x205 0x224 0x33
278  program number 9424 has PID 0x  21   data  0x36 0x208 0x224 0x33
279  program number 9460 has PID 0x  21   data  0x36 0x244 0x224 0x33
280
2812006-04-02 14:59:23.107 desired_program(9460) pid(0x21)
2822006-04-02 14:59:23.107 pmt_pid(0x21)
2832006-04-02 14:59:23.107 DVBRec(0): Card opened successfully fd(22)
2842006-04-02 14:59:23.107 PAT for output stream
2852006-04-02 14:59:23.108 DVB#0 SetRecorder()
2862006-04-02 14:59:23.108 Program Association Table
287 PSIP tableID(0x0) length(13) extension(0xd9)
288      version(1) current(1) section(0) last_section(0)
289         tsid: 217
290 programCount: 1
291  program number 1 has PID 0x  21   data  0x0 0x1 0x224 0x33
292
2932006-04-02 14:59:23.108 DVBRec(0): SetPMT(33)
2942006-04-02 14:59:23.109 DVBRec(0): SetPAT(NULL)
2952006-04-02 14:59:23.110 DVBRec(0): SetOutputPMT(NULL)
2962006-04-02 14:59:23.114 TVRec(4): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderRunning,RingBufferReady,
2972006-04-02 14:59:23.114 TVRec(4): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReady,
2982006-04-02 14:59:23.225 DevRdB(0): buffer size 32900 KB
2992006-04-02 14:59:23.226 DVBRec(0): Resetting Demux Filters
3002006-04-02 14:59:23.226 DVBRec(0): Adding pid 0x1222 size(3600384)
3012006-04-02 14:59:23.228 DVBRec(0): Set demux buffer size for pid 0x1222 to 3600384,
302                        which gives us a 1500 msec buffer.
3032006-04-02 14:59:23.228 DVBRec(0): Adding pid 0x1223 size(94208)
3042006-04-02 14:59:23.229 DVBRec(0): Set demux buffer size for pid 0x1223 to 94208,
305                        which gives us a 1500 msec buffer.
3062006-04-02 14:59:23.229 DVBRec(0): SetPAT()
307Program Association Table
308 PSIP tableID(0x0) length(13) extension(0x1)
309      version(0) current(1) section(0) last_section(0)
310         tsid: 1
311 programCount: 1
312  program number 1 has PID 0x  21   data  0x0 0x1 0x224 0x33
313
3142006-04-02 14:59:23.230 DVBRec(0): CreatePMT(void) INPUT
315
316Program Map Table ver(0) pid(0x29) pnum(9460) len(41)
317
318 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
319  Conditional Access: sid(0x1810) pid(0x122) data_size(0)
320  Conditional Access: sid(0x1801) pid(0x122) data_size(0)
321 Stream #1 pid(0x1223) type(audio-ac3  0x129)
322  ISO-639 Language: code(eng) canonical(eng) eng(English)
323
3242006-04-02 14:59:23.231 Created PMT
325Program Map Table ver(1) pid(0x21) pnum(1) len(29)
326
327 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
328 Stream #1 pid(0x1223) type(audio-ac3  0x129)
329  ISO-639 Language: code(eng) canonical(eng) eng(English)
330
3312006-04-02 14:59:23.232 DVBRec(0): CreatePMT(void) OUTPUT
332
333Program Map Table ver(1) pid(0x21) pnum(1) len(29)
334
335 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
336 Stream #1 pid(0x1223) type(audio-ac3  0x129)
337  ISO-639 Language: code(eng) canonical(eng) eng(English)
338
3392006-04-02 14:59:23.233 DVBRec(0): SetOutputPMT()
340Program Map Table ver(1) pid(0x21) pnum(1) len(29)
341
342 Stream #0 pid(0x1222) type(video-mpeg2  0x2)
343 Stream #1 pid(0x1223) type(audio-ac3  0x129)
344  ISO-639 Language: code(eng) canonical(eng) eng(English)
345
3462006-04-02 14:59:23.236 PID 0x1222 Found Payload Start
3472006-04-02 14:59:23.240 PID 0x1223 Found Payload Start
3482006-04-02 14:59:23.280 SIParser: Private Type sdt_mapping = 1 defined for NetworkID 4102
3492006-04-02 14:59:23.280 SIParser: SDT Mapping Incorrect for this Service Fixup Loaded
3502006-04-02 14:59:23.280 SIParser: Private Type tv_types = 1,145,154 defined for NetworkID 4102
3512006-04-02 14:59:23.281 SIParser: Added TV Type 1
3522006-04-02 14:59:23.281 SIParser: Added TV Type 145
3532006-04-02 14:59:23.281 SIParser: Added TV Type 154
3542006-04-02 14:59:23.281 SIParser: Private Type guide_fixup = 1 defined for NetworkID 4102
3552006-04-02 14:59:23.282 SIParser: Using Guide Fixup Scheme #1
3562006-04-02 14:59:23.282 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3572006-04-02 14:59:23.282 SIParser: Forcing Guide Present
3582006-04-02 14:59:23.282 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3592006-04-02 14:59:23.283 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3602006-04-02 14:59:23.283 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3612006-04-02 14:59:23.283 SIParser: Forcing Guide Present
3622006-04-02 14:59:23.283 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3632006-04-02 14:59:23.284 SIParser: Forcing Guide Present
3642006-04-02 14:59:23.284 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3652006-04-02 14:59:23.284 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3662006-04-02 14:59:23.284 SIParser: Forcing Guide Present
3672006-04-02 14:59:23.285 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3682006-04-02 14:59:23.285 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3692006-04-02 14:59:23.285 SIParser: Forcing Guide Present
3702006-04-02 14:59:23.285 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3712006-04-02 14:59:23.286 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3722006-04-02 14:59:23.286 SIParser: Forcing Guide Present
3732006-04-02 14:59:23.286 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3742006-04-02 14:59:23.286 SIParser: Private Type force_guide_present = yes defined for NetworkID 4102
3752006-04-02 14:59:23.286 SIParser: Forcing Guide Present
3762006-04-02 14:59:23.287 SIParser: Private Type extended_guide_tid = 229 defined for NetworkID 4102
3772006-04-02 14:59:23.637 SIParser: Table[SERVICES]->RequirePIDs() == true
3782006-04-02 14:59:23.637 DVBSIParser: Adding PID 0x  11 Filter 0x46 Mask 0xfb Buffer 40960
379...
3802006-04-02 14:59:43.598 SIParser: SDT: sid=584 type=1 eit_present=1 collect_eit=1 name=SAMAY
3812006-04-02 14:59:43.599 SIParser: SDT: sid=585 type=1 eit_present=1 collect_eit=1 name=AAJTK
3822006-04-02 14:59:43.599 SIParser: SDT: sid=586 type=1 eit_present=1 collect_eit=1 name=HT
3832006-04-02 14:59:43.600 SIParser: SDT: sid=590 type=1 eit_present=1 collect_eit=1 name=TRACE
3842006-04-02 14:59:43.601 SIParser: SDT: sid=591 type=1 eit_present=1 collect_eit=1 name=TELSD
3852006-04-02 14:59:43.601 SIParser: SDT: sid=599 type=1 eit_present=1 collect_eit=1 name=FPCHN
3862006-04-02 14:59:43.602 SIParser: SDT: sid=622 type=1 eit_present=1 collect_eit=1 name=APUNJ
3872006-04-02 14:59:43.602 SIParser: SDT: sid=623 type=1 eit_present=1 collect_eit=1 name=ZGUJ
3882006-04-02 14:59:43.602 SIParser: SDT: sid=624 type=1 eit_present=1 collect_eit=1 name=SHARA
3892006-04-02 14:59:43.602 SIParser: SDT: sid=654 type=1 eit_present=1 collect_eit=1 name=JSTV
3902006-04-02 14:59:43.603 SIParser: SDT: sid=664 type=1 eit_present=1 collect_eit=1 name=ALTER
3912006-04-02 14:59:43.597 DVBSIParser: Stopping DVB Section Reader
3922006-04-02 14:59:43.604 DVBSIParser: DVB Section Reader thread stopped
3932006-04-02 14:59:43.605 SIParser: Descriptor Stats -- begin
3942006-04-02 14:59:43.606 SIParser: On PID 0x0: Found 24, Unknown(133) Descriptors
3952006-04-02 14:59:43.606 SIParser: On PID 0x0: Found 247, Caption Service Descriptors
3962006-04-02 14:59:43.606 SIParser: On PID 0x0: Found 139, Content Advisory Descriptors
3972006-04-02 14:59:43.607 SIParser: On PID 0x0: Found 5049, Unknown(137) Descriptors
3982006-04-02 14:59:43.607 SIParser: On PID 0x0: Found 6, Unknown(139) Descriptors
3992006-04-02 14:59:43.608 SIParser: On PID 0x0: Found 93, Unknown(142) Descriptors
4002006-04-02 14:59:43.608 SIParser: On PID 0x0: Found 4368, Unknown(150) Descriptors
4012006-04-02 14:59:43.608 SIParser: On PID 0x0: Found 109, Unknown(152) Descriptors
4022006-04-02 14:59:43.608 SIParser: On PID 0x0: Found 109, Unknown(174) Descriptors
4032006-04-02 14:59:43.609 SIParser: On PID 0x10: Found 81, Service List Descriptors
4042006-04-02 14:59:43.609 SIParser: On PID 0x11: Found 2508, Linkage Descriptors
4052006-04-02 14:59:43.609 SIParser: On PID 0x11: Found 1222, ATSC Stuffing Descriptors
4062006-04-02 14:59:43.609 SIParser: On PID 0x11: Found 5, Unknown(130) Descriptors
4072006-04-02 14:59:43.610 SIParser: On PID 0x11: Found 1717, Unknown(132) Descriptors
4082006-04-02 14:59:43.610 SIParser: On PID 0x11: Found 16, Unknown(133) Descriptors
4092006-04-02 14:59:43.610 SIParser: On PID 0x11: Found 2513, Caption Service Descriptors
4102006-04-02 14:59:43.611 SIParser: On PID 0x11: Found 2513, Unknown(147) Descriptors
4112006-04-02 14:59:43.611 SIParser: On PID 0x11: Found 951, Unknown(153) Descriptors
4122006-04-02 14:59:43.611 SIParser: Descriptor Stats -- end
4132006-04-02 14:59:43.611 TVRec(4): ClearFlags(SIParserRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,
4142006-04-02 14:59:43.612 TVRec(4): ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,
4152006-04-02 14:59:43.613 TVRec(4): SetFlags(WaitingForRecPause,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForRecPause,RecorderRunning,
4162006-04-02 14:59:43.613 TVRec(4): ClearFlags(WaitingForRecPause,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,
4172006-04-02 14:59:43.614 DVBRec(0): Close() fd(22) -- begin
4182006-04-02 14:59:43.616 DVB#0 SetRecorder()
4192006-04-02 14:59:43.617 DVBRec(0): Close() fd(-1) -- end
4202006-04-02 14:59:43.617 RecBase(0): SetRingBuffer(0)
421
422Tune to new channel:
423
4242006-04-02 14:59:43.618 DVB#0 Opening DVB channel
4252006-04-02 14:59:43.618 DVB#0 SetChannelByString(9456)
4262006-04-02 14:59:43.631 DVB#0 Frequency: 12399000 Symbol Rate: 21500000 Pol: V/R Inv: Auto
4272006-04-02 14:59:44.103 DiSEqC(0): 1.3 Motor - Goto Angular Position -110
4282006-04-02 14:59:44.577 DiSEqC(0): 1.1 Switch (4 ports) - Port 0 - Tone ON 13V
4292006-04-02 14:59:44.595 DiSEqC(0): Sending 1.0 Command: e0 10 38 f1
4302006-04-02 14:59:44.682 DiSEqC(0): Sending 1.3 Repeat Command: e0 10 38 f1  0
4312006-04-02 14:59:44.911 DVB#0 Old Params: freq(12457000) type(QPSK)
4322006-04-02 14:59:44.911 DVB#0 New Params: freq(12399000) type(QPSK)
4332006-04-02 14:59:44.912 DVB#0 DVBChannel::Tune: Frequency tuning successful.
4342006-04-02 14:59:44.912 DVB#0 Tuned to frequency for channel 9456.
4352006-04-02 14:59:44.912 TVRec(4): SwitchLiveTVRingBuffer(discont 1, set_rec 0)
4362006-04-02 14:59:44.912 TVRec(4): GetProgramRingBufferForLiveTV()
4372006-04-02 14:59:44.981 TVRec(4): StartedRecording(0xa5c46e90) fn(/shares/recordings/corbin2/114560_20060402145944.mpg)
4382006-04-02 14:59:44.999 TVRec(4): FinishedRecording(SHO Me Now) in recgroup: LiveTV
4392006-04-02 14:59:45.002 Chain: Updated endtime for '11460_20060402145922' to 20060402145945
4402006-04-02 14:59:45.026 Finished recording SHO Me Now "Alfie": channel 11460
4412006-04-02 14:59:45.026 Preview: 'myth://192.168.1.121:6543/11460_20060402145922.mpg' is not local,
442                        replacing with '/shares/recordings/corbin2/11460_20060402145922.mpg', which is local.
4432006-04-02 14:59:45.040 Chain: Appended@2 '114560_20060402145944'
4440: start_time: 2690.190 duration: 1.787
4451: start_time: 2690.145 duration: 1.806
446stream: start_time: 29890.496 duration: 20.358 bitrate=12475 kb/s
4472006-04-02 14:59:45.209 AFD: Opened codec 0xa5c08f90, id(MPEG2VIDEO) type(Video)
4482006-04-02 14:59:45.211 AFD: Opened codec 0xa5c50220, id(AC3) type(Audio)
4492006-04-02 14:59:45.216 RecBase(/dev/video): SetRingBuffer(0xaa5404c8) '/shares/recordings/corbin2/114560_20060402145944.mpg'
4502006-04-02 14:59:45.216 RecBase(/dev/video): SetRecording(0xa5c46e90) title(The Wedding Date)
4512006-04-02 14:59:45.217 TVRec(4): Starting Signal Monitor
4522006-04-02 14:59:45.217 TVRec(4): SetupSignalMonitor(1, 1)
4532006-04-02 14:59:45.217 DVB#0 Opening DVB channel
4542006-04-02 14:59:45.243 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,BER,UB,)
4552006-04-02 14:59:45.244 DVBSM(0)::constructor(): initial flags 0x7400000
4562006-04-02 14:59:45.546 TVRec(4): Signal monitor successfully created
4572006-04-02 14:59:45.546 TVRec(4): Setting up table monitoring.
4582006-04-02 14:59:45.547 TVRec(4): MPEG program number: 9456
4592006-04-02 14:59:45.550 DTVSM(0)::SetProgramNumber(9456):
4602006-04-02 14:59:45.550 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait()
4612006-04-02 14:59:45.550 SM(0)::AddFlags: Seen() Match() Wait(PMT,)
4622006-04-02 14:59:45.550 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,)
4632006-04-02 14:59:45.551 TVRec(4): Successfully set up MPEG table monitoring.
4642006-04-02 14:59:45.551 SM(0)::Start: begin
4652006-04-02 14:59:45.553 SM(0)::Start: end
4662006-04-02 14:59:45.554 TVRec(4): SetFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,SignalMonitorRunning,RecorderRunning,
4672006-04-02 14:59:45.554 TVRec(4): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,SignalMonitorRunning,RecorderRunning,
4682006-04-02 14:59:45.554 TVRec(4): SetFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,SignalMonitorRunning,RecorderRunning,
4692006-04-02 14:59:45.555 DummyDTVRecorder::StartRecording -- begin
4702006-04-02 14:59:45.576 DVBSM(0)::UpdateValues: Signal Locked
4712006-04-02 14:59:45.577 DVBSM(0)::UpdateValues: Waiting for table monitor to start
4722006-04-02 14:59:45.580 DVBSM(0)::UpdateValues: Table monitor started
4732006-04-02 14:59:45.582 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0)
4742006-04-02 14:59:45.587 TVRec(4): SetFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,SignalMonitorRunning,ANYRECRUNNING,
4752006-04-02 14:59:45.587 DummyDTVRecorder -- started
4762006-04-02 14:59:45.587 TVRec(4): SetFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady,
4772006-04-02 14:59:45.588 TVRec(4): ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady,
4782006-04-02 14:59:45.588 TVRec(4): SetFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady,
4792006-04-02 14:59:45.589 TVRec(4): SetChannel() -- end
4802006-04-02 14:59:45.599 DVBSM(0): RunTableMonitorTS(): begin (# of pids 1)
4812006-04-02 14:59:45.600 DVBSM(0)::AddPIDFilter(0x0):
4822006-04-02 14:59:45.609 ProcessPAT: PAT is missing program, setting timeout
4832006-04-02 14:59:45.613 DummyRec: Restart! Frames seen 12
4842006-04-02 14:59:45.658 DummyRec: Restart! Frames seen 24
4852006-04-02 14:59:45.692 DummyRec: Restart! Frames seen 36
4862006-04-02 14:59:45.717 DummyRec: Restart! Frames seen 48
487[mpeg2video @ 0xb74123a4]ac-tex damaged at 0 65
488[mpeg2video @ 0xb74123a4]00 motion_type at 5 66
489[mpeg2video @ 0xb74123a4]00 motion_type at 9 67
4902006-04-02 14:59:45.750 DummyRec: Restart! Frames seen 60
4912006-04-02 14:59:45.789 DummyRec: Restart! Frames seen 72
4922006-04-02 14:59:46.247 DummyRec: Restart! Frames seen 84
4932006-04-02 14:59:46.750 DummyRec: Restart! Frames seen 96
4942006-04-02 14:59:47.304 DummyRec: Restart! Frames seen 108
4952006-04-02 14:59:47.807 DummyRec: Restart! Frames seen 120
4962006-04-02 14:59:48.354 DummyRec: Restart! Frames seen 132
4972006-04-02 14:59:48.911 DummyRec: Restart! Frames seen 144
4982006-04-02 14:59:49.409 DummyRec: Restart! Frames seen 156
4992006-04-02 14:59:49.966 DummyRec: Restart! Frames seen 168
5002006-04-02 14:59:50.467 DummyRec: Restart! Frames seen 180
5012006-04-02 14:59:51.018 DummyRec: Restart! Frames seen 192
5022006-04-02 14:59:51.572 DummyRec: Restart! Frames seen 204
5032006-04-02 14:59:52.072 DummyRec: Restart! Frames seen 216
5042006-04-02 14:59:52.626 DummyRec: Restart! Frames seen 228
5052006-04-02 14:59:53.128 DummyRec: Restart! Frames seen 240
5062006-04-02 14:59:53.679 DummyRec: Restart! Frames seen 252
5072006-04-02 14:59:54.235 DummyRec: Restart! Frames seen 264
5082006-04-02 14:59:54.738 DummyRec: Restart! Frames seen 276
5092006-04-02 14:59:55.291 DummyRec: Restart! Frames seen 288
5102006-04-02 14:59:55.794 DummyRec: Restart! Frames seen 300
5112006-04-02 14:59:56.346 DummyRec: Restart! Frames seen 312
5122006-04-02 14:59:56.902 DummyRec: Restart! Frames seen 324
5132006-04-02 14:59:57.402 DummyRec: Restart! Frames seen 336
5142006-04-02 14:59:57.956 DummyRec: Restart! Frames seen 348
5152006-04-02 14:59:58.462 DummyRec: Restart! Frames seen 360
5162006-04-02 14:59:59.017 DummyRec: Restart! Frames seen 372
5172006-04-02 14:59:59.578 DummyRec: Restart! Frames seen 384
5182006-04-02 15:00:00.084 DummyRec: Restart! Frames seen 396
5192006-04-02 15:00:00.649 DummyRec: Restart! Frames seen 408
5202006-04-02 15:00:01.163 DummyRec: Restart! Frames seen 420
5212006-04-02 15:00:01.960 DummyRec: Restart! Frames seen 432
5222006-04-02 15:00:02.524 DummyRec: Restart! Frames seen 444
5232006-04-02 15:00:03.039 DummyRec: Restart! Frames seen 456
5242006-04-02 15:00:03.604 DummyRec: Restart! Frames seen 468
5252006-04-02 15:00:04.128 DummyRec: Restart! Frames seen 480
526
527Give up:
528
5292006-04-02 15:00:04.329 StopLiveTV(void) curRec: 0xa5c46e90 pseudoRec: 0
5302006-04-02 15:00:04.334 TVRec(4): Changing from WatchingLiveTV to None
5312006-04-02 15:00:04.334 TVRec(4): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady,
5322006-04-02 15:00:04.335 TVRec(4): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady,
5332006-04-02 15:00:04.335 TVRec(4): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,)
5342006-04-02 15:00:04.335 TVRec(4): TeardownSignalMonitor() -- begin
5352006-04-02 15:00:04.335 DVBSM(0)::Stop: begin
5362006-04-02 15:00:04.336 SM(0)::Stop: begin
5372006-04-02 15:00:04.368 SM(0)::Stop: end
5382006-04-02 15:00:04.401 DVBSM(0): RunTableMonitorTS(): shutdown
5392006-04-02 15:00:04.401 DVBSM(0)::RemovePIDFilter(0x0):
5402006-04-02 15:00:04.402 DVBSM(0): RunTableMonitorTS(): end
5412006-04-02 15:00:04.402 DVBSM(0)::Stop: end
5422006-04-02 15:00:04.403 DVBSM(0)::Stop: begin
5432006-04-02 15:00:04.403 SM(0)::Stop: begin
5442006-04-02 15:00:04.403 SM(0)::Stop: end
5452006-04-02 15:00:04.403 DVBSM(0)::Stop: end
5462006-04-02 15:00:04.404 TVRec(4): TeardownSignalMonitor() -- end
5472006-04-02 15:00:04.404 TVRec(4): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,ANYRECRUNNING,RingBufferReady,
5482006-04-02 15:00:04.404 TVRec(4): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,ANYRECRUNNING,RingBufferReady,
5492006-04-02 15:00:04.404 DummyDTVRecorder::StopRecordingThread(void)
5502006-04-02 15:00:04.411 DummyDTVRecorder::FinishRecording()
5512006-04-02 15:00:04.447 DummyDTVRecorder::StartRecording -- end
5522006-04-02 15:00:04.447 TVRec(4): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
5532006-04-02 15:00:04.453 TVRec(4): FinishedRecording(The Wedding Date) in recgroup: LiveTV
5542006-04-02 15:00:04.455 Chain: Updated endtime for '114560_20060402145944' to 20060402150004
5552006-04-02 15:00:04.458 Finished recording The Wedding Date: channel 114560
5562006-04-02 15:00:04.464 scheduler: Finished recording: The Wedding Date: channel 114560
5572006-04-02 15:00:04.469 DVBRec(0): Close() fd(-1) -- begin
5582006-04-02 15:00:04.470 DVB#0 SetRecorder()
5592006-04-02 15:00:04.470 DVBRec(0): Close() fd(-1) -- end
5602006-04-02 15:00:04.502 TVRec(4): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
5612006-04-02 15:00:04.510 DVBRec(0): SetPAT(NULL)
5622006-04-02 15:00:04.511 DVBRec(0): SetOutputPMT(NULL)
5632006-04-02 15:00:04.517 TVRec(4): FinishedRecording(The Wedding Date) in recgroup: LiveTV
5642006-04-02 15:00:04.519 Chain: Updated endtime for '114560_20060402145944' to 20060402150004
5652006-04-02 15:00:04.521 Finished recording The Wedding Date: channel 114560
5662006-04-02 15:00:04.526 TVRec(4): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
5672006-04-02 15:00:04.527 TVRec(4): Tearing down RingBuffer
5682006-04-02 15:00:04.527 DummyDTVRecorder::StopRecordingThread(void)
5692006-04-02 15:00:04.528 TVRec(4): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady,
5702006-04-02 15:00:04.618 TVRec(4): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady,
5712006-04-02 15:00:04.619 DVBSM(0)::Stop: begin
5722006-04-02 15:00:04.619 SM(0)::Stop: begin
5732006-04-02 15:00:04.620 SM(0)::Stop: end
5742006-04-02 15:00:04.620 DVBSM(0)::Stop: end
5752006-04-02 15:00:04.620 SM(0)::Stop: begin
5762006-04-02 15:00:04.620 SM(0)::Stop: end
5772006-04-02 15:00:04.621 DVBRec(0): SetPAT(NULL)
5782006-04-02 15:00:04.621 DVBRec(0): SetOutputPMT(NULL)
5792006-04-02 15:00:04.622 DummyDTVRecorder::StopRecordingThread(void)
580c