Project

General

Profile

Bug #4922

No input source available bug

Added by LubosD - almost 7 years ago. Updated over 6 years ago.

Status:
Fixed
Priority:
Normal
Assignee:
-
Category:
-
Target version:
-
Start date:
2018-02-08
Due date:
% Done:

100%

Estimated time:
Found in version:
git
Affected Versions:

Description

Current Git version suffers from an absurd bug. My Kodi installations sometimes show "No signal" when switching channels.

When I check Tvheadend at that moment, the logs report that "No input source available". But there are 4 available input sources.

I have to stop playback in Kodi and play the channel again to make it work.

While this error is repeatedly showing in logs, I can even use VLC to tune that very channel and it will work, but won't get Kodi playing. It really must be stopped first.

Logs:

2018-02-08 00:04:44.660 subscription: 01CD: "epggrab" subscribing to mux "10788V", weight: 4, adapter: "TurboSight TBS 6985 DVB-S/S2 #2 - nalevo", network: "Astra 28.2E", service: "Raw PID Subscription" 
2018-02-08 00:04:44.662 subscription: 01C2: No input source available for subscription "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" to channel "Discovery HD Showcase" 
2018-02-08 00:04:46.662 subscription: 01C2: No input source available for subscription "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" to channel "Discovery HD Showcase" 
2018-02-08 00:04:48.662 subscription: 01C2: No input source available for subscription "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" to channel "Discovery HD Showcase" 
2018-02-08 00:04:50.662 subscription: 01C2: No input source available for subscription "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" to channel "Discovery HD Showcase" 
2018-02-08 00:04:52.662 subscription: 01C2: No input source available for subscription "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" to channel "Discovery HD Showcase" 
2018-02-08 00:04:54.268 subscription: 01C2: "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" unsubscribing from "Discovery HD Showcase", hostname="fd00:1::ba27:ebff:fe14:b462", username="fd00:1::ba27:ebff:fe14:b462", client="Kodi Media Center" 
2018-02-08 00:04:56.126 mpegts: 11843V in Thor 1W - tuning on TurboSight TBS 6985 DVB-S/S2 #3 - napravo vpredu
2018-02-08 00:04:56.622 subscription: 01D2: "fd00:1::ba27:ebff:fe14:b462 [  | Kodi Media Center ]" subscribing on channel "Discovery HD Showcase", weight: 150, adapter: "TurboSight TBS 6985 DVB-S/S2 #3 - napravo vpredu", network: "Thor 1W", mux: "11843V", provider: "UPC Direct", service: "Discovery HD Showcase", profile="htsp", hostname="fd00:1::ba27:ebff:fe14:b462", username="fd00:1::ba27:ebff:fe14:b462", client="Kodi Media Center"

Files

problem.log (79.8 KB) problem.log LubosD -, 2018-02-10 19:02
tvhtvh.log (755 KB) tvhtvh.log LubosD -, 2018-03-20 22:03

History

#1

Updated by Jaroslav Kysela almost 7 years ago

--trace service,mpegts,subscription . https://tvheadend.org/projects/tvheadend/wiki/Traces

#2

Updated by LubosD - almost 7 years ago

Here it is.

To me it would almost look like HW bug, but as I said before: I can even use VLC to tune that very channel and it will work, but won't get Kodi playing.

#3

Updated by Jaroslav Kysela almost 7 years ago

It looks like a descrambling issue. All tuners are marked with 402 error (no input detected). Do you use CAM decoding, right?

--trace service,mpegts,subscription,descrambler,dvbcam,parser

#4

Updated by LubosD - almost 7 years ago

I use a CA client (OSCAM), i.e. not a hardware CAM. I'll enable all these traces and try again.

#5

Updated by LubosD - over 6 years ago

I have a new log, no communication to OSCAM takes place during that time, which can be seen in the log. I can see some disconnections in OSCAM's log, but Tvheadend should be able to reconnect.

And it is, because while this error is repeatedly appearing in the log, I can use VLC to play the channel just fine.

#6

Updated by Jaroslav Kysela over 6 years ago

It seems like a configuration and driver issue mixed together. From log:

2018-03-20 21:58:15.884 [  TRACE]:subscription: 13A1: creating subscription for Nova HD weight 0 using profile htsp
2018-03-20 21:58:15.884 [  TRACE]:subscription: 13A1: find service for Nova HD weight 150
2018-03-20 21:58:15.884 [  DEBUG]:service: 7: Nova HD si 0x7f9a4c02fc00 TurboSight TBS 6985 DVB-S/S2 #0 weight 0 prio 11 error 0
2018-03-20 21:58:15.884 [  DEBUG]:service: 5: Nova HD si 0x7f9a4c009040 TurboSight TBS 6985 DVB-S/S2 #2 - nalevo weight 0 prio 14 error 0
2018-03-20 21:58:15.884 [  DEBUG]:service: 6: Nova HD si 0x7f9a4c0306f0 TurboSight TBS 6985 DVB-S/S2 #1- napravo weight 300 prio 15 error 0
2018-03-20 21:58:15.884 [  DEBUG]:service: 4: Nova HD si 0x7f9a4c0055e0 TurboSight TBS 6985 DVB-S/S2 #3 - napravo vpredu weight 0 prio 20 error 0
2018-03-20 21:58:15.884 [  TRACE]:service: will start new instance 4
2018-03-20 21:58:15.884 [  TRACE]:service: starting Thor 1W/12054H/Nova HD
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 001 02402 H264 und
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 002 02403 MPEG2AUDIO cze
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 003 02418 TELETEXT und
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 004 02431 CA 1882 000000
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 005 02432 CA 1815 000000
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 006 02433 CA 0d97 000000
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 007 02434 CA 0653 000000
2018-03-20 21:58:15.884 [  TRACE]:service: esfilter: "Thor 1W/12054H/Nova HD" 008 02435 CA 0b02 000000
2018-03-20 21:58:15.884 [   INFO]:mpegts: 12054H in Thor 1W - tuning on TurboSight TBS 6985 DVB-S/S2 #3 - napravo vpredu
2018-03-20 21:58:15.884 [  TRACE]:service: tuning failed
2018-03-20 21:58:15.884 [  TRACE]:subscription: 13A1: instance not available, retrying

2018-03-20 21:58:17.884 [  TRACE]:subscription: 13A1: find service for Nova HD weight 150
2018-03-20 21:58:17.884 [  DEBUG]:service: 7: Nova HD si 0x7f9a4c02fc00 TurboSight TBS 6985 DVB-S/S2 #0 weight 0 prio 11 error 203
2018-03-20 21:58:17.884 [  DEBUG]:service: 5: Nova HD si 0x7f9a4c009040 TurboSight TBS 6985 DVB-S/S2 #2 - nalevo weight 0 prio 14 error 203
2018-03-20 21:58:17.884 [  DEBUG]:service: 6: Nova HD si 0x7f9a4c0306f0 TurboSight TBS 6985 DVB-S/S2 #1- napravo weight 300 prio 15 error 203
2018-03-20 21:58:17.884 [  DEBUG]:service: 4: Nova HD si 0x7f9a4c0055e0 TurboSight TBS 6985 DVB-S/S2 #3 - napravo vpredu weight 0 prio 20 error 203
2018-03-20 21:58:17.884 [  TRACE]:subscription: 13A1: instance not available, retrying

As you see, the driver refused to tune for a reason. So TVH retries to subscribe after 2 seconds again, but your configuration (which is the default I admit) prevents to use another tuners. You may see that all tuners (service instances) are marked with 'error 203' which is 'tuning failed'.

There are basically three solutions for this problem:

1) you may find why the tuning fails (seems like a driver issue)
2) turn off 'Switch to another service' in tvheadend's streaming profiles (all which you are using)
3) I think that we can add more logic to the code which may detect the situation where there are no other services to try

#7

Updated by LubosD - over 6 years ago

Got it, thanks for the analysis.

The driver is crap, and so is the hardware (TBS 6985), so my next buy will definitely be something else (e.g. Digital Devices).

#8

Updated by Jaroslav Kysela over 6 years ago

  • Status changed from New to Fixed
  • % Done changed from 0 to 100

Applied in changeset commit:tvheadend|20e3cb8c81d9cb3d068f15bb569041a402060f32.

Also available in: Atom PDF