2006-10-19 22:48:40.119 Using runtime prefix = /usr 2006-10-19 22:48:40.160 New DB connection, total: 1 2006-10-19 22:48:40.170 Connected to database 'mythconverg' at host: localhost 2006-10-19 22:48:40.182 Current Schema Version: 1160 2006-10-19 22:48:40.193 New DB connection, total: 2 2006-10-19 22:48:40.194 Connected to database 'mythconverg' at host: localhost 2006-10-19 22:48:40.195 mythbackend: MythBackend started as master server 2006-10-19 22:48:40.204 EITHelper: localtime offset 2:00:00 2006-10-19 22:48:40.438 DVBChan(0): Opening DVB channel 2006-10-19 22:48:40.438 DVBChan(0): Using DVB card 0, with frontend 'DST DVB-C'. 2006-10-19 22:48:40.666 DVB#0 CA: CI handler successfully initialized! 2006-10-19 22:48:40.668 New DB connection, total: 3 2006-10-19 22:48:40.669 Connected to database 'mythconverg' at host: localhost 2006-10-19 22:48:40.716 DVB#0 CA: CI handler thread running 2006-10-19 22:48:40.721 ChannelBase(3): Input #3: 'DVBInput' schan(4) sourceid(2) ccid(3) 2006-10-19 22:48:40.721 ChannelBase(3): Current Input #3: 'DVBInput' 2006-10-19 22:48:40.722 DVBChan(0): SetChannelByString(4): 2006-10-19 22:48:40.725 DVBChan(0): Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-19 22:48:40.726 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-19 22:48:40.726 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-19 22:48:41.698 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-19 22:48:41.698 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-19 22:48:41.698 DVBChan(0): SetChannelByString(4): Tuned to frequency. 2006-10-19 22:48:41.698 DVBChan(0): Closing DVB channel 2006-10-19 22:48:41.700 DVB#0 CA: CiHandler thread stopped 2006-10-19 22:48:41.715 TVRec(3): SetFlags(RunMainLoop,) -> RunMainLoop, 2006-10-19 22:48:41.715 TVRec(3): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2006-10-19 22:48:41.715 EITHelper: localtime offset 2:00:00 2006-10-19 22:48:41.718 Channel(/dev/video0): Device name 'Hauppauge WinTV PVR-150' driver 'ivtv'. 2006-10-19 22:48:41.726 ChannelBase(4): Input #4: 'Tuner 1' schan(20) sourceid(1) ccid(4) 2006-10-19 22:48:41.726 ChannelBase(4): Current Input #4: 'Tuner 1' 2006-10-19 22:48:41.727 Global TVFormat Setting 'PAL-BG' 2006-10-19 22:48:41.727 Channel(/dev/video0): Input #4: 'Tuner 1' schan(20) tun() v4l1(PAL) v4l2(Unknown) 2006-10-19 22:48:41.727 Channel(/dev/video0): SetFormat(Default) fmt(PAL-BG) input(4) 2006-10-19 22:48:41.727 Channel(/dev/video0): SetInputAndFormat(4, PAL-BG) (v4l v2) 2006-10-19 22:48:41.728 Channel(/dev/video0): SetFormat(PAL-BG) fmt(PAL-BG) input(4) 2006-10-19 22:48:41.729 Channel(/dev/video0)::SwitchToInput(in 4, '') 2006-10-19 22:48:41.729 Channel(/dev/video0): SetInputAndFormat(4, PAL-BG) (v4l v2) 2006-10-19 22:48:41.729 Channel(/dev/video0): SetChannelByString(20) 2006-10-19 22:48:41.730 ChannelBase(/dev/video0)::SetCachedATSCInfo(): 0--1 2006-10-19 22:48:41.731 Channel(/dev/video0): SetFormat(Default) fmt(PAL-BG) input(4) 2006-10-19 22:48:41.733 Channel(/dev/video0)::Tune(615250000, , analog) 2006-10-19 22:48:41.863 Channel(/dev/video0)::Tune(): Frequency is now 615250000 2006-10-19 22:48:41.863 ChannelBase(/dev/video0)::SetCachedATSCInfo(20_0): 20--1 2006-10-19 22:48:41.863 TVRec(4): SetFlags(RunMainLoop,) -> RunMainLoop, 2006-10-19 22:48:41.863 TVRec(4): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2006-10-19 22:48:41.864 New DB scheduler connection 2006-10-19 22:48:41.865 Connected to database 'mythconverg' at host: localhost 2006-10-19 22:48:41.870 Main::Starting HttpServer 2006-10-19 22:48:41.881 Main::Registering HttpStatus Extension 2006-10-19 22:48:41.890 mythbackend version: 0.20.20060828-3 www.mythtv.org 2006-10-19 22:48:41.890 Enabled verbose msgs: important general siparser record channel 2006-10-19 22:48:41.890 AutoExpire: Found 2 recorders w/max rate of 210 MiB/min 2006-10-19 22:48:41.892 AutoExpire: Required Free Space: 2.6 GB w/freq: 5 min 2006-10-19 22:48:43.884 Reschedule requested for id -1. 2006-10-19 22:48:44.217 Scheduled 37 items in 0.3 = 0.08 match + 0.25 place 2006-10-19 22:48:44.221 scheduler: Scheduled items: Scheduled 37 items in 0.3 = 0.08 match + 0.25 place 2006-10-19 22:48:44.225 Seem to be woken up by USER 2006-10-19 22:48:50.215 mythbackend: Running housekeeping thread 2006-10-19 22:48:52.962 MainServer::HandleAnnounce Monitor 2006-10-19 22:48:52.962 adding: el-mahico as a client (events: 0) 2006-10-19 22:48:52.963 MainServer::HandleAnnounce Monitor 2006-10-19 22:48:52.963 adding: el-mahico as a client (events: 1) 2006-10-19 22:48:52.964 Getting next free recorder after : -1 2006-10-19 22:48:52.966 Card 3 is local. 2006-10-19 22:48:52.972 MainServer::HandleAnnounce Playback 2006-10-19 22:48:52.973 adding: el-mahico as a client (events: 0) 2006-10-19 22:48:52.976 TVRec(3): Changing from None to WatchingLiveTV 2006-10-19 22:48:52.976 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2006-10-19 22:48:52.976 TVRec(3): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording, 2006-10-19 22:48:52.976 TVRec(3): Request: Program(no) channel() input() flags(LiveTV,) 2006-10-19 22:48:52.977 TVRec(3): HW Tuner: 3->3 2006-10-19 22:48:52.977 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording, 2006-10-19 22:48:52.977 DVBChan(0): Opening DVB channel 2006-10-19 22:48:52.978 DVBChan(0): Using DVB card 0, with frontend 'DST DVB-C'. 2006-10-19 22:48:53.227 DVB#0 CA: CI handler successfully initialized! 2006-10-19 22:48:53.321 DVB#0 CA: CI handler thread running 2006-10-19 22:48:53.363 ChannelBase(3): Input #3: 'DVBInput' schan(4) sourceid(2) ccid(3) 2006-10-19 22:48:53.363 ChannelBase(3): Current Input #3: 'DVBInput' 2006-10-19 22:48:53.363 DVBChan(0): SetChannelByString(4): 2006-10-19 22:48:53.369 DVBChan(0): Frequency: 802000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-19 22:48:53.369 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-19 22:48:53.369 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-19 22:48:53.734 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-19 22:48:53.735 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-19 22:48:53.735 DVBChan(0): SetChannelByString(4): Tuned to frequency. 2006-10-19 22:48:53.735 TVRec(3): CreateLiveTVRingBuffer() 2006-10-19 22:48:53.735 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-19 22:48:53.797 TVRec(3): StartedRecording(0x8439b50) fn(/recordings/2550_20061019224853.mpg) 2006-10-19 22:48:53.805 Chain: Appended@0 '2550_20061019224853' 2006-10-19 22:48:53.807 TVRec(3): Starting Signal Monitor 2006-10-19 22:48:53.808 TVRec(3): SetupSignalMonitor(1, 1) 2006-10-19 22:48:53.808 DVBChan(0): Opening DVB channel 2006-10-19 22:48:53.971 DVBSignalMonitor(0)::constructor(3,Warning, can not measure Bit Error Rate): Operation not supported 2006-10-19 22:48:53.971 DVBSignalMonitor(0)::constructor(3,Warning, can not count Uncorrected Blocks): Operation not supported 2006-10-19 22:48:53.971 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2006-10-19 22:48:53.971 DVBSM(0)::constructor(): initial flags 0x1400000 2006-10-19 22:48:53.971 TVRec(3): Signal monitor successfully created 2006-10-19 22:48:53.971 TVRec(3): Setting up table monitoring. 2006-10-19 22:48:53.971 TVRec(3): MPEG program number: 420 2006-10-19 22:48:53.972 DTVSM(0)::SetProgramNumber(420): 2006-10-19 22:48:53.972 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait() 2006-10-19 22:48:53.973 SM(0)::AddFlags: Seen() Match() Wait(PMT,) 2006-10-19 22:48:53.973 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,) 2006-10-19 22:48:53.973 SM(0)::AddFlags: Seen() Match() Wait() 2006-10-19 22:48:53.973 TVRec(3): Successfully set up MPEG table monitoring. 2006-10-19 22:48:53.973 SM(0)::Start: begin 2006-10-19 22:48:53.973 DVBSM(0)::UpdateValues: Signal Locked 2006-10-19 22:48:53.974 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-10-19 22:48:53.974 DVBSM(0)::AddPIDFilter(0x0): 2006-10-19 22:48:53.974 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-19 22:48:53.977 SM(0)::Start: end 2006-10-19 22:48:53.977 TVRec(3): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2006-10-19 22:48:53.977 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2006-10-19 22:48:53.977 TVRec(3): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning, 2006-10-19 22:48:53.977 TVRec(3): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2006-10-19 22:48:53.978 DummyDTVRecorder -- started 2006-10-19 22:48:53.978 TVRec(3): SetFlags(RingBufferReady,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:53.978 TVRec(3): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:53.978 TVRec(3): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:53.978 TVRec(3): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:54.949 DVBSM(0)::UpdateValues: Table monitor started 2006-10-19 22:48:54.949 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-10-19 22:48:55.358 TVRec(3): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:55.377 DVBSM(0): RunTableMonitorTS(): begin (# of pids 1) 2006-10-19 22:48:55.380 DVBSM(0)::AddPIDFilter(0x0): 2006-10-19 22:48:55.396 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-10-19 22:48:55.396 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-10-19 22:48:55.396 CreatePATSingleProgram() 2006-10-19 22:48:55.396 PAT in input stream 2006-10-19 22:48:55.396 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-19 22:48:55.397 desired_program(420) pid(0x10a) 2006-10-19 22:48:55.397 pmt_pid(0x10a) 2006-10-19 22:48:55.397 PAT for output stream 2006-10-19 22:48:55.397 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-19 22:48:55.397 DVBSM(0)::AddPIDFilter(0x10a): 2006-10-19 22:48:55.501 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:48:55.501 SM(0)::AddFlags: Seen() Match(PMT,) Wait() 2006-10-19 22:48:55.501 CreatePMTSingleProgram() 2006-10-19 22:48:55.501 PMT in input stream 2006-10-19 22:48:55.501 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-19 22:48:55.502 PMT for output stream 2006-10-19 22:48:55.502 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-19 22:48:55.525 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(1) 2006-10-19 22:48:55.526 TVRec(3): Got good signal 2006-10-19 22:48:55.526 TVRec(3): TeardownSignalMonitor() -- begin 2006-10-19 22:48:55.526 DVBSM(0)::Stop: begin 2006-10-19 22:48:55.526 SM(0)::Stop: begin 2006-10-19 22:48:55.594 SM(0)::Stop: end 2006-10-19 22:48:55.609 DVBSM(0): RunTableMonitorTS(): shutdown 2006-10-19 22:48:55.609 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-19 22:48:55.609 DVBSM(0)::RemovePIDFilter(0x10a): 2006-10-19 22:48:55.610 DVBSM(0): RunTableMonitorTS(): end 2006-10-19 22:48:55.610 DVBSM(0)::Stop: end 2006-10-19 22:48:55.610 TVRec(3): TeardownSignalMonitor() -- end 2006-10-19 22:48:55.610 TVRec(3): ClearFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:55.610 TVRec(3): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady, 2006-10-19 22:48:55.611 DB Error (get_use_eit): Query was: SELECT SUM(useeit) FROM videosource, cardinput WHERE videosource.sourceid = cardinput.sourceid AND cardinput.cardid = 3 Driver error was [2/1054]: QMYSQL3: Unable to execute query Database error was: Unknown column 'useeit' in 'field list' 2006-10-19 22:48:55.611 TVRec(3): Starting Recorder 2006-10-19 22:48:55.611 TVRec(3): ClearFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,RingBufferReady, 2006-10-19 22:48:55.613 TVRec(3): FinishedRecording(Fodbold) in recgroup: LiveTV 2006-10-19 22:48:55.614 Chain: Updated endtime for '2550_20061019224853' to 20061019224855 2006-10-19 22:48:55.615 Finished recording Fodbold "OB-Parma": channel 2550 2006-10-19 22:48:55.619 scheduler: Finished recording: Fodbold "OB-Parma": channel 2550 2006-10-19 22:48:55.624 Using profile 'Live TV' to record 2006-10-19 22:48:55.624 TVRec(3): SwitchLiveTVRingBuffer(discont 1, set_rec 0) 2006-10-19 22:48:55.624 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-19 22:48:55.668 TVRec(3): StartedRecording(0x845dce8) fn(/recordings/2550_20061019224855.mpg) 2006-10-19 22:48:55.731 TVRec(3): FinishedRecording(Fodbold) in recgroup: LiveTV 2006-10-19 22:48:55.731 Chain: Updated endtime for '2550_20061019224853' to 20061019224855 2006-10-19 22:48:55.742 Finished recording Fodbold "OB-Parma": channel 2550 2006-10-19 22:48:55.742 Preview: 'myth://192.168.1.11:6543/2550_20061019224853.mpg' is not local, replacing with '/recordings/2550_20061019224853.mpg', which is local. 2006-10-19 22:48:55.745 Chain: Appended@1 '2550_20061019224855' 2006-10-19 22:48:55.764 RecBase(0): SetRingBuffer(0x84c9600) '/recordings/2550_20061019224855.mpg' 2006-10-19 22:48:55.764 DVBRec(0): SetPAT(420 on 0x10a) 2006-10-19 22:48:55.764 CreatePATSingleProgram() 2006-10-19 22:48:55.764 PAT in input stream 2006-10-19 22:48:55.764 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-19 22:48:55.764 desired_program(420) pid(0x10a) 2006-10-19 22:48:55.764 pmt_pid(0x10a) 2006-10-19 22:48:55.765 PAT for output stream 2006-10-19 22:48:55.765 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-19 22:48:55.765 DVBRec(0): SetPMT(420) 2006-10-19 22:48:55.765 DVB#0 CA: SetPMT() program num #420 2006-10-19 22:48:55.765 CreatePMTSingleProgram() 2006-10-19 22:48:55.765 PMT in input stream 2006-10-19 22:48:55.765 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-19 22:48:55.765 PMT for output stream 2006-10-19 22:48:55.765 DVB#0 CA: CiHandler needs CA_PMT 2006-10-19 22:48:55.765 DVB#0 CA: Creating CA_PMT, ServiceID = 420 2006-10-19 22:48:55.765 Adding elementary stream: video-mpeg2, pid(0x1a4) 2006-10-19 22:48:55.765 Adding CA descriptor: CASID(0x500), ECM PID(0x2f) 2006-10-19 22:48:55.765 Adding elementary stream: audio-mp2-layer[1,2,3], pid(0x1a5) 2006-10-19 22:48:55.765 Adding CA descriptor: CASID(0x500), ECM PID(0x2f) 2006-10-19 22:48:55.765 Adding elementary stream: private-data, pid(0x1a6) 2006-10-19 22:48:55.765 DVB#0 CA: Sending CA_PMT with CPLM_ONLY to CI slot #0 2006-10-19 22:48:55.765 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-19 22:48:55.774 RecBase(0): SetRecording(0x84809d0) title(Fodbold) 2006-10-19 22:48:55.776 DVBRec(0): Card opened successfully fd(20) 2006-10-19 22:48:55.782 TVRec(3): SetFlags(RecorderRunning,RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady, 2006-10-19 22:48:55.782 TVRec(3): ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning,RingBufferReady, 2006-10-19 22:48:55.790 DevRdB(0): buffer size 9400 KB 2006-10-19 22:48:55.790 DVBRec(0): Resetting Demux Filters 2006-10-19 22:48:55.790 DVBRec(0): Adding pid 0x0 size(94208) 2006-10-19 22:48:55.790 DVBRec(0): Adding pid 0x1a4 size(3600384) 2006-10-19 22:48:55.791 DVBRec(0): Adding pid 0x1a5 size(94208) 2006-10-19 22:48:55.791 DVBRec(0): Adding pid 0x1a6 size(94208) 2006-10-19 22:48:55.791 DVBRec(0): Adding pid 0x10a size(94208) 2006-10-19 22:48:55.791 DVBRec(0): SetOutputPAT() Program Association Table PSIP tableID(0x0) length(13) extension(0x1) version(1) current(1) section(0) last_section(0) tsid: 1 programCount: 1 program number 1 has PID 0x 10a data 0x0 0x1 0x225 0x10 2006-10-19 22:48:55.791 DVBRec(0): CreatePMT(void) INPUT 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-19 22:48:55.791 Created PMT Program Map Table ver(1) pid(0x10a) pnum(1) len(35) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) Stream #2 pid(0x1a6) type(private-data 0x6) Teletext Descriptor (0x56) length(5) 2006-10-19 22:48:55.791 DVBRec(0): CreatePMT(void) OUTPUT Program Map Table ver(1) pid(0x10a) pnum(1) len(35) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) Stream #2 pid(0x1a6) type(private-data 0x6) Teletext Descriptor (0x56) length(5) 2006-10-19 22:48:55.791 DVBRec(0): SetOutputPMT() Program Map Table ver(1) pid(0x10a) pnum(1) len(35) Stream #0 pid(0x1a4) type(video-mpeg2 0x2) Stream #1 pid(0x1a5) type(audio-mp2-layer[1,2,3] 0x4) Stream #2 pid(0x1a6) type(private-data 0x6) Teletext Descriptor (0x56) length(5) 2006-10-19 22:48:55.806 DVBRec(0): Adding pid 0x10 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x1a3 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x101 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x22 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x105 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x20 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x1d1 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x1b94 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): Adding pid 0x21 size(94208) 2006-10-19 22:48:55.807 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.807 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.807 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.807 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.807 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.808 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.809 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.809 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.809 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.809 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:55.812 Preview Error: Previewer file '/recordings/2550_20061019224853.mpg' is not valid. 2006-10-19 22:48:55.813 Writing PAT & PMT @0 + 0 2006-10-19 22:48:55.813 DVBRec(0): PID 0x1a4 is encrypted, ignoring 2006-10-19 22:48:55.813 DVBRec(0): PID 0x1a5 is encrypted, ignoring 2006-10-19 22:48:55.813 DVBRec(0): PID 0x0 discontinuity detected 2006-10-19 22:48:55.813 DVBRec(0): PID 0x1a6 discontinuity detected 2006-10-19 22:48:55.813 PID 0x1a6 Found Payload Start 2006-10-19 22:48:56.241 DVBRec(0): PID 0x1a4 is no longer encrypted 2006-10-19 22:48:56.257 DVBRec(0): PID 0x1a5 is no longer encrypted 2006-10-19 22:48:56.259 PID 0x1a4 Found Payload Start 2006-10-19 22:48:56.357 PID 0x1a5 Found Payload Start 2006-10-19 22:48:56.717 Writing PAT & PMT @322044 + 106032 2006-10-19 22:48:57.233 Writing PAT & PMT @677740 + 636192 2006-10-19 22:48:57.489 DVBRec(0): 14 PID filters open. 2006-10-19 22:48:57.745 Writing PAT & PMT @1034376 + 353440 2006-10-19 22:48:58.274 Writing PAT & PMT @1379544 + 1413760 2006-10-19 22:48:58.758 Writing PAT & PMT @1736556 + 353440 2006-10-19 22:48:59.274 Writing PAT & PMT @2092628 + 35344 2006-10-19 22:48:59.765 Writing PAT & PMT @2432532 + 1555136 2006-10-19 22:48:59.986 DVBRec(0): 14 PID filters open. 2006-10-19 22:49:00.281 Writing PAT & PMT @2789168 + 35344 2006-10-19 22:49:00.766 Writing PAT & PMT @3133208 + 318096 2006-10-19 22:49:01.274 Writing PAT & PMT @3477248 + 1519792 2006-10-19 22:49:01.786 Writing PAT & PMT @3835952 + 459472 2006-10-19 22:49:02.302 Writing PAT & PMT @4190144 + 1166352 2006-10-19 22:49:02.334 DVBRec(0): 14 PID filters open. 2006-10-19 22:49:02.410 ChannelBase(3): Failed to find channel() on current input (DVBInput) of card (3). 2006-10-19 22:49:02.411 ChannelBase(3): Failed to find channel() on any input of card (3). 2006-10-19 22:49:02.423 TVRec(3): SetChannel() -- begin 2006-10-19 22:49:02.423 TVRec(3): ClearFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning, 2006-10-19 22:49:02.423 TVRec(3): Request: Program(no) channel(103) input() flags(LiveTV,) 2006-10-19 22:49:02.425 TVRec(3): ClearFlags(PENDINGACTIONS,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning, 2006-10-19 22:49:02.425 TVRec(3): SetFlags(WaitingForRecPause,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForRecPause,RecorderRunning, 2006-10-19 22:49:02.430 TVRec(3): ClearFlags(WaitingForRecPause,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,RecorderRunning, 2006-10-19 22:49:02.430 DVBRec(0): Close() fd(20) -- begin 2006-10-19 22:49:02.430 DVBRec(0): Close() fd(-1) -- end 2006-10-19 22:49:02.430 RecBase(0): SetRingBuffer(0) 2006-10-19 22:49:02.430 DVBChan(0): Opening DVB channel 2006-10-19 22:49:02.431 DVBChan(0): SetChannelByString(103): 2006-10-19 22:49:02.434 DVBChan(0): Frequency: 762000000 Symbol Rate: 6875000 Inversion: Auto Inner FEC: auto 2006-10-19 22:49:02.434 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-19 22:49:02.434 DVBChan(0): Tune(): Tuning to 762000000Hz 2006-10-19 22:49:03.183 dvbchannel.cpp:wait_for_backend: Status: Signal,Carrier,FEC Stable,Sync,Lock, 2006-10-19 22:49:03.183 DVBChan(0): Tune(): Frequency tuning successful. 2006-10-19 22:49:03.183 DVBChan(0): SetChannelByString(103): Tuned to frequency. 2006-10-19 22:49:03.183 TVRec(3): SwitchLiveTVRingBuffer(discont 1, set_rec 0) 2006-10-19 22:49:03.183 TVRec(3): GetProgramRingBufferForLiveTV() 2006-10-19 22:49:03.208 TVRec(3): StartedRecording(0x8439b50) fn(/recordings/2612_20061019224903.mpg) 2006-10-19 22:49:03.322 TVRec(3): FinishedRecording(Fodbold) in recgroup: LiveTV 2006-10-19 22:49:03.323 Chain: Updated endtime for '2550_20061019224855' to 20061019224903 2006-10-19 22:49:03.339 Finished recording Fodbold "OB-Parma": channel 2550 2006-10-19 22:49:03.339 Preview: 'myth://192.168.1.11:6543/2550_20061019224855.mpg' is not local, replacing with '/recordings/2550_20061019224855.mpg', which is local. 2006-10-19 22:49:03.344 Chain: Appended@2 '2612_20061019224903' 2006-10-19 22:49:03.395 TVRec(3): Starting Signal Monitor 2006-10-19 22:49:03.395 TVRec(3): SetupSignalMonitor(1, 1) 2006-10-19 22:49:03.396 DVBChan(0): Opening DVB channel 0: start_time: 6159.397 duration: 0.518 1: start_time: 6159.370 duration: 0.518 2: start_time: 6159.317 duration: 0.565 stream: start_time: 68436.860 duration: 6.640 bitrate=5164 kb/s 2006-10-19 22:49:03.407 AFD: Opened codec 0x8512730, id(MPEG2VIDEO) type(Video) 2006-10-19 22:49:03.437 AFD: Opened codec 0x8512d30, id(MP3) type(Audio) 2006-10-19 22:49:03.563 DVBSignalMonitor(0)::constructor(3,Warning, can not measure Bit Error Rate): Operation not supported 2006-10-19 22:49:03.563 DVBSignalMonitor(0)::constructor(3,Warning, can not count Uncorrected Blocks): Operation not supported 2006-10-19 22:49:03.563 SM(0)::AddFlags: Seen() Match() Wait(Sig,SNR,) 2006-10-19 22:49:03.563 DVBSM(0)::constructor(): initial flags 0x1400000 2006-10-19 22:49:03.563 TVRec(3): Signal monitor successfully created 2006-10-19 22:49:03.563 TVRec(3): Setting up table monitoring. 2006-10-19 22:49:03.563 TVRec(3): MPEG program number: 921 2006-10-19 22:49:03.564 DTVSM(0)::SetProgramNumber(921): 2006-10-19 22:49:03.564 SM(0)::RemoveFlags: Seen(PMT,) Match(PMT,) Wait() 2006-10-19 22:49:03.564 SM(0)::AddFlags: Seen() Match() Wait(PMT,) 2006-10-19 22:49:03.565 SM(0)::AddFlags: Seen() Match() Wait(PAT,PMT,) 2006-10-19 22:49:03.565 SM(0)::AddFlags: Seen() Match() Wait() 2006-10-19 22:49:03.565 TVRec(3): Successfully set up MPEG table monitoring. 2006-10-19 22:49:03.565 SM(0)::Start: begin 2006-10-19 22:49:03.565 DVBSM(0)::UpdateValues: Signal Locked 2006-10-19 22:49:03.565 DVBSM(0)::UpdateValues: Waiting for table monitor to start 2006-10-19 22:49:03.566 SM(0)::Start: end 2006-10-19 22:49:03.566 TVRec(3): SetFlags(SignalMonitorRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SignalMonitorRunning,RecorderRunning, 2006-10-19 22:49:03.566 TVRec(3): ClearFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,SignalMonitorRunning,RecorderRunning, 2006-10-19 22:49:03.567 TVRec(3): SetFlags(WaitingForSignal,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,RecorderRunning, 2006-10-19 22:49:03.567 RecBase(0): SetRingBuffer(0) 2006-10-19 22:49:03.567 TVRec(3): SetFlags(DummyRecorderRunning,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,ANYRECRUNNING, 2006-10-19 22:49:03.567 DummyDTVRecorder -- started 2006-10-19 22:49:03.567 TVRec(3): SetFlags(RingBufferReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:03.567 TVRec(3): ClearFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:03.567 TVRec(3): SetFlags(NeedToStartRecorder,) -> FrontendReady,RunMainLoop,CancelNextRecording,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:03.567 TVRec(3): SetChannel() -- end 2006-10-19 22:49:03.591 DVBSM(0)::UpdateValues: Table monitor started 2006-10-19 22:49:03.592 DTVSM(0)::GetStatusList: WaitForPMT seen(0) matching(0) 2006-10-19 22:49:03.650 DVBSM(0): RunTableMonitorTS(): begin (# of pids 1) 2006-10-19 22:49:03.650 DVBSM(0)::AddPIDFilter(0x0): 2006-10-19 22:49:03.659 DVBRec(0): SetPAT(921 on 0x20) 2006-10-19 22:49:03.659 SM(0)::AddFlags: Seen(PAT,) Match() Wait() 2006-10-19 22:49:03.659 SM(0)::AddFlags: Seen() Match(PAT,) Wait() 2006-10-19 22:49:03.659 CreatePATSingleProgram() 2006-10-19 22:49:03.659 PAT in input stream 2006-10-19 22:49:03.660 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-19 22:49:03.660 desired_program(921) pid(0x20) 2006-10-19 22:49:03.660 pmt_pid(0x20) 2006-10-19 22:49:03.661 PAT for output stream 2006-10-19 22:49:03.661 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-19 22:49:03.661 DVBSM(0)::AddPIDFilter(0x20): 2006-10-19 22:49:03.691 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.692 DTVSM(0) Error: Wrong PMT; pmt->pn(975) desired(921) 2006-10-19 22:49:03.692 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.692 DTVSM(0) Error: Wrong PMT; pmt->pn(926) desired(921) 2006-10-19 22:49:03.692 DVBRec(0): SetPMT(921) 2006-10-19 22:49:03.692 DVB#0 CA: SetPMT() program num #921 2006-10-19 22:49:03.692 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.692 DTVSM(0) Error: We want 0 audio and 1 video streams But have 1 audio and 0 video streams 2006-10-19 22:49:03.692 CreatePMTSingleProgram() 2006-10-19 22:49:03.692 PMT in input stream 2006-10-19 22:49:03.692 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-19 22:49:03.692 Only 0 video streams seen in PMT, but 1 are required. 2006-10-19 22:49:03.692 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.693 DTVSM(0) Error: Wrong PMT; pmt->pn(918) desired(921) 2006-10-19 22:49:03.693 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.693 DTVSM(0) Error: Wrong PMT; pmt->pn(917) desired(921) 2006-10-19 22:49:03.693 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.693 DTVSM(0) Error: Wrong PMT; pmt->pn(916) desired(921) 2006-10-19 22:49:03.693 SM(0)::AddFlags: Seen(PMT,) Match() Wait() 2006-10-19 22:49:03.693 DTVSM(0) Error: Wrong PMT; pmt->pn(905) desired(921) 2006-10-19 22:49:03.694 DVB#0 CA: CiHandler needs CA_PMT 2006-10-19 22:49:03.694 DVB#0 CA: Creating CA_PMT, ServiceID = 921 2006-10-19 22:49:03.694 Adding elementary stream: audio-mp2-layer[1,2,3], pid(0x399) 2006-10-19 22:49:03.694 DVB#0 CA: Sending CA_PMT with CPLM_ONLY to CI slot #0 2006-10-19 22:49:03.698 DTVSM(0)::GetStatusList: WaitForPMT seen(1) matching(0) 2006-10-19 22:49:08.784 StopLiveTV(void) curRec: 0x8439b50 pseudoRec: 0 2006-10-19 22:49:08.787 TVRec(3): Changing from WatchingLiveTV to None 2006-10-19 22:49:08.787 TVRec(3): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:08.787 TVRec(3): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:08.788 TVRec(3): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2006-10-19 22:49:08.788 TVRec(3): TeardownSignalMonitor() -- begin 2006-10-19 22:49:08.788 DVBSM(0)::Stop: begin 2006-10-19 22:49:08.788 SM(0)::Stop: begin 2006-10-19 22:49:08.813 SM(0)::Stop: end 2006-10-19 22:49:08.814 DVBSM(0): RunTableMonitorTS(): shutdown 2006-10-19 22:49:08.814 DVBSM(0)::RemovePIDFilter(0x0): 2006-10-19 22:49:08.814 DVBSM(0)::RemovePIDFilter(0x20): 2006-10-19 22:49:08.815 DVBSM(0): RunTableMonitorTS(): end 2006-10-19 22:49:08.815 DVBSM(0)::Stop: end 2006-10-19 22:49:08.815 TVRec(3): TeardownSignalMonitor() -- end 2006-10-19 22:49:08.815 TVRec(3): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:08.815 TVRec(3): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,ANYRECRUNNING,RingBufferReady, 2006-10-19 22:49:08.815 TVRec(3): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady, 2006-10-19 22:49:08.818 TVRec(3): FinishedRecording(Colin Murray) in recgroup: LiveTV 2006-10-19 22:49:08.820 Chain: Updated endtime for '2612_20061019224903' to 20061019224908 2006-10-19 22:49:08.821 Finished recording Colin Murray: channel 2612 2006-10-19 22:49:08.855 scheduler: Last message repeated 2 times: Finished recording: Fodbold "OB-Parma": channel 2550 2006-10-19 22:49:08.859 scheduler: Finished recording: Colin Murray: channel 2612 2006-10-19 22:49:08.866 DVBRec(0): Close() fd(-1) -- begin 2006-10-19 22:49:08.866 DVBRec(0): Close() fd(-1) -- end 2006-10-19 22:49:08.870 TVRec(3): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady, 2006-10-19 22:49:08.872 DVBRec(0): SetOutputPAT(NULL) 2006-10-19 22:49:08.872 DVBRec(0): SetOutputPMT(NULL) 2006-10-19 22:49:08.875 TVRec(3): FinishedRecording(Colin Murray) in recgroup: LiveTV 2006-10-19 22:49:08.876 Chain: Updated endtime for '2612_20061019224903' to 20061019224908 2006-10-19 22:49:08.878 Finished recording Colin Murray: channel 2612 2006-10-19 22:49:08.880 TVRec(3): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,RingBufferReady, 2006-10-19 22:49:08.880 DVBChan(0): Closing DVB channel 2006-10-19 22:49:08.882 DVB#0 CA: CiHandler thread stopped 2006-10-19 22:49:08.882 TVRec(3): Tearing down RingBuffer 2006-10-19 22:49:08.883 TVRec(3): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReady,