Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Some channels do not work #317

Closed
Snippo opened this issue Jun 20, 2017 · 5 comments
Closed

Some channels do not work #317

Snippo opened this issue Jun 20, 2017 · 5 comments

Comments

@Snippo
Copy link

Snippo commented Jun 20, 2017 •
edited
Loading

Hi,

I recently replaced my PCIe tuner with a Digibit R1 SAT>IP tuner. Overall it works fine, but in Kodi I can't use some channels. It could also be a bug in either TVHeadend or minisatip, but when I use TVHClient on Android everything works fine. Also when I open the HTTP stream it works fine.

Here is a log from Kodi 15:
13:59:50 T:140305508595456 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'TV Gelderland'
13:59:50 T:140305508595456 DEBUG: opening live stream for channel 'TV Gelderland'
13:59:50 T:140305508595456 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux open
13:59:50 T:140305508595456 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux subscribe to 2027321801
13:59:50 T:140305462511360 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux unhandled subscription message [subscriptionGrace]
13:59:50 T:140305508595456 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux successfully subscribed to 2027321801
13:59:50 T:140305508595456 DEBUG: PVRFile - Open - playback has started on filename pvr://channels/tv/All channels/pvr.hts_2027321801.pvr
13:59:50 T:140305508595456 DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://channels/tv/All channels/pvr.hts_2027321801.pvr
13:59:50 T:140305508595456 NOTICE: Creating Demuxer
13:59:50 T:140305508595456 ERROR: Get - failed to get stream
13:59:50 T:140305508595456 DEBUG: CDVDPlayer::SetCaching - caching state 2
13:59:50 T:140305508595456 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED
13:59:50 T:140305508595456 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED
13:59:50 T:140305508595456 DEBUG: OnPlayBackStarted: play state was 1, starting 1
13:59:50 T:140306923383232 DEBUG: PlayFile: OpenFile succeed, play state 2
13:59:50 T:140306923383232 DEBUG: OnPlayBackStarted: play state was 2, starting 0
13:59:50 T:140306923383232 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
13:59:50 T:140306923383232 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All channels/pvr.hts_2027321801.pvr)
13:59:50 T:140304957409024 NOTICE: Thread JobWorker start, auto delete: true
13:59:50 T:140306923383232 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
13:59:50 T:140306923383232 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
13:59:50 T:140306923383232 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - Announce(flag=Player, sender=xbmc, message=OnPlay)
13:59:51 T:140306923383232 DEBUG: Keyboard: scancode: 0x40, sym: 0x0134, unicode: 0x0000, modifier: 0x100
13:59:51 T:140306923383232 DEBUG: OnKey: alt-leftalt (0x4f0d4) pressed, action is
13:59:52 T:140306923383232 DEBUG: ------ Window Init (Pointer.xml) ------
13:59:52 T:140306923383232 DEBUG: ------ Window Deinit (Pointer.xml) ------

In TVHeadend there are no errors.
A log from the latest OSMC on a RPi:
14:09:25.704 T:2589979632 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'TV Gelderland'
14:09:25.705 T:2589979632 DEBUG: opening live stream for channel 'TV Gelderland'
14:09:25.708 T:2589979632 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux open
14:09:25.712 T:2589979632 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux subscribe to 2027321801
14:09:25.716 T:2634019824 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux unhandled subscription message [subscriptionGrace]
14:09:25.719 T:2589979632 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux successfully subscribed to channel id 2027321801, subscription id 1
14:09:25.784 T:2988438512 DEBUG: CAESinkPi:Drain delay:97ms now:0ms
14:09:25.786 T:2988438512 DEBUG: CAESinkPi:Deinitialize
14:09:25.788 T:2988438512 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000
14:09:25.798 T:2988438512 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x9a6239c0
14:09:25.803 T:2988438512 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI
14:09:25.806 T:2988438512 DEBUG: CAESinkPi:Initialize Format:2 Channels:2 Samplerate:16000 framesize:4 bufsize:3200 bytes/s=64000.00 dest=PI:HDMI
14:09:25.811 T:2988438512 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized:
14:09:25.814 T:2988438512 DEBUG: Output Device : HDMI
14:09:25.815 T:2988438512 DEBUG: Sample Rate : 16000
14:09:25.817 T:2988438512 DEBUG: Sample Format : AE_FMT_S16NE
14:09:25.818 T:2988438512 DEBUG: Channel Count : 2
14:09:25.820 T:2988438512 DEBUG: Channel Layout: RAW,RAW
14:09:25.821 T:2988438512 DEBUG: Frames : 800
14:09:25.822 T:2988438512 DEBUG: Frame Size : 4
14:09:25.842 T:2589979632 DEBUG: CDVDInputStreamPVRManager - Open - playback has started on filename pvr://channels/tv/Alle kanalen/pvr.hts_2027321801.pvr
14:09:25.846 T:2589979632 DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://channels/tv/Alle kanalen/pvr.hts_2027321801.pvr
14:09:25.850 T:2589979632 NOTICE: Creating Demuxer
14:09:25.859 T:2996827120 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
14:09:25.866 T:2589979632 DEBUG: Previous line repeats 1 times.
14:09:25.868 T:2589979632 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81 m_handle 0x9a625af0
14:09:25.872 T:2589979632 DEBUG: OMXClock::OMXStop
14:09:25.874 T:2589979632 DEBUG: OMXClock::OMXSetSpeed(0.000) pause_resume:1
14:09:25.879 T:2589979632 DEBUG: OnPlayBackStarted: play state was 1, starting 1
14:09:25.880 T:3025645568 DEBUG: PlayFile: OpenFile succeed, play state 2
14:09:25.881 T:3025645568 DEBUG: OnPlayBackStarted: play state was 2, starting 0
14:09:25.884 T:3025645568 DEBUG: LIRC: Update - NEW at 120909:160 0 KEY_OK_UP linux-input-layer (KEY_OK_UP)
14:09:25.888 T:2589979632 DEBUG: CVideoPlayer::SetCaching - caching state 2
14:09:25.889 T:2589979632 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000
14:09:25.926 T:3025638384 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
14:09:25.928 T:3025638384 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
14:09:25.934 T:2520228848 DEBUG: Thread JobWorker start, auto delete: true
14:09:25.945 T:2520228848 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/Alle kanalen/pvr.hts_2027321801.pvr)
14:09:26.897 T:3025645568 DEBUG: ------ Window Init (Custom_Cache_Progress.xml) ------
14:09:26.898 T:3025645568 INFO: Loading skin file: Custom_Cache_Progress.xml, load type: KEEP_IN_MEMORY
14:09:26.919 T:3025645568 DEBUG: started alarm with name: iscachingtimer
14:09:26.924 T:2486674416 DEBUG: Thread AlarmClock start, auto delete: false
14:09:29.792 T:2634019824 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux unhandled subscription message [descrambleInfo]

Sometimes TVHeadend shows a (TELETEXT) Continuity Counter Error, but usually no errors are displayed and it just does not work. So I really have no clue what is going wrong, and if this is not a bug in the addon, please let me know.
@CvH
Copy link

CvH commented Jun 20, 2017

@Snippo not too sure that this is an pvr.hts problem at all, but could you try to use a recent kodi (17.3) and a recent Tvheadend 4.2.x and try to reproduce the problem ?

@Snippo
Copy link
Author

Snippo commented Jun 20, 2017

The second log is from kodi 17.3. The version of TVH I use is 4.3-32~g696e17d51. I tried kodi on my phone, a RPI and a PC. Neither works.
When I play the http URL directly in kodi it does work, just not when I try to open the channel.

@Snippo
Copy link
Author

Snippo commented Jun 20, 2017 •
edited
Loading

It looks like the actual stream in TVHeadend is never started. At least, it does not ask the CA for keys to descramble, and it also does not give any descrambling errors.

2017-06-20 17:03:05.607 subscription: 0059: "192.168.3.11 [ admin | Kodi Media Center ]" subscribing on channel "TV Drenthe", weight: 150, adapter: "SAT>IP DVB-S Tuner #1 (192.168.3.240)", network: "Astra 3", mux: "11914H", provider: "M7 Group", service: "TV Drenthe", profile="htsp", hostname="192.168.3.11", username="admin", client="Kodi Media Center"

It also seems to happen for this particular frequency (11914H), other frequencies I tested work fine. The SAT>IP box is also tuned to the right frequency, it is just that the stream never seems to start. I really have no clue what is happening...

Edit:
Some errors which sometimes are shown:
2017-06-20 17:10:10.728 TS: Astra 3/11914H/Omroep Zeeland Televisie: H264 @ #520: Invalid start code 46:9d:19
2017-06-20 17:10:10.729 TS: Astra 3/11914H/Omroep Zeeland Televisie: MPEG2AUDIO @ #96: Invalid start code bd:40:bb
2017-06-20 17:10:11.296 subscription: 005C: service instance is bad, reason: No access

@Jalle19
Copy link
Contributor

Jalle19 commented Jun 27, 2017

This looks 99% like a tvheadend bug. Please re-open this ticket if you still believe the addon is at fault.

@Jalle19 Jalle19 closed this as completed Jun 27, 2017
@tetzlav
Copy link

tetzlav commented Oct 2, 2017 •
edited
Loading

exactly the same problems here:

log kodi:

22:25:02.963 T:140717313730304 NOTICE: Creating Demuxer
22:25:02.964 T:140719053010688 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
22:25:02.964 T:140719053010688 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
22:25:02.964 T:140719053010688 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
22:25:03.361 T:140717322123008 DEBUG: AddOnLog: Tvheadend HTSP Client: pvr.hts - demux unhandled subscription message [subscriptionGrace]

log tvheadend:

Oct 2 22:25:03 omv tvheadend[1950]: subscription: CA82: "192.168.178.22 [ xbmc | Kodi Media Center ]" subscribing on channel "MDR Sachsen", weight: 150, adapter: "STV090x Multistandard : DVB-S #2", network: "ASTRA", mux: "12109.5H", provider: "ARD", service: "MDR Sachsen", profile="htsp", hostname="192.168.178.22", username="xbmc", client="Kodi Media Center"

With iptv-client/http/vlc all streams working fine, only kodi-hts wont play some streams.

kodi 2:17.4+git20170822.1009-fin
kodi-pvr-hts 3.4.27-3-zesty
tvheadend 4.2.1-dmo1-bpo8+1

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@Jalle19 @CvH @tetzlav @Snippo