Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

[CaptainJeanLuc]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

Hmmm - das hört sich nach einer recht coolen Konfiguration an. Welche VDR-Version verteilst Du denn an die Clients (per PXE)? Hast Du auf den Clients die gleiche channels.conf wie auf dem Server?

 

[c4lig0]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

die Config (bzw die Kanäle kommen vom Server/ Backend Kanalübertragung + EPG vom xvdr plugin) - als netboot nutze ich eine angepasste Openelec Version für Ion-Geräte (Embedded ION Boards kosten nicht viel und haben ausreichend Leistung für HD) die Openelec Kernel und Systemdatei sind ca 100mb groß und booten im Gigabit Netzwerk in ca 5 Sekunden (die bootzeit hab ich dann mit nem eigenen Logo überblendet (natürlich einer 1080p png) jeder neu angemeldete Client nutzt quasi diese Kernel und Systemdatei und baut sich ein eigenes /storage Verzeichnis (auf meinem NAS-Speicher) mit der eindeutigen MAC-Adresse (damit jeder nach belieben anpassen kann) natürlich wäre es auch möglich da noch eine Generic Version einzubauen aber hab mich da auf Ion "nennen wir es" spezialisiert...

hab auch heute erfahren dass man die Datenbank per Mysql bauen kann aber auf die jetzige art und Weise kann ich unter Windows auf die Datei Struktur zugreifen und Konfigurationen anpassen =) weiterhin soll es auch möglich sein die Clients über W-Lan booten zu lassen.. Was einen deutlich höheren Konfigurationsaufwand nach sich zieht^^

Schade ist nur dass nicht alle Sender am Client ankommen da fehlen ~10 TV Sender und beim Radio das Music-choice paket / eventuell hat jemand auch einen besseren Ansatz um meine channels.conf auszulesen da es teilweise beim XBMC unter Windows funktioniert... eventuell ein Problem in der Richtung utf-8 - bin schon etwas länger am überlegen (bei Mediaportal hatte es allerdings funktioniert)

 

[c4lig0]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

Mahlzeit!
Hab das Problem schon etwas länger gelöst lag nur an den einstellungen des xvdr plugins (hacken für "nur sender in eigener Sprache" nicht setzen - dann läufts).

Habe jetzt mittlerweile einen 2. Kartenleser und eine HD02 Karte mit Receiver im Keller gefunden, dessen Karte noch läuft - Sachen gibts =). Hatte dann mal versucht meine configs darauf anzupassen allerdings ohne Erfolg, Anfangs hatte ich Oscam soweit das sich 1 User (also mein einziger für den VDR) sich auf beiden Ports meldet nur entschlüsselt hatte er nur einen und zwar den ersten Reader (um02).. dann hatte ich versucht die HD02 Karte alleine zu entschlüsseln um zu sehen wie die config aussehen muss (das hat nur leider nicht funktioniert) und jetzt bin ich am verzweifeln, da ich nichtmal den "funktionierenden Zustand" mit nur einer Karte erreiche...

im Grunde genommen sollte die Config in Ordnung sein (direkt beim Start des Oscam meldet sich der User an - alles steht auf Okay) die Cardclient.conf hatte ich auch angepasst "meines wissens nach" so wie vorher, allerdings erzählt mir das syslog nichts über au;nagra;core usw. weiterhin steht da Cam 1-6 "no module present" und 7+8 reset modul - kurz danach - 7+8 modul present..

etwas sonderbar, ich komm grad nicht dahinter - hatte mal jemand sowas ? Hab heute das komplette System neu aufgesetzt aber wieder ohne erfolg.. (hab sogar versucht ein custom script zu erstellen um all das zu machen was ich sonst von Hand eintippen muss - aber ich glaub dafür fehlt mir noch etwas Erfahrung mit "text --> Datei" usw =/...

irgendwie nicht so mein Tag gestern/heute..

 

[Müderjoe]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

Hallo C4lig0,

hast du dein Problem lösen können?

MFG Joe

 

[chrissy0x]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

Hallo, ich habe nach diversen Threads hier auf meinem Easyvdr 1.0 softcam und oscam installiert und eine smartmouse/easymouse2 per usb angeschlosse.
Die configdateien soweit möglich hier aus den threads übernommen und entsprechend weiterer fundstellen für die in der smartmouse befindliche sky v14 angepasst....da ich jetzt nciht an den vdr komme kann ich logs erst heute nacht nachliefern aber bereits jetzt schon mal grobe problembeschreibungen:

1. der vdr (computer) schaltet nciht mehr ab. der vdr wird runtergefahren...die netzwerkverbindungen werden beendet putty schmeisst mich raus aber der rechner läuft ohne bild und ohne sicht- oder hörbare festplattenaktivität weiter.

2. ein versuch mit SofCam.key aus dem downloadbereich schlug fehl, wenn ich in den softcam plugineinstellungen im osd nach den keecksen schaue scheint es er habe keine geladen (log datei hatte ich keine gefunden obwohl ich im osd bei den plugineinstellungen das loggen in /var/log aktiviert hatte) man kommt an das plugin auch nur über die plugineinstellungen ran. gehe ich über das osd in den menüpunkt cam steht da 1 cam bereit, aber es kommt eine fehlermeldung dass das cammenü nicht geöffnet werden kann.

3. ein oscam log lag im temp verzeichnis, dort kann man sehen das wohl die sky karte erkann wurde, es kommt aber eine fehlermeldung welche aus dem kopf heraus irgendwie lautet cccclient ....error...invalid password....ich werde das log noch nachreichen.

im verhalten des vdr hat sich geändert, dass er nun bei den verschlüsselten kanälen nicht mehr meckert:" kanal nicht verfügbar", sondern er schaltet um, zeigt auch die epg daten aber der bildschirm bleibt schwarz...wie gesagt logs kommen noch sofern sich das sc herablässt ein log zu schreiben und ich hoffe ich finde im syslog was zu der runterfahrproblematik. aber vielleicht kann jetzt schon jemand anhand dieser schwammigen fehlerbeschreibung einen ansatz erkennen wo der hase im pfeffer liegt...ich liebe meinen vdr....aber so sachen wie sc plugin oscam und smartmouse sind echt mittlerweile so komliziert geworden *stöhn* vor allem wenn man nur user ist der versucht zu verstehen, aber im wesentlichen nur abschreibt...wenn ich die zusammenhänge verstehen würde wäre es vielleicht einfacher die möglichen problemquellen ausfindig zu machen...sollte ich mir doch ne xpeed lx1 kaufen? mit den fertigen images gehts vielleicht einfacher...naja ich hoffe sehr auf eure hilfe und bedanke mich bereits jetzt für jeden lösungsansatz!

 

[chrissy0x]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

So gestern hab ich es nicht mehr geschafft....sc schreibt leider kein log, obwohl ich das in den plugineinstellungen aktiviert habe...im syslog fidne ich ncihts hinsichtlich der runterfahr probleme. aber darum kann ich mich noch später kümmern. die fehlereldung im oscam.log könnt ihr dem log am ende entnehmen. ich denke die karte wird richtig erkannt...

Spoiler

-------------------------------------------------------------------------------
>> OSCam << cardserver started at Fri Oct 18 18:05:47 2013
-------------------------------------------------------------------------------
2013/10/18 18:05:47 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r8986 (i686-linux-gnu)
2013/10/18 18:05:47 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 2468
2013/10/18 18:05:47 0 s userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2013/10/18 18:05:47 0 s signal handling initialized
2013/10/18 18:05:47 0 s cccam: initialized (fd=5, port=54321)
2013/10/18 18:05:47 0 s skyv14 [mouse] creating thread for device /dev/ttyUSB0
2013/10/18 18:05:47 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2013/10/18 18:05:47 0 s waiting for local card init
2013/10/18 18:05:47 9BF9790 h webif: decompressed 54245 bytes back into 154648 bytes
2013/10/18 18:05:47 9BF9790 h HTTP Server running. ip=0.0.0.0 port=54322
2013/10/18 18:05:48 9BF7AA0 r skyv14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=357, cardmhz=357)
2013/10/18 18:05:48 9BF7AA0 r skyv14 [mouse] card detected
2013/10/18 18:05:50 9BF7AA0 r skyv14 [mouse] ATR: 3F FD 13 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2013/10/18 18:05:50 9BF7AA0 r skyv14 [mouse] Init card protocol T0, FI=1, F=372, D=4, N=2
2013/10/18 18:05:50 9BF7AA0 r skyv14 [mouse] Setting baudrate to 38400 bps
2013/10/18 18:05:50 9BF7AA0 r skyv14 [mouse] Calculated work ETU is 26.05 us
2013/10/18 18:05:50 9BF7AA0 r skyv14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed of 3.57 MHz (specified in reader->mhz)
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] Card type: P1TV
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] Rom version: 20AA
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] parental lock setting: FF FF FF FF
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] type: VideoGuard Sky Germany (098C), caid: 098C
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] ready for requests
2013/10/18 18:05:51 9BF7AA0 r skyv14 [mouse] found card system videoguard2
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] THIS WAS A SUCCESFULL START ATTEMPT No 1 out of max alloted of 1
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] card detected
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] type: VideoGuard Sky Germany (098C)
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 0046, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 0065, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 0066, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 006a, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 006b, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 006f, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 007b, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 0081, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 008e, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00c0, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00c7, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00c9, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00e4, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00f3, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00fa, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:51 9BF7AA0 r skyv14 [videoguard2] tier: 00ff, expiry date: 2014/01/28-00:00:00
2013/10/18 18:05:55 0 s init for all local cards done
2013/10/18 18:05:55 0 s anti cascading disabled
2013/10/18 18:05:55 9C031E8 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:05:55 9C031E8 c password for 'User' invalid!
2013/10/18 18:05:55 9C031E8 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:02 9C06AB0 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:02 9C06AB0 c password for 'User' invalid!
2013/10/18 18:06:02 9C06AB0 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:03 9C099E8 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:03 9C099E8 c password for 'User' invalid!
2013/10/18 18:06:03 9C099E8 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:06 9C0C920 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:06 9C0C920 c password for 'User' invalid!
2013/10/18 18:06:06 9C0C920 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:07 9C031E8 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:07 9C031E8 c password for 'User' invalid!
2013/10/18 18:06:07 9C031E8 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:15 9C06AB0 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:15 9C06AB0 c password for 'User' invalid!
2013/10/18 18:06:15 9C06AB0 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:16 9C099E8 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:16 9C099E8 c password for 'User' invalid!
2013/10/18 18:06:16 9C099E8 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:26 9C031E8 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:26 9C031E8 c password for 'User' invalid!
2013/10/18 18:06:26 9C031E8 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:27 9C06A58 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:27 9C06A58 c password for 'User' invalid!
2013/10/18 18:06:27 9C06A58 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:35 9C09990 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:35 9C09990 c password for 'User' invalid!
2013/10/18 18:06:35 9C09990 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:36 9C0C8C8 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:36 9C0C8C8 c password for 'User' invalid!
2013/10/18 18:06:36 9C0C8C8 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:46 9C06A58 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:46 9C06A58 c password for 'User' invalid!
2013/10/18 18:06:46 9C06A58 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:47 9C04430 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:47 9C04430 c password for 'User' invalid!
2013/10/18 18:06:47 9C04430 c anonymous disconnected from 127.0.0.1
2013/10/18 18:06:55 9C09990 c encrypted cccam-client 127.0.0.1 rejected (invalid access)
2013/10/18 18:06:55 9C09990 c password for 'User' invalid!
2013/10/18 18:06:55 9C09990 c anonymous disconnected from 127.0.0.1

EDIT:
das deaktivieren des SC Plugins hatte zur folge, dass der vdr nun nach dem runterfahren der software auch die hardware wieder ausschaltet...

offenbar ist bei dem sc-plugin irgendwas nicht in ordnung...gibts ne möglichkeit einer sauberen deinstallation und neuinstallation?

 

[chrissy0x]

AW: Startschwierigkeiten: easyvdr 1.0 vdr-sc oscam easymouse2

So neuer Stand der Dinge. Ein Teil der Softcam Probleme Probleme habe ich behobe. Ich habe im Syslog festgestellt dass das Plugin nicht als erstes geladen wird, obwohl es in der order.conf als einziges eingetragen ist. das problem war: sc macht alles auch die order.con in /etc/vdr/plugins und legt einen symlink auf diesen pfad in var/lib/vdr/plugins an. die order.con wird aber nciht verlinkt und daher auch nicht beachtet...ein kopieren dorthin brachte schon mal den erfolg dass ich nun ein log habe.

nach dem log fehlen noch die smartcard.conf und die cardslot.conf aber die sollen wohl nciht so wichtig sein. was ich vermisse ist ein hinweis darauf dass eine SoftCam.Key datei geladen wird. davon ist nichts zu lesen. die fehler weiter unten mit dem cccam2 sind wohl auf die oscam probleme zurückzuführen, also da besteht immer noch das problem dass er ein problem mit dem user und dem passwort hat.... ich füge die logs nochmal an und hoffe ihr könnt mir tips geben. ach so ausschalten tut er nun mit sc plugin wieder nciht mehr, aber darum würde ich imch später kümmern

Gruß

SC-Log

Spoiler

Okt 19 02:53:44.597 [general.debug] logfile '/tmp/vdr-sc' opened
Okt 19 02:53:44.597 [general.debug] capturing device 0/0 (subsystem ID 13c2101c)
Okt 19 02:53:44.597 [general.debug] creating standard device 0/0
Okt 19 02:53:44.649 [general.info] SC version 1.0.0pre-HG-29b7b5f231c8+ initializing (VDR 1.7.21)
Okt 19 02:53:44.756 [general.info] SC version 1.0.0pre-HG-29b7b5f231c8+ starting (VDR 1.7.21)
Okt 19 02:53:44.756 [core.load] ** Plugin config:
Okt 19 02:53:44.756 [core.load] ** Key updates (AU) are enabled (all CAIDs) (no prestart)
Okt 19 02:53:44.756 [core.load] ** Local systems take priority over cached remote
Okt 19 02:53:44.756 [core.load] ** Concurrent FF recordings are NOT allowed
Okt 19 02:53:44.756 [core.load] ** Force transfermode with digital audio
Okt 19 02:53:44.756 [core.load] ** ECM cache is set to enabled
Okt 19 02:53:44.756 [core.load] ** TsBufferSize is 4 MB
Okt 19 02:53:44.756 [core.load] ** ScCaps are 1 2 0 0 0 0 0 0 0 0
Okt 19 02:53:44.756 [general.info] loading cardclient config from /var/lib/vdr/plugins/sc/cardclient.conf
Okt 19 02:53:44.756 [cardclient.cccam2extra] cmd 0c crypt mode now 0
Okt 19 02:53:44.756 [cardclient.cccam2] logout from server initiated
Okt 19 02:53:44.756 [cardclient.cccam2extra] reader thread stopped
Okt 19 02:53:44.756 [cardclient.cccam2extra] network shut down
Okt 19 02:53:44.756 [cardclient.cccam2extra] cmd 0c crypt mode now 0
Okt 19 02:53:44.756 [cardclient.cccam2extra] logout done
Okt 19 02:53:44.756 [cardclient.core] hostname=127.0.0.1 port=54321 emm=1 emmCaids 098c/ffff
Okt 19 02:53:44.756 [cardclient.core] cccam2: username=User password=Pass
Okt 19 02:53:44.756 [cardclient.core] our nodeid: 52 ad 13 b2 35 9e eb 0a
Okt 19 02:53:44.756 [cardclient.core] pretended CCcam version '2.0.11' build '2892'
Okt 19 02:53:44.756 [cardclient.core] client 'cccam2' ready
Okt 19 02:53:44.756 [cardclient.cccam2] logout from server initiated
Okt 19 02:53:44.756 [cardclient.cccam2extra] reader thread stopped
Okt 19 02:53:44.756 [cardclient.cccam2extra] network shut down
Okt 19 02:53:44.756 [cardclient.cccam2extra] cmd 0c crypt mode now 0
Okt 19 02:53:44.756 [cardclient.cccam2extra] logout done
Okt 19 02:53:44.757 [core.net] connecting to 127.0.0.1:54321/tcp (127.0.0.1)
Okt 19 02:53:50.597 [cardclient.cccam2extra] welcome checksum correct
Okt 19 02:53:50.597 [cardclient.login] CCcam login succeed
Okt 19 02:53:50.597 [general.info] loading overrides from /var/lib/vdr/plugins/sc/override.conf
Okt 19 02:53:50.598 [core.override] ecmprio: S19.2E: - chain 1702 1833
Okt 19 02:53:50.598 [core.override] tunnel: 1833:S19.2E: - to 1702, rewriter nagra-beta(1001)
Okt 19 02:53:50.598 [core.load] loaded 2 overrides from /var/lib/vdr/plugins/sc/override.conf
Okt 19 02:53:50.598 [general.error] failed open /var/lib/vdr/plugins/sc/smartcard.conf: Datei oder Verzeichnis nicht gefunden
Okt 19 02:53:50.598 [general.error] failed open /var/lib/vdr/plugins/sc/cardslot.conf: Datei oder Verzeichnis nicht gefunden
Okt 19 02:53:50.598 [general.info] loading ecm cache from /var/lib/vdr/plugins/sc/ecm.cache
Okt 19 02:53:50.598 [core.load] ** registered systems:
Okt 19 02:53:50.598 [core.load] ** SC-VideoGuard2 (pri -5)
Okt 19 02:53:50.598 [core.load] ** Cardclient (pri -15)
Okt 19 02:53:50.598 [core.load] ** SC-Nagra (pri -5)
Okt 19 02:53:50.598 [core.load] ** SC-Cryptoworks (pri -5)
Okt 19 02:53:50.598 [general.info] Using software decryption on card 0/0
Okt 19 02:53:50.604 [cardclient.login] cccam2: server version 2.1.1 build 2971 nodeid 32 1e 52 3f 10 fb 14 20
Okt 19 02:53:50.604 [cardclient.cccam2extra] cmd 0B aes key 32 1e 52 3f 10 fb 14 20 32 2e 31 2e 31 00 00 00
Okt 19 02:53:50.605 [core.ci] 0/0: no active CAIDs
Okt 19 02:53:50.605 [core.ci] card 0/0, slot 0 (v= 1) caids:
Okt 19 02:53:50.605 [core.ci] 0/0: reset of slot 0 requested
Okt 19 02:53:51.358 [core.ci] 0/0.0: doReply changed, reset triggered
Okt 19 02:53:51.358 [core.ci] 0/0.0: now using CAIDs version 1
Okt 19 02:53:51.358 [core.ci] 0/0.0: status 'present'
Okt 19 02:53:51.458 [core.ci] 0/0.0: status 'reset'
Okt 19 02:53:52.004 [cardclient.cccam2shares] ADD share 00000064 hops 0 maxdown 2 caid 098c ua 00000000006488dc prov 000000/00648800 (EMM)
Okt 19 02:53:52.004 [cardclient.cccam2] enabled EMM processing
Okt 19 02:53:52.060 [core.ci] 0/0.0: status 'present'
Okt 19 02:54:01.397 [core.ci] card 0/0, slot 0 (v= 2) caids: 098c
Okt 19 02:54:01.397 [core.ci] 0/0.0: now using CAIDs version 2
Okt 19 02:54:01.498 [core.ci] 0/0.0: status 'ready'
Okt 19 02:54:01.749 [core.ci] 0/0.0 -> 00 01 82 01 01
Okt 19 02:54:01.749 [core.ci] 0/0.0 <- 00 01 83 01 01 80 02 01 80
Okt 19 02:54:01.749 [core.ci] 0/0.0 -> 00 01 81 01 01
Okt 19 02:54:01.749 [core.ci] 0/0.0 <- 00 01 a0 07 01 91 04 00 03 00 41 80 02 01 00
Okt 19 02:54:01.749 [core.ci] 0/0.0 -> 00 01 a0 0a 01 92 07 00 00 03 00 41 00 01
Okt 19 02:54:01.749 [core.ci] 0/0.0 -> 00 01 a0 09 01 90 02 00 01 9f 80 30 00
Okt 19 02:54:01.749 [core.ci] 0/0.0 sending CA info
Okt 19 02:54:01.750 [core.ci] 0/0.0 -> 00 01 81 01 01
Okt 19 02:54:01.750 [core.ci] 0/0.0 <- 00 01 a0 0b 01 90 02 00 01 9f 80 31 02 09 8c 80 02 01 00
Okt 19 02:54:02.753 [core.ci] 0/0.0 -> 00 01 a0 10 01 90 02 00 01 9f 80 32 07 03 00 00 01 00 01 03
Okt 19 02:54:02.753 [core.ci] 0/0.0 CA_PMT decoding len=7 lm=3 prg=0 len=1/1 ci_cmd(G)=03
Okt 19 02:54:02.753 [core.ci] 0/0.0 got CA pmt ciCmd=3 caLm=3
Okt 19 02:54:02.753 [core.ci] 0/0.0 answer to query
Okt 19 02:54:02.753 [core.ci] 0/0.0 no action taken
Okt 19 02:54:02.754 [core.ci] 0/0.0 -> 00 01 81 01 01
Okt 19 02:54:02.754 [core.ci] 0/0.0 <- 00 01 a0 0d 01 90 02 00 01 9f 80 33 04 00 00 00 81 80 02 01 00
Okt 19 02:54:02.855 [core.pids] 0/0: now tuned to source 5300ff40(S19.2E) transponder 1b834
Okt 19 02:54:02.904 [core.ci] 0/0.0 -> 00 01 a0 1e 01 90 02 00 01 9f 80 32 15 04 32 c9 01 00 00 02 00 a0 00 00 04 00 a1 00 00 06 00 a3 00 00
Okt 19 02:54:02.905 [core.ci] 0/0.0 CA_PMT decoding len=15 lm=4 prg=13001 len=0/f pid=2,a0 len=0/a pid=4,a1 len=0/5 pid=6,a3 len=0/0
Okt 19 02:54:02.905 [core.ci] 0/0.0 got CA pmt ciCmd=-1 caLm=4
Okt 19 02:54:02.905 [core.ci] 0/0.0 answer to query surpressed
Okt 19 02:54:02.905 [core.ci] 0/0.0 set CAM decrypt (prg 13001)
Okt 19 02:54:02.905 [core.pids] 0/0: add SID 13001 (zero=0 noshift=1)
Okt 19 02:54:02.905 [core.pids] 0/0: pids VIDEO=00a0 AUDIO=00a1 DOLBY=00a3
Okt 19 02:54:02.905 [core.pids] Ca descriptors after simplify (pidCa=0)
Okt 19 02:54:02.905 [core.pids] prgca: <empty>
Okt 19 02:54:02.905 [core.pids] pidca 00a0: <empty>
Okt 19 02:54:02.905 [core.pids] pidca 00a1: <empty>
Okt 19 02:54:02.905 [core.pids] pidca 00a3: <empty>
Okt 19 02:54:02.905 [core.pids] 0/0: SID=13001 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/-
Okt 19 02:54:02.905 [core.pids] 0/0: found handler for SID 13001 (0/0.1 idle=1 idx=1)
Okt 19 02:54:02.905 [core.ecm] 0/0.1: setting new SID 13001
Okt 19 02:54:02.905 [core.pids] 0/0.1: pids on entry
Okt 19 02:54:02.905 [core.pids] 0/0.1: pids after delete
Okt 19 02:54:02.905 [core.pids] 0/0: descrambling pid 00a0 on index 1
Okt 19 02:54:02.906 [core.pids] 0/0: descrambling pid 00a1 on index 1
Okt 19 02:54:02.906 [core.pids] 0/0: descrambling pid 00a3 on index 1
Okt 19 02:54:02.906 [core.pids] 0/0.1: pids after add VIDEO=00a0 AUDIO=00a1 DOLBY=00a3
Okt 19 02:54:02.906 [core.ecm] 0/0.1: is no longer idle
Okt 19 02:54:02.966 [core.ecm] 0/0.1: triggered SID -1/13001 idx -1/1 mode -1/0 -
Okt 19 02:54:04.259 [core.ci] 0/0.0 -> 00 01 a0 16 01 90 02 00 01 9f 80 32 0d 05 32 c9 01 00 07 01 09 04 09 8c e1 eb
Okt 19 02:54:04.260 [core.ci] 0/0.0 CA_PMT decoding len=d lm=5 prg=13001 len=7/7 ci_cmd(G)=01
Okt 19 02:54:04.260 [core.ci] 0/0.0 got CA pmt ciCmd=1 caLm=5
Okt 19 02:54:04.260 [core.ci] 0/0.0 answer to query surpressed
Okt 19 02:54:04.260 [core.ci] 0/0.0 set CAM decrypt (prg 13001)
Okt 19 02:54:04.260 [core.pids] 0/0: update SID 13001 (zero=0 noshift=1)
Okt 19 02:54:04.260 [core.pids] 0/0: SID=13001 zero=0 | sid=1/13001/0 zero=-/-/- idle=-/-/-
Okt 19 02:54:04.260 [core.pids] 0/0: found handler for SID 13001 (0/0.1 idle=0 idx=1)
Okt 19 02:54:04.260 [core.pids] 0/0.1: pids on entry VIDEO=00a0 AUDIO=00a1 DOLBY=00a3
Okt 19 02:54:04.260 [core.pids] 0/0.1: pids after delete
Okt 19 02:54:04.260 [core.pids] 0/0.1: pids after add
Okt 19 02:54:04.261 [core.ecm] 0/0.1: is idle now
Okt 19 02:54:04.261 [core.pids] 0/0: tune to same source/transponder
Okt 19 02:54:04.311 [core.ci] 0/0.0 -> 00 01 a0 2a 01 90 02 00 01 9f 80 32 21 04 32 c9 01 00 07 01 09 04 09 8c e1 eb 02 00 a0 00 00 04 00 a1 00 00 06 00 a3 00 00 04 00 a2 00 00
Okt 19 02:54:04.311 [core.ci] 0/0.0 CA_PMT decoding len=21 lm=4 prg=13001 len=7/1b ci_cmd(G)=01 pid=2,a0 len=0/f pid=4,a1 len=0/a pid=6,a3 len=0/5 pid=4,a2 len=0/0
Okt 19 02:54:04.311 [core.ci] 0/0.0 got CA pmt ciCmd=1 caLm=4
Okt 19 02:54:04.311 [core.ci] 0/0.0 answer to query surpressed
Okt 19 02:54:04.311 [core.ci] 0/0.0 set CAM decrypt (prg 13001)
Okt 19 02:54:04.311 [core.pids] 0/0: add SID 13001 (zero=0 noshift=1)
Okt 19 02:54:04.312 [core.pids] 0/0: pids VIDEO=00a0 AUDIO=00a1 DOLBY=00a3 AUDIO=00a2
Okt 19 02:54:04.312 [core.pids] Ca descriptors after simplify (pidCa=0)
Okt 19 02:54:04.312 [core.pids] prgca: 09 04 09 8C E1 EB
Okt 19 02:54:04.312 [core.pids] pidca 00a0: <empty>
Okt 19 02:54:04.312 [core.pids] pidca 00a1: <empty>
Okt 19 02:54:04.312 [core.pids] pidca 00a3: <empty>
Okt 19 02:54:04.312 [core.pids] pidca 00a2: <empty>
Okt 19 02:54:04.312 [core.pids] 0/0: SID=13001 zero=0 | sid=1/13001/1 zero=-/-/- idle=1/13001/1
Okt 19 02:54:04.312 [core.pids] 0/0: found handler for SID 13001 (0/0.1 idle=1 idx=1)
Okt 19 02:54:04.312 [core.pids] 0/0.1: pids on entry
Okt 19 02:54:04.313 [core.pids] 0/0.1: pids after delete
Okt 19 02:54:04.313 [core.pids] 0/0: descrambling pid 00a0 on index 1
Okt 19 02:54:04.313 [core.pids] 0/0: descrambling pid 00a1 on index 1
Okt 19 02:54:04.313 [core.pids] 0/0: descrambling pid 00a3 on index 1
Okt 19 02:54:04.313 [core.pids] 0/0: descrambling pid 00a2 on index 1
Okt 19 02:54:04.316 [core.pids] 0/0.1: pids after add VIDEO=00a0 AUDIO=00a1 DOLBY=00a3 AUDIO=00a2
Okt 19 02:54:04.316 [core.ecm] 0/0.1: is no longer idle
Okt 19 02:54:04.350 [core.ecm] 0/0.1: triggered SID 13001/13001 idx 1/1 mode 1/0 -
Okt 19 02:54:04.350 [core.ecm] 0/0.1: new caDescr: 09 04 09 8C E1 EB
Okt 19 02:54:04.350 [core.ecm] 0/0.1: CA descriptors for SID 13001 (len=6)
Okt 19 02:54:04.350 [core.ecm] 0/0.1: descriptor 09 8c e1 eb
Okt 19 02:54:04.351 [core.override] ecmprio: 098c/0 pri -2
Okt 19 02:54:04.351 [core.ecm] 0/0.1: found 098c(0000) (Cardclient) id 0000 with ecm 1eb/80 (new)
Okt 19 02:54:04.351 [core.ecm] 0/0.1: try system Cardclient (098c) id 0000 with ecm 1eb (pri=-15)
Okt 19 02:54:04.512 [cardclient.core] cc-loop
Okt 19 02:54:04.512 [cardclient.core] now trying client cccam2 (127.0.0.1:54321)
Okt 19 02:54:04.512 [cardclient.cccam2] ECM caid 098c prov 0000 sid 13001 pid 01eb
Okt 19 02:54:04.512 [cardclient.cccam2shares] share try list for caid 098c prov 000000 pid 01eb
Okt 19 02:54:04.513 [cardclient.cccam2shares] shareid 00000064 hops 0 lag 1000
Okt 19 02:54:04.513 [cardclient.cccam2extra] now try shareid 00000064
Okt 19 02:54:04.801 [cardclient.cccam2] server can't decode this ecm, (0 pending)
Okt 19 02:54:04.801 [cardclient.cccam2extra] wait returned after 172
Okt 19 02:54:04.801 [cardclient.cccam2extra] no CW from this share
Okt 19 02:54:04.801 [cardclient.cccam2shares] added shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:04.801 [cardclient.ecm] cccam2: unable to decode the channel
Okt 19 02:54:04.801 [cardclient.core] client cccam2 (127.0.0.1:54321) ECM failed (289 ms)
Okt 19 02:54:04.802 [cardclient.core] cc-loop
Okt 19 02:54:04.802 [cardclient.core] now trying client cccam2 (127.0.0.1:54321)
Okt 19 02:54:04.802 [cardclient.cccam2] ECM caid 098c prov 0000 sid 13001 pid 01eb
Okt 19 02:54:04.802 [cardclient.cccam2shares] shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:04.802 [cardclient.cccam2shares] share try list for caid 098c prov 000000 pid 01eb
Okt 19 02:54:04.802 [cardclient.cccam2shares] shareid 00000064 hops 0 - lag 586
Okt 19 02:54:04.802 [cardclient.cccam2extra] now try shareid 00000064
Okt 19 02:54:10.002 [cardclient.cccam2] server can't decode this ecm, (0 pending)
Okt 19 02:54:10.002 [cardclient.cccam2extra] getting CW timed out after 5000
Okt 19 02:54:10.004 [cardclient.cccam2shares] updated shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:10.004 [cardclient.ecm] cccam2: unable to decode the channel
Okt 19 02:54:10.004 [cardclient.core] client cccam2 (127.0.0.1:54321) ECM failed (5203 ms)
Okt 19 02:54:10.004 [core.ecm] 0/0.1: CA descriptors for SID 13001 (len=6)
Okt 19 02:54:10.005 [core.ecm] 0/0.1: descriptor 09 8c e1 eb
Okt 19 02:54:10.005 [core.override] ecmprio: 098c/0 pri -2
Okt 19 02:54:10.005 [core.ecm] 0/0.1: found 098c(0000) (Cardclient) id 0000 with ecm 1eb/80 (already present)
Okt 19 02:54:10.005 [core.ecm] 0/0.1: try system Cardclient (098c) id 0000 with ecm 1eb (pri=-15)
Okt 19 02:54:10.014 [cardclient.core] cc-loop
Okt 19 02:54:10.015 [cardclient.core] now trying client cccam2 (127.0.0.1:54321)
Okt 19 02:54:10.015 [cardclient.cccam2] ECM caid 098c prov 0000 sid 13001 pid 01eb
Okt 19 02:54:10.015 [cardclient.cccam2shares] shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:10.015 [cardclient.cccam2shares] share try list for caid 098c prov 000000 pid 01eb
Okt 19 02:54:10.015 [cardclient.cccam2shares] shareid 00000064 hops 0 - lag 1689
Okt 19 02:54:10.015 [cardclient.cccam2extra] now try shareid 00000064
Okt 19 02:54:10.320 [cardclient.cccam2] server can't decode this ecm, (0 pending)
Okt 19 02:54:10.320 [cardclient.cccam2extra] wait returned after 115
Okt 19 02:54:10.320 [cardclient.cccam2extra] no CW from this share
Okt 19 02:54:10.320 [cardclient.cccam2shares] updated shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:10.320 [cardclient.ecm] cccam2: unable to decode the channel
Okt 19 02:54:10.320 [cardclient.core] client cccam2 (127.0.0.1:54321) ECM failed (306 ms)
Okt 19 02:54:10.321 [cardclient.core] cc-loop
Okt 19 02:54:10.321 [cardclient.core] now trying client cccam2 (127.0.0.1:54321)
Okt 19 02:54:10.321 [cardclient.cccam2] ECM caid 098c prov 0000 sid 13001 pid 01eb
Okt 19 02:54:10.321 [cardclient.cccam2shares] shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:10.321 [cardclient.cccam2shares] share try list for caid 098c prov 000000 pid 01eb
Okt 19 02:54:10.321 [cardclient.cccam2shares] shareid 00000064 hops 0 - lag 1295
Okt 19 02:54:10.321 [cardclient.cccam2extra] now try shareid 00000064
Okt 19 02:54:10.521 [cardclient.cccam2] server can't decode this ecm, (0 pending)
Okt 19 02:54:10.522 [cardclient.cccam2extra] wait returned after 0
Okt 19 02:54:10.522 [cardclient.cccam2extra] no CW from this share
Okt 19 02:54:10.522 [cardclient.cccam2shares] updated shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:10.522 [cardclient.ecm] cccam2: unable to decode the channel
Okt 19 02:54:10.522 [cardclient.core] client cccam2 (127.0.0.1:54321) ECM failed (201 ms)
Okt 19 02:54:10.523 [core.ecm] 0/0.1: CA descriptors for SID 13001 (len=6)
Okt 19 02:54:10.523 [core.ecm] 0/0.1: descriptor 09 8c e1 eb
Okt 19 02:54:10.523 [core.override] ecmprio: 098c/0 pri -2
Okt 19 02:54:10.523 [core.ecm] 0/0.1: found 098c(0000) (Cardclient) id 0000 with ecm 1eb/80 (already present)
Okt 19 02:54:10.523 [core.ecm] 0/0.1: try system Cardclient (098c) id 0000 with ecm 1eb (pri=-15)
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 0d05 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 0648 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 0d95 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 0d98 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 0650 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 09c4 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 1833 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 1702 -> none available
Okt 19 02:54:12.782 [core.au] 0/0: chain caid 0b02 -> none available
Okt 19 02:54:15.502 [cardclient.core] cc-loop
Okt 19 02:54:15.502 [cardclient.core] now trying client cccam2 (127.0.0.1:54321)
Okt 19 02:54:15.502 [cardclient.cccam2] ECM caid 098c prov 0000 sid 13001 pid 01eb
Okt 19 02:54:15.502 [cardclient.cccam2shares] shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:15.503 [cardclient.cccam2shares] share try list for caid 098c prov 000000 pid 01eb
Okt 19 02:54:15.503 [cardclient.cccam2shares] shareid 00000064 hops 0 - lag 971
Okt 19 02:54:15.503 [cardclient.cccam2extra] now try shareid 00000064
Okt 19 02:54:15.645 [cardclient.cccam2] server can't decode this ecm, (0 pending)
Okt 19 02:54:15.645 [cardclient.cccam2extra] wait returned after 114
Okt 19 02:54:15.645 [cardclient.cccam2extra] no CW from this share
Okt 19 02:54:15.645 [cardclient.cccam2shares] updated shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:15.645 [cardclient.ecm] cccam2: unable to decode the channel
Okt 19 02:54:15.646 [cardclient.core] client cccam2 (127.0.0.1:54321) ECM failed (143 ms)
Okt 19 02:54:15.760 [cardclient.core] cc-loop
Okt 19 02:54:15.760 [cardclient.core] now trying client cccam2 (127.0.0.1:54321)
Okt 19 02:54:15.760 [cardclient.cccam2] ECM caid 098c prov 0000 sid 13001 pid 01eb
Okt 19 02:54:15.760 [cardclient.cccam2shares] shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:15.761 [cardclient.cccam2shares] share try list for caid 098c prov 000000 pid 01eb
Okt 19 02:54:15.761 [cardclient.cccam2shares] shareid 00000064 hops 0 - lag 756
Okt 19 02:54:15.761 [cardclient.cccam2extra] now try shareid 00000064
Okt 19 02:54:15.847 [cardclient.cccam2] server can't decode this ecm, (0 pending)
Okt 19 02:54:15.847 [cardclient.cccam2extra] wait returned after 1
Okt 19 02:54:15.847 [cardclient.cccam2extra] no CW from this share
Okt 19 02:54:15.847 [cardclient.cccam2shares] updated shareid 00000064 for 01eb/5300ff40/1b834 status -1
Okt 19 02:54:15.847 [cardclient.ecm] cccam2: unable to decode the channel
Okt 19 02:54:15.847 [cardclient.core] client cccam2 (127.0.0.1:54321) ECM failed (87 ms)
Okt 19 02:54:16.019 [core.ecm] 0/0.1: CA descriptors for SID 13001 (len=6)
Okt 19 02:54:16.019 [core.ecm] 0/0.1: descriptor 09 8c e1 eb
Okt 19 02:54:16.020 [core.override] ecmprio: 098c/0 pri -2
Okt 19 02:54:16.020 [core.ecm] 0/0.1: found 098c(0000) (Cardclient) id 0000 with ecm 1eb/80 (already present)
Okt 19 02:54:16.020 [core.ecm] 0/0.1: try system Cardclient (098c) id 0000 with ecm 1eb (pri=-15)
Okt 19 02:54:16.020 [core.ecm] 0/0.1: stopping message log until valid key is found
Okt 19 02:54:18.290 [core.ci] 0/0.0 -> 00 01 a0 16 01 90 02 00 01 9f 80 32 0d 05 32 c9 01 00 07 01 09 04 09 8c e1 eb
Okt 19 02:54:18.290 [core.ci] 0/0.0 CA_PMT decoding len=d lm=5 prg=13001 len=7/7 ci_cmd(G)=01
Okt 19 02:54:18.290 [core.ci] 0/0.0 got CA pmt ciCmd=1 caLm=5
Okt 19 02:54:18.290 [core.ci] 0/0.0 answer to query surpressed
Okt 19 02:54:18.290 [core.ci] 0/0.0 set CAM decrypt (prg 13001)
Okt 19 02:54:18.290 [core.pids] 0/0: update SID 13001 (zero=0 noshift=1)
Okt 19 02:54:18.291 [core.pids] 0/0: SID=13001 zero=0 | sid=1/13001/0 zero=-/-/- idle=-/-/-
Okt 19 02:54:18.291 [core.pids] 0/0: found handler for SID 13001 (0/0.1 idle=0 idx=1)
Okt 19 02:54:18.291 [core.pids] 0/0.1: pids on entry VIDEO=00a0 AUDIO=00a1 DOLBY=00a3 AUDIO=00a2
Okt 19 02:54:18.291 [core.pids] 0/0.1: pids after delete
Okt 19 02:54:18.291 [core.pids] 0/0.1: pids after add
Okt 19 02:54:18.291 [core.ecm] 0/0.1: is idle now
Okt 19 02:54:18.341 [core.ci] 0/0.0 -> 00 01 a0 0f 01 90 02 00 01 9f 80 32 06 03 00 00 01 00 00
Okt 19 02:54:18.341 [core.ci] 0/0.0 CA_PMT decoding len=6 lm=3 prg=0 len=0/0
Okt 19 02:54:18.342 [core.ci] 0/0.0 got CA pmt ciCmd=-1 caLm=3
Okt 19 02:54:18.342 [core.ci] 0/0.0 answer to query surpressed
Okt 19 02:54:18.342 [core.ci] 0/0.0 stop decrypt
Okt 19 02:54:18.342 [core.ecm] 0/0.1: stop
Okt 19 02:54:18.343 [core.pids] 0/0: now tuned to source 5300ff40(S19.2E) transponder 1b301
Okt 19 02:54:18.388 [core.ecm] 0/0.1: triggered SID 13001/-1 idx 1/1 mode 3/-1 -
Okt 19 02:54:18.389 [core.ecm] 0/0.1: new caDescr: <empty>
Okt 19 02:56:15.882 [cardclient.cccam2] server PONG
Okt 19 02:58:15.908 [cardclient.cccam2] server PONG
Okt 19 02:59:25.243 [core.pids] 0/0: removing 0/0.1 on cw index 1
Okt 19 03:00:15.938 [cardclient.cccam2] server PONG
Okt 19 03:02:15.968 [cardclient.cccam2] server PONG
Okt 19 03:04:15.998 [cardclient.cccam2] server PONG
Okt 19 03:06:16.031 [cardclient.cccam2] server PONG
Okt 19 03:08:16.062 [cardclient.cccam2] server PONG
Okt 19 03:10:16.084 [cardclient.cccam2] server PONG
Okt 19 03:12:16.119 [cardclient.cccam2] server PONG
Okt 19 03:14:16.159 [cardclient.cccam2] server PONG
Okt 19 03:16:16.189 [cardclient.cccam2] server PONG

Oscam-Log

Spoiler

-------------------------------------------------------------------------------
>> OSCam << cardserver started at Sat Oct 19 02:53:42 2013
-------------------------------------------------------------------------------
2013/10/19 02:53:42 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r8986 (i686-linux-gnu)
2013/10/19 02:53:42 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 1904
2013/10/19 02:53:42 0 s userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2013/10/19 02:53:42 0 s signal handling initialized
2013/10/19 02:53:42 0 s cccam: initialized (fd=5, port=54321)
2013/10/19 02:53:42 0 s skyv14 [mouse] creating thread for device /dev/ttyUSB0
2013/10/19 02:53:42 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2013/10/19 02:53:42 0 s waiting for local card init
2013/10/19 02:53:42 984E790 h webif: decompressed 54245 bytes back into 154648 bytes
2013/10/19 02:53:42 984E790 h HTTP Server running. ip=0.0.0.0 port=54322
2013/10/19 02:53:42 984CAA0 r skyv14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=357, cardmhz=357)
2013/10/19 02:53:43 984CAA0 r skyv14 [mouse] card detected
2013/10/19 02:53:44 984CAA0 r skyv14 [mouse] ATR: 3F FD 13 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2013/10/19 02:53:44 984CAA0 r skyv14 [mouse] Init card protocol T0, FI=1, F=372, D=4, N=2
2013/10/19 02:53:44 984CAA0 r skyv14 [mouse] Setting baudrate to 38400 bps
2013/10/19 02:53:44 984CAA0 r skyv14 [mouse] Calculated work ETU is 26.05 us
2013/10/19 02:53:44 984CAA0 r skyv14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed of 3.57 MHz (specified in reader->mhz)
2013/10/19 02:53:45 984CAA0 r skyv14 [mouse] Card type: P1TV
2013/10/19 02:53:45 984CAA0 r skyv14 [mouse] Rom version: 20AA
2013/10/19 02:53:46 984CAA0 r skyv14 [mouse] parental lock setting: FF FF FF FF
2013/10/19 02:53:46 984CAA0 r skyv14 [mouse] type: VideoGuard Sky Germany (098C), caid: 098C
2013/10/19 02:53:46 984CAA0 r skyv14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2013/10/19 02:53:46 984CAA0 r skyv14 [mouse] ready for requests
2013/10/19 02:53:46 984CAA0 r skyv14 [mouse] found card system videoguard2
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] THIS WAS A SUCCESFULL START ATTEMPT No 1 out of max alloted of 1
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] card detected
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] type: VideoGuard Sky Germany (098C)
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 0046, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 0065, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 0066, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 006a, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 006b, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 006f, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 007b, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 0081, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 008e, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00c0, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00c7, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00c9, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00e4, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00f3, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00fa, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:46 984CAA0 r skyv14 [videoguard2] tier: 00ff, expiry date: 2014/01/28-00:00:00
2013/10/19 02:53:50 0 s init for all local cards done
2013/10/19 02:53:50 0 s anti cascading disabled
2013/10/19 02:53:50 B7500E00 c encrypted cccam-client 127.0.0.1 granted (User, au=auto (1 reader))
2013/10/19 02:54:04 984CAA0 r skyv14 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/10/19 02:54:04 B7500E00 c User (098C&000000/0515/32C9/98:4A766709D72BC69A9AD5D043C3F585E4): not found (172 ms) by skyv14
2013/10/19 02:54:10 B7500E00 c User (098C&000000/0515/32C9/98:4A766709D72BC69A9AD5D043C3F585E4): timeout (5000 ms) by skyv14
2013/10/19 02:54:10 984CAA0 r skyv14 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/10/19 02:54:10 B7500E00 c User (098C&000000/0515/32C9/98:686617BABD61686975318503C83169FD): not found (114 ms) by skyv14
2013/10/19 02:54:10 B7500E00 c User (098C&000000/0515/32C9/98:686617BABD61686975318503C83169FD): not found (0 ms) by skyv14
2013/10/19 02:54:15 984CAA0 r skyv14 [videoguard2] classD3 ins54: status 90 00 = ok but cw=00 -> channel not subscribed
2013/10/19 02:54:15 B7500E00 c User (098C&000000/0515/32C9/98:7006F89FEAFE3171AAEB98FB7A7EA40F): not found (114 ms) by skyv14
2013/10/19 02:54:15 B7500E00 c User (098C&000000/0515/32C9/98:7006F89FEAFE3171AAEB98FB7A7EA40F): not found (0 ms) by skyv14