Hauppauge 850q/950q recordings fail

Have a MythTV related problem? Ask for help from other MythTV users here.

Moderator: Forum Moderators

Post Reply
Nickl1996
Newcomer
Posts: 3
Joined: Sun Apr 07, 2019 12:17 pm
United States of America

Hauppauge 850q/950q recordings fail

Post by Nickl1996 » Sun Apr 07, 2019 12:30 pm

In running myth fixes 0.30 and I still get intermittent zero byte recording failures.

I have both a hauppauge 850q and a 950q both set for max recordings of 2.

Thought I'd see if anyone knows how the signal monitor works. I noticed that when my recordings fail, I never get SetTVCT or SetProgramNumber in the backend.log:

2019-04-06T09:30:01.117848-05:00 mythbackend[16036]: I TVRecEvent recorders/dtvsignalmonitor.cpp:206 (SetChannel) DTVSigMon[1](/dev/dvb/adapter_static_dvb_1/frontend0)::SetChannel(19, 3):
2019-04-06T09:30:01.118168-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:1943 (SetupDTVSignalMonitor) TVRec[1]: Successfully set up ATSC table monitoring.
2019-04-06T09:30:01.118417-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4446 (SetFlags) TVRec[1]: SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3846
2019-04-06T09:30:01.118660-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4455 (ClearFlags) TVRec[1]: ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3847
2019-04-06T09:30:01.118897-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4446 (SetFlags) TVRec[1]: SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3852
2019-04-06T09:30:01.119127-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4455 (ClearFlags) TVRec[1]: ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3913
2019-04-06T09:30:01.119352-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4446 (SetFlags) TVRec[1]: SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3915
2019-04-06T09:30:01.119574-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4033 (TuningSignalCheck) TVRec[1]: TuningSignalCheck: Still waiting. Will timeout @ 09:59:50.000
2019-04-06T09:30:01.119829-05:00 mythbackend[16036]: I Scheduler scheduler.cpp:2936 (HandleRecordingStatusChange) Tuning recording: "The Pink Panther Show":"Pink Quackers": channel 1193 on cardid [1], sourceid 1
2019-04-06T09:30:01.120247-05:00 mythbackend[16036]: I Scheduler scheduler.cpp:2356 (HandleReschedule) Reschedule requested for CHECK -3 32 0 UpdateRecStatus2 | The Henry Ford's Innovation Nation | Speed Reading App | An app that helps increase reading speed; tape that helps athletes stay on the playing field; a phone case with pop-out legs protects against falls; microwave ovens. | EP019919100123
2019-04-06T09:30:01.120558-05:00 mythbackend[16036]: I SignalMonitor recorders/dvbsignalmonitor.cpp:302 (UpdateValues) DVBSigMon[1](/dev/dvb/adapter_static_dvb_1/frontend0): UpdateValues -- Signal Locked
2019-04-06T09:30:01.120795-05:00 mythbackend[16036]: I SignalMonitor recorders/streamhandler.cpp:57 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_1/frontend0): AddListener(0x7ff9b4331358) -- begin
2019-04-06T09:30:01.121025-05:00 mythbackend[16036]: I SignalMonitor recorders/streamhandler.cpp:69 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_1/frontend0): AddListener(0x7ff9b4331358) -- locked
2019-04-06T09:30:01.214889-05:00 mythbackend[16036]: I SignalMonitor recorders/streamhandler.cpp:91 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_1/frontend0): AddListener(0x7ff9b4331358) -- end


When I have a good recording they happen right after what I pasted above:


2019-04-06T09:00:00.831183-05:00 mythbackend[16036]: I TVRecEvent recorders/dtvsignalmonitor.cpp:206 (SetChannel) DTVSigMon[1](/dev/dvb/adapter_static_dvb_1/frontend0)::SetChannel(8, 1):
2019-04-06T09:00:00.831533-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:1943 (SetupDTVSignalMonitor) TVRec[1]: Successfully set up ATSC table monitoring.
2019-04-06T09:00:00.831924-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4446 (SetFlags) TVRec[1]: SetFlags(SignalMonitorRunning,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3846
2019-04-06T09:00:00.832765-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4455 (ClearFlags) TVRec[1]: ClearFlags(WaitingForSignal,) -> RunMainLoop,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3847
2019-04-06T09:00:00.833207-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4446 (SetFlags) TVRec[1]: SetFlags(WaitingForSignal,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3852
2019-04-06T09:00:00.833480-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4455 (ClearFlags) TVRec[1]: ClearFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3913
2019-04-06T09:00:00.833719-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4446 (SetFlags) TVRec[1]: SetFlags(NeedToStartRecorder,) -> RunMainLoop,WaitingForSignal,NeedToStartRecorder,SignalMonitorRunning,RingBufferReady, @ tv_rec.cpp:3915
2019-04-06T09:00:00.833948-05:00 mythbackend[16036]: I TVRecEvent tv_rec.cpp:4033 (TuningSignalCheck) TVRec[1]: TuningSignalCheck: Still waiting. Will timeout @ 09:29:50.000
2019-04-06T09:00:00.834178-05:00 mythbackend[16036]: I Scheduler scheduler.cpp:2936 (HandleRecordingStatusChange) Tuning recording: "The Henry Ford's Innovation Nation":"Speed Reading App": channel 1081 on cardid [1], sourceid 1
2019-04-06T09:00:00.834409-05:00 mythbackend[16036]: I SignalMonitor recorders/dvbsignalmonitor.cpp:302 (UpdateValues) DVBSigMon[1](/dev/dvb/adapter_static_dvb_1/frontend0): UpdateValues -- Signal Locked
2019-04-06T09:00:00.834635-05:00 mythbackend[16036]: I SignalMonitor recorders/streamhandler.cpp:57 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_1/frontend0): AddListener(0x7ff9b4331358) -- begin
2019-04-06T09:00:00.834879-05:00 mythbackend[16036]: I SignalMonitor recorders/streamhandler.cpp:69 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_1/frontend0): AddListener(0x7ff9b4331358) -- locked
2019-04-06T09:00:00.927323-05:00 mythbackend[16036]: I SignalMonitor recorders/streamhandler.cpp:91 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_1/frontend0): AddListener(0x7ff9b4331358) -- end
2019-04-06T09:00:01.028342-05:00 mythbackend[16036]: I DVBRead recorders/dtvsignalmonitor.cpp:449 (HandleTVCT) DTVSigMon[1](/dev/dvb/adapter_static_dvb_1/frontend0)::SetVCT(): tvct->ProgramNumber(idx 0): prog num 1
2019-04-06T09:00:01.028889-05:00 mythbackend[16036]: I DVBRead recorders/dtvsignalmonitor.cpp:223 (SetProgramNumber) DTVSigMon[1](/dev/dvb/adapter_static_dvb_1/frontend0)::SetProgramNumber(1):
2019-04-06T09:00:01.029269-05:00 mythbackend[16036]: I DVBRead mpeg/mpegstreamdata.cpp:93 (SetDesiredProgram) MPEGStream[1](0x7ff9b4331358): SetDesiredProgram(1)

Anybody know what could prevent the dtvsignalmonitor code from ever getting to HandleTVCT or SetProgramNumber?

Nickl1996
Newcomer
Posts: 3
Joined: Sun Apr 07, 2019 12:17 pm
United States of America

Re: Hauppauge 850q/950q recordings fail

Post by Nickl1996 » Fri Apr 19, 2019 9:25 pm

Starting to follow this a little further. Looks like the problem is in mpegtables.cpp. When recordings fail, the code never makes it to ProgramMapTable::Create(). That's the method that prints out the "Created PMT" below. Anybody know the code for this?

Code: Select all

2019-04-19T03:00:00.834817-05:00 mythbackend[5646]: I SignalMonitor recorders/streamhandler.cpp:91 (AddListener) SH[1](/dev/dvb/adapter_static_dvb_2/frontend0): AddListener(0x7f305c04cc10) -- end
2019-04-19T03:00:00.936355-05:00 mythbackend[5646]: I DVBRead mpeg/mpegtables.cpp:464 (Create) Created PMT #012Program Map Section#012 PSIP tableID(0x2) length(117) extension(0x1)#012      version(12) current(1) section(0) last_section(0)#012      pnum(1) pid(0x30) pcrpid(31)#012  Registration Descriptor: 'GA94' ATSC program ID A/53#012  Content Advisory, Possibly Dishnet Rights Descriptor (0x87) length(19). Dumping#012      000  c1 01 01 00 f4 0d 01 65  6e 67 01 00 00 05 54 56  |.......eng....TV|#012      010  2d 31 34                                          |-14|#012  Stream #0 pid(0x31) type(0x02 video-mpeg2)#012    STD Descriptor (0x11) length(1). Dumping#012      000  ff                                                |.|#012    Smooting Buffer Descriptor (0x10) length(6). Dumping#012      000  c0 bd 62 c0 08 00                                 |..b...|#012    Data Stream Alignment Descriptor (0x06) length(1). Dumping#012      000  02                                                |.|#012  Stream #1 pid(0x34) type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3' ATSC audio stream A/52#012    Audio Stream Descriptor  full_srv(1) sample_rate(48kbps) bit_rate(=448kbps, 15)#012      bsid(8) bs_mode(0) channels(3/2) Dolby(Not indicated)#012      mainID(0) #012    ISO-639 Language: code(eng) canonical(eng) eng(English)#012  Stream #2 pid(0x35) type(0x81 audio-ac3)#012    Registration Descriptor: 'AC-3' ATSC audio stream A/52#012    Audio Stream Descriptor  full_srv(1) sample_rate(48kbps) bit_rate(=384kbps, 14)#012      bsid(8) bs_mode(2) channels(3/2) Dolby(Not indicated)#012      associated_service(0x0) #012    ISO-639 Language: code(spa) canonical(spa) eng(Spanish; Castilian)
2019-04-19T03:00:00.937042-05:00 mythbackend[5646]: I TVRecEvent tv_rec.cpp:3941 (TuningSignalCheck) TVRec[1]: TuningSignalCheck: Good signal
2019-04-19T03:00:00.937456-05:00 mythbackend[5646]: I TVRecEvent tv_rec.cpp:730 (SetRecordingStatus) TVRec[1]: SetRecordingStatus(Tuning->Recording) on line 4039
2019-04-19T03:00:00.937802-05:00 mythbackend[5646]: I TVRecEvent tv_rec.cpp:2126 (TeardownSignalMonitor) TVRec[1]: TeardownSignalMonitor() -- begin
2019-04-19T03:00:00.938175-05:00 mythbackend[5646]: I TVRecEvent recorders/dvbsignalmonitor.cpp:152 (Stop) DVBSigMon[1](/dev/dvb/adapter_static_dvb_2/frontend0): Stop() -- begin
2019-04-19T03:00:00.938553-05:00 mythbackend[5646]: I CoreContext scheduler.cpp:729 (UpdateRecStatus) Updating status for "The Simpsons":"The Great Phatsby: Vol. II" on cardid [1] (Tuning => Recording)
2019-04-19T03:00:00.938907-05:00 mythbackend[5646]: I TVRecEvent recorders/streamhandler.cpp:99 (RemoveListener) SH[1](/dev/dvb/adapter_static_dvb_2/frontend0): RemoveListener(0x7f305c04cc10) -- begin
2019-04-19T03:00:00.939243-05:00 mythbackend[5646]: I TVRecEvent recorders/streamhandler.cpp:111 (RemoveListener) SH[1](/dev/dvb/adapter_static_dvb_2/frontend0): RemoveListener(0x7f305c04cc10) -- locked
2019-04-19T03:00:01.038417-05:00 mythbackend[5646]: I TVRecEvent recorders/streamhandler.cpp:128 (RemoveListener) SH[1](/dev/dvb/adapter_static_dvb_2/frontend0): RemoveListener(0x7f305c04cc10) -- end
2019-04-19T03:00:01.038941-05:00 mythbackend[5646]: I TVRecEvent recorders/dvbsignalmonitor.cpp:158 (Stop) DVBSigMon[1](/dev/dvb/adapter_static_dvb_2/frontend0): Stop() -- end
2019-04-19T03:00:01.039299-05:00 mythbackend[5646]: I TVRecEvent recorders/dvbstreamhandler.cpp:85 (Return) dVBSH[1]: Closing handler for /dev/dvb/adapter_static_dvb_2/frontend0

Post Reply