2007-07-29 20:37:41.684 TVRec(1): Pending recording revoked on inputid 1 2007-07-29 20:37:41.685 TVRec(1): StartRecording(122 (SCIFI)) 2007-07-29 20:37:41.687 ProgramInfo: StartedRecording() 2007-07-29 20:37:41.777 TVRec(1): StartedRecording(0x8330ca0) fn(/stash/video/2122_20070729203800.mpg) 2007-07-29 20:37:41.777 TVRec(1): ClearFlags(CancelNextRecording,) -> RunMainLoop, 2007-07-29 20:37:41.778 TVRec(1): Changing from None to RecordingOnly 2007-07-29 20:37:41.778 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2007-07-29 20:37:41.778 TVRec(1): Request: Program(yes) channel() input() flags(Recording,) 2007-07-29 20:37:41.780 TVRec(1): HW Tuner: 1->1 2007-07-29 20:37:41.780 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2007-07-29 20:37:41.780 TVRec(1): HandleTuning() request dequeued 2007-07-29 20:37:41.780 TVRec(1): TuningFrequency() 2007-07-29 20:37:41.781 DVBChan(1:1): Opening DVB channel fd(-1) 2007-07-29 20:37:42.636 DVBChan(1:1): Using DVB card 1, with frontend 'Genpix 8psk-USB DVB-S'. 2007-07-29 20:37:42.636 DVBChan(1:1): Opening DiSEqC fd(18) card(1) type(0) 2007-07-29 20:37:42.636 DiSEqCDevTree: Changing LNB voltage to 18V 2007-07-29 20:37:43.140 DiSEqCDevTree: Resetting DiSEqC Bus 2007-07-29 20:37:43.140 DiSEqCDevTree: Sending DiSEqC Command: e0 0 0 2007-07-29 20:37:43.405 ChannelBase(1): Input #1: 'DVBInput #1' schan(105) sourceid(2) ccid(1) 2007-07-29 20:37:43.405 ChannelBase(1): Input #5: 'DVBInput #2' schan() sourceid(4) ccid(1) 2007-07-29 20:37:43.405 ChannelBase(1): Input #9: 'DVBInput #3' schan(192) sourceid(5) ccid(1) 2007-07-29 20:37:43.405 ChannelBase(1): Input #13: 'DVBInput #4' schan(257) sourceid(3) ccid(1)2007-07-29 20:37:43.405 ChannelBase(1): Current Input #1: 'DVBInput #1' 2007-07-29 20:37:43.406 DVBChan(1:1): SetChannelByString(122): 2007-07-29 20:37:43.415 DVBChan(1:1): 12326060 qpsk a auto auto a a auto a l 2007-07-29 20:37:43.436 DiSEqCDevTree: Changing to DiSEqC switch port 1/4 2007-07-29 20:37:43.436 DiSEqCDevTree: Sending DiSEqC Command: e0 10 38 f2 2007-07-29 20:37:43.612 DVBChan(1:1): Old Params: 12340640 qpsk a auto auto a a auto a r DVBChan(1:1): New Params: 12326060 qpsk a auto auto a a auto a l 2007-07-29 20:37:43.612 DVBChan(1:1): Tune(): Tuning to 1076060kHz 2007-07-29 20:37:43.662 dvbchannel.cpp:wait_for_backend: Status: 2007-07-29 20:37:43.662 DVBChan(1:1): Tune(): Frequency tuning successful. 2007-07-29 20:37:43.662 DVBChan(1:1): SetChannelByString(122): Tuned to frequency. 2007-07-29 20:37:43.662 TVRec(1): Starting Signal Monitor 2007-07-29 20:37:43.662 TVRec(1): SetupSignalMonitor(1, 0) 2007-07-29 20:37:43.662 DVBChan(1:1): Opening DVB channel fd(18) 2007-07-29 20:37:43.663 DVBSM(1): Can measure Signal Strength 2007-07-29 20:37:43.663 DVBSM(1): Can measure S/N 2007-07-29 20:37:43.663 DVBSM(1): Can measure Bit Error Rate 2007-07-29 20:37:43.663 DVBSM(1): Can count Uncorrected Blocks 2007-07-29 20:37:43.663 SM(1)::RemoveFlags: Seen() Match() Wait() 2007-07-29 20:37:43.663 DVBSM(1): DVBSignalMonitor::ctor initial flags Seen() Match() Wait(Sig,SNR,BER,UB,) 2007-07-29 20:37:43.968 TVRec(1): Signal monitor successfully created 2007-07-29 20:37:43.968 TVRec(1): Setting up dvb table monitoring. 2007-07-29 20:37:43.974 Using profile 'Live TV' to record 2007-07-29 20:37:43.974 TVRec(1): DVB service_id 122 on net_id 4100 tsid 8 2007-07-29 20:37:43.974 TVRec(1): stream_data(0x8380100) 2007-07-29 20:37:43.974 DTVSM(1)::SetDVBService(transport_id: 8, network_id: 4100, service_id: 122): 2007-07-29 20:37:43.974 SM(1)::RemoveFlags: Seen(PMT,NIT,SDT,Crypt,) Match(PMT,NIT,SDT,Crypt,) Wait() 2007-07-29 20:37:43.974 SM(1)::AddFlags: Seen() Match() Wait(PMT,NIT,) 2007-07-29 20:37:43.974 SM(1)::AddFlags: Seen() Match() Wait(PMT,NIT,Pos,) 2007-07-29 20:37:43.975 TVRec(1): Successfully set up DVB table monitoring. 2007-07-29 20:37:43.975 SM(1)::Start: begin 2007-07-29 20:37:43.975 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:37:43.980 SM(1)::Start: end 2007-07-29 20:37:43.980 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning, 2007-07-29 20:37:43.980 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning, 2007-07-29 20:37:43.980 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2007-07-29 20:37:43.981 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2007-07-29 20:37:43.981 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning, 2007-07-29 20:37:43.988 DVBSM(1): UpdateValues -- Signal Locked 2007-07-29 20:37:43.988 DVBSH(1): AddListener(0x8380180) -- begin 2007-07-29 20:37:43.988 DVBSH(1): AddListener(0x8380180) -- locked 2007-07-29 20:37:43.988 DVBSH(1): AddListener(0x8380180) -- end 2007-07-29 20:37:43.989 DVBSH(1): AddPIDFilter(0x0) priority 2 2007-07-29 20:37:43.989 PIDInfo(1): Opening filter for pid 0x0 2007-07-29 20:37:43.989 DVBSH(1): RemovePIDFilter(0x0) 2007-07-29 20:37:43.990 PIDInfo(1): Closing filter for pid 0x0 2007-07-29 20:37:43.990 DVBSH(1): RunTS(): begin 2007-07-29 20:37:43.990 DVBSH(1): AddPIDFilter(0x0) priority 2 2007-07-29 20:37:43.990 PIDInfo(1): Opening filter for pid 0x0 2007-07-29 20:37:43.991 DVBSH(1): AddPIDFilter(0x10) priority 2 2007-07-29 20:37:43.991 PIDInfo(1): Opening filter for pid 0x10 2007-07-29 20:37:43.991 DVBSH(1): AddPIDFilter(0x11) priority 2 2007-07-29 20:37:43.991 PIDInfo(1): Opening filter for pid 0x11 2007-07-29 20:37:43.991 DVBSH(1): AddPIDFilter(0x14) priority 2 2007-07-29 20:37:43.991 PIDInfo(1): Opening filter for pid 0x14 2007-07-29 20:37:44.002 SM(1)::AddFlags: Seen(PAT,) Match() Wait() 2007-07-29 20:37:44.002 SM(1)::AddFlags: Seen() Match(PAT,) Wait() 2007-07-29 20:37:44.002 CreatePATSingleProgram() 2007-07-29 20:37:44.002 PAT in input stream 2007-07-29 20:37:44.003 Program Association Table PSIP tableID(0x0) length(153) extension(0x8) version(27) current(1) section(0) last_section(0) tsid: 8 programCount: 36 program number 0 has PID 0x 10 data 0x 0 0x 0 0xe0 0x10 program number 114 has PID 0x 21 data 0x 0 0x72 0xe0 0x21 program number 116 has PID 0x 21 data 0x 0 0x74 0xe0 0x21 program number 118 has PID 0x 21 data 0x 0 0x76 0xe0 0x21 program number 122 has PID 0x 21 data 0x 0 0x7a 0xe0 0x21 program number 130 has PID 0x 21 data 0x 0 0x82 0xe0 0x21 program number 138 has PID 0x 21 data 0x 0 0x8a 0xe0 0x21 program number 166 has PID 0x 21 data 0x 0 0xa6 0xe0 0x21 program number 182 has PID 0x 21 data 0x 0 0xb6 0xe0 0x21 program number 183 has PID 0x 21 data 0x 0 0xb7 0xe0 0x21 program number 249 has PID 0x 21 data 0x 0 0xf9 0xe0 0x21 program number 282 has PID 0x 21 data 0x 1 0x1a 0xe0 0x21 program number 305 has PID 0x 21 data 0x 1 0x31 0xe0 0x21 program number 319 has PID 0x 21 data 0x 1 0x3f 0xe0 0x21 program number 890 has PID 0x 21 data 0x 3 0x7a 0xe0 0x21 program number 920 has PID 0x 21 data 0x 3 0x98 0xe0 0x21 program number 922 has PID 0x 21 data 0x 3 0x9a 0xe0 0x21 program number 924 has PID 0x 21 data 0x 3 0x9c 0xe0 0x21 program number 950 has PID 0x 21 data 0x 3 0xb6 0xe0 0x21 program number 951 has PID 0x 21 data 0x 3 0xb7 0xe0 0x21 program number 952 has PID 0x 21 data 0x 3 0xb8 0xe0 0x21 program number 963 has PID 0x 21 data 0x 3 0xc3 0xe0 0x21 program number 969 has PID 0x 21 data 0x 3 0xc9 0xe0 0x21 program number 6210 has PID 0x 21 data 0x18 0x42 0xe0 0x21 program number 7241 has PID 0x 21 data 0x1c 0x49 0xe0 0x21 program number 7306 has PID 0x 21 data 0x1c 0x8a 0xe0 0x21 program number 7526 has PID 0x 21 data 0x1d 0x66 0xe0 0x21 program number 7548 has PID 0x 21 data 0x1d 0x7c 0xe0 0x21 program number 7866 has PID 0x 21 data 0x1e 0xba 0xe0 0x21 program number 7997 has PID 0x 21 data 0x1f 0x3d 0xe0 0x21 program number 8175 has PID 0x 21 data 0x1f 0xef 0xe0 0x21 program number 8448 has PID 0x 21 data 0x21 0x 0 0xe0 0x21 program number 8568 has PID 0x 21 data 0x21 0x78 0xe0 0x21 program number 8856 has PID 0x 21 data 0x22 0x98 0xe0 0x21 program number 9328 has PID 0x 21 data 0x24 0x70 0xe0 0x21 program number 9346 has PID 0x 21 data 0x24 0x82 0xe0 0x21 2007-07-29 20:37:44.004 desired_program(122) pid(0x21) 2007-07-29 20:37:44.004 pmt_pid(0x21) 2007-07-29 20:37:44.004 PAT for output stream 2007-07-29 20:37:44.005 Program Association Table PSIP tableID(0x0) length(13) extension(0x8) version(27) current(1) section(0) last_section(0) tsid: 8 programCount: 1 program number 1 has PID 0x 21 data 0x 0 0x 1 0xe0 0x21 2007-07-29 20:37:44.005 DVBSH(1): AddPIDFilter(0x21) priority 2 2007-07-29 20:37:44.005 PIDInfo(1): Opening filter for pid 0x21 2007-07-29 20:37:44.013 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.013 DTVSM(1) Error: Wrong PMT; pmt->pn(7306) desired(122) 2007-07-29 20:37:44.013 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.013 DTVSM(1) Error: Wrong PMT; pmt->pn(7526) desired(122) 2007-07-29 20:37:44.038 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.038 DTVSM(1) Error: Wrong PMT; pmt->pn(7548) desired(122) 2007-07-29 20:37:44.038 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.039 DTVSM(1) Error: Wrong PMT; pmt->pn(7866) desired(122) 2007-07-29 20:37:44.051 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.051 DTVSM(1) Error: Wrong PMT; pmt->pn(7997) desired(122) 2007-07-29 20:37:44.051 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.051 DTVSM(1) Error: Wrong PMT; pmt->pn(8175) desired(122) 2007-07-29 20:37:44.083 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.083 DTVSM(1) Error: Wrong PMT; pmt->pn(8448) desired(122) 2007-07-29 20:37:44.083 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.083 DTVSM(1) Error: Wrong PMT; pmt->pn(8568) desired(122) 2007-07-29 20:37:44.084 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.084 DTVSM(1) Error: Wrong PMT; pmt->pn(8856) desired(122) 2007-07-29 20:37:44.094 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.094 DTVSM(1) Error: Wrong PMT; pmt->pn(9328) desired(122) 2007-07-29 20:37:44.094 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.094 DTVSM(1) Error: Wrong PMT; pmt->pn(9346) desired(122) 2007-07-29 20:37:44.121 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.121 DTVSM(1) Error: Wrong PMT; pmt->pn(114) desired(122) 2007-07-29 20:37:44.122 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.122 DTVSM(1) Error: Wrong PMT; pmt->pn(118) desired(122) 2007-07-29 20:37:44.122 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.122 SM(1)::AddFlags: Seen() Match(PMT,) Wait() 2007-07-29 20:37:44.122 CreatePMTSingleProgram() 2007-07-29 20:37:44.122 PMT in input stream 2007-07-29 20:37:44.122 Program Map Table ver(0) pid(0x21) pnum(122) len(53) Stream #0 pid(0x1122) type(video-mpeg2 0x2) Conditional Access: sid(0x1810) pid(0x122) data_size(0) Conditional Access: sid(0x1801) pid(0x122) data_size(0) Stream #1 pid(0x1123) type(audio-mp2-layer[1,2,3] 0x4) Conditional Access: sid(0x1810) pid(0x122) data_size(0) Conditional Access: sid(0x1801) pid(0x122) data_size(0) ISO-639 Language: code(eng) canonical(eng) eng(English) 2007-07-29 20:37:44.123 PMT for output stream 2007-07-29 20:37:44.123 Program Map Table ver(0) pid(0x21) pnum(1) len(29) Stream #0 pid(0x1122) type(video-mpeg2 0x2) Stream #1 pid(0x1123) type(audio-mp2-layer[1,2,3] 0x4) ISO-639 Language: code(eng) canonical(eng) eng(English) 2007-07-29 20:37:44.123 DVBSH(1): AddPIDFilter(0x1122) priority 3 2007-07-29 20:37:44.123 PIDInfo(1): Opening filter for pid 0x1122 2007-07-29 20:37:44.124 DVBSH(1): AddPIDFilter(0x1123) priority 3 2007-07-29 20:37:44.124 PIDInfo(1): Opening filter for pid 0x1123 2007-07-29 20:37:44.132 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.132 DTVSM(1) Error: Wrong PMT; pmt->pn(166) desired(122) 2007-07-29 20:37:44.132 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.132 DTVSM(1) Error: Wrong PMT; pmt->pn(249) desired(122) 2007-07-29 20:37:44.151 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.151 DTVSM(1) Error: Wrong PMT; pmt->pn(319) desired(122) 2007-07-29 20:37:44.152 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.152 DTVSM(1) Error: Wrong PMT; pmt->pn(138) desired(122) 2007-07-29 20:37:44.152 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.152 DTVSM(1) Error: Wrong PMT; pmt->pn(116) desired(122) 2007-07-29 20:37:44.170 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.171 DTVSM(1) Error: Wrong PMT; pmt->pn(130) desired(122) 2007-07-29 20:37:44.171 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.171 DTVSM(1) Error: Wrong PMT; pmt->pn(183) desired(122) 2007-07-29 20:37:44.171 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.171 DTVSM(1) Error: Wrong PMT; pmt->pn(182) desired(122) 2007-07-29 20:37:44.192 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.192 DTVSM(1) Error: Wrong PMT; pmt->pn(282) desired(122) 2007-07-29 20:37:44.192 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.192 DTVSM(1) Error: Wrong PMT; pmt->pn(305) desired(122) 2007-07-29 20:37:44.192 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.193 DTVSM(1) Error: Wrong PMT; pmt->pn(920) desired(122) 2007-07-29 20:37:44.193 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.193 DTVSM(1) Error: Wrong PMT; pmt->pn(922) desired(122) 2007-07-29 20:37:44.213 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.213 DTVSM(1) Error: Wrong PMT; pmt->pn(924) desired(122) 2007-07-29 20:37:44.213 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.213 DTVSM(1) Error: Wrong PMT; pmt->pn(950) desired(122) 2007-07-29 20:37:44.213 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.213 DTVSM(1) Error: Wrong PMT; pmt->pn(951) desired(122) 2007-07-29 20:37:44.214 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.214 DTVSM(1) Error: Wrong PMT; pmt->pn(952) desired(122) 2007-07-29 20:37:44.214 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.214 DTVSM(1) Error: Wrong PMT; pmt->pn(963) desired(122) 2007-07-29 20:37:44.214 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.214 DTVSM(1) Error: Wrong PMT; pmt->pn(969) desired(122) 2007-07-29 20:37:44.232 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.232 DTVSM(1) Error: Wrong PMT; pmt->pn(6210) desired(122) 2007-07-29 20:37:44.232 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.233 DTVSM(1) Error: Wrong PMT; pmt->pn(890) desired(122) 2007-07-29 20:37:44.252 SM(1)::AddFlags: Seen(PMT,) Match() Wait() 2007-07-29 20:37:44.252 DTVSM(1) Error: Wrong PMT; pmt->pn(7241) desired(122) 2007-07-29 20:37:44.601 DTVSM(1): Time Offset: -0.601847 2007-07-29 20:37:46.056 DTVSM(1)::SetNIT(): net_id = 4100 2007-07-29 20:37:46.056 SM(1)::AddFlags: Seen(NIT,) Match() Wait() 2007-07-29 20:37:46.056 SM(1)::AddFlags: Seen() Match(NIT,) Wait() 2007-07-29 20:37:46.116 TVRec(1): Got good signal 2007-07-29 20:37:46.116 TVRec(1): TeardownSignalMonitor() -- begin 2007-07-29 20:37:46.117 DVBSM(1): Stop() -- begin 2007-07-29 20:37:46.117 SM(1)::Stop: begin 2007-07-29 20:37:46.163 DTVSM(1)::SetNIT(): net_id = 4100 2007-07-29 20:37:46.163 SM(1)::AddFlags: Seen(NIT,) Match() Wait() 2007-07-29 20:37:46.163 SM(1)::AddFlags: Seen() Match(NIT,) Wait() 2007-07-29 20:37:46.213 DTVSM(1)::SetNIT(): net_id = 4100 2007-07-29 20:37:46.213 SM(1)::AddFlags: Seen(NIT,) Match() Wait() 2007-07-29 20:37:46.213 SM(1)::AddFlags: Seen() Match(NIT,) Wait() 2007-07-29 20:37:46.317 DTVSM(1)::SetNIT(): net_id = 4100 2007-07-29 20:37:46.317 SM(1)::AddFlags: Seen(NIT,) Match() Wait() 2007-07-29 20:37:46.317 SM(1)::AddFlags: Seen() Match(NIT,) Wait() 2007-07-29 20:37:46.421 SM(1)::Stop: end 2007-07-29 20:37:46.421 DVBSH(1): RemoveListener(0x8380180) -- begin 2007-07-29 20:37:46.421 DVBSH(1): RemoveListener(0x8380180) -- locked 2007-07-29 20:37:46.421 DVBSH(1): RunTS(): shutdown 2007-07-29 20:37:46.421 DVBSH(1): RemovePIDFilter(0x0) 2007-07-29 20:37:46.421 PIDInfo(1): Closing filter for pid 0x0 2007-07-29 20:37:46.422 DVBSH(1): RemovePIDFilter(0x10) 2007-07-29 20:37:46.422 PIDInfo(1): Closing filter for pid 0x10 2007-07-29 20:37:46.422 DVBSH(1): RemovePIDFilter(0x11) 2007-07-29 20:37:46.422 PIDInfo(1): Closing filter for pid 0x11 2007-07-29 20:37:46.422 DVBSH(1): RemovePIDFilter(0x14) 2007-07-29 20:37:46.422 PIDInfo(1): Closing filter for pid 0x14 2007-07-29 20:37:46.422 DVBSH(1): RemovePIDFilter(0x21) 2007-07-29 20:37:46.422 PIDInfo(1): Closing filter for pid 0x21 2007-07-29 20:37:46.423 DVBSH(1): RemovePIDFilter(0x1122) 2007-07-29 20:37:46.423 PIDInfo(1): Closing filter for pid 0x1122 2007-07-29 20:37:46.423 DVBSH(1): RemovePIDFilter(0x1123) 2007-07-29 20:37:46.423 PIDInfo(1): Closing filter for pid 0x1123 2007-07-29 20:37:46.423 DVBSH(1): RunTS(): end 2007-07-29 20:37:46.424 DVBSH(1): RemoveListener(0x8380180) -- end 2007-07-29 20:37:46.424 DVBSM(1): Stop() -- end 2007-07-29 20:37:46.424 TVRec(1): TeardownSignalMonitor() -- end 2007-07-29 20:37:46.424 TVRec(1): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder, 2007-07-29 20:37:46.424 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder, 2007-07-29 20:37:46.425 TVRec(1): Starting Recorder 2007-07-29 20:37:46.431 Using profile 'Default' to record 2007-07-29 20:37:46.439 TVRec(1): SetRingBuffer(0x8373c68) old(0) 2007-07-29 20:37:46.449 RecBase(1:1): SetRingBuffer(0x8373c68) old(0) '/stash/video/2122_20070729203800.mpg' 2007-07-29 20:37:46.449 DVBRec(1:1): SetPAT(122 on 0x21) ringBuffer(0x8373c68) 2007-07-29 20:37:46.449 CreatePATSingleProgram() 2007-07-29 20:37:46.449 PAT in input stream 2007-07-29 20:37:46.449 Program Association Table PSIP tableID(0x0) length(153) extension(0x8) version(27) current(1) section(0) last_section(0) tsid: 8 programCount: 36 program number 0 has PID 0x 10 data 0x 0 0x 0 0xe0 0x10 program number 114 has PID 0x 21 data 0x 0 0x72 0xe0 0x21 program number 116 has PID 0x 21 data 0x 0 0x74 0xe0 0x21 program number 118 has PID 0x 21 data 0x 0 0x76 0xe0 0x21 program number 122 has PID 0x 21 data 0x 0 0x7a 0xe0 0x21 program number 130 has PID 0x 21 data 0x 0 0x82 0xe0 0x21 program number 138 has PID 0x 21 data 0x 0 0x8a 0xe0 0x21 program number 166 has PID 0x 21 data 0x 0 0xa6 0xe0 0x21 program number 182 has PID 0x 21 data 0x 0 0xb6 0xe0 0x21 program number 183 has PID 0x 21 data 0x 0 0xb7 0xe0 0x21 program number 249 has PID 0x 21 data 0x 0 0xf9 0xe0 0x21 program number 282 has PID 0x 21 data 0x 1 0x1a 0xe0 0x21 program number 305 has PID 0x 21 data 0x 1 0x31 0xe0 0x21 program number 319 has PID 0x 21 data 0x 1 0x3f 0xe0 0x21 program number 890 has PID 0x 21 data 0x 3 0x7a 0xe0 0x21 program number 920 has PID 0x 21 data 0x 3 0x98 0xe0 0x21 program number 922 has PID 0x 21 data 0x 3 0x9a 0xe0 0x21 program number 924 has PID 0x 21 data 0x 3 0x9c 0xe0 0x21 program number 950 has PID 0x 21 data 0x 3 0xb6 0xe0 0x21 program number 951 has PID 0x 21 data 0x 3 0xb7 0xe0 0x21 program number 952 has PID 0x 21 data 0x 3 0xb8 0xe0 0x21 program number 963 has PID 0x 21 data 0x 3 0xc3 0xe0 0x21 program number 969 has PID 0x 21 data 0x 3 0xc9 0xe0 0x21 program number 6210 has PID 0x 21 data 0x18 0x42 0xe0 0x21 program number 7241 has PID 0x 21 data 0x1c 0x49 0xe0 0x21 program number 7306 has PID 0x 21 data 0x1c 0x8a 0xe0 0x21 program number 7526 has PID 0x 21 data 0x1d 0x66 0xe0 0x21 program number 7548 has PID 0x 21 data 0x1d 0x7c 0xe0 0x21 program number 7866 has PID 0x 21 data 0x1e 0xba 0xe0 0x21 program number 7997 has PID 0x 21 data 0x1f 0x3d 0xe0 0x21 program number 8175 has PID 0x 21 data 0x1f 0xef 0xe0 0x21 program number 8448 has PID 0x 21 data 0x21 0x 0 0xe0 0x21 program number 8568 has PID 0x 21 data 0x21 0x78 0xe0 0x21 program number 8856 has PID 0x 21 data 0x22 0x98 0xe0 0x21 program number 9328 has PID 0x 21 data 0x24 0x70 0xe0 0x21 program number 9346 has PID 0x 21 data 0x24 0x82 0xe0 0x21 2007-07-29 20:37:46.451 desired_program(122) pid(0x21) 2007-07-29 20:37:46.451 pmt_pid(0x21) 2007-07-29 20:37:46.451 PAT for output stream 2007-07-29 20:37:46.451 Program Association Table PSIP tableID(0x0) length(13) extension(0x8) version(27) current(1) section(0) last_section(0) tsid: 8 programCount: 1 program number 1 has PID 0x 21 data 0x 0 0x 1 0xe0 0x21 2007-07-29 20:37:46.452 DVBRec(1:1): SetPMT(122) ringBuffer(0x8373c68) 2007-07-29 20:37:46.452 CreatePMTSingleProgram() 2007-07-29 20:37:46.452 PMT in input stream 2007-07-29 20:37:46.452 Program Map Table ver(0) pid(0x21) pnum(122) len(53) Stream #0 pid(0x1122) type(video-mpeg2 0x2) Conditional Access: sid(0x1810) pid(0x122) data_size(0) Conditional Access: sid(0x1801) pid(0x122) data_size(0) Stream #1 pid(0x1123) type(audio-mp2-layer[1,2,3] 0x4) Conditional Access: sid(0x1810) pid(0x122) data_size(0) Conditional Access: sid(0x1801) pid(0x122) data_size(0) ISO-639 Language: code(eng) canonical(eng) eng(English) 2007-07-29 20:37:46.452 PMT for output stream 2007-07-29 20:37:46.452 Program Map Table ver(0) pid(0x21) pnum(1) len(29) Stream #0 pid(0x1122) type(video-mpeg2 0x2) Stream #1 pid(0x1123) type(audio-mp2-layer[1,2,3] 0x4) ISO-639 Language: code(eng) canonical(eng) eng(English) 2007-07-29 20:37:46.453 RecBase(1:1): SetRecording(0x8330ca0) title(122 (SCIFI)) 2007-07-29 20:37:46.454 DVBRec(1:1): Card opened successfully fd(-1) 2007-07-29 20:37:46.454 DVBSH(1): AddListener(0x8380180) -- begin 2007-07-29 20:37:46.455 DVBSH(1): AddListener(0x8380180) -- locked 2007-07-29 20:37:46.456 DVBSH(1): AddListener(0x8380180) -- end 2007-07-29 20:37:46.464 TVRec(1): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady, 2007-07-29 20:37:46.465 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,RecorderRunning,RingBufferReady, 2007-07-29 20:37:46.474 DevRdB(1): buffer size 9400 KB 2007-07-29 20:37:46.475 DVBSH(1): RunTS(): begin 2007-07-29 20:37:46.475 DVBSH(1): AddPIDFilter(0x0) priority 2 2007-07-29 20:37:46.475 PIDInfo(1): Opening filter for pid 0x0 2007-07-29 20:37:46.475 DVBSH(1): AddPIDFilter(0x10) priority 2 2007-07-29 20:37:46.476 PIDInfo(1): Opening filter for pid 0x10 2007-07-29 20:37:46.476 DVBSH(1): AddPIDFilter(0x11) priority 2 2007-07-29 20:37:46.476 PIDInfo(1): Opening filter for pid 0x11 2007-07-29 20:37:46.476 DVBSH(1): AddPIDFilter(0x14) priority 2 2007-07-29 20:37:46.476 PIDInfo(1): Opening filter for pid 0x14 2007-07-29 20:37:46.477 DVBSH(1): AddPIDFilter(0x21) priority 2 2007-07-29 20:37:46.477 PIDInfo(1): Opening filter for pid 0x21 2007-07-29 20:37:46.477 DVBSH(1): AddPIDFilter(0x1122) priority 3 2007-07-29 20:37:46.477 PIDInfo(1): Opening filter for pid 0x1122 2007-07-29 20:37:46.477 DVBSH(1): AddPIDFilter(0x1123) priority 3 2007-07-29 20:37:46.477 PIDInfo(1): Opening filter for pid 0x1123 2007-07-29 20:37:46.512 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x10, continuity counter: 1 (expected 6). 2007-07-29 20:37:46.513 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x21, continuity counter: 1 (expected 6). 2007-07-29 20:37:46.513 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x11, continuity counter: 2 (expected 13). 2007-07-29 20:37:46.528 AddTSPacket: Out of sync!!! Need to wait for next payloadStart PID: 0x0, continuity counter: 12 (expected 10). 2007-07-29 20:37:47.360 PID 0x1122 Found Payload Start 2007-07-29 20:37:47.416 PID 0x1123 Found Payload Start 2007-07-29 20:38:06.521 DevRdB(1): fill avg( 0%) fill max( 0%) samples(764) 2007-07-29 20:38:15.075 TVRec(2): Pending recording revoked on inputid 2 2007-07-29 20:38:15.076 TVRec(2): StartRecording(130 (AMC)) 2007-07-29 20:38:15.078 ProgramInfo: StartedRecording() 2007-07-29 20:38:15.180 TVRec(2): StartedRecording(0x837e590) fn(/stash/video/2130_20070729203900.mpg) 2007-07-29 20:38:15.180 TVRec(2): ClearFlags(CancelNextRecording,) -> RunMainLoop, 2007-07-29 20:38:15.180 TVRec(2): Changing from None to RecordingOnly 2007-07-29 20:38:15.180 TVRec(2): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2007-07-29 20:38:15.180 TVRec(2): Request: Program(yes) channel() input() flags(Recording,) 2007-07-29 20:38:15.182 TVRec(2): HW Tuner: 2->2 2007-07-29 20:38:15.182 TVRec(2): ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2007-07-29 20:38:15.183 TVRec(2): HandleTuning() request dequeued 2007-07-29 20:38:15.183 TVRec(2): TuningFrequency() 2007-07-29 20:38:15.183 DVBChan(2:1): Opening DVB channel fd(-1) 2007-07-29 20:38:15.184 DVBChan(1:1): Opening DVB channel fd(18) 2007-07-29 20:38:15.275 ChannelBase(2): Input #2: 'DVBInput #1' schan(105) sourceid(2) ccid(2) 2007-07-29 20:38:15.276 ChannelBase(2): Input #6: 'DVBInput #2' schan() sourceid(4) ccid(2) 2007-07-29 20:38:15.276 ChannelBase(2): Input #10: 'DVBInput #3' schan(100) sourceid(5) ccid(2)2007-07-29 20:38:15.276 ChannelBase(2): Input #14: 'DVBInput #4' schan(257) sourceid(3) ccid(2)2007-07-29 20:38:15.276 ChannelBase(2): Current Input #2: 'DVBInput #1' 2007-07-29 20:38:15.276 DVBChan(2:1): SetChannelByString(130): 2007-07-29 20:38:15.298 DVBChan(2:1) Warning: Your frequency setting (12326060) is out of range. (min/max:950000/2150000) 2007-07-29 20:38:15.299 DVBChan(2:1): 12326060 qpsk a auto auto a a auto a l 2007-07-29 20:38:15.299 DVBChan(2:1): SetChannelByString(130): Tuned to frequency. 2007-07-29 20:38:15.299 TVRec(2): Starting Signal Monitor 2007-07-29 20:38:15.299 TVRec(2): SetupSignalMonitor(1, 0) 2007-07-29 20:38:15.299 DVBChan(2:1): Opening DVB channel fd(18) 2007-07-29 20:38:15.312 DVBSM(1): Can measure Signal Strength 2007-07-29 20:38:15.312 DVBSM(1): Can measure S/N 2007-07-29 20:38:15.312 DVBSM(1): Can measure Bit Error Rate 2007-07-29 20:38:15.312 DVBSM(1): Can count Uncorrected Blocks 2007-07-29 20:38:15.312 SM(1)::RemoveFlags: Seen() Match() Wait() 2007-07-29 20:38:15.312 DVBSM(1): DVBSignalMonitor::ctor initial flags Seen() Match() Wait(Sig,SNR,BER,UB,) 2007-07-29 20:38:15.617 TVRec(2): Signal monitor successfully created 2007-07-29 20:38:15.617 TVRec(2): Setting up mpeg table monitoring. 2007-07-29 20:38:15.623 Using profile 'Live TV' to record 2007-07-29 20:38:15.623 TVRec(2): MPEG program number: 130 2007-07-29 20:38:15.623 DTVSM(1)::SetProgramNumber(130): 2007-07-29 20:38:15.623 SM(1)::RemoveFlags: Seen(PMT,Crypt,) Match(PMT,Crypt,) Wait() 2007-07-29 20:38:15.623 SM(1)::AddFlags: Seen() Match() Wait(PMT,) 2007-07-29 20:38:15.623 SM(1)::AddFlags: Seen() Match() Wait(PAT,PMT,Pos,) 2007-07-29 20:38:15.623 TVRec(2): Successfully set up MPEG table monitoring. 2007-07-29 20:38:15.623 SM(1)::Start: begin 2007-07-29 20:38:15.624 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:15.629 SM(1)::Start: end 2007-07-29 20:38:15.629 TVRec(2): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning, 2007-07-29 20:38:15.629 TVRec(2): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning, 2007-07-29 20:38:15.629 TVRec(2): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2007-07-29 20:38:15.629 TVRec(2): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2007-07-29 20:38:15.629 TVRec(2): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning, 2007-07-29 20:38:15.637 DVBSM(1): UpdateValues -- Signal Locked 2007-07-29 20:38:15.941 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:16.257 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:16.573 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:16.889 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:17.205 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:17.525 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:17.841 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:18.157 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:18.473 SM(1)::AddFlags: Seen() Match() Wait(Sig,) 2007-07-29 20:38:18.789 SM(1)::AddFlags: Seen() Match() Wait(Sig,)