Project

General

Profile

Bug #5338

service instance is bad, reason: No descrambler

Added by Trex the Daemon almost 6 years ago. Updated over 4 years ago.

Status:
Invalid
Priority:
Normal
Assignee:
-
Category:
Descrambling
Target version:
-
Start date:
2018-11-19
Due date:
% Done:

0%

Estimated time:
Found in version:
4.3-1529
Affected Versions:

Description

I have the following problem.
When trying to watch channels from my cable provider, I'm getting the following error:

2018-11-19 22:10:46.151 subscription: 000B: service instance is bad, reason: No descrambler
2018-11-19 22:10:48.151 subscription: 000B: restarting channel HBO HD

oscam does not even get a request to decode.
However, once I enable the 'remove scrambled bits' setting, oscam starts to request ecms (with answer in 200-300ms from card), but this time I'm getting these errors:

2018-11-19 22:14:49.150 subscription: 001E: "127.0.0.1 [ root | Kodi Media Center ]" subscribing on channel "HBO HD", weight: 150, adapter: "Silicon Labs Si2168 #0 : DVB-C #0", network: "Digi", mux: "434MHz", provider: "DIGI TV", service: "HBO HD", profile="htsp", hostname="127.0.0.1", username="root", client="Kodi Media Center"

2018-11-19 22:14:49.392 TS: Digi/434MHz/HBO HD: MPEG2AUDIO @ #6522: Invalid start code d8:be:63

2018-11-19 22:14:49.392 TS: Digi/434MHz/HBO HD: MPEG2AUDIO @ #6524: Invalid start code d8:be:63

2018-11-19 22:14:49.458 TS: Digi/434MHz/HBO HD: H264 @ #6521: Invalid start code 25:25:bc

2018-11-19 22:14:49.474 TS: Digi/434MHz/HBO HD: AC3 @ #6523: Invalid start code c0:e3:cb

But, if then I disable again the 'remove scrambled bit' option, while the channel is still opening, suddenly everything start to work, no more invalid start codes, and in oscam log I can see the dvbapi requesting ECMs.

Tvheadend version being used:HTS Tvheadend 4.3-1529 ~ LibreELEC Tvh-addon v9.0.444

Tuner is a SI2168.

The same setup is used also with a Sundtek DVB-S tuner, and with this one scrambled channels are working correctly, with the 'remove scrambled bit' disabled.

Files

tvheadend.log (1.1 MB) tvheadend.log Trex the Daemon, 2018-11-20 12:49

History

#1

Updated by Jaroslav Kysela almost 6 years ago

--trace descrambler,capmt,cwc,cccam : https://tvheadend.org/projects/tvheadend/wiki/Traces

#2

Updated by Trex the Daemon almost 6 years ago

Jaroslav Kysela wrote:

--trace descrambler,capmt,cwc,cccam : https://tvheadend.org/projects/tvheadend/wiki/Traces

I've uploaded the trace. Honesly, I don't know now if it's an oscam bug (R11438) or tvheadend.
So in the trace you can see that with the SI tuner, I'm trying to open 2 scrambled channels, Hbo and Cinemasx. At some point, I tick the 'remove scrambled bit' then back again, but this time I could not get to descramble the channels any more.
Hoever, if I switch back to the DVB-S2 tuner, and try to open Sky Cinema, it also won't work until I restart oscam.

So it could be that the issue is on the oscam side?
Anyway, I've uploaded the log file, maybe you can tell more about it.

Thanks in advance for your time.

#3

Updated by john beton almost 6 years ago

Hi Trex,

After oscam OSCam r11384, some changes were made to the dvbapi connection that don't work for me either. Can you please try with OSCam r11384 ?

Thanks

#4

Updated by Trex the Daemon almost 6 years ago

john beton wrote:

Hi Trex,

After oscam OSCam r11384, some changes were made to the dvbapi connection that don't work for me either. Can you please try with OSCam r11384 ?

Thanks

I've tried, as you've suggested, but there is no change.

#5

Updated by Joe User almost 6 years ago

Can you provide another log with a corresponding oscam log with -d128 (debug level 128 = dvbapi).
Also annotate at what time you enable the 'remove scrambled bit' option, and what time you disable it.

#6

Updated by Trex the Daemon almost 6 years ago

Joe User wrote:

Can you provide another log with a corresponding oscam log with -d128 (debug level 128 = dvbapi).
Also annotate at what time you enable the 'remove scrambled bit' option, and what time you disable it.

Sure, I'll make the logs this evening.

#7

Updated by Trex the Daemon almost 6 years ago

Trex the Daemon wrote:

Joe User wrote:

Can you provide another log with a corresponding oscam log with -d128 (debug level 128 = dvbapi).
Also annotate at what time you enable the 'remove scrambled bit' option, and what time you disable it.

Sure, I'll make the logs this evening.

Unfortunately I cannot reproduce the issue any more.
Descrambling still does not work, and here's the output of oscam:


2018/11/21 20:34:43 7D765208 c (dvbapi) Demuxer 0 serving srvid 028C (HBO HD) on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:34:43 7D765208 c (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 028C fd = 95 ecmpids = 3)
2018/11/21 20:34:53 7D765208 c (dvbapi) Demuxer 0 prio ecmpid 1 1880@000000:15B7:0000 weight: 50 (file)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 sorting the ecmpids took 21227 ms
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 1880 PROVID 000000 ECMPID 15B7 ANY CHID PMTPID 1978 VPID 1979
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 try to start new filter for caid: 1880, provid: 000000, pid: 15B7
2018/11/21 20:35:04 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:04 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 01 15 B7 80 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 F0 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 0B B8 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 04
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 Filter 2 started successfully (caid 1880 provid 000000 pid 15B7)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2018/11/21 20:35:04 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:04 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 02 00 01 01 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 04
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 Filter 3 started successfully (caid 0001 provid 000001 pid 0001)
2018/11/21 20:35:04 7D765208 c (dvbapi) Got packet with opcode 9F803F04 and size 8
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stop descrambling program number 028C (HBO HD)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stop filter 3 try 1 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2018/11/21 20:35:04 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 6F 2A 00 00 02 00 01
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 1978)
2018/11/21 20:35:04 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 6F 2A 00 00 00 19 78
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stop filter 2 try 1 (fd: 65535 api: 0, caid: 1880, provid: 000000, ecmpid: 15B7)
2018/11/21 20:35:04 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 6F 2A 00 00 01 15 B7
2018/11/21 20:35:04 7D765208 c (dvbapi) Got packet with opcode 9F803282 and size 72
2018/11/21 20:35:04 7D765208 c (dvbapi) PMT Update on socket 95.
2018/11/21 20:35:04 7D765208 c (dvbapi) Parsing PMT object:
2018/11/21 20:35:04 7D765208 c (dvbapi) 9F 80 32 82 00 42 03 02 8C 18 00 28 01 81 08 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 E8 00 01 82 02 01 00 84 02 19 78 83
2018/11/21 20:35:04 7D765208 c (dvbapi) 01 00 09 04 06 BB 15 E9 09 04 18 80 15 B7 09 04
2018/11/21 20:35:04 7D765208 c (dvbapi) 18 01 15 85 1B 19 79 00 00 04 19 7A 00 00 81 19
2018/11/21 20:35:04 7D765208 c (dvbapi) 7B 00 00 04 19 7C 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) capmt:
2018/11/21 20:35:04 7D765208 c (dvbapi) 03 02 8C 18 00 28 01 81 08 00 00 00 00 00 E8 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 01 82 02 01 00 84 02 19 78 83 01 00 09 04 06 BB
2018/11/21 20:35:04 7D765208 c (dvbapi) 15 E9 09 04 18 80 15 B7 09 04 18 01 15 85 1B 19
2018/11/21 20:35:04 7D765208 c (dvbapi) 79 00 00 04 19 7A 00 00 81 19 7B 00 00 04 19 7C
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) Receiver sends PMT command 3 for channel 028C
2018/11/21 20:35:04 7D765208 c (dvbapi) Receiver wants to demux srvid 028C on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:35:04 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:04 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 00 19 78 02 02 8C 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF FF FF 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:04 7D765208 c (dvbapi) 04
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 1978)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 found pmt type: 81 length: 8 (assuming enigma private descriptor: namespace 0000 tsid e8 onid 01)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 06BB ECM_PID: 15E9 PROVID: 000000
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1880 ECM_PID: 15B7 PROVID: 000000
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 1801 ECM_PID: 1585 PROVID: 000000
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stream Videostream (MPEG-4)(type: 1b pid: 1979 length: 0)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (MPEG-2)(type: 04 pid: 197a length: 0)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (Dolby Digital)(type: 81 pid: 197b length: 0)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (MPEG-2)(type: 04 pid: 197c length: 0)
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 found 3 ECMpids and 4 STREAMpids in caPMT
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0 serving srvid 028C (HBO HD) on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:35:04 7D765208 c (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 028C fd = 95 ecmpids = 3)
2018/11/21 20:35:13 7D765208 c (dvbapi) Demuxer 0 prio ecmpid 1 1880@000000:15B7:0000 weight: 50 (file)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 sorting the ecmpids took 19099 ms
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 1880 PROVID 000000 ECMPID 15B7 ANY CHID PMTPID 1978 VPID 1979
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 try to start new filter for caid: 1880, provid: 000000, pid: 15B7
2018/11/21 20:35:23 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:23 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 01 15 B7 80 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 F0 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 0B B8 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 04
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 Filter 2 started successfully (caid 1880 provid 000000 pid 15B7)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2018/11/21 20:35:23 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:23 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 02 00 01 01 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 04
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 Filter 3 started successfully (caid 0001 provid 000001 pid 0001)
2018/11/21 20:35:23 7D765208 c (dvbapi) Got packet with opcode 9F803F04 and size 8
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stop descrambling program number 028C (HBO HD)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stop filter 3 try 1 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2018/11/21 20:35:23 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 6F 2A 00 00 02 00 01
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 1978)
2018/11/21 20:35:23 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 6F 2A 00 00 00 19 78
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stop filter 2 try 1 (fd: 65535 api: 0, caid: 1880, provid: 000000, ecmpid: 15B7)
2018/11/21 20:35:23 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 6F 2A 00 00 01 15 B7
2018/11/21 20:35:23 7D765208 c (dvbapi) Got packet with opcode 9F803282 and size 72
2018/11/21 20:35:23 7D765208 c (dvbapi) PMT Update on socket 95.
2018/11/21 20:35:23 7D765208 c (dvbapi) Parsing PMT object:
2018/11/21 20:35:23 7D765208 c (dvbapi) 9F 80 32 82 00 42 03 02 8C 19 00 28 01 81 08 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 E8 00 01 82 02 01 00 84 02 19 78 83
2018/11/21 20:35:23 7D765208 c (dvbapi) 01 00 09 04 06 BB 15 E9 09 04 18 80 15 B7 09 04
2018/11/21 20:35:23 7D765208 c (dvbapi) 18 01 15 85 1B 19 79 00 00 04 19 7A 00 00 81 19
2018/11/21 20:35:23 7D765208 c (dvbapi) 7B 00 00 04 19 7C 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) capmt:
2018/11/21 20:35:23 7D765208 c (dvbapi) 03 02 8C 19 00 28 01 81 08 00 00 00 00 00 E8 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 01 82 02 01 00 84 02 19 78 83 01 00 09 04 06 BB
2018/11/21 20:35:23 7D765208 c (dvbapi) 15 E9 09 04 18 80 15 B7 09 04 18 01 15 85 1B 19
2018/11/21 20:35:23 7D765208 c (dvbapi) 79 00 00 04 19 7A 00 00 81 19 7B 00 00 04 19 7C
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) Receiver sends PMT command 3 for channel 028C
2018/11/21 20:35:23 7D765208 c (dvbapi) Receiver wants to demux srvid 028C on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:35:23 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:23 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 00 19 78 02 02 8C 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF FF FF 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:23 7D765208 c (dvbapi) 04
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 1978)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 found pmt type: 81 length: 8 (assuming enigma private descriptor: namespace 0000 tsid e8 onid 01)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 06BB ECM_PID: 15E9 PROVID: 000000
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1880 ECM_PID: 15B7 PROVID: 000000
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 1801 ECM_PID: 1585 PROVID: 000000
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stream Videostream (MPEG-4)(type: 1b pid: 1979 length: 0)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (MPEG-2)(type: 04 pid: 197a length: 0)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (Dolby Digital)(type: 81 pid: 197b length: 0)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (MPEG-2)(type: 04 pid: 197c length: 0)
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 found 3 ECMpids and 4 STREAMpids in caPMT
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0 serving srvid 028C (HBO HD) on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 028C fd = 95 ecmpids = 3)
2018/11/21 20:35:32 7D765208 c (dvbapi) Demuxer 0 prio ecmpid 1 1880@000000:15B7:0000 weight: 50 (file)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 sorting the ecmpids took 19137 ms
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 1880 PROVID 000000 ECMPID 15B7 ANY CHID PMTPID 1978 VPID 1979
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 try to start new filter for caid: 1880, provid: 000000, pid: 15B7
2018/11/21 20:35:42 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:42 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 01 15 B7 80 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 F0 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 0B B8 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 04
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 Filter 2 started successfully (caid 1880 provid 000000 pid 15B7)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2018/11/21 20:35:42 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:42 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 02 00 01 01 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 04
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 Filter 3 started successfully (caid 0001 provid 000001 pid 0001)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 has 3 ecmpids, 4 streampids, 1 ecmfilters and 1 of max 0 emmfilters
2018/11/21 20:35:42 7D765208 c (dvbapi) Got packet with opcode 9F803F04 and size 8
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stop descrambling program number 028C (HBO HD)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stop filter 3 try 1 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2018/11/21 20:35:42 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 6F 2A 00 00 02 00 01
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 1978)
2018/11/21 20:35:42 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 6F 2A 00 00 00 19 78
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stop filter 2 try 1 (fd: 65535 api: 0, caid: 1880, provid: 000000, ecmpid: 15B7)
2018/11/21 20:35:42 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 6F 2A 00 00 01 15 B7
2018/11/21 20:35:42 7D765208 c (dvbapi) Got packet with opcode 9F803282 and size 72
2018/11/21 20:35:42 7D765208 c (dvbapi) PMT Update on socket 95.
2018/11/21 20:35:42 7D765208 c (dvbapi) Parsing PMT object:
2018/11/21 20:35:42 7D765208 c (dvbapi) 9F 80 32 82 00 42 03 02 8C 1A 00 28 01 81 08 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 E8 00 01 82 02 01 00 84 02 19 78 83
2018/11/21 20:35:42 7D765208 c (dvbapi) 01 00 09 04 06 BB 15 E9 09 04 18 80 15 B7 09 04
2018/11/21 20:35:42 7D765208 c (dvbapi) 18 01 15 85 1B 19 79 00 00 04 19 7A 00 00 81 19
2018/11/21 20:35:42 7D765208 c (dvbapi) 7B 00 00 04 19 7C 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) capmt:
2018/11/21 20:35:42 7D765208 c (dvbapi) 03 02 8C 1A 00 28 01 81 08 00 00 00 00 00 E8 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 01 82 02 01 00 84 02 19 78 83 01 00 09 04 06 BB
2018/11/21 20:35:42 7D765208 c (dvbapi) 15 E9 09 04 18 80 15 B7 09 04 18 01 15 85 1B 19
2018/11/21 20:35:42 7D765208 c (dvbapi) 79 00 00 04 19 7A 00 00 81 19 7B 00 00 04 19 7C
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) Receiver sends PMT command 3 for channel 028C
2018/11/21 20:35:42 7D765208 c (dvbapi) Receiver wants to demux srvid 028C on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:35:42 7D765208 c (dvbapi) Sending packet to dvbapi client (fd=95):
2018/11/21 20:35:42 7D765208 c (dvbapi) 40 3C 6F 2B 00 00 00 19 78 02 02 8C 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF FF FF 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2018/11/21 20:35:42 7D765208 c (dvbapi) 04
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 1978)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 found pmt type: 81 length: 8 (assuming enigma private descriptor: namespace 0000 tsid e8 onid 01)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 06BB ECM_PID: 15E9 PROVID: 000000
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1880 ECM_PID: 15B7 PROVID: 000000
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 1801 ECM_PID: 1585 PROVID: 000000
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stream Videostream (MPEG-4)(type: 1b pid: 1979 length: 0)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (MPEG-2)(type: 04 pid: 197a length: 0)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (Dolby Digital)(type: 81 pid: 197b length: 0)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 stream Audiostream (MPEG-2)(type: 04 pid: 197c length: 0)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 found 3 ECMpids and 4 STREAMpids in caPMT
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 serving srvid 028C (HBO HD) on adapter 0000 camask 0001 index 0000 pmtpid 1978
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 028C fd = 95 ecmpids = 3)
2018/11/21 20:35:51 7D765208 c (dvbapi) Demuxer 0 prio ecmpid 1 1880@000000:15B7:0000 weight: 50 (file)

Tried with another receiver with the same oscam settings and it works, so it's not a card issue I suppose.

Anyway, if you cannot see anything wrong in this log, I propose to close this ticket.

#8

Updated by Jaroslav Kysela almost 6 years ago

Sorting of pids took 19 seconds? Ohh.. It's something in oscam really broken.

2018/11/21 20:35:23 7D765208 c (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 028C fd = 95 ecmpids = 3)
2018/11/21 20:35:32 7D765208 c (dvbapi) Demuxer 0 prio ecmpid 1 1880@000000:15B7:0000 weight: 50 (file)
2018/11/21 20:35:42 7D765208 c (dvbapi) Demuxer 0 sorting the ecmpids took 19137 ms
#9

Updated by Flole Systems over 4 years ago

  • Status changed from New to Invalid

Also available in: Atom PDF