2005-12-31 01:39:20.798 Using runtime prefix = /usr/local 2005-12-31 01:39:20.878 New DB connection, total: 1 2005-12-31 01:39:20.892 Enabling Settings Cache. 2005-12-31 01:39:20.892 Clearing Settings Cache. 2005-12-31 01:39:20.895 Current Schema Version: 1121 2005-12-31 01:39:20.933 New DB connection, total: 2 2005-12-31 01:39:20.936 mythbackend: MythBackend started as master server 2005-12-31 01:39:20.958 DVB#0 Using DVB card 0, with frontend 'ST STV0299 DVB-S'. 2005-12-31 01:39:21.594 New DB connection, total: 3 2005-12-31 01:39:21.598 DVB#0 invalidating DeCSA for card 0 2005-12-31 01:39:22.474 TVRec(1): SetFlags(RunMainLoop,) -> RunMainLoop, 2005-12-31 01:39:22.474 TVRec(1): ClearFlags(ExitPlayer,FinishRecording,) -> RunMainLoop, 2005-12-31 01:39:22.475 New DB scheduler connection 2005-12-31 01:39:22.516 mythbackend version: 0.19.20051208-1 www.mythtv.org 2005-12-31 01:39:22.516 Enabled verbose msgs: important general record 2005-12-31 01:39:22.517 AutoExpire: Found 1 recorders w/max rate of 138 MiB/min 2005-12-31 01:39:22.518 AutoExpire: Required Free Space: 3.0 GB w/freq: 10 min 2005-12-31 01:39:24.525 Reschedule requested for id -1. 2005-12-31 01:39:24.574 Scheduled 0 items in 0.0 = 0.02 match + 0.03 place 2005-12-31 01:39:24.584 scheduler: Scheduled items 2005-12-31 01:39:24.589 Seem to be woken up by USER 2005-12-31 01:39:30.941 Running HouseKeeping 2005-12-31 01:39:30.961 mythbackend: Running housekeeping thread 2005-12-31 01:39:35.371 MainServer::HandleAnnounce Monitor 2005-12-31 01:39:35.371 adding: testbox as a client (events: 0) 2005-12-31 01:39:35.412 Getting next free recorder after : -1 2005-12-31 01:39:35.414 Card 1 is local. 2005-12-31 01:39:35.429 MainServer::HandleAnnounce Monitor 2005-12-31 01:39:35.429 adding: testbox as a client (events: 1) 2005-12-31 01:39:35.435 MainServer::HandleAnnounce Playback 2005-12-31 01:39:35.435 adding: testbox as a client (events: 0) 2005-12-31 01:39:35.450 TVRec(1): Changing from None to WatchingLiveTV 2005-12-31 01:39:35.450 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2005-12-31 01:39:35.450 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording, 2005-12-31 01:39:35.450 TVRec(1): Request: Program(no) channel() input() flags(LiveTV,) 2005-12-31 01:39:35.450 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording, 2005-12-31 01:39:35.453 TVRec(1): CreateLiveTVRingBuffer() 2005-12-31 01:39:35.454 TVRec(1): GetProgramRingBufferForLiveTV() 2005-12-31 01:39:35.530 TVRec(1): StartedRecording(0x813f198) fn(/mnt/store//5703_20051231013935.mpg) 2005-12-31 01:39:35.541 Chain: Appended@0 '5703_20051231013935' 2005-12-31 01:39:35.553 RecBase(/dev/video): SetRingBuffer(0x8159688) '/mnt/store//5703_20051231013935.mpg' 2005-12-31 01:39:35.553 RecBase(/dev/video): SetRecording(0x813f198) title(Unknown) 2005-12-31 01:39:35.553 TVRec(1): Starting Signal Monitor 2005-12-31 01:39:35.553 TVRec(1): SetupSignalMonitor(1, 1) 2005-12-31 01:39:35.555 TVRec(1): Signal monitor successfully created 2005-12-31 01:39:35.555 TVRec(1): Setting up table monitoring. 2005-12-31 01:39:35.555 TVRec(1): MPEG program number: 4703 2005-12-31 01:39:35.557 TVRec(1): Successfully set up MPEG table monitoring. 2005-12-31 01:39:35.559 TVRec(1): SetFlags(SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2005-12-31 01:39:35.559 TVRec(1): ClearFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,SignalMonitorRunning, 2005-12-31 01:39:35.559 TVRec(1): SetFlags(WaitingForSignal,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning, 2005-12-31 01:39:35.570 DummyDTVRecorder::StartRecording -- begin 2005-12-31 01:39:35.659 TVRec(1): SetFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2005-12-31 01:39:35.659 DummyDTVRecorder -- started 2005-12-31 01:39:35.659 TVRec(1): SetFlags(RingBufferReset,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2005-12-31 01:39:35.659 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2005-12-31 01:39:35.659 TVRec(1): SetFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReset, 2005-12-31 01:39:35.705 CreatePATSingleProgram() 2005-12-31 01:39:35.705 PAT in input stream 2005-12-31 01:39:35.705 Program Association Table PSIP prefix(0x0) tableID(0x0) length(41) extension(0x7ee) version(19) current(1) section(0) last_section(0) tsid: 2030 programCount: 8 program number 0 has PID 0x 10 data 0x0 0x0 0x224 0x16 program number 4409 has PID 0x 101 data 0x17 0x57 0x225 0x1 program number 4602 has PID 0x 107 data 0x17 0x250 0x225 0x7 program number 4603 has PID 0x 109 data 0x17 0x251 0x225 0x9 program number 4604 has PID 0x 100 data 0x17 0x252 0x225 0x0 program number 4703 has PID 0x 104 data 0x18 0x95 0x225 0x4 program number 4802 has PID 0x 10c data 0x18 0x194 0x225 0x12 program number 4809 has PID 0x 10b data 0x18 0x201 0x225 0x11 2005-12-31 01:39:35.706 desired_program(4703) pid(0x104) 2005-12-31 01:39:35.706 pmt_pid(0x104) 2005-12-31 01:39:35.706 PAT for output stream 2005-12-31 01:39:35.706 Program Association Table PSIP prefix(0x0) tableID(0x0) length(13) extension(0x7ee) version(19) current(1) section(0) last_section(0) tsid: 2030 programCount: 1 program number 1 has PID 0x 104 data 0x0 0x1 0x225 0x4 2005-12-31 01:39:35.773 DummyRec: Restart! Frames seen 11 2005-12-31 01:39:35.826 DummyRec: Restart! Frames seen 22 2005-12-31 01:39:35.849 DummyRec: Restart! Frames seen 33 2005-12-31 01:39:35.860 CreatePMTSingleProgram() 2005-12-31 01:39:35.860 PMT in input stream 2005-12-31 01:39:35.860 Program Map Table ver(7) pid(0x104) pnum(4703) Multiplex Buffer Utilization Descriptor (0xc) length(4) Maximum Bitrate Descriptor (0xe) length(3) Smoothing Buffer Descriptor (0x10) length(6) Stream #0 pid(0x201) type(video-mpeg2 0x2) Video Descriptor (0x2) length(3) Conditional Access: sid(0x960) pid(0x500) data_size(0) Conditional Access: sid(0x961) pid(0x500) data_size(0) Stream Identifier Descriptor (0x52) length(1) Maximum Bitrate Descriptor (0xe) length(3) Unknown(6) Descriptor (0x6) length(1) Stream #1 pid(0x281) type(audio-mp2-layer[1,2,3] 0x4) Audio Descriptor (0x3) length(1) Conditional Access: sid(0x960) pid(0x500) data_size(0) Conditional Access: sid(0x961) pid(0x500) data_size(0) ISO-639 Language: code(eng) canonical(eng) eng(English) Stream Identifier Descriptor (0x52) length(1) Maximum Bitrate Descriptor (0xe) length(3) Stream #2 pid(0x295) type(audio-mp2-layer[1,2,3] 0x4) Audio Descriptor (0x3) length(1) Conditional Access: sid(0x960) pid(0x500) data_size(0) Conditional Access: sid(0x961) pid(0x500) data_size(0) ISO-639 Language: code(NAR) canonical(NAR) eng(Unknown) Stream Identifier Descriptor (0x52) length(1) Maximum Bitrate Descriptor (0xe) length(3) Stream #3 pid(0x240) type(private-data 0x6) Teletext Descriptor (0x56) length(5) Stream Identifier Descriptor (0x52) length(1) Maximum Bitrate Descriptor (0xe) length(3) Stream #4 pid(0x241) type(private-data 0x6) Teletext Descriptor (0x56) length(5) Stream Identifier Descriptor (0x52) length(1) Maximum Bitrate Descriptor (0xe) length(3) Stream #5 pid(0x980) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #6 pid(0x981) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #7 pid(0x983) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #8 pid(0x982) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #9 pid(0x984) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #10 pid(0x985) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #11 pid(0x986) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #12 pid(0x987) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #13 pid(0x988) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #14 pid(0x989) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #15 pid(0x98a) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #16 pid(0x98b) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #17 pid(0x98c) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #18 pid(0x98d) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #19 pid(0x98e) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #20 pid(0xc01) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream Identifier Descriptor (0x52) length(1) Stream #21 pid(0xc02) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream Identifier Descriptor (0x52) length(1) Stream #22 pid(0xc03) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream Identifier Descriptor (0x52) length(1) Stream #23 pid(0xc04) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream Identifier Descriptor (0x52) length(1) Stream #24 pid(0x993) type(private-sec 0x5) Maximum Bitrate Descriptor (0xe) length(3) Private Data Indicator Descriptor (0xf) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Stream #25 pid(0x406) type(private-sec 0x5) Private Data Specifier Descriptor (0x5f) length(4) Unknown(144) Descriptor (0x90) length(1) Unknown(254) Descriptor (0xfe) length(4) Data Broadcast Identifier Descriptor (0x66) length(2) 2005-12-31 01:39:35.863 PMT for output stream 2005-12-31 01:39:35.863 Program Map Table ver(7) pid(0x104) pnum(1) Stream #0 pid(0x201) type(video-mpeg2 0x2) Stream #1 pid(0x281) type(audio-mp2-layer[1,2,3] 0x4) Stream #2 pid(0x295) type(audio-mp2-layer[1,2,3] 0x4) 2005-12-31 01:39:35.864 TFW, Error: Write() -- IOBOUND begin cnt(188) free(11) 2005-12-31 01:39:35.867 TFW, Error: Write() -- IOBOUND end 2005-12-31 01:39:35.875 DummyRec: Restart! Frames seen 44 2005-12-31 01:39:35.883 TVRec(1): Got good signal 2005-12-31 01:39:35.883 TVRec(1): MPEG program num(4703) 2005-12-31 01:39:35.883 TVRec(1): TeardownSignalMonitor() -- begin 2005-12-31 01:39:35.966 TVRec(1): TeardownSignalMonitor() -- end 2005-12-31 01:39:36.122 TVRec(1): ClearFlags(WaitingForSignal,SignalMonitorRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReset, 2005-12-31 01:39:36.123 TVRec(1): prog_num(4703) vs. dvbc->srv_id(4703) 2005-12-31 01:39:36.131 DVB#0 DVB SI Table Parser Started 2005-12-31 01:39:36.133 TVRec(1): SetFlags(WaitingForSIParser,SIParserRunning,) -> RunMainLoop,AskAllowRecording,WaitingForSIParser,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReset, 2005-12-31 01:39:36.134 DummyRec: Restart! Frames seen 55 2005-12-31 01:39:36.216 DummyRec: Restart! Frames seen 66 2005-12-31 01:39:36.306 DummyRec: Restart! Frames seen 77 2005-12-31 01:39:36.328 DummyRec: Restart! Frames seen 88 2005-12-31 01:39:36.551 DummyRec: Restart! Frames seen 99 2005-12-31 01:39:37.128 DummyRec: Restart! Frames seen 110 2005-12-31 01:39:37.427 DummyRec: Restart! Frames seen 121 2005-12-31 01:39:37.549 TVRec(1): Got SIParser PMT 2005-12-31 01:39:37.549 TVRec(1): ClearFlags(WaitingForSIParser,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,DummyRecorderRunning,RingBufferReset, 2005-12-31 01:39:37.550 TVRec(1): Starting Recorder 2005-12-31 01:39:37.550 DummyDTVRecorder::StopRecordingThread(void) 2005-12-31 01:39:37.550 DummyDTVRecorder::FinishRecording() 2005-12-31 01:39:37.604 DummyDTVRecorder::StartRecording -- end 2005-12-31 01:39:37.605 TVRec(1): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReset, 2005-12-31 01:39:37.607 Chain: Updated endtime for '5703_20051231013935' to 20051231013937 2005-12-31 01:39:37.609 Finished recording Unknown: channel 5703 2005-12-31 01:39:37.631 scheduler: Finished recording 2005-12-31 01:39:37.695 TVRec(1): Using profile 'Live TV' to record 2005-12-31 01:39:37.695 TVRec(1): SwitchLiveTVRingBuffer(discont 1, set_rec 0) 2005-12-31 01:39:37.695 TVRec(1): GetProgramRingBufferForLiveTV() 2005-12-31 01:39:37.733 TVRec(1): StartedRecording(0x8165ad8) fn(/mnt/store//5703_20051231013937.mpg) 2005-12-31 01:39:37.747 Preview: 'myth://127.0.0.1:6543/5703_20051231013935.mpg' is not local, replacing with '/mnt/store//5703_20051231013935.mpg', which is local. 2005-12-31 01:39:37.754 Chain: Appended@1 '5703_20051231013937' 2005-12-31 01:39:37.755 DummyDTVRecorder::StopRecordingThread(void) 2005-12-31 01:39:37.755 TVRec(1): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RingBufferReset, 2005-12-31 01:39:37.755 DummyDTVRecorder::StopRecordingThread(void) 2005-12-31 01:39:37.943 RecBase(0): SetRingBuffer(0x817ced0) '/mnt/store//5703_20051231013937.mpg' 2005-12-31 01:39:37.943 RecBase(0): SetRecording(0x8159688) title(Unknown) 2005-12-31 01:39:37.945 DVBRec(0): Card opened successfully fd(20) (using TS mode). 2005-12-31 01:39:37.946 DVBRec(0): SetPMTObject() 2005-12-31 01:39:37.946 DVBRec(0): AutoPID for MPEG Program Number(4703), PCR PID(0x1ffe) 2005-12-31 01:39:37.946 DVBRec(0): AutoPID recording PID 0x201, MPEG-2 Video 2005-12-31 01:39:37.946 DVBRec(0): AutoPID recording PID 0x281, MPEG-2 Audio (eng 2005-12-31 01:39:37.946 DVBRec(0): AutoPID recording PID 0x295, MPEG-2 Audio (NAR 2005-12-31 01:39:37.946 DVBRec(0): AutoPID recording PID 0x240, Teletext 2005-12-31 01:39:37.947 DVBRec(0): AutoPID recording PID 0x241, Teletext 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x980, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x981, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x983, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x982, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x984, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x985, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x986, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x987, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x988, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x989, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x98a, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x98b, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x98c, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x98d, Unknown type: 5 2005-12-31 01:39:37.947 DVBRec(0): AutoPID skipping PID 0x98e, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID skipping PID 0xc01, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID skipping PID 0xc02, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID skipping PID 0xc03, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID skipping PID 0xc04, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID skipping PID 0x993, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID skipping PID 0x406, Unknown type: 5 2005-12-31 01:39:37.948 DVBRec(0): AutoPID Complete - PAT/PMT Loaded for service A/V Streams are ENCRYPTED 2005-12-31 01:39:37.948 DVB#0 CA: SetPMT for ServiceID=4703 2005-12-31 01:39:37.948 DVB#0 SID: 4703 TID: 1 (8190 2) (513 1) (641 0) (661 0) 2005-12-31 01:39:37.948 DVB#0 Found CA Descriptors: (36) 9 4 9 60 5 0 9 4 9 61 5 0 9 4 9 60 5 0 9 4 9 61 5 0 9 4 9 60 5 0 9 4 9 61 5 0 2005-12-31 01:39:37.951 TVRec(1): SetFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,NeedToStartRecorder,SIParserRunning,RecorderRunning,RingBufferReset, 2005-12-31 01:39:37.952 TVRec(1): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2005-12-31 01:39:37.953 Got Key type(80) idx: 1, pid: 8190 2005-12-31 01:39:37.955 Got Key type(80) idx: 1, pid: 513 2005-12-31 01:39:37.955 Got Key type(80) idx: 1, pid: 641 2005-12-31 01:39:37.955 Got Key type(80) idx: 1, pid: 661 2005-12-31 01:39:37.979 DevRdB(0): buffer size 9400 KB 2005-12-31 01:39:37.980 DVBRec(0): Resetting Demux Filters 2005-12-31 01:39:37.980 DVBRec(0): Adding pid 0x201 size(3600384) 2005-12-31 01:39:37.981 DVBRec(0): Set demux buffer size for pid 0x201 to 3600384, which gives us a 1500 msec buffer. 2005-12-31 01:39:37.981 DVBRec(0): Adding pid 0x281 size(94208) 2005-12-31 01:39:37.981 DVBRec(0): Set demux buffer size for pid 0x281 to 94208, which gives us a 1500 msec buffer. 2005-12-31 01:39:37.981 DVBRec(0): Adding pid 0x295 size(94208) 2005-12-31 01:39:37.981 DVBRec(0): Set demux buffer size for pid 0x295 to 94208, which gives us a 1500 msec buffer. 2005-12-31 01:39:37.981 DVBRec(0): Adding pid 0x240 size(94208) 2005-12-31 01:39:37.981 DVBRec(0): Set demux buffer size for pid 0x240 to 94208, which gives us a 1500 msec buffer. 2005-12-31 01:39:37.981 DVBRec(0): Adding pid 0x241 size(94208) 2005-12-31 01:39:37.981 DVBRec(0): Set demux buffer size for pid 0x241 to 94208, which gives us a 1500 msec buffer. 2005-12-31 01:39:37.981 DVBRec(0): Adding pid 0x1ffe size(94208) 2005-12-31 01:39:37.981 DVBRec(0): Set demux buffer size for pid 0x1ffe to 94208, which gives us a 1500 msec buffer. 2005-12-31 01:39:37.998 PID 0x241 Found Payload Start 2005-12-31 01:39:37.999 PID 0x240 Found Payload Start 2005-12-31 01:39:37.999 DVBRec(0): PID 0x201 is encrypted, ignoring 2005-12-31 01:39:38.012 DVBRec(0): PID 0x281 is encrypted, ignoring 2005-12-31 01:39:38.013 DVBRec(0): PID 0x295 is encrypted, ignoring plainkeys: registering key type V (super) loaders: registering loader Viaccess systems: registering CA system Viaccess, pri -10 plainkeys: registering key type Z systems: registering CA system @SHL, pri -10 plainkeys: registering key type S (super) loaders: registering loader Seca systems: registering CA system Seca, pri -10 systems: registering CA system SC-Viaccess, pri -5 smartcards: registering Viaccess smartcard (id 56696173) systems: registering CA system SC-Seca, pri -5 smartcards: registering Seca smartcard (id 53656361) systems: registering CA system SC-Irdeto, pri -5 smartcards: registering Irdeto smartcard (id 49726474) systems: registering CA system SC-Cryptoworks, pri -5 smartcards: registering Cryptoworks smartcard (id 4372576f) systems: registering CA system SC-Conax, pri -5 smartcards: registering Conax smartcard (id 436f6e78) plainkeys: registering key type N (super) systems: registering CA system Nagra, pri -10 plainkeys: registering key type I loaders: registering loader Irdeto systems: registering CA system Irdeto, pri -10 plainkeys: registering key type X (super) plainkeys: registering key type C (super) systems: registering CA system Conax, pri -10 systems: registering CA system Cardclient, pri -15 cardclients: registering cardclient Radegast cardclients: registering cardclient Newcamd cardclients: registering cardclient Camd33 cardclients: registering cardclient Cardd cardclients: registering cardclient Buffy cardclients: registering cardclient Camd35 cardclients: registering cardclient Aroureos loaders: registering loader ECM loaders: registering loader KEY /root/.mythtv/externcam_0 opening keyfile: /root/.mythtv/externcam_0/keyfifo -> 3 sasc (0): initializing plugin: SoftCam (0.5.3): A software emulated CAM sasc (0): starting plugin: scplugin: version 0.5.3 starting plainkeys: loaded 0 keys from /root/.mythtv/externcam_0/SoftCam.Key ERROR: no keys loaded for softcam! cc-newcamd: now using protocol version 525 (cdLen=8) cc: hostname=192.168.0.11 port=15000 emm=0 emmCaids 0961/ffff cc-newcamd: username=dummy6 password=dummy6 key=8E1F7AA4561297184C739E0AFEAD netwatch: up socket: connecting to 192.168.0.11:15000/tcp (192.168.0.11) cc-newcamd: CaID=0961 admin=1 srvUA=0000000001548C42 provider 000000/0000000001548C00 cc-newcamd: EMM disabled from config cc-link: client 'Newcamd' ready cc-link: created 1 client(s) from /root/.mythtv/externcam_0/cardclient.conf cardinfo: loaded 0 Irdeto cards from /root/.mythtv/externcam_0/Ird-Beta.KID cardinfo: loaded 0 Seca cards from /root/.mythtv/externcam_0/Seca.KID cardinfo: loaded 0 Viaccess cards from /root/.mythtv/externcam_0/Viaccess.KID loaders: loading ca cache from /root/.mythtv/externcam_0/ca.cache softcam: ScCaps are 1 2 0 0 0 0 0 0 0 0 WARNING: no smartcard interface defined! sasc (0): got PMT (len = 36)09 04 09 60 05 00 09 04 09 61 05 00 09 04 09 60 05 00 09 04 09 61 05 00 09 04 09 60 05 00 09 04 09 61 05 00 sasc (0): corrected to (len = 36) sasc (0): Changing channels: 36 0 36 cam 0: try to open ca device myself cam 0: no ca device, assuming budget card & SoftCSA ecmhandler 0.1: setting new SID 4703 ecmhandler 0.1: is no longer idle softcam: now 1 SoftCSA stream(s) registered ecmhandler 0.1: triggered SID 0/4703 idx -1/1 mode -1/0 - ecmcache: from cache: system Cardclient (0961) id 0000 with ecm 500 Transfering 36 bytes ecmhandler 0.1: got CaDescriptors (len=36) ecmhandler 0.1: descriptor 09 60 05 00 ecmhandler 0.1: no module available for system 0960 ecmhandler 0.1: descriptor 09 61 05 00 ecmhandler 0.1: found 0961 (Cardclient) id 0000 with ecm 500 (already present) ecmhandler 0.1: descriptor 09 60 05 00 ecmhandler 0.1: no module available for system 0960 ecmhandler 0.1: descriptor 09 61 05 00 ecmhandler 0.1: found 0961 (Cardclient) id 0000 with ecm 500 (already present) ecmhandler 0.1: descriptor 09 60 05 00 ecmhandler 0.1: no module available for system 0960 ecmhandler 0.1: descriptor 09 61 05 00 ecmhandler 0.1: found 0961 (Cardclient) id 0000 with ecm 500 (already present) ecmhandler 0.1: try system Cardclient (0961) id 0000 with ecm 500 (cached) 2005-12-31 01:39:38.084 Got Key type(69) idx: 1, pid: 0 2005-12-31 01:39:38.085 Got Key type(79) idx: 1, pid: 0 2005-12-31 01:39:40.059 TVRec(1): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2005-12-31 01:39:41.431 Got Key type(69) idx: 1, pid: 0 0: start_time: 857.475 duration: -9223372036854.775 stream: start_time: 9527.500 duration: -9223372036854.775 bitrate=0 kb/s 2005-12-31 01:39:42.313 AFD: Opened codec 0x819d600, id(MPEG1VIDEO) type(Video) 2005-12-31 01:39:42.313 NVP: Disabling Audio, params(-1,-1,-1) 2005-12-31 01:39:42.313 AFD: Initializing audio parms from audio track #0 2005-12-31 01:39:42.313 AFD: Audio format changed from id(NONE) -1Hz -1ch 0bps ; id(NONE) -1Hz -1ch 0bps to id(NONE) -1Hz -1ch 0bps ; id(NONE) -1Hz -1ch 0bps 2005-12-31 01:39:42.313 NVP: Disabling Audio, params(0,-1,-1) 2005-12-31 01:39:49.285 Got Key type(79) idx: 1, pid: 0 2005-12-31 01:39:57.315 Got Key type(69) idx: 1, pid: 0 2005-12-31 01:39:59.772 TVRec(1): Changing from WatchingLiveTV to None 2005-12-31 01:39:59.772 TVRec(1): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2005-12-31 01:39:59.773 TVRec(1): SetFlags(AskAllowRecording,) -> RunMainLoop,AskAllowRecording,SIParserRunning,RecorderRunning,RingBufferReset, 2005-12-31 01:39:59.773 TVRec(1): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2005-12-31 01:39:59.775 TVRec(1): ClearFlags(SIParserRunning,) -> RunMainLoop,AskAllowRecording,RecorderRunning,RingBufferReset, 2005-12-31 01:39:59.785 DVBRec(0): Close() fd(20) -- begin 2005-12-31 01:39:59.786 DVBRec(0): Close() fd(-1) -- end 2005-12-31 01:39:59.790 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReset, 2005-12-31 01:39:59.792 Chain: Updated endtime for '5703_20051231013937' to 20051231013959 2005-12-31 01:39:59.793 Finished recording Unknown: channel 5703 2005-12-31 01:39:59.802 TVRec(1): ClearFlags(RecorderRunning,) -> RunMainLoop,AskAllowRecording,RingBufferReset, 2005-12-31 01:39:59.803 TVRec(1): Tearing down RingBuffer 2005-12-31 01:39:59.803 TVRec(1): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,AskAllowRecording,RingBufferReset,