[mythtv-users] livetv dies or sometimes fails to stat with HDHomerun Prime

Sun Nov 13 18:34:16 UTC 2011

I'm having this problem where livetv just stops or sometimes even
fails to start when another tuner on my prime is busy.
I'm logging mythbackend with general,important,record and this is a
sample of the log across where livetv just dies.  Any help is
appreciated.

2011-11-13 09:00:06.419 HDHRSH(192.168.1.102-0): RunTS(): begin
2011-11-13 09:00:06.485 HDHRRec(1): SetPAT(704 on 0x229)
2011-11-13 09:00:06.493 HDHRSH(192.168.1.102-0) Error: UpdateFilters
called in wrong tune mode
2011-11-13 09:00:06.501 CreatePATSingleProgram()
2011-11-13 09:00:06.518 PAT in input stream
2011-11-13 09:00:06.526 Program Association Table
2011-11-13 09:00:06.535 desired_program(704) pid(0x229)
2011-11-13 09:00:06.543 pmt_pid(0x229)
2011-11-13 09:00:06.551 PAT for output stream
2011-11-13 09:00:06.560 Program Association Table
2011-11-13 09:00:06.568 HDHRRec(1): SetPMT(704)
2011-11-13 09:00:06.576 CreatePMTSingleProgram()
2011-11-13 09:00:06.585 PMT in input stream
2011-11-13 09:00:06.593 Program Map Table ver(0) pid(0x229) pnum(704) len(78)
2011-11-13 09:00:06.643 PMT for output stream
2011-11-13 09:00:06.651 Program Map Table ver(0) pid(0x229) pnum(1) len(78)
2011-11-13 09:00:06.660 RecBase(1:1): SetRecording(0xb0c66680) title(Today)
2011-11-13 09:00:06.669 HDHRRec(1): StartRecording -- begin
2011-11-13 09:00:06.676 HDHRSH: Using existing stream handler
101430AA-0 for 101430AA-0 (2 in use)
2011-11-13 09:00:06.684 HDHRRec(1): HDHR opened successfully
2011-11-13 09:00:06.693 HDHRSH(101430AA-0): AddListener(0x8a2efd8) -- begin
2011-11-13 09:00:06.694 TVRec(1):
SetFlags(RecorderRunning,RingBufferReady,) ->
RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady,
2011-11-13 09:00:06.701 HDHRSH(101430AA-0): AddListener(0x8a2efd8) -- locked
2011-11-13 09:00:06.709 TVRec(1): ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,RecorderRunning,RingBufferReady,
2011-11-13 09:00:06.718 HDHRSH(101430AA-0): AddListener(0x8a2efd8) -- end
2011-11-13 09:00:06.782 HDHRSH(101430AA-0): RunTS(): begin
2011-11-13 09:00:06.826 FindMPEG2Keyframes: frame rate = 29970
2011-11-13 09:00:06.835 PID 0x8c Found Payload Start
2011-11-13 09:00:06.863 PID 0x8d Found Payload Start
2011-11-13 09:00:07.127 FindMPEG2Keyframes: frame rate = 29970
2011-11-13 09:00:07.135 PID 0x220 Found Payload Start
2011-11-13 09:00:07.239 PID 0x222 Found Payload Start
2011-11-13 09:00:07.268 PID 0x221 Found Payload Start
2011-11-13 09:07:27.664 TVRec(18): StopLiveTV(void) curRec: 0xb0c276d0
pseudoRec: 0x0
2011-11-13 09:07:27.676 TVRec(18): Changing from WatchingLiveTV to None
2011-11-13 09:07:27.683 TVRec(18):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,RecorderRunning,RingBufferReady,
2011-11-13 09:07:27.692 TVRec(18): HandleTuning Request: Program(no)
channel() input() flags(KillRec,KillRingBuffer,)
2011-11-13 09:07:27.718 HDHRRec(18): StartRecording -- ending...
2011-11-13 09:07:27.733 HDHRSH(192.168.1.102-2):
RemoveListener(0x82cc3a8) -- begin

2011-11-13 09:07:27.742 HDHRSH(192.168.1.102-2):
RemoveListener(0x82cc3a8) -- locked
2011-11-13 09:07:27.750 HDHRSH(192.168.1.102-2) Error: UpdateFilters
called in wrong tune mode
2011-11-13 09:07:27.763 HDHRSH(192.168.1.102-2): RunTS(): shutdown
2011-11-13 09:07:27.775 HDHRSH(192.168.1.102-2) Error: UpdateFilters
called in wrong tune mode
2011-11-13 09:07:28.284 HDHRSH(192.168.1.102-2): RunTS(): end
2011-11-13 09:07:28.291 HDHRSH(192.168.1.102-2):
RemoveListener(0x82cc3a8) -- end
2011-11-13 09:07:28.300 HDHRRec(18): Close() -- begin
2011-11-13 09:07:28.308 HDHRRec(18): Close() -- end
2011-11-13 09:07:28.349 HDHRRec(18): StartRecording -- end
2011-11-13 09:07:28.358 TVRec(18): ClearFlags(RecorderRunning,) ->
RunMainLoop,RingBufferReady,
2011-11-13 09:07:28.375 HDHRRec(18): Close() -- begin
2011-11-13 09:07:28.383 HDHRRec(18): Close() -- end
2011-11-13 09:07:28.391 RecBase(18:18): SetRecording(0x0)
2011-11-13 09:07:28.400 TVRec(18): FinishedRecording(Eyewitness News
This Morning) in recgroup: LiveTV
2011-11-13 09:07:28.408 Chain: Updated endtime for
'5707_20111113090000' to 20111113090728
2011-11-13 09:07:28.419 HDHRSH(192.168.1.102-2): Tuning channel none
(was qam:699000000)
2011-11-13 09:07:28.427 TVRec(18): ClearFlags(RecorderRunning,) ->
RunMainLoop,RingBufferReady,
2011-11-13 09:07:28.433 HDHRSH: Closing handler for 192.168.1.102-2
2011-11-13 09:07:28.525 HDHRSH(192.168.1.102-2): Not Re-Tuning channel none
2011-11-13 09:07:28.557 TVRec(18): Tearing down RingBuffer
2011-11-13 09:07:28.567 TVRec(18): ClearFlags(PENDINGACTIONS,) ->
RunMainLoop,RingBufferReady,
2011-11-13 09:07:28.576 TVRec(18): SetFlags(FrontendReady,) ->
FrontendReady,RunMainLoop,RingBufferReady,
2011-11-13 09:07:28.595 Getting next free recorder after : -1
2011-11-13 09:07:28.601 Checking card 1. Best card so far -1
2011-11-13 09:07:28.608 Checking card 2. Best card so far 2
2011-11-13 09:07:28.619 Checking card 4. Best card so far 4
2011-11-13 09:07:28.626 Checking card 14. Best card so far 4
2011-11-13 09:07:28.633 Checking card 16. Best card so far 16
2011-11-13 09:07:28.642 Checking card 18. Best card so far 18
2011-11-13 09:07:28.666 MainServer::ANN Playback
2011-11-13 09:07:28.674 adding: LivingRoom-Dell1525 as a client (events: 0)
2011-11-13 09:07:28.716 TVRec(18): Found channel (707) on current card(18).
2011-11-13 09:07:28.727 TVRec(18): Changing from None to WatchingLiveTV
2011-11-13 09:07:28.733 TVRec(18):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,RingBufferReady,
2011-11-13 09:07:28.741 TVRec(18): HandleTuning Request: Program(no)
channel() input() flags(LiveTV,)
2011-11-13 09:07:28.753 TVRec(18): HW Tuner: 18->18
2011-11-13 09:07:28.758 TVRec(18): ClearFlags(PENDINGACTIONS,) ->
RunMainLoop,RingBufferReady,
2011-11-13 09:07:28.766 TVRec(18): No recorder yet, calling TuningFrequency
2011-11-13 09:07:28.785 HDHRSH(192.168.1.102-2): Successfully
connected to device
2011-11-13 09:07:28.791 HDHRSH: Creating new stream handler
192.168.1.102-2 for 192.168.1.102-2
2011-11-13 09:07:28.814 TVRec(18): CreateLiveTVRingBuffer(707)
2011-11-13 09:07:28.825 TVRec(18): GetProgramRingBufferForLiveTV()
2011-11-13 09:07:28.834 LoadFromScheduler(): Error, called from backend.
2011-11-13 09:07:28.846 TVRec(18): StartedRecording(0x88e0358)
fn(/mnt/video/livetv/5707_20111113090728.mpg)
2011-11-13 09:07:28.849 AutoExpire: CalcParams(): Max required Free
Space: 6.0 GB w/freq: 4 min
2011-11-13 09:07:28.860 Chain: Appended at 0 '5707_20111113090728'
2011-11-13 09:07:28.878 TVRec(18): Starting Signal Monitor
2011-11-13 09:07:28.883 TVRec(18): SetupSignalMonitor(1, 1)
2011-11-13 09:07:28.891 HDHRSH: Using existing stream handler
192.168.1.102-2 for 192.168.1.102-2 (2 in use)
2011-11-13 09:07:28.899 TVRec(18): Signal monitor successfully created
2011-11-13 09:07:28.881 HDHRSH(192.168.1.102-2): Tuning vchannel 707
2011-11-13 09:07:28.908 TVRec(18): SetFlags(SignalMonitorRunning,) ->
RunMainLoop,SignalMonitorRunning,RingBufferReady,
2011-11-13 09:07:28.924 TVRec(18): ClearFlags(WaitingForSignal,) ->
RunMainLoop,SignalMonitorRunning,RingBufferReady,
2011-11-13 09:07:28.933 TVRec(18): SetFlags(WaitingForSignal,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady,
2011-11-13 09:07:28.941 TVRec(18): SetFlags(DummyRecorderRunning,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2011-11-13 09:07:28.949 DummyDTVRecorder -- started
2011-11-13 09:07:28.958 TVRec(18): SetFlags(RingBufferReady,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,

2011-11-13 09:07:28.949 DummyDTVRecorder -- started
2011-11-13 09:07:28.958 TVRec(18): SetFlags(RingBufferReady,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2011-11-13 09:07:28.958 TVRec(18): Setting up table monitoring.
2011-11-13 09:07:28.966 TVRec(18): ClearFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,SignalMonitorRunning,DummyRecorderRunning,RingBufferReady,
2011-11-13 09:07:28.977 Using profile 'Live TV' to record
2011-11-13 09:07:28.983 TVRec(18): SetFlags(NeedToStartRecorder,) ->
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorderRunning,RingBuf$
2011-11-13 09:07:28.991 TVRec(18): MPEG program number: 0
2011-11-13 09:07:29.007 TVRec(18): Successfully set up MPEG table monitoring.
2011-11-13 09:07:29.016 TVRec(18): SetFlags(CancelNextRecording,) ->
RunMainLoop,CancelNextRecording,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRec$
2011-11-13 09:07:29.057 TVRec(18): StopLiveTV(void) curRec: 0x88e0358
pseudoRec: 0x0
2011-11-13 09:07:29.158 TVRec(18): Changing from WatchingLiveTV to None
2011-11-13 09:07:29.191 TVRec(18):
ClearFlags(FrontendReady,CancelNextRecording,) ->
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,DummyRecorde$
2011-11-13 09:07:29.199 TVRec(18): HandleTuning Request: Program(no)
channel() input() flags(KillRec,KillRingBuffer,)
2011-11-13 09:07:29.207 TVRec(18): TeardownSignalMonitor() -- begin
2011-11-13 09:07:29.222 HDHRSH(192.168.1.102-2):
RemoveListener(0x9a61a3a8) -- begin
2011-11-13 09:07:29.232 HDHRSH(192.168.1.102-2):
RemoveListener(0x9a61a3a8) -- locked
2011-11-13 09:07:29.241 HDHRSH(192.168.1.102-2):
RemoveListener(0x9a61a3a8) -- end
2011-11-13 09:07:29.249 TVRec(18): TeardownSignalMonitor() -- end
2011-11-13 09:07:29.257 TVRec(18): ClearFlags(SignalMonitorRunning,)
-> RunMainLoop,WaitingForSignal,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2011-11-13 09:07:29.266 TVRec(18): ClearFlags(WaitingForSignal,) ->
RunMainLoop,NeedToStartRecorder,DummyRecorderRunning,RingBufferReady,
2011-11-13 09:07:29.274 TVRec(18): ClearFlags(DummyRecorderRunning,)
-> RunMainLoop,NeedToStartRecorder,RingBufferReady,
2011-11-13 09:07:29.283 TVRec(18): FinishedRecording(Eyewitness News
This Morning) in recgroup: LiveTV
2011-11-13 09:07:29.291 Chain: Updated endtime for
'5707_20111113090728' to 20111113090729
2011-11-13 09:07:29.300 TVRec(18): ClearFlags(RecorderRunning,) ->
RunMainLoop,NeedToStartRecorder,RingBufferReady,
2011-11-13 09:07:29.308 TVRec(18): FinishedRecording(Eyewitness News
This Morning) in recgroup: LiveTV
2011-11-13 09:07:29.316 Chain: Updated endtime for
'5707_20111113090728' to 20111113090729
2011-11-13 09:07:29.325 HDHRSH(192.168.1.102-2): Tuning channel none
(was qam:699000000)
2011-11-13 09:07:29.334 TVRec(18): ClearFlags(RecorderRunning,) ->
RunMainLoop,NeedToStartRecorder,RingBufferReady,
2011-11-13 09:07:29.341 HDHRSH: Closing handler for 192.168.1.102-2
2011-11-13 09:07:29.349 HDHRSH(192.168.1.102-2): Not Re-Tuning channel none
2011-11-13 09:07:29.357 TVRec(18): Tearing down RingBuffer
2011-11-13 09:07:29.366 TVRec(18): ClearFlags(PENDINGACTIONS,) ->
RunMainLoop,RingBufferReady,
2011-11-13 09:07:35.699 MainServer::ANN Monitor
2011-11-13 09:07:35.711 adding: LivingRoom-Dell1525 as a client (events: 0)
2011-11-13 09:07:35.721 MainServer::ANN Monitor
2011-11-13 09:07:35.728 adding: LivingRoom-Dell1525 as a client (events: 1)