[mythtv-users] Can't tune HDHR

Wed May 13 23:56:07 UTC 2020

On Wed, May 13, 2020 at 4:37 PM DryHeat122 . <dryheat122 at gmail.com> wrote:

> On Wed, May 13, 2020 at 2:08 AM Stephen Worthington <
> stephen_agent at jsw.gen.nz> wrote:
>
>> On Tue, 12 May 2020 20:22:59 -0700, you wrote:
>>
>> >When it rains it pours I guess.  I was just posting about HDPVR problems
>> a
>> >few days ago.  Now Myth can't tune any channels on my HDHomerun Duo.
>> >Checked the troubleshooting section on the wiki, but it assumes the
>> problem
>> >is with the HDHR. I can tune channels just fine on a Windows machine on
>> the
>> >same network, so its not the HDHR.  Any advice on how to troubleshoot?
>>
>> Does it work if you restart mythbackend?  Are there any error messages
>> in mythbackend.log?  You can get additional logging about the
>> recording process by adding -v record to the mythbackend command line:
>>
>> root at mypvr:/etc/mythtv# cat additional.args
>> ADDITIONAL_ARGS=-v record
>>
>> Then restart mythbackend.  Or from a command line, temporarily add the
>> extra "record" logging while mythbackend is running:
>>
>> sudo mythbackend --setverbose record
>>
>> and turn it off again with:
>>
>> sudo mythbackend --setverbose norecord
>>
>> I am not sure if sudo is required above - all the second copy of
>> mythbackend is doing is to open a connection to a port on the main
>> mythbackend and send it the serverbose command.  So it may not need
>> any extra privileges.
>>
>> Thanks for the advice.  I checked the logs before doing anything, and
> found (machine ID stuff stripped out for readability):
>
> May 13 15:39:21  I ProcessRequest mainserver.cpp:1698 (HandleAnnounce)
> MainServer: MainServer::ANN Playback
> May 13 15:39:21  I ProcessRequest mainserver.cpp:1703 (HandleAnnounce)
> MainServer: adding: steve-EP45-UD3P(1f26320) as a client (events: 0)
> May 13 15:39:21  I TVRecEvent tv_rec.cpp:1073 (HandleStateChange)
> TVRec[2]: Changing from None to WatchingLiveTV
> May 13 15:39:21  I TVRecEvent mythdbcon.cpp:422 (PurgeIdleConnections) New
> DB connection, total: 13
> May 13 15:39:21  I TVRecEvent tv_rec.cpp:3685 (TuningFrequency) TVRec[2]:
> TuningFrequency
> May 13 15:39:21  N CoreContext autoexpire.cpp:264 (CalcParams) AutoExpire:
> CalcParams(): Max required Free Space: 3.0 GB w/freq: 14 min
> May 13 15:39:21  N TVRecEvent recordinginfo.cpp:687
> (ApplyRecordRecGroupChange) ApplyRecordRecGroupChange: LiveTV to LiveTV (2)
> May 13 15:39:25  W TVRecEvent tv_rec.cpp:4004 (TuningSignalCheck)
> TVRec[2]: TuningSignalCheck: taking more than 3000 ms to get a lock.
> marking this recording as 'Failing'.
> May 13 15:39:25  W TVRecEvent tv_rec.cpp:4006 (TuningSignalCheck)
> TVRec[2]: See 'Tuning timeout' in mythtv-setup for this input
> May 13 15:39:36  I TVRecEvent tv_rec.cpp:1073 (HandleStateChange)
> TVRec[2]: Changing from WatchingLiveTV to None
> May 13 15:39:36  I MythSocketThread(74) mainserver.cpp:7629
> (connectionClosed) Playback sock(1f26320) 'steve-EP45-UD3P' disconnected
>
> I then rebooted and tried to tune one of the HDHR channels (3_1) from the
> program guide.  Now it doesn't even try to tune and I get:
>
> May 13 15:55:33  I ProcessRequest mainserver.cpp:1698 (HandleAnnounce)
> MainServer: MainServer::ANN Playback
> May 13 15:55:33  I ProcessRequest mainserver.cpp:1703 (HandleAnnounce)
> MainServer: adding: steve-EP45-UD3P(13e54b0) as a client (events: 0)
> May 13 15:55:33  I TVRecEvent tv_rec.cpp:1073 (HandleStateChange)
> TVRec[2]: Changing from None to WatchingLiveTV
> May 13 15:55:33  I TVRecEvent tv_rec.cpp:3685 (TuningFrequency) TVRec[2]:
> TuningFrequency
> May 13 15:55:33  E TVRecEvent dtvmultiplex.cpp:379 (ParseTuningParams)
> DTVMux: ParseTuningParams -- Unknown tuner type = 0xffffffff80000000
> May 13 15:55:33  E TVRecEvent recorders/dtvchannel.cpp:299
> (SetChannelByString) DTVChan[2](10668BF0-0): SetChannelByString(3_1):
> Failed to initialize multiplex options
> May 13 15:55:33  E TVRecEvent tv_rec.cpp:3763 (TuningFrequency) TVRec[2]:
> Failed to set channel to 3_1. Reverting to kState_None
> May 13 15:55:33  I TVRecEvent tv_rec.cpp:1073 (HandleStateChange)
> TVRec[2]: Changing from WatchingLiveTV to None
> May 13 15:55:33  I MythSocketThread(67) mainserver.cpp:7629
> (connectionClosed) Playback sock(13e54b0) 'steve-EP45-UD3P' disconnected
>
> Hmm.  That doesn't look good.  I checked backend setup for tuners and
> nothing seems to be amiss.
>
> I also tried to follow your instructions for configuring verbose logging
> but it didn't work:
>
> steve at steve-EP45-UD3P:~$ cd /etc/mythtv
> steve at steve-EP45-UD3P:/etc/mythtv$ ls
> config.xml  config.xml.orig  session-settings
> steve at steve-EP45-UD3P:/etc/mythtv$ cat additional.args
> cat: additional.args: No such file or directory
> steve at steve-EP45-UD3P:/etc/mythtv$ ADDITIONAL_ARGS=-v record
> The program 'record' is currently not installed. You can install it by
> typing:
> sudo apt install xawtv-tools
> steve at steve-EP45-UD3P:/etc/mythtv$ cat additional.args
> cat: additional.args: No such file or directory
>
> Did you mean cat "ADDITIONAL_ARGS=-v record" > additional.args?
>
>
I just started mythbackend with the -v record option and got:

2020-05-13 16:48:14.026697 I  MainServer: MainServer::ANN Playback
2020-05-13 16:48:14.026707 I  MainServer: adding: steve-EP45-UD3P(223c4b0)
as a client (events: 0)
2020-05-13 16:48:14.033902 I  TVRec[2]: Found channel (3_1) on current
input(2).
2020-05-13 16:48:14.044957 I  TVRec[2]: Changing from None to WatchingLiveTV
2020-05-13 16:48:14.044977 I  TVRec[2]:
ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, @
tv_rec.cpp:1301
2020-05-13 16:48:14.044991 I  TVRec[2]: HandleTuning Request: Program(NULL)
channel() input() flags(LiveTV,)
2020-05-13 16:48:14.047755 I  TVRec[2]: TuningShutdowns(Program(NULL)
channel(3_1) input() flags(LiveTV,))
2020-05-13 16:48:14.048112 I  TVRec[2]: ClearFlags(PENDINGACTIONS,) ->
RunMainLoop, @ tv_rec.cpp:3663
2020-05-13 16:48:14.048122 I  TVRec[2]: No recorder yet, calling
TuningFrequency
2020-05-13 16:48:14.048129 I  TVRec[2]: TuningFrequency
2020-05-13 16:48:14.050975 E  DTVMux: ParseTuningParams -- Unknown tuner
type = 0xffffffff80000000
2020-05-13 16:48:14.051000 E  DTVChan[2](10668BF0-0):
SetChannelByString(3_1): Failed to initialize multiplex options
2020-05-13 16:48:14.051010 E  TVRec[2]: Failed to set channel to 3_1.
Reverting to kState_None
2020-05-13 16:48:14.051028 I  TVRec[2]: Changing from WatchingLiveTV to None
2020-05-13 16:48:14.051209 I  TVRec[2]:
ClearFlags(FrontendReady,CancelNextRecording,) -> RunMainLoop, @
tv_rec.cpp:1301
2020-05-13 16:48:14.051224 I  TVRec[2]: HandleTuning Request: Program(NULL)
channel() input() flags(KillRec,KillRingBuffer,)
2020-05-13 16:48:14.051236 I  TVRec[2]: TuningShutdowns(Program(NULL)
channel() input() flags(KillRec,KillRingBuffer,))
2020-05-13 16:48:14.051258 I  TVRec[2]: ClearFlags(PENDINGACTIONS,) ->
RunMainLoop, @ tv_rec.cpp:3663
2020-05-13 16:48:14.051291 I  TVRec[2]: SetFlags(CancelNextRecording,) ->
RunMainLoop,CancelNextRecording, @ tv_rec.cpp:2667
2020-05-13 16:48:14.051989 I  Playback sock(223c4b0) 'steve-EP45-UD3P'
disconnected
2020-05-13 16:48:32.395051 I  BackendContext: Frontend 'steve-EP45-UD3P'
disconnected.
2020-05-13 16:48:32.395070 I  Playback sock(224ec00) 'steve-EP45-UD3P'
disconnected
2020-05-13 16:48:32.395299 I  Monitor sock(1fdca30) 'steve-EP45-UD3P'
disconnected
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.mythtv.org/pipermail/mythtv-users/attachments/20200513/5fa27f2f/attachment.htm>