rendered paste body2006-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,