Kodi Community Forum

Build: Kodi 16.1
PVR Backend: v0.27-193.g8ee257c
TV Tuner: HDHomerun Prime

I'm currently having an issue on my client devices trying to tune to live TV if one of my other client devices is using the first tuner. I get the "channel unavailable" error on the MythTV Kodi Addon. I am able to record, and then play the channel from Kodi, but I am unable to view it live.

In this specific instance, Kodi is running on a Windows 10 PC, and the backend in a VM of Mythbuntu 14.04.

I have disabled IPv6 on the backend, and on the frontend PC, and I have increased tuning time to 30 seconds, and enabled debug on the log file.

Here is a section of the logfile when attempting to tune to LiveTV.

11:39:08 T:2452 NOTICE: DVDPlayer: Opening: pvr://channels/tv/All channels/pvr.mythtv_1570.pvr
11:39:08 T:2452 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
11:39:08 T:12144 NOTICE: Creating InputStream
11:39:28 T:12144 ERROR: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::LiveTVPlayback::SpawnLiveTV: tune delay exceeded (30000ms)
11:39:28 T:12144 ERROR: AddOnLog: MythTV PVR Client: PVRClientMythTV::OpenLiveStream: Failed to open live stream
11:39:28 T:12144 NOTICE: Creating Demuxer
11:39:28 T:12144 NOTICE: Opening stream: 0 source: 256
11:39:28 T:12144 NOTICE: Creating video codec with codec id: 2
11:39:28 T:12144 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
11:39:28 T:12144 NOTICE: Creating video thread
11:39:28 T:12144 ERROR: CSelectionStreams::Get - failed to get stream
11:39:28 T:12144 WARNING: CDVDMessageQueue(audio):ut MSGQ_NOT_INITIALIZED
11:39:28 T:8252 NOTICE: running thread: video_thread
11:39:28 T:12144 NOTICE: Opening stream: 0 source: 256
11:39:28 T:12144 NOTICE: Creating video codec with codec id: 2
11:39:28 T:12144 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
11:39:28 T:8252 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(960x540)
11:39:28 T:8252 NOTICE: fps: 0.000000, pwidth: 960, pheight: 540, dwidth: 960, dheight: 540
11:39:28 T:8252 NOTICE: D3D: rendering method forced to DXVA processor
11:39:28 T:8252 NOTICE: DXVA::CProcessorHD::InitProcessor - Supported deinterlace methods: Blend:yes, Bob:yes, Adaptive:yes, MoComp:yes.
11:39:28 T:2452 WARNING: CWinRenderer::UpdateVideoFilter - chosen scaling method 1 is not supported by renderer

If I stop the device which is the first tuner, Kodi will tune in on live TV, But when the first tuner is in use, I can only record, not watch live.

I increased signal timeout for each tuner on backend from 1000ms to 10000ms.

12:06:07 T:9044 NOTICE: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::TcpSocket::ReadResponse: socket(0C32074C) timed out (0)
12:06:07 T:9044 NOTICE: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::TcpSocket::ReadResponse: socket(0C32074C) timed out (1)
12:06:07 T:9044 NOTICE: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::TcpSocket::ReadResponse: socket(0C32074C) timed out (2)
12:06:07 T:9044 NOTICE: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::TcpSocket::ReadResponse: socket(0C32074C) timed out (3)
12:06:07 T:9044 NOTICE: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::TcpSocket::ReadResponse: socket(0C32074C) timed out (4)
12:06:07 T:9044 NOTICE: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::TcpSocket::ReadResponse: socket(0C32074C) timed out (5)
12:06:07 T:9044 ERROR: AddOnLog: MythTV PVR Client: (CPPMyth)Myth:rotoBase::HangException: protocol connection hang with error 138
12:06:09 T:9044 ERROR: AddOnLog: MythTV PVR Client: (CPPMyth)Myth:rotoBase::HangException: protocol connection hang with error 10054
12:06:09 T:192 ERROR: CNetwork::WakeOnLan - Invalid hardware address specified (192.168.1.167)
12:06:28 T:3760 ERROR: Previous line repeats 1 times.
12:06:28 T:3760 WARNING: CDVDMessageQueue(audio):ut MSGQ_NOT_INITIALIZED
12:06:48 T:3760 WARNING: Previous line repeats 2 times.
12:06:48 T:3760 ERROR: AddOnLog: MythTV PVR Client: (CPPMyth)Myth::LiveTVPlayback::SpawnLiveTV: tune delay exceeded (20000ms)
12:06:48 T:3760 ERROR: AddOnLog: MythTV PVR Client: PVRClientMythTV::OpenLiveStream: Failed to open live stream
12:06:48 T:3760 NOTICE: PVRManager - PVR::CPVRManager:erformChannelSwitch - switched to channel 'ESPNHD'
12:06:48 T:3760 NOTICE: Creating Demuxer
12:06:48 T:3760 NOTICE: Opening stream: 0 source: 256
12:06:48 T:3760 NOTICE: Creating video codec with codec id: 2
12:06:48 T:3760 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
12:06:48 T:3760 ERROR: CSelectionStreams::Get - failed to get stream
12:06:48 T:3760 WARNING: CDVDMessageQueue(audio):ut MSGQ_NOT_INITIALIZED
12:06:48 T:3760 NOTICE: Opening stream: 0 source: 256
12:06:48 T:3760 NOTICE: Creating video codec with codec id: 2
12:06:48 T:3760 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: MPEG-2 video
12:06:48 T:11028 NOTICE: DXVA::CDecoder::Close - closing decoder
12:06:48 T:11028 NOTICE: DXVA::Close - closing decoder context
12:06:48 T:11028 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(960x540)
12:06:49 T:11028 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer

Really need a full Kodi debug log (make sure in pvr.mythtv addon Advanced tab that "Include more information in logfile" is selected). Please don't post the debug log here, use pastebin or xbmlogs see http://kodi.wiki/view/log_file

However can you confirm in mythtv-backend that Max Recordings is set to 1 for each tuner. See Capture Card Setup > Recording options for each of the three tuners in the Prime. MythTV, with other versions of the HDHomerun, can record more than 1 program per tuner but not with the HDHomerun Prime. see https://www.mythtv.org/wiki/Silicondust_HDHomeRun_Prime

The pvr.mythtv addon by default attempts to use the first free tuner reported by the mythtv-backend. There is an option in pvr.mythtv addon Advanced tab "Limit channel tuning attempts", selected by default, but if deselected will try each tuner in turn until tuning is achieved or all tuners have been tried (at which point "Channel unavailable" will be displayed).

Mike

Okay, I will post a full debug log shortly. I can confirm that mythtv-backend Max Recordings was set to TWO (2) for each tuner. I did change it to 1, but I'm still having the issue.

Here is the log file:

http://pastebin.com/kGNnSdde

Unfortunately the log file is not a debug log with "Include more information in log file" selected for pvr.mythtv addon. It looks like a normal kodi log. Is debug logging turned in Settings → System → Debugging.

Note you may have to restart Kodi to get the additional debug information from pvr.mythtv addon

Mike

(2016-07-04, 19:41)MikeB2013 Wrote: [ -> ]Unfortunately the log file is not a debug log with "Include more information in log file" selected for pvr.mythtv addon. It looks like a normal kodi log. Is debug logging turned in Settings → System → Debugging.

Note you may have to restart Kodi to get the additional debug information from pvr.mythtv addon

Mike

I did, and I restarted numerous times. I noticed it was odd too had nothing came up with the DEBUG comment.

I'll take a look again.

I did deselect "limit channel tuning attempts" and it was able to connect though! I don't know if that's the end of my problems, but it's certainly a step in the right direction.

The log file definitely has debug logging disabled :
13:22:20 T:9452 NOTICE: Disabled debug logging due to GUI setting. Level 0.
13:22:20 T:9452 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"

Interesting that with "Limit channel tuning attempts" deselected that it works. Its not the end of your problems, it simply means that pvr.mythtv addon could not tune using what mythtv-backend is reporting as a free tuner, the full debug log file will give much more information on what is happening.

Mike

(2016-07-04, 21:22)MikeB2013 Wrote: [ -> ]The log file definitely has debug logging disabled :
13:22:20 T:9452 NOTICE: Disabled debug logging due to GUI setting. Level 0.
13:22:20 T:9452 NOTICE: Log level changed to "LOG_LEVEL_NORMAL"

Interesting that with "Limit channel tuning attempts" deselected that it works. Its not the end of your problems, it simply means that pvr.mythtv addon could not tune using what mythtv-backend is reporting as a free tuner, the full debug log file will give much more information on what is happening.

Mike

How do I get the debug log when I 100% have it selected and have since closed and opened numerous times?

The debug setting for pvr.mythtv that you have done is correct.

You also need to to go into
System>Settings>System>Logging and enable "Enable debug logging" for Kodi 16.1
At this point you should see 3 lines of text running across the top of your screen, then restart Kodi (gets a clean start debug log). If you don't see the 3 lines of text at the top of your screen something else is wrong.

Run you tests and paste the kodi.log file.

Mike

Sorry for the delay!

Here is the debug log.
http://pastebin.com/Jxyqij8Q

As I mentioned, it works, but it's still flakey and takes a solid 10+ seconds to tune to a channel if tuner #1 is in use.

Thanks for the debug log.

I think the problem is that your mythtv-backend 0.27 is very old from March 23 2014 (I missed the version you quoted in your original post -sorry)

There have literally been hundreds of changes to mythtv 0.27 since then. I suggest you update your mythtv-backend to the latest 0.27/fixes.

The easy way to do the update on Mythbuntu 14.04 is from a terminal:

sudo add-apt-repository ppa:mythbuntu/0.27
sudo apt-get update
sudo apt-get dist-upgrade

I would also recommend you restart the VM completely.
sudo reboot

Mike

(2016-07-06, 08:51)MikeB2013 Wrote: [ -> ]Thanks for the debug log.

I think the problem is that your mythtv-backend 0.27 is very old from March 23 2014 (I missed the version you quoted in your original post -sorry)

There have literally been hundreds of changes to mythtv 0.27 since then. I suggest you update your mythtv-backend to the latest 0.27/fixes.

The easy way to do the update on Mythbuntu 14.04 is from a terminal:

sudo add-apt-repository ppa:mythbuntu/0.27
sudo apt-get update
sudo apt-get dist-upgrade

I would also recommend you restart the VM completely.
sudo reboot

Mike

Should I just upgrade to 16.04 instead? Also, should I re-enable the "limit channel tuning attempts" option?

Upgraded to 16.04. This time, it did not work out of box, but worked when I selected "limit channel tuning attempts" to ON.

Does this seem like a proper configuration?

Depends on how you did the upgrade to 16.04.

Upgrading the operating system to 16.04, may not have updated the mythtv-backend version.

What is the current mythtv-backend version ? (from a terminal post the output from "mythbackend --version"

Normally "limit channel tuning attempts" should be ON.

Mike