2006-10-20 17:13:48.229 Using runtime prefix = /usr 2006-10-20 17:13:48.259 New DB connection, total: 1 2006-10-20 17:13:48.268 Connected to database 'mythconverg' at host: localhost 2006-10-20 17:13:48.272 Current Schema Version: 1160 2006-10-20 17:13:48.283 New DB connection, total: 2 2006-10-20 17:13:48.284 Connected to database 'mythconverg' at host: localhost 2006-10-20 17:13:48.285 mythbackend: MythBackend started as master server 2006-10-20 17:13:48.293 EITHelper: localtime offset 2:00:00 2006-10-20 17:13:48.539 DVBChan(0): Opening DVB channel 2006-10-20 17:13:48.539 DVBChan(0): Using DVB card 0, with frontend 'DST DVB-C'. 2006-10-20 17:13:48.767 DVB#0 CA: CI handler successfully initialized! 2006-10-20 17:13:48.769 New DB connection, total: 3 2006-10-20 17:13:48.769 Connected to database 'mythconverg' at host: localhost 2006-10-20 17:13:48.776 DVB#0 CA: CI handler thread running 2006-10-20 17:13:48.824 ChannelBase(3): Input #3: 'DVBInput' schan(4) sourceid(2) ccid(3) 2006-10-20 17:13:48.824 ChannelBase(3): Current Input #3: 'DVBInput' 2006-10-20 17:13:48.825 DVBChan(0): SetChannelByString(4): 2006-10-20 17:13:48.829 DVBChan(0): Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:13:48.829 DVBChan(0): Old Params: Frequency: 0 Symbol Rate: 0 Inversion: Off Inner FEC: none DVBChan(0): New Params: Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:13:48.829 DVBChan(0): Tune(): Tuning to 802000000Hz Debug: 159 128 49 2 5 0 0 1 5 0 171 255 255 255 255 255 255 255 255 255 2006-10-20 17:13:49.190 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-20 17:13:49.190 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-20 17:13:49.190 DVBChan(0): SetChannelByString(4): Tuned to frequency. 2006-10-20 17:13:49.190 DVBChan(0): Closing DVB channel 2006-10-20 17:13:49.192 DVB#0 CA: CiHandler thread stopped 2006-10-20 17:13:49.206 TVRec(3): SetFlags(RunMainLoop,) -> RunMainLoop, 2006-10-20 17:13:49.207 TVRec(3): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2006-10-20 17:13:49.207 EITHelper: localtime offset 2:00:00 2006-10-20 17:13:49.209 Channel(/dev/video0): Device name 'Hauppauge WinTV PVR-150' driver 'ivtv'. 2006-10-20 17:13:49.218 ChannelBase(4): Input #4: 'Tuner 1' schan(20) sourceid(1) ccid(4) 2006-10-20 17:13:49.218 ChannelBase(4): Current Input #4: 'Tuner 1' 2006-10-20 17:13:49.219 Global TVFormat Setting 'PAL-BG' 2006-10-20 17:13:49.220 Channel(/dev/video0): Input #4: 'Tuner 1' schan(20) tun() v4l1(PAL) v4l2(Unknown) 2006-10-20 17:13:49.220 Channel(/dev/video0): SetFormat(Default) fmt(PAL-BG) input(4) 2006-10-20 17:13:49.220 Channel(/dev/video0): SetInputAndFormat(4, PAL-BG) (v4l v2) 2006-10-20 17:13:49.220 Channel(/dev/video0): SetFormat(PAL-BG) fmt(PAL-BG) input(4) 2006-10-20 17:13:49.221 Channel(/dev/video0)::SwitchToInput(in 4, '') 2006-10-20 17:13:49.222 Channel(/dev/video0): SetInputAndFormat(4, PAL-BG) (v4l v2) 2006-10-20 17:13:49.222 Channel(/dev/video0): SetChannelByString(20) 2006-10-20 17:13:49.223 ChannelBase(/dev/video0)::SetCachedATSCInfo(): 0--1 2006-10-20 17:13:49.224 Channel(/dev/video0): SetFormat(Default) fmt(PAL-BG) input(4) 2006-10-20 17:13:49.226 Channel(/dev/video0)::Tune(615250000, , analog) 2006-10-20 17:13:49.358 Channel(/dev/video0)::Tune(): Frequency is now 615250000 2006-10-20 17:13:49.359 ChannelBase(/dev/video0)::SetCachedATSCInfo(20_0): 20--1 2006-10-20 17:13:49.359 TVRec(4): SetFlags(RunMainLoop,) -> RunMainLoop, 2006-10-20 17:13:49.359 TVRec(4): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2006-10-20 17:13:49.360 New DB scheduler connection 2006-10-20 17:13:49.361 Connected to database 'mythconverg' at host: localhost 2006-10-20 17:13:49.369 Main::Starting HttpServer 2006-10-20 17:13:49.376 Main::Registering HttpStatus Extension 2006-10-20 17:13:49.383 mythbackend version: 0.20.20060828-3 www.mythtv.org 2006-10-20 17:13:49.383 Enabled verbose msgs: important general siparser record channel 2006-10-20 17:13:49.383 AutoExpire: Found 2 recorders w/max rate of 210 MiB/min 2006-10-20 17:13:49.385 AutoExpire: Required Free Space: 2.6 GB w/freq: 5 min 2006-10-20 17:13:51.372 Reschedule requested for id -1. 2006-10-20 17:13:51.837 Scheduled 42 items in 0.5 = 0.08 match + 0.38 place 2006-10-20 17:13:51.849 scheduler: Scheduled items: Scheduled 42 items in 0.5 = 0.08 match + 0.38 place 2006-10-20 17:13:51.852 Seem to be woken up by USER 2006-10-20 17:13:53.805 MainServer::HandleAnnounce Monitor 2006-10-20 17:13:53.805 adding: el-duce as a client (events: 0) 2006-10-20 17:13:53.806 MainServer::HandleAnnounce Monitor 2006-10-20 17:13:53.806 adding: el-duce as a client (events: 1) 2006-10-20 17:13:53.807 Getting next free recorder after : -1 2006-10-20 17:13:53.808 Checking card 3. Best card so far 3 2006-10-20 17:13:53.808 Checking card 4. Best card so far 3 2006-10-20 17:13:53.812 MainServer::HandleAnnounce Playback 2006-10-20 17:13:53.812 adding: el-duce as a client (events: 0) 2006-10-20 17:13:53.831 TVRec(3): Changing from None to WatchingLiveTV 2006-10-20 17:13:53.832 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2006-10-20 17:13:53.832 TVRec(3): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording, 2006-10-20 17:13:53.832 TVRec(3): Request: Program(no) channel() input() flags(LiveTV,) 2006-10-20 17:13:53.833 TVRec(3): HW Tuner: 3->3 2006-10-20 17:13:53.833 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording, 2006-10-20 17:13:53.833 DVBChan(0): Opening DVB channel 2006-10-20 17:13:53.833 DVBChan(0): Using DVB card 0, with frontend 'DST DVB-C'. 2006-10-20 17:13:54.059 DVB#0 CA: CI handler successfully initialized! 2006-10-20 17:13:54.061 DVB#0 CA: CI handler thread running 2006-10-20 17:13:54.122 ChannelBase(3): Input #3: 'DVBInput' schan(4) sourceid(2) ccid(3) 2006-10-20 17:13:54.122 ChannelBase(3): Current Input #3: 'DVBInput' 2006-10-20 17:13:54.122 DVBChan(0): SetChannelByString(4): 2006-10-20 17:13:54.126 DVBChan(0): Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:13:54.126 DVBChan(0): Old Params: Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto DVBChan(0): New Params: Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:13:54.126 DVBChan(0): Tune(): Tuning to 802000000Hz Debug: 159 128 49 2 5 0 0 1 5 0 171 255 255 255 255 255 255 255 255 255 2006-10-20 17:13:54.490 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-20 17:13:54.490 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-20 17:13:54.490 DVBChan(0): SetChannelByString(4): Tuned to frequency. 2006-10-20 17:13:54.490 TVRec(3): CreateLiveTVRingBuffer() 2006-10-20 17:13:54.490 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-20 17:13:54.657 TVRec(3): StartedRecording(0x8cd2698) fn(/recordings/2550_20061020171354.mpg) 2006-10-20 17:13:54.677 Chain: Appended@0 '2550_20061020171354' 2006-10-20 17:13:54.689 TVRec(3): Starting Signal Monitor 2006-10-20 17:13:54.690 TVRec(3): SetupSignalMonitor(1, 1) 2006-10-20 17:13:54.690 DVBChan(0): Opening DVB channel 2006-10-20 17:13:54.854 DVBSignalMonitor(0)::constructor(3,Warning, can not measure Bit Error Rate): Operation not supported 2006-10-20 17:13:54.854 DVBSignalMonitor(0)::constructor(3,Warning, can not count Uncorrected Blocks): Operation not supported 2006-10-20 17:13:54.854 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2006-10-20 17:13:54.854 DVBSM(0)::constructor(): initial flags 0x1400000 2006-10-20 17:13:54.854 TVRec(3): Signal monitor successfully created 2006-10-20 17:13:54.854 TVRec(3): Setting up table monitoring. 2006-10-20 17:13:54.854 DEBUG net_id 0 tsid 0 2006-10-20 17:13:54.898 Using profile 'Live TV' to record 2006-10-20 17:13:54.898 TVRec(3): DVB service_id 420 on net_id 0 tsid 0 2006-10-20 17:13:54.899 DTVSM(0)::SetDVBService(transport_id: 0, network_id: 0, service_id: 420): 2006-10-20 17:13:54.899 SM(0)::RemoveFlags: Seen(PMT,SDT,) Match(PMT,SDT,) Wait() 2006-10-20 17:13:54.899 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:13:54.899 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:13:54.899 SM(0)::AddFlags: Seen() Match() Wait() 2006-10-20 17:13:54.899 TVRec(3): Successfully set up DVB table monitoring. 2006-10-20 17:13:54.900 SM(0)::Start: begin 2006-10-20 17:13:54.900 DVBSM(0)::UpdateValues: Signal Locked 2006-10-20 17:13:54.900 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-10-20 17:13:54.901 SM(0)::Start: end 2006-10-20 17:13:54.901 TVRec(3): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2006-10-20 17:13:54.901 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2006-10-20 17:13:54.901 TVRec(3): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning, 2006-10-20 17:13:54.901 TVRec(3): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2006-10-20 17:13:54.901 DummyDTVRecorder -- started 2006-10-20 17:13:54.901 TVRec(3): SetFlags(RingBufferReady,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:13:54.901 TVRec(3): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:13:54.901 TVRec(3): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:13:54.902 TVRec(3): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:13:54.902 DVBSM(0)::UpdateValues: Table monitor started 2006-10-20 17:13:54.902 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-10-20 17:13:54.903 DVBSM(0)::AddPIDFilter(0x0): 2006-10-20 17:13:54.904 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-20 17:13:54.911 DVBSM(0): RunTableMonitorTS(): begin (# of pids 3) 2006-10-20 17:13:54.911 DVBSM(0)::AddPIDFilter(0x0): 2006-10-20 17:13:54.911 DVBSM(0)::AddPIDFilter(0x10): 2006-10-20 17:13:54.911 DVBSM(0)::AddPIDFilter(0x11): 2006-10-20 17:13:54.982 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:13:54.986 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-10-20 17:13:54.986 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-10-20 17:13:54.986 CreatePATSingleProgram() 2006-10-20 17:13:54.986 PAT in input stream 2006-10-20 17:13:54.986 Program Association Table PSIP tableID(0x0) length(49) extension(0x44c) version(4) current(1) section(0) last_section(0) tsid: 1100 programCount: 10 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16 program number 410 has PID 0x 1a3 data 0x1 0x154 0x225 0x163 program number 430 has PID 0x 101 data 0x1 0x174 0x225 0x1 program number 928 has PID 0x 22 data 0x3 0x160 0x224 0x34 program number 420 has PID 0x 10a data 0x1 0x164 0x225 0x10 program number 1900 has PID 0x 105 data 0x7 0x108 0x225 0x5 program number 440 has PID 0x 20 data 0x1 0x184 0x224 0x32 program number 460 has PID 0x 1d1 data 0x1 0x204 0x225 0x209 program number 470 has PID 0x1b94 data 0x1 0x214 0x251 0x148 program number 920 has PID 0x 21 data 0x3 0x152 0x224 0x33 2006-10-20 17:13:54.986 desired_program(420) pid(0x10a) 2006-10-20 17:13:54.986 pmt_pid(0x10a) 2006-10-20 17:13:54.986 PAT for output stream 2006-10-20 17:13:54.986 Program Association Table PSIP tableID(0x0) length(13) extension(0x44c) version(4) current(1) section(0) last_section(0) tsid: 1100 programCount: 1 program number 1 has PID 0x 10a data 0x0 0x1 0x225 0x10 2006-10-20 17:13:54.987 DVBSM(0)::AddPIDFilter(0x10a): 2006-10-20 17:13:55.093 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:13:55.093 SM(0)::AddFlags: Seen() Match(PMT,) Wait() 2006-10-20 17:13:55.093 CreatePMTSingleProgram() 2006-10-20 17:13:55.093 PMT in input stream 2006-10-20 17:13:55.093 Program Map Table ver(8) pid(0x10a) pnum(420) len(69) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Conditional Access: sid(0x500) pid(0x2f) data_size(11) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) Conditional Access: sid(0x500) pid(0x2f) data_size(11) Stream #2 pid(0x1a6) type(private-data 0x6) Teletext Descriptor (0x56) length(5) 2006-10-20 17:13:55.093 PMT for output stream 2006-10-20 17:13:55.093 Program Map Table ver(8) pid(0x10a) pnum(1) len(23) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) 2006-10-20 17:13:55.125 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1) 2006-10-20 17:13:55.540 TVRec(3): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:13:55.993 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:13:57.001 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:13:58.017 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:13:58.310 mythbackend: Running housekeeping thread 2006-10-20 17:13:58.381 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:13:58.381 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:13:58.485 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:13:58.485 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:13:59.020 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:00.025 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:01.025 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:02.029 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:02.981 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:03.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:04.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:05.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:06.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:07.997 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:09.002 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:10.002 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:10.998 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:11.994 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:12.093 ChannelBase(3): Failed to find channel() on current input (DVBInput) of card (3). 2006-10-20 17:14:12.094 ChannelBase(3): Failed to find channel() on any input of card (3). 2006-10-20 17:14:12.105 TVRec(3): PauseRecorder() called with no recorder 2006-10-20 17:14:12.107 TVRec(3): SetChannel() -- begin 2006-10-20 17:14:12.107 TVRec(3): ClearFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning, 2006-10-20 17:14:12.107 TVRec(3): Request: Program(no) channel(103) input() flags(LiveTV,) 2006-10-20 17:14:12.108 TVRec(3): TeardownSignalMonitor() -- begin 2006-10-20 17:14:12.109 DVBSM(0)::Stop: begin 2006-10-20 17:14:12.109 SM(0)::Stop: begin 2006-10-20 17:14:12.142 SM(0)::Stop: end 2006-10-20 17:14:12.150 DVBSM(0): RunTableMonitorTS(): shutdown 2006-10-20 17:14:12.150 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-20 17:14:12.150 DVBSM(0)::RemovePIDFilter(0x10): 2006-10-20 17:14:12.150 DVBSM(0)::RemovePIDFilter(0x11): 2006-10-20 17:14:12.150 DVBSM(0)::RemovePIDFilter(0x10a): 2006-10-20 17:14:12.151 DVBSM(0): RunTableMonitorTS(): end 2006-10-20 17:14:12.151 DVBSM(0)::Stop: end 2006-10-20 17:14:12.151 TVRec(3): TeardownSignalMonitor() -- end 2006-10-20 17:14:12.151 TVRec(3): ClearFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning, 2006-10-20 17:14:12.152 TVRec(3): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning, 2006-10-20 17:14:12.152 TVRec(3): ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,DummyRecorderRunning, 2006-10-20 17:14:12.152 DVBChan(0): Opening DVB channel 2006-10-20 17:14:12.152 DVBChan(0): SetChannelByString(103): 2006-10-20 17:14:12.156 DVBChan(0): Frequency: 762000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:14:12.156 DVBChan(0): Old Params: Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto DVBChan(0): New Params: Frequency: 762000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:14:12.157 DVBChan(0): Tune(): Tuning to 762000000Hz 2006-10-20 17:14:12.907 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-20 17:14:12.907 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-20 17:14:12.907 DVBChan(0): SetChannelByString(103): Tuned to frequency. 2006-10-20 17:14:12.907 TVRec(3): SwitchLiveTVRingBuffer(discont 1, set_rec 0) 2006-10-20 17:14:12.907 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-20 17:14:12.948 TVRec(3): StartedRecording(0x8ceb790) fn(/recordings/2612_20061020171412.mpg) 2006-10-20 17:14:13.033 TVRec(3): FinishedRecording(Alias) in recgroup: LiveTV 2006-10-20 17:14:13.034 Chain: Updated endtime for '2550_20061020171354' to 20061020171413 2006-10-20 17:14:13.050 Finished recording Alias: channel 2550 2006-10-20 17:14:13.054 scheduler: Finished recording: Alias: channel 2550 2006-10-20 17:14:13.055 Preview: 'myth://192.168.1.11:6543/2550_20061020171354.mpg' is not local, replacing with '/recordings/2550_20061020171354.mpg', which is local. 2006-10-20 17:14:13.060 Chain: Appended@1 '2612_20061020171412' 2006-10-20 17:14:13.063 TVRec(3): ClearFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording, 2006-10-20 17:14:13.064 TVRec(3): Starting Signal Monitor 2006-10-20 17:14:13.064 TVRec(3): SetupSignalMonitor(1, 1) 2006-10-20 17:14:13.064 DVBChan(0): Opening DVB channel 2006-10-20 17:14:13.071 Preview Error: Previewer file '/recordings/2550_20061020171354.mpg' is not valid. 2006-10-20 17:14:13.235 DVBSignalMonitor(0)::constructor(3,Warning, can not measure Bit Error Rate): Operation not supported 2006-10-20 17:14:13.235 DVBSignalMonitor(0)::constructor(3,Warning, can not count Uncorrected Blocks): Operation not supported 2006-10-20 17:14:13.235 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2006-10-20 17:14:13.235 DVBSM(0)::constructor(): initial flags 0x1400000 2006-10-20 17:14:13.235 TVRec(3): Signal monitor successfully created 2006-10-20 17:14:13.235 TVRec(3): Setting up table monitoring. 2006-10-20 17:14:13.235 DEBUG net_id 0 tsid 0 2006-10-20 17:14:13.243 Using profile 'Live TV' to record 2006-10-20 17:14:13.243 TVRec(3): DVB service_id 921 on net_id 0 tsid 0 2006-10-20 17:14:13.244 DTVSM(0)::SetDVBService(transport_id: 0, network_id: 0, service_id: 921): 2006-10-20 17:14:13.244 SM(0)::RemoveFlags: Seen(PMT,SDT,) Match(PMT,SDT,) Wait() 2006-10-20 17:14:13.244 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:14:13.244 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:14:13.244 SM(0)::AddFlags: Seen() Match() Wait() 2006-10-20 17:14:13.244 TVRec(3): Successfully set up DVB table monitoring. 2006-10-20 17:14:13.244 SM(0)::Start: begin 2006-10-20 17:14:13.245 DVBSM(0)::UpdateValues: Signal Locked 2006-10-20 17:14:13.245 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-10-20 17:14:13.246 SM(0)::Start: end 2006-10-20 17:14:13.246 TVRec(3): SetFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SignalMonitorRunning, 2006-10-20 17:14:13.246 TVRec(3): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SignalMonitorRunning, 2006-10-20 17:14:13.246 TVRec(3): SetFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning, 2006-10-20 17:14:13.246 TVRec(3): SetFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2006-10-20 17:14:13.246 DummyDTVRecorder -- started 2006-10-20 17:14:13.246 TVRec(3): SetFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:13.246 TVRec(3): ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:13.246 TVRec(3): SetFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:13.247 TVRec(3): SetChannel() -- end 2006-10-20 17:14:13.247 DVBSM(0)::UpdateValues: Table monitor started 2006-10-20 17:14:13.247 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-10-20 17:14:13.255 DVBSM(0): RunTableMonitorTS(): begin (# of pids 3) 2006-10-20 17:14:13.255 DVBSM(0)::AddPIDFilter(0x0): 2006-10-20 17:14:13.256 DVBSM(0)::AddPIDFilter(0x10): 2006-10-20 17:14:13.256 DVBSM(0)::AddPIDFilter(0x11): 2006-10-20 17:14:13.284 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-10-20 17:14:13.284 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-10-20 17:14:13.284 CreatePATSingleProgram() 2006-10-20 17:14:13.284 PAT in input stream 2006-10-20 17:14:13.284 Program Association Table PSIP tableID(0x0) length(161) extension(0x410) version(4) current(1) section(0) last_section(0) tsid: 1040 programCount: 38 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16 program number 310 has PID 0x 101 data 0x1 0x54 0x225 0x1 program number 340 has PID 0x 159 data 0x1 0x84 0x225 0x89 program number 902 has PID 0x 21 data 0x3 0x134 0x224 0x33 program number 903 has PID 0x 21 data 0x3 0x135 0x224 0x33 program number 904 has PID 0x 21 data 0x3 0x136 0x224 0x33 program number 905 has PID 0x 20 data 0x3 0x137 0x224 0x32 program number 906 has PID 0x 26 data 0x3 0x138 0x224 0x38 program number 907 has PID 0x 101 data 0x3 0x139 0x225 0x1 program number 910 has PID 0x 22 data 0x3 0x142 0x224 0x34 program number 911 has PID 0x 101 data 0x3 0x143 0x225 0x1 program number 912 has PID 0x 23 data 0x3 0x144 0x224 0x35 program number 913 has PID 0x 23 data 0x3 0x145 0x224 0x35 program number 914 has PID 0x 23 data 0x3 0x146 0x224 0x35 program number 916 has PID 0x 20 data 0x3 0x148 0x224 0x32 program number 917 has PID 0x 20 data 0x3 0x149 0x224 0x32 program number 918 has PID 0x 20 data 0x3 0x150 0x224 0x32 program number 919 has PID 0x 101 data 0x3 0x151 0x225 0x1 program number 921 has PID 0x 20 data 0x3 0x153 0x224 0x32 program number 922 has PID 0x 101 data 0x3 0x154 0x225 0x1 program number 923 has PID 0x 101 data 0x3 0x155 0x225 0x1 program number 925 has PID 0x 101 data 0x3 0x157 0x225 0x1 program number 926 has PID 0x 20 data 0x3 0x158 0x224 0x32 program number 927 has PID 0x 101 data 0x3 0x159 0x225 0x1 program number 930 has PID 0x 21 data 0x3 0x162 0x224 0x33 program number 931 has PID 0x 21 data 0x3 0x163 0x224 0x33 program number 932 has PID 0x 21 data 0x3 0x164 0x224 0x33 program number 933 has PID 0x 21 data 0x3 0x165 0x224 0x33 program number 934 has PID 0x 21 data 0x3 0x166 0x224 0x33 program number 935 has PID 0x 21 data 0x3 0x167 0x224 0x33 program number 936 has PID 0x 21 data 0x3 0x168 0x224 0x33 program number 975 has PID 0x 20 data 0x3 0x207 0x224 0x32 program number 976 has PID 0x 101 data 0x3 0x208 0x225 0x1 program number 330 has PID 0x 102 data 0x1 0x74 0x225 0x2 program number 350 has PID 0x1888 data 0x1 0x94 0x248 0x136 program number 360 has PID 0x 852 data 0x1 0x104 0x232 0x82 program number 320 has PID 0x 24 data 0x1 0x64 0x224 0x36 program number 901 has PID 0x 25 data 0x3 0x133 0x224 0x37 2006-10-20 17:14:13.285 desired_program(921) pid(0x20) 2006-10-20 17:14:13.285 pmt_pid(0x20) 2006-10-20 17:14:13.285 PAT for output stream 2006-10-20 17:14:13.285 Program Association Table PSIP tableID(0x0) length(13) extension(0x410) version(4) current(1) section(0) last_section(0) tsid: 1040 programCount: 1 program number 1 has PID 0x 20 data 0x0 0x1 0x224 0x32 2006-10-20 17:14:13.285 DVBSM(0)::AddPIDFilter(0x20): 2006-10-20 17:14:13.292 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.292 DTVSM(0) Error: Wrong PMT; pmt->pn(975) desired(921) 2006-10-20 17:14:13.296 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.296 DTVSM(0) Error: Wrong PMT; pmt->pn(926) desired(921) 2006-10-20 17:14:13.298 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.298 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(0) 2006-10-20 17:14:13.298 SM(0)::AddFlags: Seen() Match(PMT,) Wait() 2006-10-20 17:14:13.299 CreatePMTSingleProgram() 2006-10-20 17:14:13.299 PMT in input stream 2006-10-20 17:14:13.299 Program Map Table ver(1) pid(0x20) pnum(921) len(18) Stream #0 pid(0x399) type(audio-mp2-layer[1,2,3] 0x4) 2006-10-20 17:14:13.299 PMT for output stream 2006-10-20 17:14:13.299 Program Map Table ver(1) pid(0x20) pnum(1) len(18) Stream #0 pid(0x399) type(audio-mp2-layer[1,2,3] 0x4) 2006-10-20 17:14:13.299 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.299 DTVSM(0) Error: Wrong PMT; pmt->pn(918) desired(921) 2006-10-20 17:14:13.299 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.299 DTVSM(0) Error: Wrong PMT; pmt->pn(917) desired(921) 2006-10-20 17:14:13.299 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.299 DTVSM(0) Error: Wrong PMT; pmt->pn(916) desired(921) 2006-10-20 17:14:13.300 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:14:13.300 DTVSM(0) Error: Wrong PMT; pmt->pn(905) desired(921) 2006-10-20 17:14:13.350 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1) 2006-10-20 17:14:13.628 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:14.198 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:14.622 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:14.882 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:14:14.882 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:14:15.090 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:14:15.090 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:14:15.194 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:15.618 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:16.190 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:16.622 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:17.194 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:17.618 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:18.190 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:18.618 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:19.190 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:14:19.301 StopLiveTV(void) curRec: 0x8ceb790 pseudoRec: 0 2006-10-20 17:14:19.305 TVRec(3): Changing from WatchingLiveTV to None 2006-10-20 17:14:19.305 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:19.305 TVRec(3): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:19.305 TVRec(3): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2006-10-20 17:14:19.305 TVRec(3): TeardownSignalMonitor() -- begin 2006-10-20 17:14:19.305 DVBSM(0)::Stop: begin 2006-10-20 17:14:19.305 SM(0)::Stop: begin 2006-10-20 17:14:19.323 SM(0)::Stop: end 2006-10-20 17:14:19.346 DVBSM(0): RunTableMonitorTS(): shutdown 2006-10-20 17:14:19.346 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-20 17:14:19.346 DVBSM(0)::RemovePIDFilter(0x10): 2006-10-20 17:14:19.346 DVBSM(0)::RemovePIDFilter(0x11): 2006-10-20 17:14:19.346 DVBSM(0)::RemovePIDFilter(0x20): 2006-10-20 17:14:19.347 DVBSM(0): RunTableMonitorTS(): end 2006-10-20 17:14:19.348 DVBSM(0)::Stop: end 2006-10-20 17:14:19.348 TVRec(3): TeardownSignalMonitor() -- end 2006-10-20 17:14:19.348 TVRec(3): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:19.348 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:14:19.348 TVRec(3): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady, 2006-10-20 17:14:19.351 TVRec(3): FinishedRecording(Sara Cox) in recgroup: LiveTV 2006-10-20 17:14:19.352 Chain: Updated endtime for '2612_20061020171412' to 20061020171419 2006-10-20 17:14:19.354 Finished recording Sara Cox: channel 2612 2006-10-20 17:14:19.359 scheduler: Finished recording: Sara Cox: channel 2612 2006-10-20 17:14:19.359 DVBChan(0): Closing DVB channel 2006-10-20 17:14:19.362 DVB#0 CA: CiHandler thread stopped 2006-10-20 17:14:19.362 TVRec(3): Tearing down RingBuffer 2006-10-20 17:14:19.363 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2006-10-20 17:15:03.868 Getting next free recorder after : -1 2006-10-20 17:15:03.870 Checking card 3. Best card so far 3 2006-10-20 17:15:03.870 Checking card 4. Best card so far 3 2006-10-20 17:15:03.876 MainServer::HandleAnnounce Playback 2006-10-20 17:15:03.877 adding: el-duce as a client (events: 0) 2006-10-20 17:15:03.879 TVRec(3): Changing from None to WatchingLiveTV 2006-10-20 17:15:03.879 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2006-10-20 17:15:03.879 TVRec(3): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2006-10-20 17:15:03.879 TVRec(3): Request: Program(no) channel() input() flags(LiveTV,) 2006-10-20 17:15:03.880 TVRec(3): HW Tuner: 3->3 2006-10-20 17:15:03.880 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady, 2006-10-20 17:15:03.880 DVBChan(0): Opening DVB channel 2006-10-20 17:15:03.881 DVBChan(0): Using DVB card 0, with frontend 'DST DVB-C'. 2006-10-20 17:15:04.107 DVB#0 CA: CI handler successfully initialized! 2006-10-20 17:15:04.110 DVB#0 CA: CI handler thread running 2006-10-20 17:15:04.163 ChannelBase(3): Input #3: 'DVBInput' schan(4) sourceid(2) ccid(3) 2006-10-20 17:15:04.164 ChannelBase(3): Current Input #3: 'DVBInput' 2006-10-20 17:15:04.164 DVBChan(0): SetChannelByString(4): 2006-10-20 17:15:04.168 DVBChan(0): Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:15:04.168 DVBChan(0): Old Params: Frequency: 762000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto DVBChan(0): New Params: Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:15:04.168 DVBChan(0): Tune(): Tuning to 802000000Hz Debug: 159 128 49 2 5 0 0 1 5 0 171 255 255 255 255 255 255 255 255 255 2006-10-20 17:15:05.131 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-20 17:15:05.131 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-20 17:15:05.131 DVBChan(0): SetChannelByString(4): Tuned to frequency. 2006-10-20 17:15:05.131 TVRec(3): CreateLiveTVRingBuffer() 2006-10-20 17:15:05.131 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-20 17:15:05.191 TVRec(3): StartedRecording(0x8d02f38) fn(/recordings/2550_20061020171505.mpg) 2006-10-20 17:15:05.199 Chain: Appended@0 '2550_20061020171505' 2006-10-20 17:15:05.204 TVRec(3): Starting Signal Monitor 2006-10-20 17:15:05.204 TVRec(3): SetupSignalMonitor(1, 1) 2006-10-20 17:15:05.204 DVBChan(0): Opening DVB channel 2006-10-20 17:15:05.366 DVBSignalMonitor(0)::constructor(3,Warning, can not measure Bit Error Rate): Operation not supported 2006-10-20 17:15:05.366 DVBSignalMonitor(0)::constructor(3,Warning, can not count Uncorrected Blocks): Operation not supported 2006-10-20 17:15:05.366 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2006-10-20 17:15:05.366 DVBSM(0)::constructor(): initial flags 0x1400000 2006-10-20 17:15:05.366 TVRec(3): Signal monitor successfully created 2006-10-20 17:15:05.367 TVRec(3): Setting up table monitoring. 2006-10-20 17:15:05.367 DEBUG net_id 0 tsid 0 2006-10-20 17:15:05.374 Using profile 'Live TV' to record 2006-10-20 17:15:05.374 TVRec(3): DVB service_id 420 on net_id 0 tsid 0 2006-10-20 17:15:05.375 DTVSM(0)::SetDVBService(transport_id: 0, network_id: 0, service_id: 420): 2006-10-20 17:15:05.375 SM(0)::RemoveFlags: Seen(PMT,SDT,) Match(PMT,SDT,) Wait() 2006-10-20 17:15:05.375 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:15:05.375 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:15:05.375 SM(0)::AddFlags: Seen() Match() Wait() 2006-10-20 17:15:05.375 TVRec(3): Successfully set up DVB table monitoring. 2006-10-20 17:15:05.375 SM(0)::Start: begin 2006-10-20 17:15:05.376 DVBSM(0)::UpdateValues: Signal Locked 2006-10-20 17:15:05.376 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-10-20 17:15:05.377 SM(0)::Start: end 2006-10-20 17:15:05.377 TVRec(3): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,RingBufferReady, 2006-10-20 17:15:05.377 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning,RingBufferReady, 2006-10-20 17:15:05.377 TVRec(3): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,RingBufferReady, 2006-10-20 17:15:05.377 TVRec(3): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:05.377 DummyDTVRecorder -- started 2006-10-20 17:15:05.377 TVRec(3): SetFlags(RingBufferReady,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:05.377 TVRec(3): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:05.378 TVRec(3): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:05.378 TVRec(3): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:05.378 DVBSM(0)::UpdateValues: Table monitor started 2006-10-20 17:15:05.378 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-10-20 17:15:05.386 DVBSM(0): RunTableMonitorTS(): begin (# of pids 3) 2006-10-20 17:15:05.386 DVBSM(0)::AddPIDFilter(0x0): 2006-10-20 17:15:05.386 DVBSM(0)::AddPIDFilter(0x10): 2006-10-20 17:15:05.387 DVBSM(0)::AddPIDFilter(0x11): 2006-10-20 17:15:05.440 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-10-20 17:15:05.440 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-10-20 17:15:05.440 CreatePATSingleProgram() 2006-10-20 17:15:05.440 PAT in input stream 2006-10-20 17:15:05.440 Program Association Table PSIP tableID(0x0) length(49) extension(0x44c) version(4) current(1) section(0) last_section(0) tsid: 1100 programCount: 10 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16 program number 410 has PID 0x 1a3 data 0x1 0x154 0x225 0x163 program number 430 has PID 0x 101 data 0x1 0x174 0x225 0x1 program number 928 has PID 0x 22 data 0x3 0x160 0x224 0x34 program number 420 has PID 0x 10a data 0x1 0x164 0x225 0x10 program number 1900 has PID 0x 105 data 0x7 0x108 0x225 0x5 program number 440 has PID 0x 20 data 0x1 0x184 0x224 0x32 program number 460 has PID 0x 1d1 data 0x1 0x204 0x225 0x209 program number 470 has PID 0x1b94 data 0x1 0x214 0x251 0x148 program number 920 has PID 0x 21 data 0x3 0x152 0x224 0x33 2006-10-20 17:15:05.441 desired_program(420) pid(0x10a) 2006-10-20 17:15:05.441 pmt_pid(0x10a) 2006-10-20 17:15:05.441 PAT for output stream 2006-10-20 17:15:05.441 Program Association Table PSIP tableID(0x0) length(13) extension(0x44c) version(4) current(1) section(0) last_section(0) tsid: 1100 programCount: 1 program number 1 has PID 0x 10a data 0x0 0x1 0x225 0x10 2006-10-20 17:15:05.441 DVBSM(0)::AddPIDFilter(0x10a): 2006-10-20 17:15:05.549 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:05.549 SM(0)::AddFlags: Seen() Match(PMT,) Wait() 2006-10-20 17:15:05.549 CreatePMTSingleProgram() 2006-10-20 17:15:05.549 PMT in input stream 2006-10-20 17:15:05.549 Program Map Table ver(8) pid(0x10a) pnum(420) len(69) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Conditional Access: sid(0x500) pid(0x2f) data_size(11) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) Conditional Access: sid(0x500) pid(0x2f) data_size(11) Stream #2 pid(0x1a6) type(private-data 0x6) Teletext Descriptor (0x56) length(5) 2006-10-20 17:15:05.550 PMT for output stream 2006-10-20 17:15:05.550 Program Map Table ver(8) pid(0x10a) pnum(1) len(23) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) 2006-10-20 17:15:05.585 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1) 2006-10-20 17:15:05.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:06.058 TVRec(3): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:06.937 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:07.985 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:08.357 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:15:08.357 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:15:08.465 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:15:08.465 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:15:08.985 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:09.383 AutoExpire: ERROR when trying to autoexpire file: /recordings/2576_20061017140500.mpg. File doesn't exist. Database metadata will not be removed. 2006-10-20 17:15:09.388 mythbackend: Autoexpire Recording: ERROR when trying to autoexpire file: /recordings/2576_20061017140500.mpg. File doesn't exist. Database metadata will not be removed. 2006-10-20 17:15:09.388 AutoExpire: ERROR when trying to autoexpire file: /recordings/2576_20061017150000.mpg. File doesn't exist. Database metadata will not be removed. 2006-10-20 17:15:09.392 mythbackend: Autoexpire Recording: ERROR when trying to autoexpire file: /recordings/2576_20061017150000.mpg. File doesn't exist. Database metadata will not be removed. 2006-10-20 17:15:09.393 AutoExpire: ERROR when trying to autoexpire file: /recordings/2685_20061017155357.mpg. File doesn't exist. Database metadata will not be removed. 2006-10-20 17:15:09.397 mythbackend: Autoexpire Recording: ERROR when trying to autoexpire file: /recordings/2685_20061017155357.mpg. File doesn't exist. Database metadata will not be removed. 2006-10-20 17:15:09.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:10.985 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:11.989 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:12.986 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:13.571 ChannelBase(3): Failed to find channel() on current input (DVBInput) of card (3). 2006-10-20 17:15:13.572 ChannelBase(3): Failed to find channel() on any input of card (3). 2006-10-20 17:15:13.584 TVRec(3): PauseRecorder() called with no recorder 2006-10-20 17:15:13.584 TVRec(3): SetChannel() -- begin 2006-10-20 17:15:13.585 TVRec(3): ClearFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning, 2006-10-20 17:15:13.585 TVRec(3): Request: Program(no) channel(103) input() flags(LiveTV,) 2006-10-20 17:15:13.586 TVRec(3): TeardownSignalMonitor() -- begin 2006-10-20 17:15:13.586 DVBSM(0)::Stop: begin 2006-10-20 17:15:13.586 SM(0)::Stop: begin 2006-10-20 17:15:13.630 SM(0)::Stop: end 2006-10-20 17:15:13.673 DVBSM(0): RunTableMonitorTS(): shutdown 2006-10-20 17:15:13.674 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-20 17:15:13.674 DVBSM(0)::RemovePIDFilter(0x10): 2006-10-20 17:15:13.674 DVBSM(0)::RemovePIDFilter(0x11): 2006-10-20 17:15:13.674 DVBSM(0)::RemovePIDFilter(0x10a): 2006-10-20 17:15:13.675 DVBSM(0): RunTableMonitorTS(): end 2006-10-20 17:15:13.675 DVBSM(0)::Stop: end 2006-10-20 17:15:13.675 TVRec(3): TeardownSignalMonitor() -- end 2006-10-20 17:15:13.675 TVRec(3): ClearFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning, 2006-10-20 17:15:13.675 TVRec(3): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning, 2006-10-20 17:15:13.675 TVRec(3): ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,DummyRecorderRunning, 2006-10-20 17:15:13.676 DVBChan(0): Opening DVB channel 2006-10-20 17:15:13.676 DVBChan(0): SetChannelByString(103): 2006-10-20 17:15:13.680 DVBChan(0): Frequency: 762000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:15:13.680 DVBChan(0): Old Params: Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto DVBChan(0): New Params: Frequency: 762000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-20 17:15:13.680 DVBChan(0): Tune(): Tuning to 762000000Hz 2006-10-20 17:15:14.431 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-20 17:15:14.431 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-20 17:15:14.431 DVBChan(0): SetChannelByString(103): Tuned to frequency. 2006-10-20 17:15:14.431 TVRec(3): SwitchLiveTVRingBuffer(discont 1, set_rec 0) 2006-10-20 17:15:14.431 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-20 17:15:14.455 TVRec(3): StartedRecording(0x8d4a008) fn(/recordings/2612_20061020171514.mpg) 2006-10-20 17:15:14.494 TVRec(3): FinishedRecording(Alias) in recgroup: LiveTV 2006-10-20 17:15:14.495 Chain: Updated endtime for '2550_20061020171505' to 20061020171514 2006-10-20 17:15:14.529 Finished recording Alias: channel 2550 2006-10-20 17:15:14.534 scheduler: Finished recording: Alias: channel 2550 2006-10-20 17:15:14.534 Preview: 'myth://192.168.1.11:6543/2550_20061020171505.mpg' is not local, replacing with '/recordings/2550_20061020171505.mpg', which is local. 2006-10-20 17:15:14.539 Chain: Appended@1 '2612_20061020171514' 2006-10-20 17:15:14.542 TVRec(3): ClearFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording, 2006-10-20 17:15:14.543 TVRec(3): Starting Signal Monitor 2006-10-20 17:15:14.543 TVRec(3): SetupSignalMonitor(1, 1) 2006-10-20 17:15:14.543 DVBChan(0): Opening DVB channel 2006-10-20 17:15:14.552 Preview Error: Previewer file '/recordings/2550_20061020171505.mpg' is not valid. 2006-10-20 17:15:14.707 DVBSignalMonitor(0)::constructor(3,Warning, can not measure Bit Error Rate): Operation not supported 2006-10-20 17:15:14.707 DVBSignalMonitor(0)::constructor(3,Warning, can not count Uncorrected Blocks): Operation not supported 2006-10-20 17:15:14.707 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2006-10-20 17:15:14.707 DVBSM(0)::constructor(): initial flags 0x1400000 2006-10-20 17:15:14.707 TVRec(3): Signal monitor successfully created 2006-10-20 17:15:14.707 TVRec(3): Setting up table monitoring. 2006-10-20 17:15:14.707 DEBUG net_id 0 tsid 0 2006-10-20 17:15:14.714 Using profile 'Live TV' to record 2006-10-20 17:15:14.715 TVRec(3): DVB service_id 921 on net_id 0 tsid 0 2006-10-20 17:15:14.716 DTVSM(0)::SetDVBService(transport_id: 0, network_id: 0, service_id: 921): 2006-10-20 17:15:14.716 SM(0)::RemoveFlags: Seen(PMT,SDT,) Match(PMT,SDT,) Wait() 2006-10-20 17:15:14.716 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:15:14.716 SM(0)::AddFlags: Seen() Match() Wait(PMT,SDT,) 2006-10-20 17:15:14.716 SM(0)::AddFlags: Seen() Match() Wait() 2006-10-20 17:15:14.716 TVRec(3): Successfully set up DVB table monitoring. 2006-10-20 17:15:14.716 SM(0)::Start: begin 2006-10-20 17:15:14.716 DVBSM(0)::UpdateValues: Signal Locked 2006-10-20 17:15:14.716 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-10-20 17:15:14.718 SM(0)::Start: end 2006-10-20 17:15:14.718 TVRec(3): SetFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SignalMonitorRunning, 2006-10-20 17:15:14.718 TVRec(3): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SignalMonitorRunning, 2006-10-20 17:15:14.718 TVRec(3): SetFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning, 2006-10-20 17:15:14.718 TVRec(3): SetFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2006-10-20 17:15:14.718 DummyDTVRecorder -- started 2006-10-20 17:15:14.718 TVRec(3): SetFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:14.718 TVRec(3): ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:14.718 TVRec(3): SetFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:14.718 TVRec(3): SetChannel() -- end 2006-10-20 17:15:14.718 DVBSM(0)::UpdateValues: Table monitor started 2006-10-20 17:15:14.719 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-10-20 17:15:14.728 DVBSM(0): RunTableMonitorTS(): begin (# of pids 3) 2006-10-20 17:15:14.728 DVBSM(0)::AddPIDFilter(0x0): 2006-10-20 17:15:14.728 DVBSM(0)::AddPIDFilter(0x10): 2006-10-20 17:15:14.728 DVBSM(0)::AddPIDFilter(0x11): 2006-10-20 17:15:14.759 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-10-20 17:15:14.759 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-10-20 17:15:14.760 CreatePATSingleProgram() 2006-10-20 17:15:14.760 PAT in input stream 2006-10-20 17:15:14.760 Program Association Table PSIP tableID(0x0) length(161) extension(0x410) version(4) current(1) section(0) last_section(0) tsid: 1040 programCount: 38 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16 program number 310 has PID 0x 101 data 0x1 0x54 0x225 0x1 program number 340 has PID 0x 159 data 0x1 0x84 0x225 0x89 program number 902 has PID 0x 21 data 0x3 0x134 0x224 0x33 program number 903 has PID 0x 21 data 0x3 0x135 0x224 0x33 program number 904 has PID 0x 21 data 0x3 0x136 0x224 0x33 program number 905 has PID 0x 20 data 0x3 0x137 0x224 0x32 program number 906 has PID 0x 26 data 0x3 0x138 0x224 0x38 program number 907 has PID 0x 101 data 0x3 0x139 0x225 0x1 program number 910 has PID 0x 22 data 0x3 0x142 0x224 0x34 program number 911 has PID 0x 101 data 0x3 0x143 0x225 0x1 program number 912 has PID 0x 23 data 0x3 0x144 0x224 0x35 program number 913 has PID 0x 23 data 0x3 0x145 0x224 0x35 program number 914 has PID 0x 23 data 0x3 0x146 0x224 0x35 program number 916 has PID 0x 20 data 0x3 0x148 0x224 0x32 program number 917 has PID 0x 20 data 0x3 0x149 0x224 0x32 program number 918 has PID 0x 20 data 0x3 0x150 0x224 0x32 program number 919 has PID 0x 101 data 0x3 0x151 0x225 0x1 program number 921 has PID 0x 20 data 0x3 0x153 0x224 0x32 program number 922 has PID 0x 101 data 0x3 0x154 0x225 0x1 program number 923 has PID 0x 101 data 0x3 0x155 0x225 0x1 program number 925 has PID 0x 101 data 0x3 0x157 0x225 0x1 program number 926 has PID 0x 20 data 0x3 0x158 0x224 0x32 program number 927 has PID 0x 101 data 0x3 0x159 0x225 0x1 program number 930 has PID 0x 21 data 0x3 0x162 0x224 0x33 program number 931 has PID 0x 21 data 0x3 0x163 0x224 0x33 program number 932 has PID 0x 21 data 0x3 0x164 0x224 0x33 program number 933 has PID 0x 21 data 0x3 0x165 0x224 0x33 program number 934 has PID 0x 21 data 0x3 0x166 0x224 0x33 program number 935 has PID 0x 21 data 0x3 0x167 0x224 0x33 program number 936 has PID 0x 21 data 0x3 0x168 0x224 0x33 program number 975 has PID 0x 20 data 0x3 0x207 0x224 0x32 program number 976 has PID 0x 101 data 0x3 0x208 0x225 0x1 program number 330 has PID 0x 102 data 0x1 0x74 0x225 0x2 program number 350 has PID 0x1888 data 0x1 0x94 0x248 0x136 program number 360 has PID 0x 852 data 0x1 0x104 0x232 0x82 program number 320 has PID 0x 24 data 0x1 0x64 0x224 0x36 program number 901 has PID 0x 25 data 0x3 0x133 0x224 0x37 2006-10-20 17:15:14.761 desired_program(921) pid(0x20) 2006-10-20 17:15:14.761 pmt_pid(0x20) 2006-10-20 17:15:14.761 PAT for output stream 2006-10-20 17:15:14.761 Program Association Table PSIP tableID(0x0) length(13) extension(0x410) version(4) current(1) section(0) last_section(0) tsid: 1040 programCount: 1 program number 1 has PID 0x 20 data 0x0 0x1 0x224 0x32 2006-10-20 17:15:14.761 DVBSM(0)::AddPIDFilter(0x20): 2006-10-20 17:15:14.770 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.770 DTVSM(0) Error: Wrong PMT; pmt->pn(975) desired(921) 2006-10-20 17:15:14.775 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.775 DTVSM(0) Error: Wrong PMT; pmt->pn(926) desired(921) 2006-10-20 17:15:14.775 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.775 SM(0)::AddFlags: Seen() Match(PMT,) Wait() 2006-10-20 17:15:14.775 CreatePMTSingleProgram() 2006-10-20 17:15:14.775 PMT in input stream 2006-10-20 17:15:14.775 Program Map Table ver(1) pid(0x20) pnum(921) len(18) Stream #0 pid(0x399) type(audio-mp2-layer[1,2,3] 0x4) 2006-10-20 17:15:14.775 PMT for output stream 2006-10-20 17:15:14.775 Program Map Table ver(1) pid(0x20) pnum(1) len(18) Stream #0 pid(0x399) type(audio-mp2-layer[1,2,3] 0x4) 2006-10-20 17:15:14.778 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.778 DTVSM(0) Error: Wrong PMT; pmt->pn(918) desired(921) 2006-10-20 17:15:14.778 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.779 DTVSM(0) Error: Wrong PMT; pmt->pn(917) desired(921) 2006-10-20 17:15:14.779 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.779 DTVSM(0) Error: Wrong PMT; pmt->pn(916) desired(921) 2006-10-20 17:15:14.779 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-20 17:15:14.779 DTVSM(0) Error: Wrong PMT; pmt->pn(905) desired(921) 2006-10-20 17:15:14.822 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1) 2006-10-20 17:15:14.837 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:15:14.837 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:15:15.078 DTVSM(0)::SetNIT(): net_id = 72 2006-10-20 17:15:15.078 SM(0)::AddFlags: Seen(NIT,) Match() Wait() 2006-10-20 17:15:15.182 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:15.546 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:16.178 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:16.594 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:17.174 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:17.590 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:18.174 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:18.590 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:19.166 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:19.582 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:20.154 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:20.574 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:21.146 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:21.566 SM(0)::AddFlags: Seen(SDT,) Match() Wait() 2006-10-20 17:15:21.766 StopLiveTV(void) curRec: 0x8d4a008 pseudoRec: 0 2006-10-20 17:15:21.775 TVRec(3): Changing from WatchingLiveTV to None 2006-10-20 17:15:21.775 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:21.775 TVRec(3): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:21.775 TVRec(3): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2006-10-20 17:15:21.775 TVRec(3): TeardownSignalMonitor() -- begin 2006-10-20 17:15:21.775 DVBSM(0)::Stop: begin 2006-10-20 17:15:21.775 SM(0)::Stop: begin 2006-10-20 17:15:21.827 SM(0)::Stop: end 2006-10-20 17:15:21.830 DVBSM(0): RunTableMonitorTS(): shutdown 2006-10-20 17:15:21.830 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-20 17:15:21.830 DVBSM(0)::RemovePIDFilter(0x10): 2006-10-20 17:15:21.830 DVBSM(0)::RemovePIDFilter(0x11): 2006-10-20 17:15:21.830 DVBSM(0)::RemovePIDFilter(0x20): 2006-10-20 17:15:21.831 DVBSM(0): RunTableMonitorTS(): end 2006-10-20 17:15:21.832 DVBSM(0)::Stop: end 2006-10-20 17:15:21.832 TVRec(3): TeardownSignalMonitor() -- end 2006-10-20 17:15:21.832 TVRec(3): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:21.832 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2006-10-20 17:15:21.832 TVRec(3): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady, 2006-10-20 17:15:21.835 TVRec(3): FinishedRecording(Sara Cox) in recgroup: LiveTV 2006-10-20 17:15:21.836 Chain: Updated endtime for '2612_20061020171514' to 20061020171521 2006-10-20 17:15:21.838 Finished recording Sara Cox: channel 2612 2006-10-20 17:15:21.842 scheduler: Finished recording: Sara Cox: channel 2612 2006-10-20 17:15:21.843 DVBChan(0): Closing DVB channel 2006-10-20 17:15:21.846 DVB#0 CA: CiHandler thread stopped 2006-10-20 17:15:21.846 TVRec(3): Tearing down RingBuffer 2006-10-20 17:15:21.847 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady,