[mythtv-users] TuningSignalCheck: SignalMonitor failed ----- Wrong timeout

John jksjdevelop at gmail.com
Wed Sep 29 11:44:19 UTC 2021


v32-Pre-2807-g8a7505a0ad

I have recently resurrected a USB tuner (Hauppauge Dual HD) which 
performs very well. However it is failing every few days with the 
following error:-

Three instances:-

Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: E TVRecEvent 
tv_rec.cpp:3959 (TuningSignalCheck) TVRec[9]: TuningSignalCheck: 
SignalMonitor failed
Sep 19 20:00:01 tv mythbackend: mythbackend[4247]: E TVRecEvent 
tv_rec.cpp:3959 (TuningSignalCheck) TVRec[9]: TuningSignalCheck: 
SignalMonitor failed
Sep 12 20:00:01 tv mythbackend: mythbackend[1854]: E TVRecEvent 
tv_rec.cpp:3959 (TuningSignalCheck) TVRec[9]: TuningSignalCheck: 
SignalMonitor failed

EIT scanning is running on this mux.

The fact that they all occur at the same time is pretty weird. The 
backend boots up at 17:00 and does a couple of single recordings from 
then until about 18:30. At 20:00 the main recording period starts. The 
above failure is not fatal, later recordings on this mux do work.

The fact that the timeout is only one second is strange as well - the 
timeouts for the tuner are the defaults 3000 signal 6000 tune.

Can anybody give any guidance on what logging is required to debug this 
and I will raise it as a proper issue.

The following log snipit shows the fail at 20:01 for one recording and 
another succeeding on the same mux at the same time?

Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:402 (StartRecording) TVRec[9]: StartRecording("The Great 
British Bake Off")
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:692 (SetRecordingStatus) TVRec[9]: 
SetRecordingStatus(Recording->Aborted) on line 408
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:472 (StartRecording) TVRec[9]: Checking input group recorders 
- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:546 (StartRecording) TVRec[9]: Checking input group recorders 
- done
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: W Scheduler 
recordinginfo.cpp:998 (InsertRecording) RecordingInfo(TV): 
InsertRecording: m_pathname was '/media/library/TV'. This is usually blank.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:794 (StartedRecording) TVRec[9]: 
StartedRecording(20104_2021-09-28T19:00:00Z) 
fn(/media/library/TV/20104_20210928190000.ts)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:4144 (LoadProfile) TVRec[9]: Using profile 'Default' to record
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(CancelNextRecording,) 
-> RunMainLoop,RingBufferReady, @ tv_rec.cpp:591
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:692 (SetRecordingStatus) TVRec[9]: 
SetRecordingStatus(Aborted->Tuning) on line 594
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1060 (HandleStateChange) TVRec[9]: Changing from None to 
RecordingOnly
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: 
ClearFlags(FrontendReady,CancelNextRecording,) -> 
RunMainLoop,RingBufferReady, @ tv_rec.cpp:1299
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3509 (HandleTuning) TVRec[9]: HandleTuning Request: 
Program(ProgramInfo(20104_20210928190000.ts): channame(Channel 4 
HD)#012             startts(Tue Sep 28 19:00:00 2021 GMT) endts(Tue Sep 
28 20:30:00 2021 GMT)#012 recstartts(Tue Sep 28 19:00:00 2021 GMT) 
recendts(Tue Sep 28 20:30:00 2021 GMT)#012             title(The Great 
British Bake Off)) channel() input() flags(Recording,)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3578 (TuningShutdowns) TVRec[9]: 
TuningShutdowns(Program(ProgramInfo(20104_20210928190000.ts): 
channame(Channel 4 HD)#012             startts(Tue Sep 28 19:00:00 2021 
GMT) endts(Tue Sep 28 20:30:00 2021 GMT)#012             recstartts(Tue 
Sep 28 19:00:00 2021 GMT) recendts(Tue Sep 28 20:30:00 2021 
GMT)#012             title(The Great British Bake Off)) channel(4) 
input(DVB-T2) flags(Recording,))
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(PENDINGACTIONS,) -> 
RunMainLoop,RingBufferReady, @ tv_rec.cpp:3645
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3531 (HandleTuning) TVRec[9]: No recorder yet, calling 
TuningFrequency
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3667 (TuningFrequency) TVRec[9]: TuningFrequency
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
cardutil.cpp:2093 (GetConflictingInputs) CardUtil[9]: 
GetConflictingInputs(9) 11,12,13
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3803 (TuningFrequency) TVRec[9]: Starting Signal Monitor
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2044 (SetupSignalMonitor) TVRec[9]: SetupSignalMonitor(1, 0)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/dvbstreamhandler.cpp:46 (Get) DVBSH[9]: Creating new stream 
handler /dev/dvb/adapter0/frontend0
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2068 (SetupSignalMonitor) TVRec[9]: Signal monitor 
successfully created
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1864 (SetupDTVSignalMonitor) TVRec[9]: Setting up table 
monitoring.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4144 (LoadProfile) TVRec[9]: Using profile 'Live TV' to record
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1939 (SetupDTVSignalMonitor) TVRec[9]: DVB service_id 17664 
on net_id 9018 tsid 16520
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1961 (SetupDTVSignalMonitor) TVRec[9]: Successfully set up 
DVB table monitoring.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[9]: SetFlags(SignalMonitorRunning,) -> 
RunMainLoop,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3830
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(WaitingForSignal,) -> 
RunMainLoop,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3831
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[9]: SetFlags(WaitingForSignal,) -> 
RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ 
tv_rec.cpp:3836
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(NeedToStartRecorder,) 
-> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ 
tv_rec.cpp:3897
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[9]: SetFlags(NeedToStartRecorder,) -> 
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,RingBufferReady, 
@ tv_rec.cpp:3899
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4014 (TuningSignalCheck) TVRec[9]: TuningSignalCheck: Still 
waiting.  Will timeout @ 21:29:50.000
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
scheduler.cpp:2876 (HandleRecordingStatusChange) Tuning recording: "The 
Great British Bake Off": channel 20104 on cardid [9], sourceid 2
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:402 (StartRecording) TVRec[11]: StartRecording("Love Your 
Garden":"Woodland Wonders")
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:692 (SetRecordingStatus) TVRec[11]: 
SetRecordingStatus(Unknown->Aborted) on line 408
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:472 (StartRecording) TVRec[11]: Checking input group 
recorders - begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:546 (StartRecording) TVRec[11]: Checking input group 
recorders - done
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: W Scheduler 
recordinginfo.cpp:998 (InsertRecording) RecordingInfo(TV): 
InsertRecording: m_pathname was '/media/library/TV'. This is usually blank.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:794 (StartedRecording) TVRec[11]: 
StartedRecording(20103_2021-09-28T19:00:00Z) 
fn(/media/library/TV/20103_20210928190000.ts)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:4144 (LoadProfile) TVRec[11]: Using profile 'Default' to record
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: ClearFlags(CancelNextRecording,) 
-> RunMainLoop, @ tv_rec.cpp:591
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
tv_rec.cpp:692 (SetRecordingStatus) TVRec[11]: 
SetRecordingStatus(Aborted->Tuning) on line 594
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1060 (HandleStateChange) TVRec[11]: Changing from None to 
RecordingOnly
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: 
ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, @ 
tv_rec.cpp:1299
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3509 (HandleTuning) TVRec[11]: HandleTuning Request: 
Program(ProgramInfo(20103_20210928190000.ts): channame(ITV 
HD)#012             startts(Tue Sep 28 19:00:00 2021 GMT) endts(Tue Sep 
28 20:00:00 2021 GMT)#012 recstartts(Tue Sep 28 19:00:00 2021 GMT) 
recendts(Tue Sep 28 20:00:00 2021 GMT)#012             title(Love Your 
Garden)) channel() input() flags(Recording,)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3578 (TuningShutdowns) TVRec[11]: 
TuningShutdowns(Program(ProgramInfo(20103_20210928190000.ts): 
channame(ITV HD)#012             startts(Tue Sep 28 19:00:00 2021 GMT) 
endts(Tue Sep 28 20:00:00 2021 GMT)#012 recstartts(Tue Sep 28 19:00:00 
2021 GMT) recendts(Tue Sep 28 20:00:00 2021 GMT)#012             
title(Love Your Garden)) channel(3) input(DVB-T2) flags(Recording,))
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: ClearFlags(PENDINGACTIONS,) -> 
RunMainLoop, @ tv_rec.cpp:3645
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3531 (HandleTuning) TVRec[11]: No recorder yet, calling 
TuningFrequency
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3667 (TuningFrequency) TVRec[11]: TuningFrequency
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
cardutil.cpp:2093 (GetConflictingInputs) CardUtil[11]: 
GetConflictingInputs(11) 9,12,13
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3803 (TuningFrequency) TVRec[11]: Starting Signal Monitor
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2044 (SetupSignalMonitor) TVRec[11]: SetupSignalMonitor(1, 0)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/dvbstreamhandler.cpp:54 (Get) DVBSH[11]: Using existing stream 
handler for /dev/dvb/adapter0/frontend0 (2 in use)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2068 (SetupSignalMonitor) TVRec[11]: Signal monitor 
successfully created
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1864 (SetupDTVSignalMonitor) TVRec[11]: Setting up table 
monitoring.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4144 (LoadProfile) TVRec[11]: Using profile 'Live TV' to record
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1978 (SetupDTVSignalMonitor) TVRec[11]: MPEG program number: 
17608
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
mpeg/mpegstreamdata.cpp:73 (SetDesiredProgram) 
MPEGStream[11](0x7fbc6401ae90): SetDesiredProgram(17608)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:1998 (SetupDTVSignalMonitor) TVRec[11]: Successfully set up 
MPEG table monitoring.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[11]: SetFlags(SignalMonitorRunning,) -> 
RunMainLoop,SignalMonitorRunning, @ tv_rec.cpp:3830
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: ClearFlags(WaitingForSignal,) -> 
RunMainLoop,SignalMonitorRunning, @ tv_rec.cpp:3831
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[11]: SetFlags(WaitingForSignal,) -> 
RunMainLoop,WaitingForSignal,SignalMonitorRunning, @ tv_rec.cpp:3836
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: ClearFlags(NeedToStartRecorder,) 
-> RunMainLoop,WaitingForSignal,SignalMonitorRunning, @ tv_rec.cpp:3897
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[11]: SetFlags(NeedToStartRecorder,) -> 
RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning, @ 
tv_rec.cpp:3899
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4014 (TuningSignalCheck) TVRec[11]: TuningSignalCheck: Still 
waiting.  Will timeout @ 20:59:50.000
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
scheduler.cpp:2876 (HandleRecordingStatusChange) Tuning recording: "Love 
Your Garden":"Woodland Wonders": channel 20103 on cardid [11], sourceid 2
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: N Scheduler 
scheduler.cpp:3234 (HandleIdleShutdown) Blocking shutdown because of an 
active encoder
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: N Scheduler 
scheduler.cpp:3245 (HandleIdleShutdown) Blocking shutdown because of 
delay request from external application
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
scheduler.cpp:2309 (HandleReschedule) Reschedule requested for MATCH 
8001 0 0 - SaveRule World's Most Scenic Railway
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: C CoreContext 
programinfo.cpp:256 (ProgramInfo) ProgramInfo(): Failed to find recorded 
entry for 0.
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I Scheduler 
scheduler.cpp:2423 (HandleReschedule) Scheduled 79 items in 0.1 = 0.01 
match + 0.00 check + 0.07 place
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I SignalMonitor 
recorders/streamhandler.cpp:40 (AddListener) SH[9]: 
AddListener(0x7fbc6401ae90) -- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I SignalMonitor 
recorders/streamhandler.cpp:52 (AddListener) SH[9]: 
AddListener(0x7fbc6401ae90) -- locked
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I SignalMonitor 
recorders/streamhandler.cpp:74 (AddListener) SH[9]: 
AddListener(0x7fbc6401ae90) -- end
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I SignalMonitor 
recorders/streamhandler.cpp:40 (AddListener) SH[9]: 
AddListener(0x7fbc7402abe8) -- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I SignalMonitor 
recorders/streamhandler.cpp:52 (AddListener) SH[9]: 
AddListener(0x7fbc7402abe8) -- locked
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I SignalMonitor 
recorders/streamhandler.cpp:74 (AddListener) SH[9]: 
AddListener(0x7fbc7402abe8) -- end
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:3925 (TuningSignalCheck) TVRec[11]: TuningSignalCheck: Good 
signal
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:692 (SetRecordingStatus) TVRec[11]: 
SetRecordingStatus(Tuning->Recording) on line 4023
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2101 (TeardownSignalMonitor) TVRec[11]: 
TeardownSignalMonitor() -- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I CoreContext 
scheduler.cpp:706 (UpdateRecStatus) Updating status for "Love Your 
Garden":"Woodland Wonders" on cardid [11] (Tuning => Recording)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/streamhandler.cpp:82 (RemoveListener) SH[9]: 
RemoveListener(0x7fbc6401ae90) -- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/streamhandler.cpp:94 (RemoveListener) SH[9]: 
RemoveListener(0x7fbc6401ae90) -- locked
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/streamhandler.cpp:111 (RemoveListener) SH[9]: 
RemoveListener(0x7fbc6401ae90) -- end
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2120 (TeardownSignalMonitor) TVRec[11]: 
TeardownSignalMonitor() -- end
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: 
ClearFlags(SignalMonitorRunning,) -> 
RunMainLoop,WaitingForSignal,NeedToStartRecorder, @ tv_rec.cpp:4049
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: ClearFlags(WaitingForSignal,) -> 
RunMainLoop,NeedToStartRecorder, @ tv_rec.cpp:4051
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4176 (TuningNewRecorder) TVRec[11]: Starting Recorder
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4144 (LoadProfile) TVRec[11]: Using profile 'Default' to record
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4214 (TuningNewRecorder) TVRec[11]: rec->GetPathname(): 
'/media/library/TV/20103_20210928190000.ts'
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4247 (TuningNewRecorder) TVRec[11]: TuningNewRecorder - 
CreateRecorder()
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/dtvrecorder.cpp:140 (ResetForNewFile) DTVRec[11]: 
ResetForNewFile(void)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/recorderbase.cpp:81 (SetRingBuffer) 
RecBase[11](/dev/dvb/adapter0/frontend0): SetRingBuffer(0x7fbc64004c00) 
'/media/library/TV/20103_20210928190000.ts'
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/recorderbase.cpp:92 (SetRecording) 
RecBase[11](/dev/dvb/adapter0/frontend0): SetRecording(0x7fbc4403da60) 
title(Love Your Garden)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
mpeg/mpegstreamdata.cpp:73 (SetDesiredProgram) 
MPEGStream[11](0x7fbc6401ae90): SetDesiredProgram(17608)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/dtvrecorder.cpp:1281 (HandlePAT) DTVRec[11]: SetPAT(17608 on 
pid 0xc8)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(17608, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/dtvrecorder.cpp:1307 (HandlePMT) DTVRec[11]: SetPMT(17608)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/dtvrecorder.cpp:140 (ResetForNewFile) DTVRec[11]: 
ResetForNewFile(void)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/dvbstreamhandler.cpp:54 (Get) DVBSH[11]: Using existing stream 
handler for /dev/dvb/adapter0/frontend0 (2 in use)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/dvbrecorder.cpp:68 (Open) 
DVBRec[11](/dev/dvb/adapter0/frontend0): Card opened successfully
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4429 (SetFlags) TVRec[11]: 
SetFlags(RecorderRunning,RingBufferReady,) -> 
RunMainLoop,NeedToStartRecorder,RecorderRunning,RingBufferReady, @ 
tv_rec.cpp:4318
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[11]: ClearFlags(NeedToStartRecorder,) 
-> RunMainLoop,RecorderRunning,RingBufferReady, @ tv_rec.cpp:4320
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/streamhandler.cpp:40 (AddListener) SH[9]: 
AddListener(0x7fbc6401ae90) -- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/streamhandler.cpp:52 (AddListener) SH[9]: 
AddListener(0x7fbc6401ae90) -- locked
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/streamhandler.cpp:124 (Start) SH[9]: Restarting StreamHandler
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/DeviceReadBuffer.cpp:99 (Setup) 
DevRdB(/dev/dvb/adapter0/frontend0): buffer size 18800 KB
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/DeviceReadBuffer.cpp:106 (Start) 
DevRdB(/dev/dvb/adapter0/frontend0): Start() -- begin
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/DeviceReadBuffer.cpp:124 (Start) 
DevRdB(/dev/dvb/adapter0/frontend0): Start() -- middle
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/DeviceReadBuffer.cpp:129 (Start) 
DevRdB(/dev/dvb/adapter0/frontend0): Start() -- end
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(20256, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(18112, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(17472, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(17664, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I RecThread 
recorders/streamhandler.cpp:74 (AddListener) SH[9]: 
AddListener(0x7fbc6401ae90) -- end
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(17728, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(17540, valid)
Sep 28 20:00:00 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1301 (HandlePMT) DTVRec[11]: SetPMT(20160, valid)
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: E TVRecEvent 
tv_rec.cpp:3959 (TuningSignalCheck) TVRec[9]: TuningSignalCheck: 
SignalMonitor failed
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(NeedToStartRecorder,) 
-> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ 
tv_rec.cpp:3962
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:692 (SetRecordingStatus) TVRec[9]: 
SetRecordingStatus(Tuning->Recorder Failed) on line 4023
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2101 (TeardownSignalMonitor) TVRec[9]: 
TeardownSignalMonitor() -- begin
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I CoreContext 
scheduler.cpp:706 (UpdateRecStatus) Updating status for "The Great 
British Bake Off" on cardid [9] (Tuning => Recorder Failed)
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I Scheduler 
scheduler.cpp:2309 (HandleReschedule) Reschedule requested for CHECK -9 
7973 0 UpdateRecStatus2 | The Great British Bake Off | | It's crunch 
time for the bakers in Biscuit Week, as they put their twist on brandy 
snaps, make a jammy childhood favourite and create an interactive toy 
made entirely from biscuit. (S5 Ep2) | www.channel4.com/70301/002
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/streamhandler.cpp:82 (RemoveListener) SH[9]: 
RemoveListener(0x7fbc7402abe8) -- begin
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/streamhandler.cpp:94 (RemoveListener) SH[9]: 
RemoveListener(0x7fbc7402abe8) -- locked
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
recorders/streamhandler.cpp:111 (RemoveListener) SH[9]: 
RemoveListener(0x7fbc7402abe8) -- end
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:2120 (TeardownSignalMonitor) TVRec[9]: 
TeardownSignalMonitor() -- end
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(SignalMonitorRunning,) 
-> RunMainLoop,WaitingForSignal,RingBufferReady, @ tv_rec.cpp:4049
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I TVRecEvent 
tv_rec.cpp:4438 (ClearFlags) TVRec[9]: ClearFlags(WaitingForSignal,) -> 
RunMainLoop,RingBufferReady, @ tv_rec.cpp:4051
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I Scheduler 
scheduler.cpp:2423 (HandleReschedule) Scheduled 79 items in 0.1 = 0.00 
match + 0.01 check + 0.06 place
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1018 (FindH2645Keyframes) DTVRec[11]: 
FindH2645Keyframes: timescale: 50, tick: 1, framerate: 25000
Sep 28 20:00:01 tv mythbackend: mythbackend[1523]: I DVBRead 
recorders/dtvrecorder.cpp:1634 (ProcessAVTSPacket) DTVRec[11]: PID 0xc9 
Found Payload Start



More information about the mythtv-users mailing list