Auf einmal war es wieder Dunkel Raspi/Oscam/V14

-------------------------------------------------------------------------------
>> OSCam << cardserver started at Wed Apr 1 12:40:45 2015
-------------------------------------------------------------------------------
2015/04/01 12:40:45 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r9921 (arm-linux-gnueabihf)
2015/04/01 12:40:45 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 2182
2015/04/01 12:40:45 0 s userdb reloaded: 11 accounts loaded, 0 expired, 0 disabled
2015/04/01 12:40:45 0 s signal handling initialized
2015/04/01 12:40:45 0 s 659 service-id's loaded in 10 ms
2015/04/01 12:40:45 0 s cccam: initialized (fd=5, port=10000)
2015/04/01 12:40:45 0 s V14 [mouse] creating thread for device /dev/ttyUSB0
2015/04/01 12:40:45 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2015/04/01 12:40:45 0 s waiting for local card init
2015/04/01 12:40:45 F92390 h webif: decompressed 149826 bytes back into 364788 bytes
2015/04/01 12:40:45 F92390 h HTTP Server running. ip=0.0.0.0 port=88
2015/04/01 12:40:45 F7D018 r V14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=358, cardmhz=358)
2015/04/01 12:40:46 F7D018 r V14 [mouse] card detected
2015/04/01 12:40:47 F7D018 r V14 [mouse] ATR: 3F FD 13 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2015/04/01 12:40:47 F7D018 r V14 [mouse] Init card protocol T0, FI=1, F=372, D=4, N=2
2015/04/01 12:40:47 F7D018 r V14 [mouse] Setting baudrate to 38400 bps
2015/04/01 12:40:47 F7D018 r V14 [mouse] Calculated work ETU is 25.98 us reader mhz = 358
2015/04/01 12:40:47 F7D018 r V14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.58 MHz (specified in reader->mhz)
2015/04/01 12:40:48 F7D018 r V14 [mouse] Card type: P1TV
2015/04/01 12:40:48 F7D018 r V14 [mouse] Rom version: 20AA
2015/04/01 12:40:48 F7D018 r V14 [mouse] Credit available on card: 0 euro
2015/04/01 12:40:48 F7D018 r V14 [mouse] Extended 4C detected
2015/04/01 12:40:48 F7D018 r V14 [mouse] classD0 ins7E11: Scheduling card reset for TA1 change from 13 to 15
2015/04/01 12:40:48 F7D018 r V14 [mouse] found card system videoguard2
2015/04/01 12:40:48 F7D018 r V14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/04/01 12:40:48 F7D018 r V14 [videoguard2] card detected
2015/04/01 12:40:48 F7D018 r V14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2015/04/01 12:40:50 F7D018 r V14 [mouse] ATR: 3F FD 15 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2015/04/01 12:40:50 F7D018 r V14 [mouse] Init card protocol T0, FI=1, F=372, D=16, N=2
2015/04/01 12:40:50 F7D018 r V14 [mouse] Setting baudrate to 153600 bps
2015/04/01 12:40:50 F7D018 r V14 [mouse] Calculated work ETU is 6.49 us reader mhz = 358
2015/04/01 12:40:50 F7D018 r V14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.58 MHz (specified in reader->mhz)
2015/04/01 12:40:51 F7D018 r V14 [mouse] Card type: P1TV
2015/04/01 12:40:51 F7D018 r V14 [mouse] Rom version: 20AA
2015/04/01 12:40:51 F7D018 r V14 [mouse] Credit available on card: 0 euro
2015/04/01 12:40:51 F7D018 r V14 [mouse] Extended 4C detected
2015/04/01 12:40:51 F7D018 r V14 [mouse] FuseByte: 25
2015/04/01 12:40:51 F7D018 r V14 [mouse] Region Code: 00BO0102
2015/04/01 12:40:51 F7D018 r V14 [mouse] Country Code: DEU
2015/04/01 12:40:51 F7D018 r V14 [mouse] Pincode read: 5154
2015/04/01 12:40:51 F7D018 r V14 [mouse] PCB settings: FF FF FF FF
2015/04/01 12:40:51 F7D018 r V14 [mouse] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2015/04/01 12:40:51 F7D018 r V14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2015/04/01 12:40:51 F7D018 r V14 [mouse] ready for requests
2015/04/01 12:40:51 F7D018 r V14 [mouse] found card system videoguard2
2015/04/01 12:40:51 F7D018 r V14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/04/01 12:40:51 F7D018 r V14 [videoguard2] card detected
2015/04/01 12:40:51 F7D018 r V14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2015/04/01 12:40:53 0 s init for all local cards done
2015/04/01 12:40:53 0 s anti cascading disabled
2015/04/01 12:40:53 F99188 c anonymous disconnected from 192.168.178.39
2015/04/01 12:40:53 F969E8 c plain dvbapi-client granted (anonymous, au=off)
2015/04/01 12:40:53 F969E8 c [DVBAPI] Error in oscam.dvbapi: ret=-1 | p: 0000 000000 0000 10000
2015/04/01 12:40:53 0 --- Skipped 1 duplicated log lines ---
2015/04/01 12:40:53 F969E8 c [DVBAPI] Error in oscam.dvbapi: ret=-1 | i: 0000 000000 0000 10000
2015/04/01 12:40:53 F969E8 c Using SamyGO dvbapi v0.1
2015/04/01 12:41:09 F99188 c encrypted cccam-client 192.168.178.20 granted (Mamma-Wohnzimmer, au=auto (1 reader))
2015/04/01 12:41:12 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 12:41:12 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 12:41:12 F99188 c Mamma-Wohnzimmer (098C&000000/01FB/0017/9813025D5AC85C290F5FD12CC672AF580): not found (104 ms) by V14 - Sky Krimi
2015/04/01 12:41:22 1A56FB8 r Smartreader device 001:005 not found
2015/04/01 12:41:22 1A56FB8 r sky [smartreader] Cannot open device: 001:005
2015/04/01 12:41:22 FA2A90 c encrypted cccam-client 192.168.178.39 granted (Marco-Wohnzimmer, au=auto (1 reader))
2015/04/01 12:42:20 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 12:42:20 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 12:42:20 F99188 c Mamma-Wohnzimmer (098C&000000/01FB/0017/98:C6C5DA8ABEAF3046FF80E424F734418A): not found (59 ms) by V14 - Sky Krimi
2015/04/01 12:42:22 F92390 h WARNING lock http_lock (WRITELOCK) timed out.
2015/04/01 12:42:22 1A56FB8 r Smartreader device 001:005 not found
2015/04/01 12:42:22 1A56FB8 r sky [smartreader] Cannot open device: 001:005
2015/04/01 12:43:22 1A56FB8 r Smartreader device 001:005 not found
2015/04/01 12:43:22 1A56FB8 r sky [smartreader] Cannot open device: 001:005
2015/04/01 12:43:23 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 12:43:23 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 12:43:23 F99188 c Mamma-Wohnzimmer (098C&000000/01FB/0017/9B:FEE0C6428BE83357B431B62B2F5F787D): not found (59 ms) by V14 - Sky Krimi
2015/04/01 12:43:34 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 12:43:34 F7D018 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 12:43:34 F99188 c Mamma-Wohnzimmer (098C&000000/01FB/0017/98:73177F4DD5B70F410DE8EF5CC66B8F8F): not found (60 ms) by V14 - Sky Krimi
2015/04/01 12:44:22 1A56FB8 r Smartreader device 001:005 not found
2015/04/01 12:44:22 1A56FB8 r sky [smartreader] Cannot open device: 001:005

[global]
logfile = /var/cache/oscam.log
nice = -1
maxlogsize = 1500
preferlocalcards = 1
emmlogdir = /usr/local/etc
[cache]
max_time = 18
[cccam]
port = 10000
nodeid = 3191724E102613EC
version = 2.0.11
reshare = 0
reshare_mode = 1
minimizecards = 2
[dvbapi]
enabled = 1
user = dvbapi
boxtype = dreambox
[webif]
httpport = 88
httprefresh = 15
httppollrefresh = 25
httpallowed = 127.0.0.1,192.168.1.1-192.168.255.255
hideclient_to = 15

[account]
user = raspberry
pwd = XXXXXXXXXXXXXX
au = 1
group = 1
[account]
user = Marco-Wohnzimmer
pwd = XXXXXXXXXXXXXX
au = 1
group = 1,2,3
[account]
user = Marco-Schlafzimmer
pwd = XXXXXXXXXXXXXXX
au = 1
group = 1,2,3
[account]
user = Mamma-Wohnzimmer
pwd = XXXXXXXXXXXXXXX
au = 1
group = 1,2,3

P : 098C 1
P : 1843 1
I : 09C4

[reader]
label = V14
protocol = mouse
device = /dev/ttyUSB0
autospeed = 0
caid = 098C
boxid = 12345678
ins7e11 = 15
detect = cd
mhz = 358
cardmhz = 358
group = 1
emmcache = 1,1,10
blockemm-unknown = 1
blockemm-u = 1
blockemm-s = 1
blockemm-g = 1
saveemm-unknown = 1
saveemm-u = 1
ndsversion = 2

2015/04/01 13:09:07 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r9921 (arm-linux-gnueabihf)
2015/04/01 13:09:07 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 3965
2015/04/01 13:09:07 0 s userdb reloaded: 11 accounts loaded, 0 expired, 0 disabled
2015/04/01 13:09:07 0 s signal handling initialized
2015/04/01 13:09:07 0 s 659 service-id's loaded in 10 ms
2015/04/01 13:09:07 0 s cccam: initialized (fd=5, port=10000)
2015/04/01 13:09:07 0 s V14 [mouse] creating thread for device /dev/ttyUSB0
2015/04/01 13:09:07 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2015/04/01 13:09:07 0 s waiting for local card init
2015/04/01 13:09:07 F92380 h webif: decompressed 149826 bytes back into 364788 bytes
2015/04/01 13:09:07 F92380 h HTTP Server running. ip=0.0.0.0 port=88
2015/04/01 13:09:08 F7D008 r V14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=358, cardmhz=358)
2015/04/01 13:09:08 F7D008 r V14 [mouse] card detected
2015/04/01 13:09:10 F7D008 r V14 [mouse] ATR: 3F FD 15 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2015/04/01 13:09:10 F7D008 r V14 [mouse] Init card protocol T0, FI=1, F=372, D=16, N=2
2015/04/01 13:09:10 F7D008 r V14 [mouse] Setting baudrate to 153600 bps
2015/04/01 13:09:10 F7D008 r V14 [mouse] Calculated work ETU is 6.49 us reader mhz = 358
2015/04/01 13:09:10 F7D008 r V14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.58 MHz (specified in reader->mhz)
2015/04/01 13:09:11 F7D008 r V14 [mouse] Card type: P1TV
2015/04/01 13:09:11 F7D008 r V14 [mouse] Rom version: 20AA
2015/04/01 13:09:11 F7D008 r V14 [mouse] Credit available on card: 0 euro
2015/04/01 13:09:11 F7D008 r V14 [mouse] Extended 4C detected
2015/04/01 13:09:11 F7D008 r V14 [mouse] FuseByte: 25
2015/04/01 13:09:11 F7D008 r V14 [mouse] Region Code: 00BO0102
2015/04/01 13:09:11 F7D008 r V14 [mouse] Country Code: DEU
2015/04/01 13:09:11 F7D008 r V14 [mouse] Pincode read: 5154
2015/04/01 13:09:11 F7D008 r V14 [mouse] PCB settings: FF FF FF FF
2015/04/01 13:09:11 F7D008 r V14 [mouse] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2015/04/01 13:09:11 F7D008 r V14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2015/04/01 13:09:11 F7D008 r V14 [mouse] ready for requests
2015/04/01 13:09:11 F7D008 r V14 [mouse] found card system videoguard2
2015/04/01 13:09:11 F7D008 r V14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/04/01 13:09:11 F7D008 r V14 [videoguard2] card detected
2015/04/01 13:09:11 F7D008 r V14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2015/04/01 13:09:13 0 s init for all local cards done
2015/04/01 13:09:13 0 s anti cascading disabled
2015/04/01 13:09:13 F96AA0 c anonymous disconnected from 192.168.178.39
2015/04/01 13:09:17 F9AB78 c encrypted cccam-client 192.168.178.20 granted (Mamma-Wohnzimmer, au=auto (1 reader))
2015/04/01 13:09:19 F7D008 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 13:09:19 F7D008 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 13:09:19 F9AB78 c Mamma-Wohnzimmer (098C&000000/01FB/0017/98:13DC4B279619CDCC203A5E5AC454F711): not found (74 ms) by V14 - Sky Krimi
2015/04/01 13:09:38 F96AA0 c encrypted cccam-client 192.168.178.39 granted (Marco-Wohnzimmer, au=auto (1 reader))
2015/04/01 13:09:41 F7D008 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 13:09:41 F7D008 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 13:09:41 F96AA0 c Marco-Wohnzimmer (098C&000000/01FB/0017/98:4F637D0EACAB130C27361A6788500020): not found (53 ms) by V14 - Sky Krimi

2015/04/01 13:16:51 F92380 h all debug_level=2
2015/04/01 13:16:56 F92380 h all debug_level=6
2015/04/01 13:16:56 F7D008 r V14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2015/04/01 13:17:25 F7D008 00 00 90 64 C1 01 CA 18 BE D2 F3 2A 7E D7 83 63
2015/04/01 13:17:25 F7D008 D0 28 E6 20 E9 2C 0D 57 0C 44 79 01 6A 2F FF 12
2015/04/01 13:17:25 F7D008 68 0B 42 85 9A FE A8 DE 2E DC 23 88 1B 8C C0 75
2015/04/01 13:17:25 F7D008 1A 87 48 A0 EB 68 B2 CA ED 83 6A EB 09 A3 28 4D
2015/04/01 13:17:25 F7D008 74 C3 BA 94 50 1A F9 AA EB E7 BC 97 98 6F 4B DA
2015/04/01 13:17:25 F7D008 F4 9F 43 55 02 59 D0 7E 3F EF 8A 0F 12 34 E5 E9
2015/04/01 13:17:25 F7D008 73 6F 0B A6 D6 B9 9B 52
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] write to cardreader
2015/04/01 13:17:25 F7D008 D1 40 00 80 74 00 7D 0B 0C 30 BA 94 73 04 D6 17
2015/04/01 13:17:25 F7D008 AB 00 00 90 64 C1 01 CA 18 BE D2 F3 2A 7E D7 83
2015/04/01 13:17:25 F7D008 63 D0 28 E6 20 E9 2C 0D 57 0C 44 79 01 6A 2F FF
2015/04/01 13:17:25 F7D008 12 68 0B 42 85 9A FE A8 DE 2E DC 23 88 1B 8C C0
2015/04/01 13:17:25 F7D008 75 1A 87 48 A0 EB 68 B2 CA ED 83 6A EB 09 A3 28
2015/04/01 13:17:25 F7D008 4D 74 C3 BA 94 50 1A F9 AA EB E7 BC 97 98 6F 4B
2015/04/01 13:17:25 F7D008 DA F4 9F 43 55 02 59 D0 7E 3F EF 8A 0F 12 34 E5
2015/04/01 13:17:25 F7D008 E9 73 6F 0B A6 D6 B9 9B 52
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] Answer from cardreader:
2015/04/01 13:17:25 F7D008 90 00
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] write to cardreader
2015/04/01 13:17:25 F7D008 D3 54 00 00 5E
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] Answer from cardreader:
2015/04/01 13:17:25 F7D008 1D B7 5B 1C EA 10 D9 EE 9F D0 D8 EC A3 F5 31 11
2015/04/01 13:17:25 F7D008 4F CF 8B 96 19 E2 A7 B9 A4 91 3F 37 5C 11 E6 52
2015/04/01 13:17:25 F7D008 C7 13 C8 76 DC 09 93 5B 3D AC B6 F8 7F 76 A2 FB
2015/04/01 13:17:25 F7D008 F0 4D 28 77 6C 02 DC 64 4E 51 AD A0 20 7C D4 E0
2015/04/01 13:17:25 F7D008 55 C2 29 82 79 45 E4 CA 0A 5D 5B FF CE 0A CD D7
2015/04/01 13:17:25 F7D008 74 D7 64 59 66 EE E5 AB EE 36 F4 80 26 A9 90 00
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] Decrypted payload
2015/04/01 13:17:25 F7D008 00 00 00 00 00 00 00 00 00 00 00 00 FF 00 22 02
2015/04/01 13:17:25 F7D008 00 80 0E 02 00 00 0F 06 00 10 20 00 00 11 20 04
2015/04/01 13:17:25 F7D008 00 00 00 00 25 11 00 00 00 00 00 00 00 00 00 00
2015/04/01 13:17:25 F7D008 00 00 00 00 00 00 00 2A 04 00 00 00 00 55 01 20
2015/04/01 13:17:25 F7D008 56 08 00 00 00 00 00 00 00 00 2B 02 00 00
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] cardreader_do_ecm: after csystem.do_ecm rc=0
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] cardreader_do_ecm: ret rc=0
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=0 (ERROR=0)
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] Error processing ecm for caid 098C, srvid 0017, servicename: Sky Krimi
2015/04/01 13:17:25 F9AB78 c Mamma-Wohnzimmer (098C&000000/01FB/0017/98:4AB640895DCF52E5DE9FF638487AA923): not found (70 ms) by V14 - Sky Krimi
2015/04/01 13:17:25 F9AB78 c cw:
2015/04/01 13:17:25 F9AB78 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2015/04/01 13:17:25 F7D008 r V14 [videoguard2] ecm hash: 4AB640895DCF52E5DE9FF638487AA923 real time: 63 ms
2015/04/01 13:17:26 F7D008 r V14 [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1