Bug #3501
decrypting fails but restart TVH fixes it works straight away (assume to be TVH timing out with connection to oscam or something)
0%
Description
This one is difficult to provide logs for as it seems to lose the ability to decode successfully after a certain period (say the next day).
I have a kodi client connected, I restart tvh and it jumps into live (I thought it was oscam not being able to decode but its seems to be the connection with TVH).
I have two snippets of logs, the first trying to connect to a encrypted channel and it failing, then a restart of TVH and it works as expected.
Let me know if I can provide more logs or info on this.
Thanks
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: Starting CAPMT server for service "Sky Sports 1" on adapter 1
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: New caid 0x0960:0x000000 (pid 0x051F) for service "Sky Sports 1"
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: New caid 0x0961:0x000000 (pid 0x051F) for service "Sky Sports 1"
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: New caid 0x0963:0x000000 (pid 0x051F) for service "Sky Sports 1"
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: adding ECMPID=0x51F (1311), CAID=0x963 (2403) PROVID=0x0 (0), SID=4611, ADAPTER=1
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: adding ECMPID=0x51F (1311), CAID=0x961 (2401) PROVID=0x0 (0), SID=4611, ADAPTER=1
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: adding ECMPID=0x51F (1311), CAID=0x960 (2400) PROVID=0x0 (0), SID=4611, ADAPTER=1
Jan 16 10:00:07 server tvheadend7031: capmt: tvh: Trying to obtain key for service "Sky Sports 1"
Jan 16 10:00:07 server tvheadend7031: subscription: 02BA: "192.168.0.130 [ zotac-d88 | Kodi Media Center ]" subscribing on channel "Sky Sports 1", weight: 150, adapter: "SAT>IP DVB-S Tuner #1 (192.168.0.75)", network: "DVB-S2", mux: "12148H", provider: "BSkyB", service: "Sky Sports 1", profile="htsp", hostname="192.168.0.130", username="zotac-d88", client="Kodi Media Center"
Jan 16 10:00:07 server tvheadend7031: htsp: 192.168.0.130 [ zotac-d88 | Kodi Media Center ] - subscription grace 10 seconds
Jan 16 10:00:07 server tvheadend7031: htsp: 192.168.0.130 [ zotac-d88 | Kodi Media Center ] - subscription speed
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0000 (0) [20/0x2862360]
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0001 (1) [16/0x29a2f00]
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0010 (16) [16/0x2900710]
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0011 (17) [20/0x2bb5ef0]
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0011 (17) [16/0x2190a20]
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0014 (20) [20/0x23bec80]
Jan 16 10:00:07 server tvheadend7031: mpegts: 12148H in DVB-S2 - open PID 0014 (20) [20/0x2c0c720]
Jan 16 10:00:07 server tvheadend7031: satip: 192.168.0.75 #1 - new session 14b42fdb7829292 stream id 3619
Jan 16 10:00:07 server tvheadend7031: service: DVB-S2/12148H/Sky Sports 1: Status changed to [Hardware input]
Jan 16 10:00:07 server tvheadend7031: service: DVB-S2/12148H/Sky Sports 1: Status changed to [Hardware input] [Input on service]
Jan 16 10:00:07 server tvheadend7031: service: DVB-S2/12148H/Sky Sports 1: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Jan 16 10:00:07 server tvheadend7031: service: DVB-S2/12148H/Sky Sports 1: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Jan 16 10:00:07 server tvheadend7031: eit: 12148H in DVB-S2: PID 0012 CC error 10 != 0
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: CA_SET_PID adapter 0 index -1 pid 516 (0x0204)
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: CA_SET_PID adapter 0 index 0 pid 516 (0x0204)
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: CA_SET_PID adapter 0 index -1 pid 644 (0x0284)
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: CA_SET_PID adapter 0 index 0 pid 644 (0x0284)
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: CA_SET_PID adapter 0 index -1 pid 1036 (0x040c)
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: CA_SET_PID adapter 0 index 0 pid 1036 (0x040c)
Jan 16 10:01:05 server tvheadend25745: capmt: tvh, CA_SET_DESCR adapter 0 par 1 idx 0 c61900df63cee314
Jan 16 10:01:05 server tvheadend25745: descrambler: Obtained keys from capmt-127.0.0.1 for service "Sky Sports 1"
Jan 16 10:01:05 server tvheadend25745: descrambler: info - service='Sky Sports 1' caid=0963(videoguard) provid=000000 ecmtime=315 hops=2 reader='XXXX' from='XXXX' protocol='cccam'
Jan 16 10:01:05 server tvheadend25745: capmt: tvh: ECM_INFO: adapter=0 sid=4611 caid=0963(videoguard) pid=051F provid=000000 ecmtime=315 hops=2 reader=XXXX from=XXXX protocol=cccam
Jan 16 10:01:05 server tvheadend25745: service: DVB-S2/12148H/Sky Sports 1: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access]
Jan 16 10:01:05 server tvheadend25745: htsp: 192.168.0.130 [ zotac-d88 | Kodi Media Center ] - subscription start
Jan 16 10:01:05 server tvheadend25745: service: DVB-S2/12148H/Sky Sports 1: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
History
Updated by Jaroslav Kysela almost 9 years ago
Provide log from oscam - level 128 - and traces for tvh - '--trace descrambler,capmt' for working / non-working states. https://tvheadend.org/projects/tvheadend/wiki/Traces