2008-02-27 10:10:20.333 Checking card 1. Best card so far -1 2008-02-27 10:10:20.335 Checking card 2. Best card so far 2 2008-02-27 10:10:20.336 Checking card 3. Best card so far 2 2008-02-27 10:10:20.338 Checking card 4. Best card so far 4 2008-02-27 10:10:20.340 Checking card 5. Best card so far 5 2008-02-27 10:10:20.342 Checking card 12. Best card so far 5 2008-02-27 10:10:20.343 Checking card 105. Best card so far 105 2008-02-27 10:10:20.345 Checking card 205. Best card so far 205 2008-02-27 10:10:20.347 Checking card 1000. Best card so far 1000 2008-02-27 10:10:20.348 Checking card 1001. Best card so far 1001 2008-02-27 10:10:20.353 MainServer::HandleAnnounce Playback 2008-02-27 10:10:20.355 adding: pc4 as a client (events: 0) 2008-02-27 10:10:20.359 TVRec(1001): Changing from None to WatchingLiveTV 2008-02-27 10:10:20.362 TVRec(1001): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2008-02-27 10:10:20.363 TVRec(1001): Request: Program(no) channel() input() flags(LiveTV,) 2008-02-27 10:10:20.366 TVRec(1001): Start channel: 10. 2008-02-27 10:10:20.376 TVRec(1001): HW Tuner: 1001->1001 2008-02-27 10:10:20.378 TVRec(1001): ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2008-02-27 10:10:20.379 TVRec(1001): No recorder yet, calling TuningFrequency 2008-02-27 10:10:20.384 Channel(/dev/video1): Device name 'WinTV PVR 500 (unit #2)' driver 'ivtv'. 2008-02-27 10:10:21.430 ChannelBase(1001): Input #2: 'S-Video 1' schan(10) sourceid(1) ccid(1001) 2008-02-27 10:10:21.432 ChannelBase(1001): Current Input #2: 'S-Video 1' 2008-02-27 10:10:21.434 Global TVFormat Setting 'NTSC' 2008-02-27 10:10:21.436 Channel(/dev/video1): Input #2: 'S-Video 1' schan(10) tun() v4l1(NTSC) v4l2(NTSC) 2008-02-27 10:10:21.437 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(2) 2008-02-27 10:10:21.439 Channel(/dev/video1)::SwitchToInput(in 2, '') 2008-02-27 10:10:21.449 Channel(/dev/video1): SetInputAndFormat(2, NTSC) (v4l v2) 2008-02-27 10:10:21.450 Channel(/dev/video1): SetChannelByString(10) 2008-02-27 10:10:21.461 Channel(/dev/video1): SetFormat(Default) fmt(NTSC) input(2) 2008-02-27 10:10:21.463 External channel change: /usr/local/bin/RCA2.pl 10 2008-02-27 10:10:21.468 Waiting for External Tuning program to exit 102008-02-27 10:10:22.471 ret_pid(453) child(453) status(0x0) 2008-02-27 10:10:22.476 External Tuning program no longer running 2008-02-27 10:10:22.477 External Tuning program exited with no error 2008-02-27 10:10:22.482 Channel(/dev/video1): InitPictureAttribute(brightness): 128 [ 0, 255] dflt( 128, 0.50, 128) 2008-02-27 10:10:22.488 Channel(/dev/video1): InitPictureAttribute( contrast): 63 [ 0, 127] dflt( 64, 0.50, 257) 2008-02-27 10:10:22.494 Channel(/dev/video1): InitPictureAttribute( colour): 63 [ 0, 127] dflt( 64, 0.50, 257) 2008-02-27 10:10:22.502 Channel(/dev/video1): InitPictureAttribute( hue): 0 [ -128, 127] dflt( 0, 0.50, 128) 2008-02-27 10:10:22.505 TVRec(1001): ClearFlags(NeedToStartRecorder,) -> RunMainLoop, 2008-02-27 10:10:22.507 TVRec(1001): SetFlags(NeedToStartRecorder,) -> RunMainLoop,NeedToStartRecorder, 2008-02-27 10:10:22.509 TVRec(1001): Starting Recorder 2008-02-27 10:10:22.580 Using profile 'Live TV' to record 2008-02-27 10:10:22.582 TVRec(1001): CreateLiveTVRingBuffer() 2008-02-27 10:10:22.584 TVRec(1001): GetProgramRingBufferForLiveTV() 2008-02-27 10:10:23.711 TVRec(1001): StartedRecording(0x872e968) fn(/shares/recordings/LiveTV/1010_20080227101022.mpg) 2008-02-27 10:10:23.728 TFW: Using io multiplier 3, min/max = 16384/131072 2008-02-27 10:10:23.737 Chain: Appended@0 '1010_20080227101022' 2008-02-27 10:10:23.743 TVRec(1001): SetFlags(RingBufferReady,) -> RunMainLoop,NeedToStartRecorder,RingBufferReady, 2008-02-27 10:10:23.757 RecBase(1001:/dev/video1): SetRingBuffer(0xae33c838) '/shares/recordings/LiveTV/1010_20080227101022.mpg' 2008-02-27 10:10:23.759 RecBase(1001:/dev/video1): SetRecording(0xae33b6d8) title(Today) 2008-02-27 10:10:23.764 Channel(/dev/video1): InitPictureAttribute(brightness): 128 [ 0, 255] dflt( 128, 0.50, 128) 2008-02-27 10:10:23.770 Channel(/dev/video1): InitPictureAttribute( contrast): 63 [ 0, 127] dflt( 64, 0.50, 257) 2008-02-27 10:10:23.775 Channel(/dev/video1): InitPictureAttribute( colour): 63 [ 0, 127] dflt( 64, 0.50, 257) 2008-02-27 10:10:23.782 Channel(/dev/video1): InitPictureAttribute( hue): 0 [ -128, 127] dflt( 0, 0.50, 128) 2008-02-27 10:10:23.785 TVRec(1001): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady, 2008-02-27 10:10:23.786 MPEGRec(/dev/video1): usingv4l2(1) has_v4l2_vbi(1) has_buggy_vbi(1) 2008-02-27 10:10:23.816 MPEGRec(/dev/video1) Warning: Stream type 'MPEG-2 TS' is not supported by ivtv driver, using 'MPEG-2 PS' instead. 2008-02-27 10:10:23.960 MPEGRec(/dev/video1) Warning: VBI recording with broken drivers. Upgrade to ivtv 0.10.0 if you experience problems. 2008-02-27 10:10:24.051 MPEGRec(/dev/video1): VBI service: 4096, io size: 0 2008-02-27 10:10:24.075 TVRec(1001): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady, 2008-02-27 10:10:24.075 AutoExpire: CalcParams(): Max required Free Space: 6.0 GB w/freq: 15 min 2008-02-27 10:10:24.078 TVRec(1001): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady, 2008-02-27 10:10:25.130 Expiring 0 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know" 2008-02-27 10:10:25.141 autoexpire: Expiring Program: Expiring 0 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know" 2008-02-27 10:10:25.144 Expiring 20 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know" 2008-02-27 10:10:25.159 autoexpire: Expiring Program: Expiring 20 MBytes for 50627 @ Wed Feb 27 10:00:00 2008 => Stargate SG-1 "The Devil You Know" 2008-02-27 10:10:26.556 TVRec(1001): SetFlags(FrontendReady,) -> FrontendReady,RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady, 2008-02-27 10:10:37.574 TVRec(1001): StopLiveTV(void) curRec: 0x872e968 pseudoRec: 0 2008-02-27 10:10:37.582 TVRec(1001): Changing from WatchingLiveTV to None 2008-02-27 10:10:37.587 TVRec(1001): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady, 2008-02-27 10:10:37.590 TVRec(1001): Request: Program(no) channel() input() flags(KillRec,KillRingBuffer,) 2008-02-27 10:10:37.718 TVRec(1001): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady, 2008-02-27 10:10:37.752 TVRec(1001): FinishedRecording(Today) in recgroup: LiveTV 2008-02-27 10:10:37.755 Chain: Updated endtime for '1010_20080227101022' to 20080227101037 2008-02-27 10:10:37.760 Finished recording Today: channel 1010 2008-02-27 10:10:37.769 scheduler: Finished recording: Today: channel 1010 2008-02-27 10:10:37.773 TVRec(1001): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady, 2008-02-27 10:10:37.775 TVRec(1001): Tearing down RingBuffer 2008-02-27 10:10:37.779 TVRec(1001): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady, 2008-02-27 10:10:38.002 MainServer::HandleAnnounce Playback 2008-02-27 10:10:38.004 adding: pc4 as a client (events: 0) 2008-02-27 10:10:38.009 TVRec(5): Changing from None to WatchingLiveTV 2008-02-27 10:10:38.011 TVRec(5): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, 2008-02-27 10:10:38.013 TVRec(5): Request: Program(no) channel() input() flags(LiveTV,) 2008-02-27 10:10:38.014 ChannelBase(5): Looking for startchannel '110' on input 'DiSEqC v1.3 Input 1' 2008-02-27 10:10:38.038 ChannelBase(5): Found startchannel '110' on input 'DiSEqC v1.3 Input 2' 2008-02-27 10:10:38.041 TVRec(5): HW Tuner: 5->5 2008-02-27 10:10:38.043 TVRec(5): ClearFlags(PENDINGACTIONS,) -> RunMainLoop, 2008-02-27 10:10:38.044 TVRec(5): No recorder yet, calling TuningFrequency 2008-02-27 10:10:38.047 DVBChan(5:5): Opening DVB channel 2008-02-27 10:10:38.049 DVBChan(5:5): SetChannelByString(110): 2008-02-27 10:10:38.064 DVBChan(5:5): 12296900 qpsk a auto auto a a auto a l 2008-02-27 10:10:38.067 DVBChan(5:5): Old Params: 12326060 qpsk a auto auto a a auto a l DVBChan(5:5): New Params: 12296900 qpsk a auto auto a a auto a l 2008-02-27 10:10:38.068 DVBChan(5:5): Tune(): Tuning to 1046900kHz 2008-02-27 10:10:38.084 dvbchannel.cpp:wait_for_backend: Status: 2008-02-27 10:10:38.087 DVBChan(5:5): Tune(): Frequency tuning successful. 2008-02-27 10:10:38.088 DVBChan(5:5): SetChannelByString(110): Tuned to frequency. 2008-02-27 10:10:38.089 TVRec(5): CreateLiveTVRingBuffer() 2008-02-27 10:10:38.091 TVRec(5): GetProgramRingBufferForLiveTV() 2008-02-27 10:10:39.154 TVRec(5): StartedRecording(0x872e968) fn(/shares/recordings/LiveTV/3110_20080227101038.mpg) 2008-02-27 10:10:39.163 TFW: Using io multiplier 3, min/max = 16384/131072 2008-02-27 10:10:39.172 Chain: Appended@1 '3110_20080227101038' 2008-02-27 10:10:39.178 TVRec(5): Starting Signal Monitor 2008-02-27 10:10:39.179 TVRec(5): SetupSignalMonitor(1, 1) 2008-02-27 10:10:39.181 DVBChan(5:5): Opening DVB channel 2008-02-27 10:10:39.195 DVBSM(5): Can measure Signal Strength 2008-02-27 10:10:39.197 DVBSM(5): Can measure S/N 2008-02-27 10:10:39.198 DVBSM(5): Can measure Bit Error Rate 2008-02-27 10:10:39.200 DVBSM(5): Can count Uncorrected Blocks 2008-02-27 10:10:39.201 SM(5)::RemoveFlags: Seen() Match() Wait() 2008-02-27 10:10:39.203 DVBSM(5): DVBSignalMonitor::ctor initial flags Seen() Match() Wait(Sig,SNR,BER,UB,) 2008-02-27 10:10:39.204 TVRec(5): Signal monitor successfully created 2008-02-27 10:10:39.206 TVRec(5): Setting up table monitoring. 2008-02-27 10:10:39.219 Using profile 'Live TV' to record 2008-02-27 10:10:39.221 TVRec(5): DVB service_id 110 on net_id 4100 tsid 6 2008-02-27 10:10:39.223 DTVSM(5)::SetDVBService(transport_id: 6, network_id: 4100, service_id: 110): 2008-02-27 10:10:39.224 SM(5)::RemoveFlags: Seen(PMT,SDT,Crypt,) Match(PMT,SDT,Crypt,) Wait() 2008-02-27 10:10:39.226 SM(5)::AddFlags: Seen() Match() Wait(PMT,NIT,) 2008-02-27 10:10:39.227 SM(5)::AddFlags: Seen() Match() Wait(PMT,NIT,Pos,) 2008-02-27 10:10:39.228 TVRec(5): Successfully set up DVB table monitoring. 2008-02-27 10:10:39.230 SM(5)::Start: begin 2008-02-27 10:10:39.232 DVBSM(5): UpdateValues -- Signal Locked 2008-02-27 10:10:39.233 SM(5)::Start: end 2008-02-27 10:10:39.235 DTVSM(5)::GetStatusList: WaitForPMT seen(0) matching(0) 2008-02-27 10:10:39.236 TVRec(5): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning, 2008-02-27 10:10:39.240 TVRec(5): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning, 2008-02-27 10:10:39.242 TVRec(5): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning, 2008-02-27 10:10:39.243 TVRec(5): SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning, 2008-02-27 10:10:39.245 DummyDTVRecorder -- started 2008-02-27 10:10:39.246 TVRec(5): SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2008-02-27 10:10:39.247 TVRec(5): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2008-02-27 10:10:39.249 TVRec(5): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2008-02-27 10:10:39.252 TVRec(5): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady, 2008-02-27 10:10:39.259 AutoExpire: CalcParams(): Max required Free Space: 7.0 GB w/freq: 15 min