-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Tue May 27 17:54:05 2014
-------------------------------------------------------------------------------
2014/05/27 17:54:05 7A1660 h >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r9371 (mipsel-unknown-linux-gnu)
2014/05/27 17:54:05 7A1660 h WebIf: Origin checked. Result: access from 192.168.178.38 => allowed
2014/05/27 17:54:06 77B00588 r SkyV14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/05/27 17:54:07 0 --- Skipped 1 duplicated log lines ---
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 16
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #2 started succesfully (caid 0001 provid 000001 pid 0001)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 has 4 ecmpids, 4 streampids, 1 ecmfilters and 1 emmfilters
2014/05/27 17:54:07 77B02448 c [DVBAPI] new events occurred on 1 of 4 handlers after 3403 ms inactivity
2014/05/27 17:54:07 77B02448 c [DVBAPI] now handling fd 16 that reported event 3
2014/05/27 17:54:07 77B02448 c [DVBAPI] Readed:
2014/05/27 17:54:07 77B02448 01 B0 21 FF FF E1 00 00 09 04 18 33 F0 02 09 04
2014/05/27 17:54:07 77B02448 09 C4 F0 08 09 04 09 AF F0 09 09 04 09 8C F0 08
2014/05/27 17:54:07 77B02448 94 49 D3 6A
2014/05/27 17:54:07 77B02448 c receiving cat
2014/05/27 17:54:07 77B02448 c cat:
2014/05/27 17:54:07 77B02448 01 B0 21 FF FF E1 00 00 09 04 18 33 F0 02 09 04
2014/05/27 17:54:07 77B02448 09 C4 F0 08 09 04 09 AF F0 09 09 04 09 8C F0 08
2014/05/27 17:54:07 77B02448 94 49 D3 6A
2014/05/27 17:54:07 77B02448 c Reader SkyV14 au enabled -> parsing cat for emm pids!
2014/05/27 17:54:07 77B02448 c SkyV14 [videoguard2] EMM: reader_caid 098C != caid 1833
2014/05/27 17:54:07 77B02448 c [IGNORE EMMPID] CAID: 1833 EMM_PID: 1002 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: (no match)
2014/05/27 17:54:07 77B02448 c SkyV14 [videoguard2] EMM: reader_caid 098C != caid 09C4
2014/05/27 17:54:07 77B02448 c [IGNORE EMMPID] CAID: 09C4 EMM_PID: 1008 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: (no match)
2014/05/27 17:54:07 77B02448 c SkyV14 [videoguard2] EMM: reader_caid 098C != caid 09AF
2014/05/27 17:54:07 77B02448 c [IGNORE EMMPID] CAID: 09AF EMM_PID: 1009 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: (no match)
2014/05/27 17:54:07 77B02448 c SkyV14 [videoguard2] EMM: caid 098C has no provider
2014/05/27 17:54:07 77B02448 c [ADD EMMPID #0] CAID: 098C EMM_PID: 1008 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL:
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 stop Filter #2 (fd: 16 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 has 4 ecmpids, 4 streampids, 1 ecmfilters and 0 emmfilters
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type UNIQUE, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 40 00 84 6B 0A 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 FF C0 FF FF FF FF 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 16
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #2 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #2 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type UNIQUE, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 40 00 00 00 00 00 84 6B 0A 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 FF C0 00 00 00 00 FF FF FF FF 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 17
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #3 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #3 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type UNIQUE, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 40 00 00 00 00 00 00 00 00 00 84 6B 0A 00 00
2014/05/27 17:54:07 77B02448 FF C0 00 00 00 00 00 00 00 00 FF FF FF FF 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 19
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #4 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #4 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type SHARED, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 80 00 84 6B 00 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 FF C0 FF FF FF 00 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 20
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #5 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #5 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type SHARED, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 80 00 00 00 00 00 84 6B 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 FF C0 00 00 00 00 FF FF FF 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 21
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #6 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #6 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type SHARED, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 80 00 00 00 00 00 00 00 00 00 84 6B 00 00 00
2014/05/27 17:54:07 77B02448 FF C0 00 00 00 00 00 00 00 00 FF FF FF 00 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 22
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #7 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #7 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] starting emm filter type GLOBAL, pid: 0x1008
2014/05/27 17:54:07 77B02448 82 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 FF C0 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:07 77B02448 c DEVICE open (/dev/dvb/adapter0/demux3) fd 23
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #8 started succesfully (caid 098C provid 000000 pid 1008)
2014/05/27 17:54:07 77B02448 c [DVBAPI] Demuxer #0 Filter #8 added to active emmfilters (CAID 098C PROVID 000000 EMMPID 1008)
2014/05/27 17:54:07 77B02448 c [EMM Filter] 7 matching emm filter found
2014/05/27 17:54:08 77B02448 c [DVBAPI] Demuxer #0 has 4 ecmpids, 4 streampids, 1 ecmfilters and 7 emmfilters
2014/05/27 17:54:08 7A1660 h WebIf: Origin checked. Result: access from 192.168.178.38 => allowed
2014/05/27 17:54:08 77B00588 r SkyV14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/05/27 17:54:09 0 start client thread action 31
2014/05/27 17:54:09 77B02448 c data from add_job action=31 client c local
2014/05/27 17:54:09 77B00588 r SkyV14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/05/27 17:54:09 7A1660 h Restart requested by WebIF from 192.168.178.38
2014/05/27 17:54:09 7A1660 h restart oscam requested
2014/05/27 17:54:11 77B02448 c [DVBAPI] new events occurred on 1 of 10 handlers after 3597 ms inactivity
2014/05/27 17:54:11 77B02448 c [DVBAPI] now handling fd 8 that reported event 3
2014/05/27 17:54:11 77B02448 c [DVBAPI] Readed:
2014/05/27 17:54:11 77B02448 80 70 95 00 00 01 1D 7C 1B 7E C1 0C 1E AA 55 05
2014/05/27 17:54:11 77B02448 20 01 00 00 80 40 FA 0B 5D 20 AA E2 E3 EE 33 03
2014/05/27 17:54:11 77B02448 02 05 02 21 73 7D 0B 0C 70 AD B2 D2 DA 57 74 19
2014/05/27 17:54:11 77B02448 00 00 90 64 C1 01 BC 85 95 93 C4 CF 67 A9 E5 D7
2014/05/27 17:54:11 77B02448 D1 EA F5 AB A9 6B 73 80 5D 63 CB 0F D3 5D 6F DB
2014/05/27 17:54:11 77B02448 7D 13 F4 6C 6E C2 5B CB 28 B7 2F 1B F2 A8 00 C5
2014/05/27 17:54:11 77B02448 96 40 A8 D4 37 00 C1 82 AD A6 1C 71 92 21 9C 8F
2014/05/27 17:54:11 77B02448 CD 60 B4 1D 9C DC 78 A6 07 0D 9A AD 4D DF 89 6C
2014/05/27 17:54:11 77B02448 B8 F1 B6 90 CD D5 80 DB E5 87 80 B8 4B C6 4A 09
2014/05/27 17:54:11 77B02448 49 8D DC 0E B4 19 9A 5F
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 ECMTYPE 80 CAID 098C PROVID 000000 ECMPID 1A0B FAKECHID 0C1E (unique part in ecm)
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to ODD (CAID 098C PROVID 000000 FD 8)
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 Filter #1 set chid to 0C1E on fd 8
2014/05/27 17:54:11 77B02448 c {client local, caid 098C, prid 000000, srvid 006B} [get_cw] NEW REQUEST!
2014/05/27 17:54:11 77B02448 c [GET_CW] wait_time 0 caid 098C prov 000000 srvid 006B rc 100 cacheex cl mode 0 ex1rdr 0
2014/05/27 17:54:11 77B02448 c {client local, caid 098C, prid 000000, srvid 006B} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/05/27 17:54:11 77B02448 c request_cw stage=2 to reader SkyV14 ecm hash=6FEB44A658E55CA83FC4C3052441391A
2014/05/27 17:54:11 77B02448 c start reader thread action 5
2014/05/27 17:54:11 77B02448 c {client local, caid 098C, prid 000000, srvid 006B} [write_ecm_request] reader SkyV14 --> SENT 1
2014/05/27 17:54:11 77B00588 r data from add_job action=5 client r SkyV14
2014/05/27 17:54:11 77B00588 r ecm:
2014/05/27 17:54:11 77B00588 80 70 95 00 00 01 1D 7C 1B 7E C1 0C 1E AA 55 05
2014/05/27 17:54:11 77B00588 20 01 00 00 80 40 FA 0B 5D 20 AA E2 E3 EE 33 03
2014/05/27 17:54:11 77B00588 02 05 02 21 73 7D 0B 0C 70 AD B2 D2 DA 57 74 19
2014/05/27 17:54:11 77B00588 00 00 90 64 C1 01 BC 85 95 93 C4 CF 67 A9 E5 D7
2014/05/27 17:54:11 77B00588 D1 EA F5 AB A9 6B 73 80 5D 63 CB 0F D3 5D 6F DB
2014/05/27 17:54:11 77B00588 7D 13 F4 6C 6E C2 5B CB 28 B7 2F 1B F2 A8 00 C5
2014/05/27 17:54:11 77B00588 96 40 A8 D4 37 00 C1 82 AD A6 1C 71 92 21 9C 8F
2014/05/27 17:54:11 77B00588 CD 60 B4 1D 9C DC 78 A6 07 0D 9A AD 4D DF 89 6C
2014/05/27 17:54:11 77B00588 B8 F1 B6 90 CD D5 80 DB E5 87 80 B8 4B C6 4A 09
2014/05/27 17:54:11 77B00588 49 8D DC 0E B4 19 9A 5F
2014/05/27 17:54:11 77B02448 c Client local ECM dump 098C&000000/0C1E/006B/98:6FEB44A658E55CA83FC4C3052441391A
2014/05/27 17:54:11 77B02448 80 70 95 00 00 01 1D 7C 1B 7E C1 0C 1E AA 55 05
2014/05/27 17:54:11 77B02448 20 01 00 00 80 40 FA 0B 5D 20 AA E2 E3 EE 33 03
2014/05/27 17:54:11 77B02448 02 05 02 21 73 7D 0B 0C 70 AD B2 D2 DA 57 74 19
2014/05/27 17:54:11 77B02448 00 00 90 64 C1 01 BC 85 95 93 C4 CF 67 A9 E5 D7
2014/05/27 17:54:11 77B02448 D1 EA F5 AB A9 6B 73 80 5D 63 CB 0F D3 5D 6F DB
2014/05/27 17:54:11 77B02448 7D 13 F4 6C 6E C2 5B CB 28 B7 2F 1B F2 A8 00 C5
2014/05/27 17:54:11 77B02448 96 40 A8 D4 37 00 C1 82 AD A6 1C 71 92 21 9C 8F
2014/05/27 17:54:11 77B02448 CD 60 B4 1D 9C DC 78 A6 07 0D 9A AD 4D DF 89 6C
2014/05/27 17:54:11 77B02448 B8 F1 B6 90 CD D5 80 DB E5 87 80 B8 4B C6 4A 09
2014/05/27 17:54:11 77B02448 49 8D DC 0E B4 19 9A 5F
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 request cw for ecm 098C&000000/0C1E/006B/98:6FEB44A658E55CA83FC4C3052441391A
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] write to cardreader
2014/05/27 17:54:11 77B00588 D1 40 00 80 74 00 7D 0B 0C 70 AD B2 D2 DA 57 74
2014/05/27 17:54:11 77B00588 19 00 00 90 64 C1 01 BC 85 95 93 C4 CF 67 A9 E5
2014/05/27 17:54:11 77B00588 D7 D1 EA F5 AB A9 6B 73 80 5D 63 CB 0F D3 5D 6F
2014/05/27 17:54:11 77B00588 DB 7D 13 F4 6C 6E C2 5B CB 28 B7 2F 1B F2 A8 00
2014/05/27 17:54:11 77B00588 C5 96 40 A8 D4 37 00 C1 82 AD A6 1C 71 92 21 9C
2014/05/27 17:54:11 77B00588 8F CD 60 B4 1D 9C DC 78 A6 07 0D 9A AD 4D DF 89
2014/05/27 17:54:11 77B00588 6C B8 F1 B6 90 CD D5 80 DB E5 87 80 B8 4B C6 4A
2014/05/27 17:54:11 77B00588 09 49 8D DC 0E B4 19 9A 5F
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 14 ETU (72 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=72 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit:
2014/05/27 17:54:11 77B00588 D1 40 00 80 74
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Write timeout 72 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Sending:
2014/05/27 17:54:11 77B00588 D1 40 00 80 74
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 40
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 14 ETU (72 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit size 116 bytes, expected len 2 bytes, delay 0 us, timeout=72 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit:
2014/05/27 17:54:11 77B00588 00 7D 0B 0C 70 AD B2 D2 DA 57 74 19 00 00 90 64
2014/05/27 17:54:11 77B00588 C1 01 BC 85 95 93 C4 CF 67 A9 E5 D7 D1 EA F5 AB
2014/05/27 17:54:11 77B00588 A9 6B 73 80 5D 63 CB 0F D3 5D 6F DB 7D 13 F4 6C
2014/05/27 17:54:11 77B00588 6E C2 5B CB 28 B7 2F 1B F2 A8 00 C5 96 40 A8 D4
2014/05/27 17:54:11 77B00588 37 00 C1 82 AD A6 1C 71 92 21 9C 8F CD 60 B4 1D
2014/05/27 17:54:11 77B00588 9C DC 78 A6 07 0D 9A AD 4D DF 89 6C B8 F1 B6 90
2014/05/27 17:54:11 77B00588 CD D5 80 DB E5 87 80 B8 4B C6 4A 09 49 8D DC 0E
2014/05/27 17:54:11 77B00588 B4 19 9A 5F
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Write timeout 72 us, write delay 0 us, to send 116 char(s), chunksize 116 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Sending:
2014/05/27 17:54:11 77B00588 00 7D 0B 0C 70 AD B2 D2 DA 57 74 19 00 00 90 64
2014/05/27 17:54:11 77B00588 C1 01 BC 85 95 93 C4 CF 67 A9 E5 D7 D1 EA F5 AB
2014/05/27 17:54:11 77B00588 A9 6B 73 80 5D 63 CB 0F D3 5D 6F DB 7D 13 F4 6C
2014/05/27 17:54:11 77B00588 6E C2 5B CB 28 B7 2F 1B F2 A8 00 C5 96 40 A8 D4
2014/05/27 17:54:11 77B00588 37 00 C1 82 AD A6 1C 71 92 21 9C 8F CD 60 B4 1D
2014/05/27 17:54:11 77B00588 9C DC 78 A6 07 0D 9A AD 4D DF 89 6C B8 F1 B6 90
2014/05/27 17:54:11 77B00588 CD D5 80 DB E5 87 80 B8 4B C6 4A 09 49 8D DC 0E
2014/05/27 17:54:11 77B00588 B4 19 9A 5F
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 90
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] TRACE: SW1: 90
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] TRACE: SW2: 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] Answer from cardreader:
2014/05/27 17:54:11 77B00588 90 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] write to cardreader
2014/05/27 17:54:11 77B00588 D3 54 00 00 5E
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 14 ETU (72 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit size 5 bytes, expected len 97 bytes, delay 0 us, timeout=72 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit:
2014/05/27 17:54:11 77B00588 D3 54 00 00 5E
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Write timeout 72 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Sending:
2014/05/27 17:54:11 77B00588 D3 54 00 00 5E
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Transmit succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 54
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 94 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 94 char(s), chunksize 94 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 BC DA AB B2 9E 70 AC C1 72 4C D1 C5 92 DA 61 A0
2014/05/27 17:54:11 77B00588 C2 F9 9F BF 47 F1 2B 65 EB 30 6E 27 55 CC 1E D1
2014/05/27 17:54:11 77B00588 57 A4 C7 CC 76 7B 48 89 9B D8 35 FE 90 45 C2 27
2014/05/27 17:54:11 77B00588 34 07 8C 00 99 FD 20 3C 0F AB A6 D3 70 F5 3D BE
2014/05/27 17:54:11 77B00588 92 99 7C C3 31 26 85 06 E0 ED 3D C2 1B 88 65 51
2014/05/27 17:54:11 77B00588 8E FB 0B F0 BF 67 DC 3F 93 88 ED BD 0F 34
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 90
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] TRACE: SW1: 90
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Setting timeout to 230400 ETU (1190400 us)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1190400 us
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Read timeout 1190400 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IO: Receiving:
2014/05/27 17:54:11 77B00588 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] IFD: Receive succesful
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] TRACE: SW2: 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] Answer from cardreader:
2014/05/27 17:54:11 77B00588 BC DA AB B2 9E 70 AC C1 72 4C D1 C5 92 DA 61 A0
2014/05/27 17:54:11 77B00588 C2 F9 9F BF 47 F1 2B 65 EB 30 6E 27 55 CC 1E D1
2014/05/27 17:54:11 77B00588 57 A4 C7 CC 76 7B 48 89 9B D8 35 FE 90 45 C2 27
2014/05/27 17:54:11 77B00588 34 07 8C 00 99 FD 20 3C 0F AB A6 D3 70 F5 3D BE
2014/05/27 17:54:11 77B00588 92 99 7C C3 31 26 85 06 E0 ED 3D C2 1B 88 65 51
2014/05/27 17:54:11 77B00588 8E FB 0B F0 BF 67 DC 3F 93 88 ED BD 0F 34 90 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] INS54:
2014/05/27 17:54:11 77B00588 D3 54 00 00 4E
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] Decrypted payload
2014/05/27 17:54:11 77B00588 36 0A 17 57 D9 1A 71 64 00 00 00 CA 00 01 22 02
2014/05/27 17:54:11 77B00588 00 80 0E 02 03 00 0F 06 00 00 00 00 00 03 20 04
2014/05/27 17:54:11 77B00588 00 00 00 00 25 11 00 00 00 00 00 00 00 00 00 00
2014/05/27 17:54:11 77B00588 00 00 00 00 00 00 00 2A 04 00 CA 00 00 55 01 A8
2014/05/27 17:54:11 77B00588 56 08 00 00 00 00 00 00 00 00 2B 02 00 00
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] cardreader_do_ecm: after csystem.do_ecm rc=1
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] cardreader_do_ecm: ret rc=1
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2014/05/27 17:54:11 77B00588 r {client local, caid 098C, srvid 006B} [write_ecm_answer] cyclecheck passed! Reader: SkyV14 rc: 0
2014/05/27 17:54:11 77B00588 r {client local, caid 098C, prid 000000, srvid 006B} [write_ecm_answer] reader SkyV14 rc 0, ecm time 91 ms (92 ms)
2014/05/27 17:54:11 77B00588 r start client thread action 32
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] TRACE: ecm answer for ecm hash 6FEB44A658E55CA83FC4C3052441391A rc=0
2014/05/27 17:54:11 77B00588 r SkyV14 [videoguard2] ecm hash: 6FEB44A658E55CA83FC4C3052441391A real time: 87 ms
2014/05/27 17:54:11 77B02448 c data from add_job action=32 client c local
2014/05/27 17:54:11 77B02448 c {client local, caid 098C, prid 000000, srvid 006B} [send_dcw] rc 0 from reader SkyV14
2014/05/27 17:54:11 77B02448 c Client local csphash 3079AC64 cw 360A1757D91A71640000000000000000 rc 0 098C&000000/0C1E/006B/98:6FEB44A658E55CA83FC4C3052441391A
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 controlword received for PID #3 CAID 098C PROVID 000000 ECMPID 1A0B CHID 0C1E VPID 02FF
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 requested controlword for ecm 6FEB44A658E55CA83FC4C3052441391A on fd 8
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 writing odd part (360A1757D91A7164) of controlword, replacing expired (992BDB9F12064058)
2014/05/27 17:54:11 77B02448 c [DVBAPI] Demuxer #0 write cw0 index: 0 (ca3)
2014/05/27 17:54:11 77B02448 c local (098C&000000/0C1E/006B/98:6FEB44A658E55CA83FC4C3052441391A): found (95 ms) by SkyV14
2014/05/27 17:54:11 77B02448 c cw:
2014/05/27 17:54:11 77B02448 36 0A 17 57 D9 1A 71 64 00 00 00 00 00 00 00 00
2014/05/27 17:54:14 7A1660 h HTTP Server stopped
2014/05/27 17:54:14 0 s killing client local
2014/05/27 17:54:14 0 s start client thread action 24
2014/05/27 17:54:14 0 s SkyV14 [videoguard2] Killing reader
2014/05/27 17:54:14 0 s start client thread action 24
2014/05/27 17:54:14 77B00588 r ending thread (kill)
2014/05/27 17:54:14 0 s userdb 2 accounts freed
2014/05/27 17:54:14 0 s readerdb 1 readers freed
2014/05/27 17:54:14 0 s cardserver down
2014/05/27 17:54:14 77B02448 c ending thread (kill)
-------------------------------------------------------------------------------
>> OSCam << cardserver started at Tue May 27 17:54:14 2014
-------------------------------------------------------------------------------
2014/05/27 17:54:14 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r9371 (mipsel-unknown-linux-gnu)
2014/05/27 17:54:14 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 4882
2014/05/27 17:54:14 0 s userdb reloaded: 2 accounts loaded, 0 expired, 0 disabled
2014/05/27 17:54:14 0 s signal handling initialized
2014/05/27 17:54:14 0 s cccam: initialized (fd=5, port=15000)
2014/05/27 17:54:14 0 s SkyV14 [internal] creating thread for device /dev/sci0
2014/05/27 17:54:14 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2014/05/27 17:54:14 0 s waiting for local card init
2014/05/27 17:54:14 77B00588 r SkyV14 [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=3.57 MHz
2014/05/27 17:54:14 7A1660 h webif: decompressed 65950 bytes back into 189264 bytes
2014/05/27 17:54:14 7A1660 h HTTP Server running. ip=0.0.0.0 port=8888
2014/05/27 17:54:15 77B00588 r SkyV14 [internal] card detected
2014/05/27 17:54:16 77B00588 r SkyV14 [internal] ATR: 3F FD 15 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2014/05/27 17:54:16 77B00588 r SkyV14 [internal] Init card protocol T0, FI=1, F=372, D=16, N=2
2014/05/27 17:54:16 77B00588 r SkyV14 [internal] TEST tempo mhz check = 500 mhz
2014/05/27 17:54:16 77B00588 r SkyV14 [internal] Calculated work ETU is 5.17 us reader mhz = 450
2014/05/27 17:54:17 77B00588 r SkyV14 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->cardmhz)
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] Card type: P1TV
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] Rom version: 20AA
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] parental lock setting: FF FF FF FF
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] serial: ########, BoxID: ########, baseyear: 2004
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] ready for requests
2014/05/27 17:54:18 77B00588 r SkyV14 [internal] found card system videoguard2
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] THIS WAS A SUCCESFULL START ATTEMPT No 1 out of max alloted of 1
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] card detected
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0046, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 005d, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 005e, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0065, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0066, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0067, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0068, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0069, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 006a, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 006b, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 006f, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 007b, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 007d, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 0081, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 008e, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00c0, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00c7, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00c8, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00c9, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00ca, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00e4, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00e5, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00f3, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00fa, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:18 77B00588 r SkyV14 [videoguard2] tier: 00ff, expiry date: 2014/08/03-01:00:00
2014/05/27 17:54:20 0 s init for all local cards done
2014/05/27 17:54:20 0 s anti cascading disabled
2014/05/27 17:54:20 77B03010 c plain dvbapi-client granted (local, au=on (1 reader))
2014/05/27 17:54:20 77B03010 c [DVBAPI] Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2014/05/27 17:54:24 77B03010 c [DVBAPI] Receiver sends PMT command 3 for channel 006B
2014/05/27 17:54:24 77B03010 c [DVBAPI] Receiver wants to demux srvid 006B on adapter 0000 camask 0008 index 0003 pmtpid 0062
2014/05/27 17:54:24 77B03010 c [ADD PID 0] CAID: 1833 ECM_PID: 180B PROVID: 000000
2014/05/27 17:54:24 77B03010 c [ADD PID 1] CAID: 09C4 ECM_PID: 1B0B PROVID: 000000
2014/05/27 17:54:24 77B03010 c [ADD PID 2] CAID: 09AF ECM_PID: 1F0B PROVID: 000000
2014/05/27 17:54:24 77B03010 c [ADD PID 3] CAID: 098C ECM_PID: 1A0B PROVID: 000000
2014/05/27 17:54:24 77B03010 c Found 4 ECMpids and 4 STREAMpids in PMT
2014/05/27 17:54:24 77B03010 c [DVBAPI] Receiver wants to demux srvid 006B on adapter 0000 camask 0008 index 0003 pmtpid 0062
2014/05/27 17:54:24 77B03010 c New program number: 006B (1833:006B unknown) [pmt_list_management 3]
2014/05/27 17:54:24 77B03010 c [DVBAPI] Demuxer #0 trying to descramble PID #3 CAID 098C PROVID 000000 ECMPID 1A0B ANY CHID PMTPID 0062 VPID 02FF
2014/05/27 17:54:25 77B03010 c local (098C&000000/0C1E/006B/98:9A6E1AFE618D7194DD8866C1B66A4497): found (88 ms) by SkyV14
2014/05/27 17:54:25 77B03010 c local (098C&000000/0C1E/006B/98:22155E30EEAC333DCE0545AD1DAB63EF): found (77 ms) by SkyV14
2014/05/27 17:54:32 77B03010 c local (098C&000000/0C1E/006B/98:C41ACE06D19ED8010DAB2D4C3D8A1CC9): found (78 ms) by SkyV14
2014/05/27 17:54:39 77B03010 c local (098C&000000/0C1E/006B/98:3F304BA29C95E2093FD9DE90F2396C63): found (77 ms) by SkyV14
2014/05/27 17:54:46 77B03010 c local (098C&000000/0C1E/006B/98:EDA61CFA702169F17018F4EB126A915C): found (77 ms) by SkyV14
2014/05/27 17:54:53 77B03010 c local (098C&000000/0C1E/006B/98:150EE2670E008886F0670C02D59F5FFA): found (77 ms) by SkyV14
2014/05/27 17:54:58 7A1660 h Stopping log...