012-03-28 19:26:01.771205 I  Checking card 8. Best card so far 5
2012-03-28 19:26:01.773042 I  Best card is 5
2012-03-28 19:26:01.786895 I  MainServer::ANN Playback
2012-03-28 19:26:01.786901 I  adding: bugs as a client (events: 0)
2012-03-28 19:26:01.818488 I  TVRec(5): Found channel (49) on different card(8).
2012-03-28 19:26:01.836379 I  MainServer::ANN Playback
2012-03-28 19:26:01.836384 I  adding: bugs as a client (events: 0)
2012-03-28 19:26:01.839542 I  TVRec(8): Changing from None to WatchingLiveTV
2012-03-28 19:26:01.839566 I  TVRec(8): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RingBufferReady,
2012-03-28 19:26:01.839575 I  TVRec(8): HandleTuning Request: Program(NULL) channel() input() flags(LiveTV,)
2012-03-28 19:26:01.846602 I  TVRec(8): HW Tuner: 8->8
2012-03-28 19:26:01.846616 I  TVRec(8): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,
2012-03-28 19:26:01.846623 I  TVRec(8): No recorder yet, calling TuningFrequency
2012-03-28 19:26:01.863301 I  V4LChannel(/dev/video0): SetInputAndFormat(5, NTSC) (v4l v2) input_switch: 0 mode_switch: 1
2012-03-28 19:26:02.184829 I  TVRec(8): CreateLiveTVRingBuffer(49)
2012-03-28 19:26:02.185961 I  TVRec(8): GetProgramRingBufferForLiveTV()
2012-03-28 19:26:02.194420 N  AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 15 min
2012-03-28 19:26:02.298152 I  TVRec(8): StartedRecording(0xe8fa70) fn(/share/TV/recordings/6049_20120328192602.nuv)
2012-03-28 19:26:02.302687 I  Chain: Appended@0 '6049_20120328192602'
2012-03-28 19:26:02.306972 I  TVRec(8): Starting Signal Monitor
2012-03-28 19:26:02.306982 I  TVRec(8): SetupSignalMonitor(1, 1)
2012-03-28 19:26:02.307005 I  TVRec(8): Signal monitor successfully created
2012-03-28 19:26:02.312042 I  TVRec(8): SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady,
2012-03-28 19:26:02.312053 I  TVRec(8): ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady,
2012-03-28 19:26:02.312060 I  TVRec(8): SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
2012-03-28 19:26:02.312068 I  TVRec(8): SetFlags(DummyRecorderRunning,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.312071 I  DummyDTVRecorder -- started
2012-03-28 19:26:02.312077 I  TVRec(8): SetFlags(RingBufferReady,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.312085 I  TVRec(8): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.312093 I  TVRec(8): SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.312101 I  TVRec(8): Got good signal
2012-03-28 19:26:02.312133 I  TVRec(8): TeardownSignalMonitor() -- begin
2012-03-28 19:26:02.362308 I  TVRec(8): TeardownSignalMonitor() -- end
2012-03-28 19:26:02.362325 I  TVRec(8): ClearFlags(SignalMonitorRunning,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.362333 I  TVRec(8): ClearFlags(WaitingForSignal,) -> RunMainLoop,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.362400 I  TVRec(8): SetFlags(CancelNextRecording,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2012-03-28 19:26:02.362507 I  TVRec(8): Starting Recorder
2012-03-28 19:26:02.364346 I  TVRec(8): FinishedRecording(Little House on the Prairie)
			key: 6049_2012-03-28T19:26:02
			in recgroup: LiveTV status: Recording:Recorded is_dummy finished_now
2012-03-28 19:26:02.365922 I  Chain: Updated endtime for '6049_20120328192602' to 20120328192602
2012-03-28 19:26:02.368362 I  TVRec(8): ClearFlags(DummyRecorderRunning,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RingBufferReady,
2012-03-28 19:26:02.434378 I  Using profile 'Live TV' to record
2012-03-28 19:26:02.434391 I  TVRec(8): SwitchLiveTVRingBuffer(discont 1, set_rec 0
2012-03-28 19:26:02.435571 I  TVRec(8): GetProgramRingBufferForLiveTV()
2012-03-28 19:26:02.443717 N  AutoExpire: CalcParams(): Max required Free Space: 3.0 GB w/freq: 15 min
2012-03-28 19:26:02.507789 E  RecordingInfo::InsertProgram(ProgramInfo(6049_20120328192602.nuv): channame(Hallmark Channel) startts(Wed Mar 28 19:00:00 2012) endts(Wed Mar 28 20:00:00 2012)
             recstartts(Wed Mar 28 19:26:02 2012) recendts(Wed Mar 28 20:00:00 2012)
             title(Little House on the Prairie)): recording already exists...
2012-03-28 19:26:02.524365 I  TVRec(8): StartedRecording(0xbc1e60) fn(/share/TV/recordings/6049_20120328192603.nuv)
2012-03-28 19:26:02.538703 I  TVRec(8): FinishedRecording(Little House on the Prairie)
			key: 6049_2012-03-28T19:26:02
			in recgroup: LiveTV status: Recorded:Recorded not_dummy already_finished
2012-03-28 19:26:02.547368 I  Chain: Appended@1 '6049_20120328192603'
2012-03-28 19:26:02.550295 I  DTVRec(8): ResetForNewFile(void)
2012-03-28 19:26:02.562982 E  NVR(/dev/video0): Unknown video codec.  Please go into the TV Settings, Recording Profiles and setup the four 'Software Encoders' profiles.  Assuming RTjpeg for now.
2012-03-28 19:26:02.563005 E  NVR(/dev/video0): Unknown audio codec
2012-03-28 19:26:02.563021 I  RecBase(8:/dev/video0): SetRingBuffer(0x1162c50) '/share/TV/recordings/6049_20120328192603.nuv'
2012-03-28 19:26:02.582844 I  RecBase(8:/dev/video0): SetRecording(0xbc1e60) title(Little House on the Prairie)
2012-03-28 19:26:02.595239 I  NVR(/dev/video0): v4l2: format set, getting yuyv from v4l, converting
2012-03-28 19:26:02.616577 I  NVR(/dev/video0): NVR: frame rate = 29970
2012-03-28 19:26:02.620640 I  TVRec(8): SetFlags(RecorderRunning,RingBufferReady,) -> RunMainLoop,CancelNextRecording,NeedToStartRecorder,RecorderRunning,RingBufferReady,
2012-03-28 19:26:02.620671 I  TVRec(8): ClearFlags(NeedToStartRecorder,) -> RunMainLoop,CancelNextRecording,RecorderRunning,RingBufferReady,
2012-03-28 19:26:02.646877 I  TVRec(8): StopLiveTV(void) curRec: 0xbc1e60 pseudoRec: 0x0
2012-03-28 19:26:02.648375 I  TVRec(8): Changing from WatchingLiveTV to None
2012-03-28 19:26:02.648397 I  TVRec(8): ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop,RecorderRunning,RingBufferReady,
2012-03-28 19:26:02.648408 I  TVRec(8): HandleTuning Request: Program(NULL) channel() input() flags(KillRec,KillRingBuffer,)
2012-03-28 19:26:03.011686 I  TVRec(8): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
2012-03-28 19:26:03.012843 I  RecBase(8:/dev/video0): SetRecording(0x0)
2012-03-28 19:26:03.014474 I  TVRec::FinishedRecording(Little House on the Prairie) good recq:<RecordingQuality overall_score="1" key="6049_2012-03-28T19:26:03" />

2012-03-28 19:26:03.014529 I  TVRec(8): FinishedRecording(Little House on the Prairie)
			key: 6049_2012-03-28T19:26:03
			in recgroup: LiveTV status: Recorder Failed:Recorder Failed not_dummy finished_now
2012-03-28 19:26:03.015676 I  Chain: Updated endtime for '6049_20120328192603' to 20120328192603
2012-03-28 19:26:03.017863 I  SaveVideoProperties(0x38, 0x20)
2012-03-28 19:26:03.023941 I  TVRec(8): ClearFlags(RecorderRunning,) -> RunMainLoop,RingBufferReady,
2012-03-28 19:26:03.023953 I  TVRec(8): Tearing down RingBuffer
2012-03-28 19:26:03.024136 I  TVRec(8): ClearFlags(PENDINGACTIONS,) -> RunMainLoop,RingBufferReady,


