2006-08-21 15:38:52.173 Using runtime prefix = /usr 2006-08-21 15:38:52.228 New DB connection, total: 1 2006-08-21 15:38:52.243 Connected to database 'mythconverg' at host: localhost 2006-08-21 15:38:52.254 Current Schema Version: 1123 Starting up as the master server. 2006-08-21 15:38:52.270 mythbackend: MythBackend started as master server 2006-08-21 15:38:52.290 New DB connection, total: 2 2006-08-21 15:38:52.291 Connected to database 'mythconverg' at host: localhost 2006-08-21 15:38:52.303 DVB#0 Opening DVB channel 2006-08-21 15:38:52.304 DVB#0 Using DVB card 0, with frontend 'ST STV0299 DVB-S' . 2006-08-21 15:38:52.762 DVB#0 Input #1: 'DVBInput' schan(501) 2006-08-21 15:38:52.762 DVB#0 Current Input #1: 'DVBInput' 2006-08-21 15:38:52.762 DVB#0 SetChannelByString(501) 2006-08-21 15:38:52.766 New DB connection, total: 3 2006-08-21 15:38:52.768 Connected to database 'mythconverg' at host: localhost 2006-08-21 15:38:52.770 DVB#0 Frequency: 12540000 Symbol Rate: 27500000 Pol: H/L Inv: Auto 2006-08-21 15:38:52.771 DiSEqC(0): Setting LNB: Tone ON 18V 2006-08-21 15:38:52.805 DVB#0 Old Params: freq(0) type(QPSK) 2006-08-21 15:38:52.806 DVB#0 New Params: freq(12540000) type(QPSK) 2006-08-21 15:38:52.806 dvbchannel.cpp:wait_for_backend: Status: 2006-08-21 15:38:52.806 DVB#0 DVBChannel::Tune: Frequency tuning successful. 2006-08-21 15:38:52.806 DVB#0 Tuned to frequency for channel 501. 2006-08-21 15:38:52.844 TVRec(1): SetFlags(RunMainLoop,) -> RunMainLoop, 2006-08-21 15:38:52.845 TVRec(1): ClearFlags(ExitPlayer,FinishRecording,) -> Run MainLoop, 2006-08-21 15:38:52.847 New DB scheduler connection 2006-08-21 15:38:52.849 Connected to database 'mythconverg' at host: localhost 2006-08-21 15:38:52.866 mythbackend version: 0.19.20060121-2 www.mythtv.org 2006-08-21 15:38:52.867 Enabled verbose msgs: important general channel record siparser 2006-08-21 15:38:52.868 AutoExpire: Found 1 recorders w/max rate of 138 MiB/min 2006-08-21 15:38:52.871 AutoExpire: Required Free Space: 3.0 GB w/freq: 10 min 2006-08-21 15:38:54.862 Reschedule requested for id -1. 2006-08-21 15:38:54.887 Scheduled 0 items in 0.0 = 0.01 match + 0.02 place 2006-08-21 15:38:54.892 scheduler: Scheduled items: Scheduled 0 items in 0.0 = 0 .01 match + 0.02 place 2006-08-21 15:38:54.901 Seem to be woken up by USER 2006-08-21 15:39:02.303 mythbackend: Running housekeeping thread 2006-08-21 15:40:50.891 TVRec(1): SetFlags(EITScannerRunning,) -> RunMainLoop,EITScannerRunning, 2006-08-21 15:40:57.076 MainServer::HandleAnnounce Monitor 2006-08-21 15:40:57.077 adding: mshome as a client (events: 0) 2006-08-21 15:40:57.113 Getting next free recorder after : -1 2006-08-21 15:40:57.117 Card 1 is local. 2006-08-21 15:40:57.138 MainServer::HandleAnnounce Monitor 2006-08-21 15:40:57.139 adding: mshome as a client (events: 1) 2006-08-21 15:40:57.150 MainServer::HandleAnnounce Playback 2006-08-21 15:40:57.150 adding: mshome as a client (events: 0) 2006-08-21 15:40:57.161 TVRec(1): ClearFlags(EITScannerRunning,) -> RunMainLoop, 2006-08-21 15:40:57.161 TVRec(1): Changing from None to WatchingLiveTV 2006-08-21 15:40:57.161 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2006-08-21 15:40:57.161 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording, 2006-08-21 15:40:57.161 TVRec(1): Request: Program(no) channel() input() flags(LiveTV,) 2006-08-21 15:40:57.162 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording, 2006-08-21 15:40:57.164 DVB#0 Opening DVB channel 2006-08-21 15:40:57.164 DVB#0 SetChannelByString(501) 2006-08-21 15:40:57.164 DVB#0 SetChannelByString(501): already on channel 2006-08-21 15:40:57.164 TVRec(1): CreateLiveTVRingBuffer() 2006-08-21 15:40:57.164 TVRec(1): GetProgramRingBufferForLiveTV() 2006-08-21 15:40:57.285 TVRec(1): StartedRecording(0x816d0c0) fn(/var/lib/mythtv//1501_20060821154057.mpg) 2006-08-21 15:40:57.303 Chain: Appended@0 '1501_20060821154057' 2006-08-21 15:40:57.319 RecBase(/dev/video): SetRingBuffer(0x8182ad8) '/var/lib/mythtv//1501_20060821154057.mpg' 2006-08-21 15:40:57.320 RecBase(/dev/video): SetRecording(0x816d0c0) title(Unknown) 2006-08-21 15:40:57.321 TVRec(1): Starting Signal Monitor 2006-08-21 15:40:57.321 TVRec(1): SetupSignalMonitor(1, 1) 2006-08-21 15:40:57.322 DVB#0 Opening DVB channel 2006-08-21 15:40:57.324 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,BER,UB,) 2006-08-21 15:40:57.325 DVBSM(0)::constructor(): initial flags 0x7400000 2006-08-21 15:40:57.638 TVRec(1): Signal monitor successfully created 2006-08-21 15:40:57.638 TVRec(1): Setting up table monitoring. 2006-08-21 15:40:57.639 TVRec(1): MPEG program number: 8801 2006-08-21 15:40:57.641 DTVSM(0)::SetProgramNumber(8801): 2006-08-21 15:40:57.647 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait() 2006-08-21 15:40:57.647 SM(0)::AddFlags: Seen() Match() Wait(PMT,) 2006-08-21 15:40:57.647 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,) 2006-08-21 15:40:57.648 TVRec(1): Successfully set up MPEG table monitoring. 2006-08-21 15:40:57.648 SM(0)::Start: begin 2006-08-21 15:40:57.650 DVBSM(0)::UpdateValues: Signal Locked 2006-08-21 15:40:57.650 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-08-21 15:40:57.651 DVBSM(0)::AddPIDFilter(0x0): 2006-08-21 15:40:57.652 DVBSM(0)::RemovePIDFilter(0x0): 2006-08-21 15:40:57.654 SM(0)::Start: end 2006-08-21 15:40:57.654 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2006-08-21 15:40:57.655 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2006-08-21 15:40:57.655 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning, 2006-08-21 15:40:57.656 DummyDTVRecorder::StartRecording -- begin 2006-08-21 15:40:57.667 DVBSM(0)::UpdateValues: Table monitor started 2006-08-21 15:40:57.668 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-08-21 15:40:57.680 DVBSM(0): RunTableMonitorTS(): begin (# of pids 2) 2006-08-21 15:40:57.680 DVBSM(0)::AddPIDFilter(0x0): 2006-08-21 15:40:57.685 DVBSM(0)::AddPIDFilter(0x1ffb): 2006-08-21 15:40:57.935 TVRec(1): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2006-08-21 15:40:57.936 DummyDTVRecorder -- started 2006-08-21 15:40:57.936 TVRec(1): SetFlags(RingBufferReset,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:57.936 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:57.936 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:57.936 DiSEqC(0): Setting LNB: Tone ON 18V 2006-08-21 15:40:57.971 DVB#0 Old Params: freq(12540000) type(QPSK) 2006-08-21 15:40:57.972 DVB#0 New Params: freq(12540000) type(QPSK) 2006-08-21 15:40:57.972 dvbchannel.cpp:wait_for_backend: Status: 2006-08-21 15:40:57.972 DVB#0 DVBChannel::Tune: Frequency tuning successful. 2006-08-21 15:40:57.974 TVRec(1): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:58.119 DummyRec: Restart! Frames seen 11 2006-08-21 15:40:58.390 DummyRec: Restart! Frames seen 22 2006-08-21 15:40:58.583 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-08-21 15:40:58.583 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-08-21 15:40:58.583 CreatePATSingleProgram() 2006-08-21 15:40:58.583 PAT in input stream 2006-08-21 15:40:58.583 Program Association Table PSIP prefix(0x0) tableID(0x0) length(125) extension(0x238c) version(6) current(1) section(0) last_section(0) tsid: 9100 programCount: 29 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16 program number 8801 has PID 0x1000 data 0x34 0x97 0x240 0x0 program number 8986 has PID 0x 468 data 0x35 0x26 0x228 0x104 program number 8988 has PID 0x 46d data 0x35 0x28 0x228 0x109 program number 8987 has PID 0x 46a data 0x35 0x27 0x228 0x106 program number 8809 has PID 0x1153 data 0x34 0x105 0x241 0x83 program number 8813 has PID 0x1154 data 0x34 0x109 0x241 0x84 program number 8814 has PID 0x1156 data 0x34 0x110 0x241 0x86 program number 8811 has PID 0x1158 data 0x34 0x107 0x241 0x88 program number 8812 has PID 0x115b data 0x34 0x108 0x241 0x91 program number 8810 has PID 0x115d data 0x34 0x106 0x241 0x93 program number 8981 has PID 0x 49a data 0x35 0x21 0x228 0x154 program number 8982 has PID 0x 49b data 0x35 0x22 0x228 0x155 program number 8983 has PID 0x 49f data 0x35 0x23 0x228 0x159 program number 8984 has PID 0x 4a3 data 0x35 0x24 0x228 0x163 program number 8985 has PID 0x 4a5 data 0x35 0x25 0x228 0x165 program number 8991 has PID 0x 4a7 data 0x35 0x31 0x228 0x167 program number 8927 has PID 0x1603 data 0x34 0x223 0x246 0x3 program number 8926 has PID 0x1602 data 0x34 0x222 0x246 0x2 program number 8901 has PID 0x1503 data 0x34 0x197 0x245 0x3 program number 8905 has PID 0x1508 data 0x34 0x201 0x245 0x8 program number 8904 has PID 0x1502 data 0x34 0x200 0x245 0x2 program number 8906 has PID 0x150a data 0x34 0x202 0x245 0x10 program number 8907 has PID 0x150c data 0x34 0x203 0x245 0x12 program number 8876 has PID 0x1402 data 0x34 0x172 0x244 0x2 program number 8877 has PID 0x1403 data 0x34 0x173 0x244 0x3 program number 8826 has PID 0x1202 data 0x34 0x122 0x242 0x2 program number 8827 has PID 0x1203 data 0x34 0x123 0x242 0x3 program number 8828 has PID 0x1206 data 0x34 0x124 0x242 0x6 2006-08-21 15:40:58.707 desired_program(8801) pid(0x1000) 2006-08-21 15:40:58.707 pmt_pid(0x1000) 2006-08-21 15:40:58.707 PAT for output stream 2006-08-21 15:40:58.707 Program Association Table PSIP prefix(0x0) tableID(0x0) length(13) extension(0x238c) version(6) current(1) section(0) last_section(0) tsid: 9100 programCount: 1 program number 1 has PID 0x1000 data 0x0 0x1 0x240 0x0 2006-08-21 15:40:58.707 DVBSM(0)::AddPIDFilter(0x1000): 2006-08-21 15:40:58.743 DummyRec: Restart! Frames seen 33 2006-08-21 15:40:58.818 Parsed PMT(0x0x8169d50) Program Map Table ver(1) pid(0x1000) pnum(8801) Stream #0 pid(0x16a8) type(video-opencable 0x128) Stream #1 pid(0x2b) type(video-opencable 0x128) Stream #2 pid(0x2a) type(video-opencable 0x128) Stream #3 pid(0x1ffe) type(video-opencable 0x128) Stream #4 pid(0x20) type(video-opencable 0x128) Stream #5 pid(0x21) type(video-opencable 0x128) Stream #6 pid(0x22) type(video-opencable 0x128) Stream #7 pid(0x23) type(video-opencable 0x128) Stream #8 pid(0x24) type(video-opencable 0x128) Stream #9 pid(0x25) type(video-opencable 0x128) 2006-08-21 15:40:58.936 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-08-21 15:40:58.936 SM(0)::AddFlags: Seen() Match(PMT,) Wait() 2006-08-21 15:40:58.937 CreatePMTSingleProgram() 2006-08-21 15:40:58.937 PMT in input stream 2006-08-21 15:40:58.937 Program Map Table ver(1) pid(0x1000) pnum(8801) Stream #0 pid(0x16a8) type(video-opencable 0x128) Stream #1 pid(0x2b) type(video-opencable 0x128) Stream #2 pid(0x2a) type(video-opencable 0x128) Stream #3 pid(0x1ffe) type(video-opencable 0x128) Stream #4 pid(0x20) type(video-opencable 0x128) Stream #5 pid(0x21) type(video-opencable 0x128) Stream #6 pid(0x22) type(video-opencable 0x128) Stream #7 pid(0x23) type(video-opencable 0x128) Stream #8 pid(0x24) type(video-opencable 0x128) Stream #9 pid(0x25) type(video-opencable 0x128) 2006-08-21 15:40:58.937 Parsed PMT(0x0x8169d50) Program Map Table ver(1) pid(0x1000) pnum(8801) Stream #0 pid(0x16a8) type(video-opencable 0x128) Stream #1 pid(0x2b) type(video-opencable 0x128) Stream #2 pid(0x2a) type(video-opencable 0x128) Stream #3 pid(0x1ffe) type(video-opencable 0x128) Stream #4 pid(0x20) type(video-opencable 0x128) Stream #5 pid(0x21) type(video-opencable 0x128) Stream #6 pid(0x22) type(video-opencable 0x128) Stream #7 pid(0x23) type(video-opencable 0x128) Stream #8 pid(0x24) type(video-opencable 0x128) Stream #9 pid(0x25) type(video-opencable 0x128) 2006-08-21 15:40:58.938 Warning: More than one video stream in old PMT, only using first one in new PMT 2006-08-21 15:40:58.938 Parsed PMT(0x0x8185930) Program Map Table ver(0) pid(0x0) pnum(0) 2006-08-21 15:40:58.938 PMT for output stream 2006-08-21 15:40:58.938 Program Map Table ver(1) pid(0x1000) pnum(1) Stream #0 pid(0x16a8) type(video-opencable 0x128) 2006-08-21 15:40:58.999 TVRec(1): Got good signal 2006-08-21 15:40:59.000 TVRec(1): MPEG program num(8801) 2006-08-21 15:40:59.001 TVRec(1): TeardownSignalMonitor() -- begin 2006-08-21 15:40:59.001 DVBSM(0)::Stop: begin 2006-08-21 15:40:59.002 SM(0)::Stop: begin 2006-08-21 15:40:59.007 DummyRec: Restart! Frames seen 44 2006-08-21 15:40:59.179 DummyRec: Restart! Frames seen 55 2006-08-21 15:40:59.187 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1) 2006-08-21 15:40:59.188 SM(0)::Stop: end 2006-08-21 15:40:59.230 DVBSM(0): RunTableMonitorTS(): shutdown 2006-08-21 15:40:59.231 DVBSM(0)::RemovePIDFilter(0x0): 2006-08-21 15:40:59.231 DVBSM(0)::RemovePIDFilter(0x1000): 2006-08-21 15:40:59.231 DVBSM(0)::RemovePIDFilter(0x1ffb): 2006-08-21 15:40:59.240 DVBSM(0): RunTableMonitorTS(): end 2006-08-21 15:40:59.240 DVBSM(0)::Stop: end 2006-08-21 15:40:59.241 DVBSM(0)::Stop: begin 2006-08-21 15:40:59.241 SM(0)::Stop: begin 2006-08-21 15:40:59.241 SM(0)::Stop: end 2006-08-21 15:40:59.241 DVBSM(0)::Stop: end 2006-08-21 15:40:59.241 DVBSM(0)::Stop: begin 2006-08-21 15:40:59.241 SM(0)::Stop: begin 2006-08-21 15:40:59.241 SM(0)::Stop: end 2006-08-21 15:40:59.241 DVBSM(0)::Stop: end 2006-08-21 15:40:59.242 TVRec(1): TeardownSignalMonitor() -- end 2006-08-21 15:40:59.276 TVRec(1): ClearFlags(WaitingForSignal,SignalMonitorRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:59.278 TVRec(1): prog_num(8801) vs. dvbc->srv_id(8801) 2006-08-21 15:40:59.279 DVBSM(0)::Stop: begin 2006-08-21 15:40:59.279 SM(0)::Stop: begin 2006-08-21 15:40:59.279 SM(0)::Stop: end 2006-08-21 15:40:59.279 DVBSM(0)::Stop: end 2006-08-21 15:40:59.279 SM(0)::Stop: begin 2006-08-21 15:40:59.280 SM(0)::Stop: end 2006-08-21 15:40:59.282 SIParser: About to do a reset 2006-08-21 15:40:59.283 SIParser: Descriptor Stats -- begin 2006-08-21 15:40:59.283 SIParser: Descriptor Stats -- end 2006-08-21 15:40:59.284 SIParser: Closing all PIDs 2006-08-21 15:40:59.284 SIParser: DelAllPids does nothing 2006-08-21 15:40:59.285 SIParser: Resetting all Table Handlers 2006-08-21 15:40:59.285 SIParser: SIParser Reset due to channel change 2006-08-21 15:40:59.286 SIParser: FillEITMaps() 2006-08-21 15:40:59.314 SIParser: Added initial preferred language 'eng' with priority 1 2006-08-21 15:40:59.315 SIParser: Added initial preferred language 'eng' with priority 2 2006-08-21 15:40:59.315 DVB#0 DVB SI Table Parser Started 2006-08-21 15:40:59.316 SIParser: ReinitSIParser(std dvb, service #8801) 2006-08-21 15:40:59.316 FillPMap(str dvb) 2006-08-21 15:40:59.316 FillPMap(SIS dvb) 2006-08-21 15:40:59.316 SIParser: Requesting PAT 2006-08-21 15:40:59.316 SIParser: Adding PMT program number #8801 to the request list 2006-08-21 15:40:59.317 TVRec(1): SetFlags(WaitingForSIParser,SIParserRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSIParser,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:59.318 DVBSIParser: Starting DVB Section Reader thread 2006-08-21 15:40:59.320 SIParser: Table[0]->RequirePIDs() == true 2006-08-21 15:40:59.321 DVBSIParser: Adding PID 0x 0 Filter 0x 0 Mask 0xff Buffer 40960 2006-08-21 15:40:59.342 DummyRec: Restart! Frames seen 66 2006-08-21 15:40:59.347 SIParser: Table[2]->RequirePIDs() == true 2006-08-21 15:40:59.348 DVBSIParser: Adding PID 0x1ffb Filter 0xff Mask 0x 0 Buffer 40960 2006-08-21 15:40:59.348 SIParser: Table[3]->RequirePIDs() == true 2006-08-21 15:40:59.349 DVBSIParser: Adding PID 0x1ffb Filter 0xff Mask 0x 0 Buffer 40960 2006-08-21 15:40:59.349 SIParser: Table[6]->RequirePIDs() == true 2006-08-21 15:40:59.350 DVBSIParser: Adding PID 0x 10 Filter 0x40 Mask 0xff Buffer 40960 2006-08-21 15:40:59.466 DummyRec: Restart! Frames seen 77 2006-08-21 15:40:59.534 SIParser: PAT Version = 6 2006-08-21 15:40:59.534 SIParser: Tuned to TransportID: 9100 2006-08-21 15:40:59.534 SIParser: NIT Present on this transport on PID 0x10 2006-08-21 15:40:59.534 SIParser: PMT pn(8801) on PID 0x1000 2006-08-21 15:40:59.535 SIParser: PMT pn(8986) on PID 0x468 2006-08-21 15:40:59.535 SIParser: PMT pn(8988) on PID 0x46d 2006-08-21 15:40:59.535 SIParser: PMT pn(8987) on PID 0x46a 2006-08-21 15:40:59.536 SIParser: PMT pn(8809) on PID 0x1153 2006-08-21 15:40:59.536 SIParser: PMT pn(8813) on PID 0x1154 2006-08-21 15:40:59.536 SIParser: PMT pn(8814) on PID 0x1156 2006-08-21 15:40:59.536 SIParser: PMT pn(8811) on PID 0x1158 2006-08-21 15:40:59.536 SIParser: PMT pn(8812) on PID 0x115b 2006-08-21 15:40:59.536 SIParser: PMT pn(8810) on PID 0x115d 2006-08-21 15:40:59.537 SIParser: PMT pn(8981) on PID 0x49a 2006-08-21 15:40:59.537 SIParser: PMT pn(8982) on PID 0x49b 2006-08-21 15:40:59.537 SIParser: PMT pn(8983) on PID 0x49f 2006-08-21 15:40:59.537 SIParser: PMT pn(8984) on PID 0x4a3 2006-08-21 15:40:59.537 SIParser: PMT pn(8985) on PID 0x4a5 2006-08-21 15:40:59.538 SIParser: PMT pn(8991) on PID 0x4a7 2006-08-21 15:40:59.538 SIParser: PMT pn(8927) on PID 0x1603 2006-08-21 15:40:59.538 SIParser: PMT pn(8926) on PID 0x1602 2006-08-21 15:40:59.538 SIParser: PMT pn(8901) on PID 0x1503 2006-08-21 15:40:59.538 SIParser: PMT pn(8905) on PID 0x1508 2006-08-21 15:40:59.539 SIParser: PMT pn(8904) on PID 0x1502 2006-08-21 15:40:59.539 SIParser: PMT pn(8906) on PID 0x150a 2006-08-21 15:40:59.539 SIParser: PMT pn(8907) on PID 0x150c 2006-08-21 15:40:59.539 SIParser: PMT pn(8876) on PID 0x1402 2006-08-21 15:40:59.539 SIParser: PMT pn(8877) on PID 0x1403 2006-08-21 15:40:59.539 SIParser: PMT pn(8826) on PID 0x1202 2006-08-21 15:40:59.540 SIParser: PMT pn(8827) on PID 0x1203 2006-08-21 15:40:59.540 SIParser: PMT pn(8828) on PID 0x1206 2006-08-21 15:40:59.540 SIParser: Services on this Transport: 8801 8809 8810 8811 8812 8813 8814 8826 8827 8828 8876 8877 8901 8904 8905 8906 8907 8926 8927 8981 8982 8983 8984 8985 8986 8987 8988 8991 2006-08-21 15:40:59.540 SIParser: Table[0]->Complete() == true 2006-08-21 15:40:59.541 SIParser: Table[1]->RequirePIDs() == true 2006-08-21 15:40:59.541 DVBSIParser: Adding PID 0x1000 Filter 0x 2 Mask 0xff Buffer 40960 2006-08-21 15:40:59.635 DummyRec: Restart! Frames seen 88 2006-08-21 15:40:59.774 SIParser: PMT pn(8801) version(1) 2006-08-21 15:40:59.775 SIParser: PID: 0x16a8 2006-08-21 15:40:59.775 SIParser: PID: 0x2b 2006-08-21 15:40:59.775 SIParser: PID: 0x2a 2006-08-21 15:40:59.775 SIParser: PID: 0x1ffe 2006-08-21 15:40:59.775 SIParser: PID: 0x20 2006-08-21 15:40:59.775 SIParser: PID: 0x21 2006-08-21 15:40:59.775 SIParser: PID: 0x22 2006-08-21 15:40:59.775 SIParser: PID: 0x23 2006-08-21 15:40:59.776 SIParser: PID: 0x24 2006-08-21 15:40:59.776 SIParser: PID: 0x25 2006-08-21 15:40:59.776 SIParser: Table[1]->EmitRequired() == true 2006-08-21 15:40:59.776 DVB#0 SetPMT ServiceID=8801, PCRPID=8191 (0x1fff) 2006-08-21 15:40:59.778 TVRec(1): Got SIParser PMT 2006-08-21 15:40:59.779 TVRec(1): ClearFlags(WaitingForSIParser,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReset, 2006-08-21 15:40:59.779 TVRec(1): Starting Recorder 2006-08-21 15:40:59.781 DummyDTVRecorder::StopRecordingThread(void) 2006-08-21 15:40:59.787 DummyDTVRecorder::FinishRecording() 2006-08-21 15:40:59.792 DummyDTVRecorder::StartRecording -- end 2006-08-21 15:40:59.794 TVRec(1): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReset, 2006-08-21 15:40:59.800 TVRec(1): FinishedRecording(Unknown) in recgroup: LiveTV 2006-08-21 15:40:59.803 Chain: Updated endtime for '1501_20060821154057' to 20060821154059 2006-08-21 15:40:59.806 Finished recording Unknown: channel 1501 2006-08-21 15:40:59.810 scheduler: Finished recording: Unknown: channel 1501 2006-08-21 15:40:59.818 TVRec(1): Using profile 'Live TV' to record 2006-08-21 15:40:59.818 TVRec(1): SwitchLiveTVRingBuffer(discont 1, set_rec 0) 2006-08-21 15:40:59.819 TVRec(1): GetProgramRingBufferForLiveTV() 2006-08-21 15:40:59.861 TVRec(1): StartedRecording(0x81920c8) fn(/var/lib/mythtv//1501_20060821154059.mpg) 2006-08-21 15:40:59.883 TVRec(1): FinishedRecording(Unknown) in recgroup: LiveTV 2006-08-21 15:40:59.886 Chain: Updated endtime for '1501_20060821154057' to 20060821154059 2006-08-21 15:40:59.923 Finished recording Unknown: channel 1501 2006-08-21 15:40:59.924 Preview: 'myth://127.0.0.1:6543/1501_20060821154057.mpg' is not local, replacing with '/var/lib/mythtv//1501_20060821154057.mpg', which is local. 2006-08-21 15:40:59.934 Chain: Appended@1 '1501_20060821154059' 2006-08-21 15:40:59.940 DummyDTVRecorder::StopRecordingThread(void) 2006-08-21 15:40:59.941 DummyDTVRecorder::StopRecordingThread(void) 2006-08-21 15:40:59.942 TVRec(1): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReset, 2006-08-21 15:41:00.038 RecBase(0): SetRingBuffer(0x81a8548) '/var/lib/mythtv//1501_20060821154059.mpg' 2006-08-21 15:41:00.039 RecBase(0): SetRecording(0x8182ad8) title(Unknown) 2006-08-21 15:41:00.042 DVBRec(0): Card opened successfully fd(17) (using TS mode). 2006-08-21 15:41:00.044 DVBRec(0): SetPMTObject() 2006-08-21 15:41:00.045 DVBRec(0): AutoPID for MPEG Program Number(8801), PCR PID(0x1fff) 2006-08-21 15:41:00.045 DVBRec(0): AutoPID recording PID 0x16a8, MPEG-2 Video 2006-08-21 15:41:00.046 DVBRec(0): AutoPID recording PID 0x2b, MPEG-2 Video 2006-08-21 15:41:00.047 DVBRec(0): AutoPID recording PID 0x2a, MPEG-2 Video 2006-08-21 15:41:00.047 DVBRec(0): AutoPID recording PID 0x1ffe, MPEG-2 Video 2006-08-21 15:41:00.048 DVBRec(0): AutoPID recording PID 0x20, MPEG-2 Video 2006-08-21 15:41:00.048 DVBRec(0): AutoPID recording PID 0x21, MPEG-2 Video 2006-08-21 15:41:00.049 DVBRec(0): AutoPID recording PID 0x22, MPEG-2 Video 2006-08-21 15:41:00.050 DVBRec(0): AutoPID recording PID 0x23, MPEG-2 Video 2006-08-21 15:41:00.051 DVBRec(0): AutoPID recording PID 0x24, MPEG-2 Video 2006-08-21 15:41:00.051 DVBRec(0): AutoPID recording PID 0x25, MPEG-2 Video 2006-08-21 15:41:00.052 DVBRec(0): AutoPID Complete - PAT/PMT Loaded for service A/V Streams are unencrypted 2006-08-21 15:41:00.053 DVBRecorder::SetPAT(NULL) 2006-08-21 15:41:00.053 DVBRecorder::SetPMT(NULL) 2006-08-21 15:41:00.063 TVRec(1): SetFlags(RecorderRunning,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderRunning,RingBufferReset, 2006-08-21 15:41:00.063 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2006-08-21 15:41:00.092 DevRdB(0): buffer size 9400 KB 2006-08-21 15:41:00.093 DVBRec(0): Resetting Demux Filters 2006-08-21 15:41:00.150 DVBRec(0): Adding pid 0x16a8 size(3600384) 2006-08-21 15:41:00.152 DVBRec(0): Set demux buffer size for pid 0x16a8 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.153 DVBRec(0): Adding pid 0x2b size(3600384) 2006-08-21 15:41:00.154 DVBRec(0): Set demux buffer size for pid 0x2b to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.155 DVBRec(0): Adding pid 0x2a size(3600384) 2006-08-21 15:41:00.156 DVBRec(0): Set demux buffer size for pid 0x2a to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.157 DVBRec(0): Adding pid 0x1ffe size(3600384) 2006-08-21 15:41:00.158 DVBRec(0): Set demux buffer size for pid 0x1ffe to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.159 DVBRec(0): Adding pid 0x20 size(3600384) 2006-08-21 15:41:00.160 DVBRec(0): Set demux buffer size for pid 0x20 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.161 DVBRec(0): Adding pid 0x21 size(3600384) 2006-08-21 15:41:00.162 DVBRec(0): Set demux buffer size for pid 0x21 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.164 DVBRec(0): Adding pid 0x22 size(3600384) 2006-08-21 15:41:00.165 DVBRec(0): Set demux buffer size for pid 0x22 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.166 DVBRec(0): Adding pid 0x23 size(3600384) 2006-08-21 15:41:00.167 DVBRec(0): Set demux buffer size for pid 0x23 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.168 DVBRec(0): Adding pid 0x24 size(3600384) 2006-08-21 15:41:00.169 DVBRec(0): Set demux buffer size for pid 0x24 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.170 DVBRec(0): Adding pid 0x25 size(3600384) 2006-08-21 15:41:00.171 DVBRec(0): Set demux buffer size for pid 0x25 to 3600384, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.173 DVBRec(0): Adding pid 0x1fff size(94208) 2006-08-21 15:41:00.174 DVBRec(0): Set demux buffer size for pid 0x1fff to 94208, which gives us a 1500 msec buffer. 2006-08-21 15:41:00.177 DVBRecorder::SetPAT() Program Association Table PSIP prefix(0x0) tableID(0x0) length(13) extension(0x1) version(0) current(1) section(0) last_section(0) tsid: 1 programCount: 1 program number 1 has PID 0x1700 data 0x0 0x1 0x247 0x0 2006-08-21 15:41:00.179 Parsed PMT(0x0x81682d8) Program Map Table ver(0) pid(0x0) pnum(0) 2006-08-21 15:41:00.180 DVBRecorder::SetPMT() Program Map Table ver(1) pid(0x1700) pnum(1) Stream #0 pid(0x16a8) type(video-mpeg2 0x2) Stream #1 pid(0x2b) type(video-mpeg2 0x2) Stream #2 pid(0x2a) type(video-mpeg2 0x2) Stream #3 pid(0x1ffe) type(video-mpeg2 0x2) Stream #4 pid(0x20) type(video-mpeg2 0x2) Stream #5 pid(0x21) type(video-mpeg2 0x2) Stream #6 pid(0x22) type(video-mpeg2 0x2) Stream #7 pid(0x23) type(video-mpeg2 0x2) Stream #8 pid(0x24) type(video-mpeg2 0x2) Stream #9 pid(0x25) type(video-mpeg2 0x2) 2006-08-21 15:41:03.266 SIParser: No Private Types defined for NetworkID 64511 2006-08-21 15:41:04.031 TVRec(1): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 0: start_time: 857.475 duration: -9223372036854.775 stream: start_time: 9527.500 duration: -9223372036854.775 bitrate=0 kb/s 2006-08-21 15:41:06.515 AFD: Opened codec 0x81bdb80, id(MPEG1VIDEO) type(Video) 2006-08-21 15:41:06.516 NVP: Disabling Audio, params(-1,-1,-1) 2006-08-21 15:41:06.516 NVP: Disabling Audio, params(0,-1,-1) 2006-08-21 15:41:07.752 SIParser: Table[6]->Complete() == true 2006-08-21 15:41:07.752 SIParser: Table[5]->RequirePIDs() == true 2006-08-21 15:41:07.752 DVBSIParser: Adding PID 0x 11 Filter 0x46 Mask 0xfb Buffer 40960 2006-08-21 15:41:08.811 SIParser: SDT: NetworkID=318 TransportID=9100 2006-08-21 15:41:08.811 SIParser: SDT: sid=8801 type=128 eit_present=0 eit_requested=0 name=SKYPLEX TXP91 2006-08-21 15:41:08.811 SIParser: SDT: sid=8876 type=128 eit_present=0 eit_requested=0 name=SKYGATE1 2006-08-21 15:41:08.811 SIParser: SDT: sid=8877 type=128 eit_present=0 eit_requested=0 name=simba_v41300_121005 2006-08-21 15:41:08.812 SIParser: SDT: sid=8901 type=128 eit_present=0 eit_requested=0 name=Skyplex 10.2 2006-08-21 15:41:08.812 SIParser: SDT: sid=8905 type=12 eit_present=0 eit_requested=0 name=HitCast S.Amer. 2006-08-21 15:41:08.812 SIParser: SDT: sid=8904 type=12 eit_present=0 eit_requested=0 name=HitCast Data 1 2006-08-21 15:41:08.812 SIParser: SDT: sid=8906 type=12 eit_present=0 eit_requested=0 name=Data_01 2006-08-21 15:41:08.812 SIParser: SDT: sid=8907 type=12 eit_present=0 eit_requested=0 name=Data_02 2006-08-21 15:41:08.813 SIParser: SDT: sid=8986 type=128 eit_present=0 eit_requested=0 name=SKY MEDIO 2006-08-21 15:41:08.813 SIParser: SDT: sid=8988 type=12 eit_present=0 eit_requested=0 name=Network 2006-08-21 15:41:08.813 SIParser: SDT: sid=8981 type=128 eit_present=0 eit_requested=0 name=SKYGATE ERTU 2006-08-21 15:41:08.813 SIParser: SDT: sid=8982 type=1 eit_present=0 eit_requested=0 name=Nile TV International 2006-08-21 15:41:08.813 SIParser: SDT: sid=8983 type=1 eit_present=0 eit_requested=0 name=Nile News 2006-08-21 15:41:08.813 SIParser: SDT: sid=8984 type=2 eit_present=0 eit_requested=0 name=El Shark El Awsat 2006-08-21 15:41:08.814 SIParser: SDT: sid=8985 type=2 eit_present=0 eit_requested=0 name=Al moagehat 2006-08-21 15:41:08.814 SIParser: SDT: sid=8991 type=1 eit_present=0 eit_requested=0 name=Sports test 2006-08-21 15:41:08.814 SIParser: SDT: sid=8927 type=1 eit_present=0 eit_requested=0 name=PTV 2006-08-21 15:41:08.814 SIParser: SDT: sid=8926 type=128 eit_present=0 eit_requested=0 name=SkyPlex CHID 3 2006-08-21 15:41:08.814 SIParser: SDT: sid=8809 type=128 eit_present=0 eit_requested=0 name=skygateTDA 2006-08-21 15:41:08.814 SIParser: SDT: sid=8826 type=128 eit_present=0 eit_requested=0 name=Skygate 600 2006-08-21 15:41:08.815 SIParser: SDT: sid=8827 type=1 eit_present=0 eit_requested=0 name=Bulgaria TV 2006-08-21 15:41:08.815 SIParser: SDT: sid=8828 type=2 eit_present=0 eit_requested=0 name=Bulgaria Radio 2006-08-21 15:41:08.815 SIParser: SDT: sid=8813 type=2 eit_present=0 eit_requested=0 name=Chaine 2 2006-08-21 15:41:08.816 SIParser: SDT: sid=8814 type=2 eit_present=0 eit_requested=0 name=Chaine 3 2006-08-21 15:41:08.816 SIParser: SDT: sid=8811 type=1 eit_present=0 eit_requested=0 name=A3 2006-08-21 15:41:08.816 SIParser: SDT: sid=8812 type=2 eit_present=0 eit_requested=0 name=Chaine 1 2006-08-21 15:41:08.816 SIParser: SDT: sid=8810 type=1 eit_present=0 eit_requested=0 name=Canal Algerie 2006-08-21 15:41:08.816 SIParser: SDT: sid=8987 type=1 eit_present=0 eit_requested=0 name=MEDIOLANUM 2006-08-21 15:41:08.817 SIParser: Table[4]->RequirePIDs() == true 2006-08-21 15:41:08.817 DVBSIParser: Adding PID 0x 12 Filter 0x7f Mask 0x80 Buffer 4096000 2006-08-21 15:41:10.624 StopLiveTV(void) curRec: 0x81920c8 pseudoRec: 0 2006-08-21 15:41:10.627 TVRec(1): Changing from WatchingLiveTV to None 2006-08-21 15:41:10.627 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2006-08-21 15:41:10.628 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2006-08-21 15:41:10.628 TVRec(1): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2006-08-21 15:41:10.628 DVBSIParser: Stopping DVB Section Reader 2006-08-21 15:41:10.781 DVBSIParser: DVB Section Reader thread stopped 2006-08-21 15:41:10.782 SIParser: Descriptor Stats -- begin 2006-08-21 15:41:10.782 SIParser: On PID 0x10: Found 1, Service List Descriptor 2006-08-21 15:41:10.782 SIParser: On PID 0x11: Found 5, Data Broadcast Descriptors 2006-08-21 15:41:10.792 SIParser: Descriptor Stats -- end 2006-08-21 15:41:10.792 TVRec(1): ClearFlags(SIParserRunning,) -> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReset, 2006-08-21 15:41:10.803 DVBRec(0): Close() fd(17) -- begin 2006-08-21 15:41:10.816 DVBRec(0): Close() fd(-1) -- end 2006-08-21 15:41:10.823 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReset, 2006-08-21 15:41:10.825 DVBRecorder::SetPAT(NULL) 2006-08-21 15:41:10.826 DVBRecorder::SetPMT(NULL) 2006-08-21 15:41:10.834 TVRec(1): FinishedRecording(Unknown) in recgroup: LiveTV 2006-08-21 15:41:10.837 Chain: Updated endtime for '1501_20060821154059' to 20060821154110 2006-08-21 15:41:10.840 Finished recording Unknown: channel 1501 2006-08-21 15:41:10.844 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReset, 2006-08-21 15:41:10.845 TVRec(1): Tearing down RingBuffer 2006-08-21 15:41:10.847 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReset, 2006-08-21 15:41:10.848 DVBRecorder::SetPAT(NULL) 2006-08-21 15:41:10.848 DVBRecorder::SetPMT(NULL) 2006-08-21 15:42:13.052 autoexpire: Expiring Program: Expiring: Unknown Mon Aug 21 15:40:57 2006 3 MBytes 2006-08-21 15:42:13.066 autoexpire: Expiring Program: Expiring: Unknown Mon Aug 21 15:40:59 2006 0 MBytes 2006-08-21 15:42:38.227 TVRec(1): SetFlags(EITScannerRunning,) -> RunMainLoop,AskAllowRecording,EITScannerRunning,RingBufferReset,