channel not subscribed

[master2k]

Hallo zusammen!

Ich betreibe OSCAM 1.20-unstable_svn build #8099 mit Debian auf einem Futro.
Die lokale Sky V13 ist in einer Easymouse 2.

Mein Sharepartner (OSCAM2OSCAM mit C-Line) bekommt zwischendurch immer wieder keine CWs retour, bei mir funktioniert der Kanal jedoch ohne Probleme.
Im Logfile finde ich zu 90% [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed vor dem "not found", war bei allen Logzeilen unten der Fall, hatte es aber nur nicht wegkopiert.

Woher kommen die Fehler und wie kann ich sie beheben?

Logfile (Auszug):

Spoiler

2013/01/16 13:46:24 xxx c sharepartner (09C4&000000/0000/0038/B3:365688601261E83BBA3CE7586449444B): not found (142 ms) by skyv13 - Boomerang
2013/01/16 12:56:30 xxx c sharepartner (09C4&000000/0000/0038/B3:61E86F07F8AD8E67CFC4D35C24A14C1E): not found (55 ms) by skyv13 - Boomerang
2013/01/16 12:56:29 xxx c sharepartner (09C4&000000/0000/0038/B3:5C8DF6AB2A88B861957CA073DE9CE511): not found (73 ms) by skyv13 - Boomerang
2013/01/16 14:54:45 xxx c sharepartner (09C4&000000/0000/000A/B3:67EA7666DD8F00F0F1E072E7548A14B6): not found (89 ms) by skyv13 - Sky Cinema
2013/01/16 15:05:34 xxx c sharepartner (09C4&000000/0000/000A/B3:29B99E99E4E57A385AA03CC0EB5FF86F): not found (147 ms) by skyv13 - Sky Cinema
2013/01/16 15:21:22 xxx c sharepartner (09C4&000000/0000/000A/B3:7DF2B8AC3CE008DB296C58F1D04A9970): not found (141 ms) by skyv13 - Sky Cinema
2013/01/16 15:22:21 xxx c sharepartner (09C4&000000/0000/000A/B3:FB7CFAC9D2ED5286FCD6333F41336607): not found (63 ms) by skyv13 - Sky Cinema
2013/01/16 19:38:20 xxx r skyv13 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/01/16 19:38:20 xxx c sharepartner (09C4&000000/0000/000A/B3:556F829F2034E64FEA589DB2ACA7FC76): not found (137 ms) by skyv13 - Sky Cinema
2013/01/16 19:54:49 xxx c meinreceiver (09C4&000000/0000/000A/B3:CD9AAD74265CED5C8F6B60BC913758CF): found (125 ms) by skyv13 (L/1/2/2) - Sky Cinema

oscam.server

Spoiler

[reader]
label = skyv13
protocol = mouse
device = /dev/ttyUSB0
services = eigene_sky_v13
boxid = 12345678
ins7e11 = 15
detect = cd
mhz = 600
cardmhz = 357
group = 3
emmcache = 1,3,2
blockemm-unknown = 1
blockemm-s = 1
blockemm-g = 1
blockemm-u = 0
ecmwhitelist = 09C4:56,9B,A0,B3
ecmheaderwhitelist = 09C4:807098000001,817098000001,807060000001,817060000001,80709D000001,81709D000001,80704E000001,81704E000001,807066000001,817066000001,8070B0000001,8170B0000001

Danke

 

[mxer]

AW: channel not subscribed

Laß mal die ecm-whitelist weg, leermachen.
Auch mit der ecm-Headerwhitelist das erstmal so machen.
Channel not subscribed - Sender nicht im Abo?

 

[master2k]

AW: channel not subscribed

Danke für deinen Hinweis.
Beide Werte beim Reader hab ich erst aus der Not heraus konfiguriert, d.h. mit/ohne diese Parameter das gleiche Verhalten.

Im letzten Logeintrag siehst du dass der Kanal hell wird, ist also im Abo.
Fehler tritt auch zB bei Eurosport HD auf, bei vielleicht jeder 5. ECM kommt dieser Fehler, manchmal auch öfter.

Auf meinen Boxen mit OSCAM/CCcam keine Probleme.

 

[master2k]

AW: channel not subscribed

Guten Morgen!

Falls es hilft, hab hier noch einen ungekürzten Log der letzten Stunde:

Spoiler

2013/01/17 07:46:09 xxx c sharepartner (09C4&000000/0000/0084/B3:AA38437D0BC99AAD2CBD39C24A8B2EFB): found (141 ms) by skyv13 - Eurosport HD
2013/01/17 07:54:33 xxx c sharepartner (09C4&000000/0000/0084/B3:AFF7A7F5B4126B4A6AADFBD58F405AC8): found (126 ms) by skyv13 - Eurosport HD
2013/01/17 07:58:17 xxx c sharepartner (09C4&000000/0000/0084/B3:A49EB9D846DDE404927DE06E8CB6A8FF): found (125 ms) by skyv13 - Eurosport HD
2013/01/17 08:00:13 xxx r skyv13 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/01/17 08:00:13 xxx c sharepartner (09C4&000000/0000/0084/B3:57A8B6E2AB9BE4A91382E7696FD5BFD9): not found (91 ms) by skyv13 - Eurosport HD
2013/01/17 08:00:20 xxx c sharepartner (09C4&000000/0000/0084/B3:ECCACDF5A9D9A96709C297AA4FFC37BE): rejected group (1 ms) (0/0/0/0) - Eurosport HD (no matching reader)
2013/01/17 08:06:11 xxx c sharepartner (09C4&000000/0000/0084/B3:0DAD3BB2BAC2469DF4AB7D6850788108): found (128 ms) by skyv13 - Eurosport HD
2013/01/17 08:06:32 xxx c sharepartner (09C4&000000/0000/0084/B3:86FC11D4728733AE6605F92257E07B6A): found (129 ms) by skyv13 - Eurosport HD
2013/01/17 08:07:09 xxx c sharepartner (09C4&000000/0000/0084/B3:C6624373563D057D0CCB8B95ED7F81F3): found (127 ms) by skyv13 - Eurosport HD
2013/01/17 08:07:26 xxx c sharepartner (09C4&000000/0000/0084/B3:F0F4B4D66DEF66F9D2C06D11413A4C51): found (128 ms) by skyv13 - Eurosport HD
2013/01/17 08:07:28 xxx c sharepartner (09C4&000000/0000/0084/B3:B7BC1D915A95D589358A3356F86F8863): found (120 ms) by skyv13 - Eurosport HD
2013/01/17 08:08:37 xxx c sharepartner (09C4&000000/0000/0084/B3:475D5AB09289BFD84D4591295813E622): found (127 ms) by skyv13 - Eurosport HD
2013/01/17 08:14:05 xxx c sharepartner (09C4&000000/0000/0084/B3:06DBF3C971174250350AAC60A49C2BB3): found (128 ms) by skyv13 - Eurosport HD
2013/01/17 08:15:36 xxx c sharepartner (09C4&000000/0000/0084/B3:C974E7498F816F97649AA28E0B52269D): found (124 ms) by skyv13 - Eurosport HD
2013/01/17 08:16:04 xxx c sharepartner (09C4&000000/0000/0084/B3:B2201F199DAB43F9B748318B8D9CEA35): found (126 ms) by skyv13 - Eurosport HD
2013/01/17 08:16:16 xxx c sharepartner (09C4&000000/0000/0084/B3:6A7058849471CB6852B33D01414E3118): found (125 ms) by skyv13 - Eurosport HD
2013/01/17 08:16:17 xxx c sharepartner (09C4&000000/0000/0084/B3:B5DA5C44394DFBC0E9DCD860B766DC3A): found (125 ms) by skyv13 - Eurosport HD
2013/01/17 08:16:55 xxx c sharepartner (09C4&000000/0000/0084/B3:F2A3BAE5121B9733992F0B6AB2C3EDFB): found (126 ms) by skyv13 - Eurosport HD
2013/01/17 08:17:12 xxx c sharepartner (09C4&000000/0000/0084/B3:0EBE861C9B3FAE9B58FC5C4F76351B18): found (127 ms) by skyv13 - Eurosport HD
2013/01/17 08:18:20 xxx c sharepartner (09C4&000000/0000/0084/B3:091019AAED6A1A9005AA6B0E7C5744B7): found (127 ms) by skyv13 - Eurosport HD
2013/01/17 08:19:44 xxx r skyv13 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/01/17 08:19:44 xxx c sharepartner (09C4&000000/0000/0084/B3:64BCF98936C8308FEB86473334D6B709): not found (150 ms) by skyv13 - Eurosport HD

 

[mxer]

AW: channel not subscribed

Fiel mir gerade auf: Du hast keine CAID im Reader vergeben.

 

[master2k]

AW: channel not subscribed

Ich habe caid = 09C4 beim Reader hinzugefügt und OSCAM neu gestartet, gleiches Verhalten.

 

[mxer]

AW: channel not subscribed

Irgendwo WLAN oder noch ein Switch dazwischen?

Scheint nur ab und zu zu klemmen, nicht dauernd.

 

[master2k]

AW: channel not subscribed

Hmm, der CS Server hängt direkt in der DMZ auf der Firewall mit 100MBit - kein WLAN o.ä.
Vereinzelt treten die Fehler nacheinander auf, andere Clients werden fehlerfrei beantwortet.

 

[mxer]

AW: channel not subscribed

Dann mal auf dem betroffenen Client suchen.
Deswegen ja meine Frage, wegen der Verbindung.
Am Server liegt das dann wohl weniger.

 

[master2k]

AW: channel not subscribed

Der Client ist in dem Fall ein Sharepartner (OSCAM zu OSCAM mit CCcam ext.).
Hast du eine Idee woran das liegen könnte?

 

[mxer]

AW: channel not subscribed

Seine Verbindung zu anfällig?
Er hat nebenbei noch einen Download am Start, wenn der Fehler auftritt?

 

[master2k]

AW: channel not subscribed

Die Verbindung ist synchrones DSL, Ping immer bei konstanten 50ms.

 

[breitflansch]

AW: channel not subscribed

geh mal auf debug level 2 und schau dir die ecm vom user an.
wenn da viele nullen drin stehen, dann sendet er keine sauberen anfragen.

eine saubere anfrage sieht ungefähr so aus:

Spoiler

2013/01/18 11:19:35 A0C95D8 r ecm:
2013/01/18 11:19:35 A0C95D8 80 70 A6 00 00 01 0E 6C 12 52 75 01 FA AA 55 05
2013/01/18 11:19:35 A0C95D8 20 01 00 00 74 93 7D 13 1C 58 B8 C5 31 46 6D 87
2013/01/18 11:19:35 A0C95D8 A6 00 00 C2 50 96 FB 9A C1 0F 49 90 7C C0 01 E9
2013/01/18 11:19:35 A0C95D8 87 FC C1 BB 3F 8A EC 11 9F B3 B9 8B 9D 31 36 0E
2013/01/18 11:19:35 A0C95D8 91 0C 38 F7 F9 EF D6 F6 3B 27 D9 08 7B 88 39 CB
2013/01/18 11:19:35 A0C95D8 B5 BA BB EB A2 EB 03 31 52 2A 64 39 D0 7A F9 38
2013/01/18 11:19:35 A0C95D8 F9 2F 87 13 6D EA 50 6D 2E 4B 29 D6 05 CA 6A 5C
2013/01/18 11:19:35 A0C95D8 37 86 2A DE D0 F1 FA 82 FD C1 F5 42 6C DA 64 A0
2013/01/18 11:19:35 A0C95D8 93 0A E4 B1 9A EE 25 93 B9 D9 2D 7A 81 66 3B 40
2013/01/18 11:19:35 A0C95D8 E8 41 49 AD AB 76 F8 CF DE DA 18 9A 5B 5A CC 23
2013/01/18 11:19:35 A0C95D8 80 1A 91 30 4B E7 1A 77 89

 

[master2k]

AW: channel not subscribed

Danke für den Tipp.
Die ECMs sind in Ordnung, keine übermäßigen 0en und der Header passt auch.

Spoiler

2013/01/18 11:55:12 8A89618 r ecm:
2013/01/18 11:55:12 8A89618 80 70 B0 00 00 01 1D 6C 12 45 94 02 BF AA 55 05
2013/01/18 11:55:12 8A89618 20 01 00 00 80 40 73 D8 AA 24 30 0F 26 19 2A 03
2013/01/18 11:55:12 8A89618 02 05 02 E8 8E 7E 0A C3 F0 3A A9 66 47 49 CE 00
2013/01/18 11:55:12 8A89618 00 90 80 C1 01 AD AF EC 30 DE 72 4C BA AD CB F9
2013/01/18 11:55:12 8A89618 74 1A 86 13 95 0B 94 E5 16 98 2C D2 4F 83 B8 B3
2013/01/18 11:55:12 8A89618 73 95 6B AE D0 6E 13 D1 8D FA 37 E7 26 90 9B 21
2013/01/18 11:55:12 8A89618 A1 E6 B5 C6 1C C4 A8 89 84 D4 E1 2A EA B2 A4 78
2013/01/18 11:55:12 8A89618 08 93 CB 56 A7 55 4C 91 15 15 6E 0C 3E A5 2B DC
2013/01/18 11:55:12 8A89618 81 87 16 7F 8E 16 E9 18 9E B5 7C A0 C0 A9 A4 38
2013/01/18 11:55:12 8A89618 85 14 18 AE 06 A7 A6 B1 33 D5 7C 87 8B 63 6D 41
2013/01/18 11:55:12 8A89618 80 4E B3 60 9C 19 D7 87 FE CD DE A9 CD D6 4E CC
2013/01/18 11:55:12 8A89618 8D B9 E3
2013/01/18 11:55:12 8A89618 r skyv13 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/01/18 11:55:12 8B37F58 c sharepartner (09C4&000000/0000/0076/B3:51FDF83F23E198A3690D8D479551BE24): not found (148 ms) by skyv13 - Nat Geo Wild HD
2013/01/18 11:55:12 8B37F58 c cw:
2013/01/18 11:55:12 8B37F58 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00

 

[breitflansch]

AW: channel not subscribed

tja, dann vielleicht mal eine andere oscam version beim user einspielen,
manchmal hilfts...