14/02/22 13:18:24 776045F8 c [DVBAPI] new events occurred on 1 of 3 handlers after 2051 ms inactivity
2014/02/22 13:18:24 776045F8 c [DVBAPI] now handling fd 17 that reported event 3
2014/02/22 13:18:24 776045F8 c [DVBAPI] Readed:
2014/02/22 13:18:24 776045F8 80 70 B4 00 00 01 14 CD 16 62 47 05 94 AA 55 81
2014/02/22 13:18:24 776045F8 21 84 01 00 01 01 02 FF FF 00 62 9B 7E 0A 89 85
2014/02/22 13:18:24 776045F8 66 7B 12 17 D2 3A 00 00 90 8D C0 02 F7 7E 8B 9E
2014/02/22 13:18:24 776045F8 32 0A 9E 19 7B 5D 95 42 33 0F 78 0D AD B6 81 F2
2014/02/22 13:18:24 776045F8 D0 22 EC 43 20 89 90 54 45 5A 7B C6 E5 EA 9D 27
2014/02/22 13:18:24 776045F8 59 CA 96 2F 0B 87 A3 67 DD 61 AE FC 56 4D FB 02
2014/02/22 13:18:24 776045F8 6C 25 10 EC 13 45 81 70 9A E8 B7 8C 40 B6 32 DE
2014/02/22 13:18:24 776045F8 85 0D A3 41 71 BF AF AC 18 B0 C5 ED E6 CB CA 96
2014/02/22 13:18:24 776045F8 B9 EA 30 14 37 90 F6 89 B8 C2 9E 28 77 0A CE 8F
2014/02/22 13:18:24 776045F8 FC D0 DE 1B 66 04 D1 71 0F 6E AD 18 BE 97 CB 01
2014/02/22 13:18:24 776045F8 5A 87 7F B1 F6 AC F0 1E A7 5F CA FC 4D 66 3A 2B
2014/02/22 13:18:24 776045F8 83 45 C0 92 F4 09 6B
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 ECMTYPE 80 CAID 093B PROVID 000000 ECMPID 06AD FAKECHID 0594 (unique part in ecm)
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to ODD (CAID 093B PROVID 000000 FD 17)
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set chid to 0594 on fd 17
2014/02/22 13:18:24 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] NEW REQUEST!
2014/02/22 13:18:24 776045F8 c trying reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:24 776045F8 c 093B:000000 allowed by reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:24 776045F8 c [GET_CW] wait_time 0 caid 093B prov 000000 srvid 0594 rc 100 cacheex cl mode 0 ex1rdr 0
2014/02/22 13:18:24 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/02/22 13:18:24 776045F8 c request_cw stage=2 to reader Sky_Italia ecm hash=8675F964EE1E1BFC260D25E8A048B165
2014/02/22 13:18:24 776045F8 c start reader thread action 5
2014/02/22 13:18:24 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_request] reader Sky_Italia --> SENT 1
2014/02/22 13:18:24 776045F8 c Client DM-7020HD ECM dump 093B&000000/0594/0594/B7:8675F964EE1E1BFC260D25E8A048B165
2014/02/22 13:18:24 776045F8 80 70 B4 00 00 01 14 CD 16 62 47 05 94 AA 55 81
2014/02/22 13:18:24 776045F8 21 84 01 00 01 01 02 FF FF 00 62 9B 7E 0A 89 85
2014/02/22 13:18:24 776045F8 66 7B 12 17 D2 3A 00 00 90 8D C0 02 F7 7E 8B 9E
2014/02/22 13:18:24 776045F8 32 0A 9E 19 7B 5D 95 42 33 0F 78 0D AD B6 81 F2
2014/02/22 13:18:24 776045F8 D0 22 EC 43 20 89 90 54 45 5A 7B C6 E5 EA 9D 27
2014/02/22 13:18:24 776045F8 59 CA 96 2F 0B 87 A3 67 DD 61 AE FC 56 4D FB 02
2014/02/22 13:18:24 776045F8 6C 25 10 EC 13 45 81 70 9A E8 B7 8C 40 B6 32 DE
2014/02/22 13:18:24 776045F8 85 0D A3 41 71 BF AF AC 18 B0 C5 ED E6 CB CA 96
2014/02/22 13:18:24 776045F8 B9 EA 30 14 37 90 F6 89 B8 C2 9E 28 77 0A CE 8F
2014/02/22 13:18:24 776045F8 FC D0 DE 1B 66 04 D1 71 0F 6E AD 18 BE 97 CB 01
2014/02/22 13:18:24 776045F8 5A 87 7F B1 F6 AC F0 1E A7 5F CA FC 4D 66 3A 2B
2014/02/22 13:18:24 776045F8 83 45 C0 92 F4 09 6B
2014/02/22 13:18:24 776004F8 r data from add_job action=5 client r Sky_Italia
2014/02/22 13:18:24 776004F8 r ecm:
2014/02/22 13:18:24 776004F8 80 70 B4 00 00 01 14 CD 16 62 47 05 94 AA 55 81
2014/02/22 13:18:24 776004F8 21 84 01 00 01 01 02 FF FF 00 62 9B 7E 0A 89 85
2014/02/22 13:18:24 776004F8 66 7B 12 17 D2 3A 00 00 90 8D C0 02 F7 7E 8B 9E
2014/02/22 13:18:24 776004F8 32 0A 9E 19 7B 5D 95 42 33 0F 78 0D AD B6 81 F2
2014/02/22 13:18:24 776004F8 D0 22 EC 43 20 89 90 54 45 5A 7B C6 E5 EA 9D 27
2014/02/22 13:18:24 776004F8 59 CA 96 2F 0B 87 A3 67 DD 61 AE FC 56 4D FB 02
2014/02/22 13:18:24 776004F8 6C 25 10 EC 13 45 81 70 9A E8 B7 8C 40 B6 32 DE
2014/02/22 13:18:24 776004F8 85 0D A3 41 71 BF AF AC 18 B0 C5 ED E6 CB CA 96
2014/02/22 13:18:24 776004F8 B9 EA 30 14 37 90 F6 89 B8 C2 9E 28 77 0A CE 8F
2014/02/22 13:18:24 776004F8 FC D0 DE 1B 66 04 D1 71 0F 6E AD 18 BE 97 CB 01
2014/02/22 13:18:24 776004F8 5A 87 7F B1 F6 AC F0 1E A7 5F CA FC 4D 66 3A 2B
2014/02/22 13:18:24 776004F8 83 45 C0 92 F4 09 6B
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 request cw for ecm 093B&000000/0594/0594/B7:8675F964EE1E1BFC260D25E8A048B165
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:24 776004F8 D1 40 00 80 9C 00 7E 0A 89 85 66 7B 12 17 D2 3A
2014/02/22 13:18:24 776004F8 00 00 90 8D C0 02 F7 7E 8B 9E 32 0A 9E 19 7B 5D
2014/02/22 13:18:24 776004F8 95 42 33 0F 78 0D AD B6 81 F2 D0 22 EC 43 20 89
2014/02/22 13:18:24 776004F8 90 54 45 5A 7B C6 E5 EA 9D 27 59 CA 96 2F 0B 87
2014/02/22 13:18:24 776004F8 A3 67 DD 61 AE FC 56 4D FB 02 6C 25 10 EC 13 45
2014/02/22 13:18:24 776004F8 81 70 9A E8 B7 8C 40 B6 32 DE 85 0D A3 41 71 BF
2014/02/22 13:18:24 776004F8 AF AC 18 B0 C5 ED E6 CB CA 96 B9 EA 30 14 37 90
2014/02/22 13:18:24 776004F8 F6 89 B8 C2 9E 28 77 0A CE 8F FC D0 DE 1B 66 04
2014/02/22 13:18:24 776004F8 D1 71 0F 6E AD 18 BE 97 CB 01 5A 87 7F B1 F6 AC
2014/02/22 13:18:24 776004F8 F0 1E A7 5F CA FC 4D 66 3A 2B 83 45 C0 92 F4 09
2014/02/22 13:18:24 776004F8 6B
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:24 776004F8 D1 40 00 80 9C
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:24 776004F8 D1 40 00 80 9C
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 40
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 156 bytes, expected len 2 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:24 776004F8 00 7E 0A 89 85 66 7B 12 17 D2 3A 00 00 90 8D C0
2014/02/22 13:18:24 776004F8 02 F7 7E 8B 9E 32 0A 9E 19 7B 5D 95 42 33 0F 78
2014/02/22 13:18:24 776004F8 0D AD B6 81 F2 D0 22 EC 43 20 89 90 54 45 5A 7B
2014/02/22 13:18:24 776004F8 C6 E5 EA 9D 27 59 CA 96 2F 0B 87 A3 67 DD 61 AE
2014/02/22 13:18:24 776004F8 FC 56 4D FB 02 6C 25 10 EC 13 45 81 70 9A E8 B7
2014/02/22 13:18:24 776004F8 8C 40 B6 32 DE 85 0D A3 41 71 BF AF AC 18 B0 C5
2014/02/22 13:18:24 776004F8 ED E6 CB CA 96 B9 EA 30 14 37 90 F6 89 B8 C2 9E
2014/02/22 13:18:24 776004F8 28 77 0A CE 8F FC D0 DE 1B 66 04 D1 71 0F 6E AD
2014/02/22 13:18:24 776004F8 18 BE 97 CB 01 5A 87 7F B1 F6 AC F0 1E A7 5F CA
2014/02/22 13:18:24 776004F8 FC 4D 66 3A 2B 83 45 C0 92 F4 09 6B
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 156 char(s), chunksize 156 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:24 776004F8 00 7E 0A 89 85 66 7B 12 17 D2 3A 00 00 90 8D C0
2014/02/22 13:18:24 776004F8 02 F7 7E 8B 9E 32 0A 9E 19 7B 5D 95 42 33 0F 78
2014/02/22 13:18:24 776004F8 0D AD B6 81 F2 D0 22 EC 43 20 89 90 54 45 5A 7B
2014/02/22 13:18:24 776004F8 C6 E5 EA 9D 27 59 CA 96 2F 0B 87 A3 67 DD 61 AE
2014/02/22 13:18:24 776004F8 FC 56 4D FB 02 6C 25 10 EC 13 45 81 70 9A E8 B7
2014/02/22 13:18:24 776004F8 8C 40 B6 32 DE 85 0D A3 41 71 BF AF AC 18 B0 C5
2014/02/22 13:18:24 776004F8 ED E6 CB CA 96 B9 EA 30 14 37 90 F6 89 B8 C2 9E
2014/02/22 13:18:24 776004F8 28 77 0A CE 8F FC D0 DE 1B 66 04 D1 71 0F 6E AD
2014/02/22 13:18:24 776004F8 18 BE 97 CB 01 5A 87 7F B1 F6 AC F0 1E A7 5F CA
2014/02/22 13:18:24 776004F8 FC 4D 66 3A 2B 83 45 C0 92 F4 09 6B
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 90
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:24 776004F8 90 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:24 776004F8 D3 54 00 00 59
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 92 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:24 776004F8 D3 54 00 00 59
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:24 776004F8 D3 54 00 00 59
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 54
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 89 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 89 char(s), chunksize 89 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 39 20 4D F0 19 4A 70 3F 6D AB B8 6B B4 8A B5 B0
2014/02/22 13:18:24 776004F8 92 7E 56 11 E8 9B 03 2B EC 7D 65 57 34 AD E6 40
2014/02/22 13:18:24 776004F8 42 25 CE C7 14 4E 39 C5 28 71 C4 42 3B 09 BF F9
2014/02/22 13:18:24 776004F8 97 59 34 EB FC 1A 5A 21 31 DB 71 16 37 88 4A 69
2014/02/22 13:18:24 776004F8 3C 1F 07 A9 34 BD A4 15 C5 01 6F 97 11 60 17 19
2014/02/22 13:18:24 776004F8 60 34 92 B2 87 6F 5A 1D 3C
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 90
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:24 776004F8 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:24 776004F8 39 20 4D F0 19 4A 70 3F 6D AB B8 6B B4 8A B5 B0
2014/02/22 13:18:24 776004F8 92 7E 56 11 E8 9B 03 2B EC 7D 65 57 34 AD E6 40
2014/02/22 13:18:24 776004F8 42 25 CE C7 14 4E 39 C5 28 71 C4 42 3B 09 BF F9
2014/02/22 13:18:24 776004F8 97 59 34 EB FC 1A 5A 21 31 DB 71 16 37 88 4A 69
2014/02/22 13:18:24 776004F8 3C 1F 07 A9 34 BD A4 15 C5 01 6F 97 11 60 17 19
2014/02/22 13:18:24 776004F8 60 34 92 B2 87 6F 5A 1D 3C 90 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] INS54:
2014/02/22 13:18:24 776004F8 D3 54 00 00 49
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] Decrypted payload
2014/02/22 13:18:24 776004F8 5C B5 23 34 7E B6 8D C1 AA 55 00 00 FF 03 22 02
2014/02/22 13:18:24 776004F8 C0 00 0E 02 80 00 0F 05 02 20 00 00 00 20 04 00
2014/02/22 13:18:24 776004F8 00 00 00 25 11 00 00 00 00 00 00 00 00 00 00 00
2014/02/22 13:18:24 776004F8 00 00 00 00 00 00 2A 04 00 00 00 00 55 01 80 56
2014/02/22 13:18:24 776004F8 08 00 00 00 00 00 00 00 00
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: after csystem.do_ecm rc=1
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: ret rc=1
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2014/02/22 13:18:24 776004F8 r {client DM-7020HD, caid 093B, srvid 0594} [write_ecm_answer] cyclecheck passed! Reader: Sky_Italia rc: 0
2014/02/22 13:18:24 776004F8 r {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_answer] reader Sky_Italia rc 0, ecm time 119 ms (120 ms)
2014/02/22 13:18:24 776004F8 r start client thread action 32
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] TRACE: ecm answer for ecm hash 8675F964EE1E1BFC260D25E8A048B165 rc=0
2014/02/22 13:18:24 776004F8 r Sky_Italia [videoguard2] ecm hash: 8675F964EE1E1BFC260D25E8A048B165 real time: 113 ms
2014/02/22 13:18:24 776045F8 c data from add_job action=32 client c DM-7020HD
2014/02/22 13:18:24 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [send_dcw] rc 0 from reader Sky_Italia
2014/02/22 13:18:24 776045F8 c Client DM-7020HD csphash EF01284D cw 5CB523347EB68DC10000000000000000 rc 0 093B&000000/0594/0594/B7:8675F964EE1E1BFC260D25E8A048B165
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 controlword received for PID #1 CAID 093B PROVID 000000 ECMPID 06AD CHID 0594 VPID 00A8
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 requested controlword for ecm 8675F964EE1E1BFC260D25E8A048B165 on fd 17
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 writing odd part (5CB523347EB68DC1) of controlword, replacing expired (1BD3A391F0958C11)
2014/02/22 13:18:24 776045F8 c [DVBAPI] Demuxer #0 write cw0 index: 0 (ca3)
2014/02/22 13:18:24 776045F8 c DM-7020HD (093B&000000/0594/0594/B7:8675F964EE1E1BFC260D25E8A048B165): found (123 ms) by Sky_Italia - MTV Music
2014/02/22 13:18:24 776045F8 c cw:
2014/02/22 13:18:24 776045F8 5C B5 23 34 7E B6 8D C1 00 00 00 00 00 00 00 00
2014/02/22 13:18:25 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:29 0 --- Skipped 4 duplicated log lines ---
2014/02/22 13:18:29 0 start client thread action 31
2014/02/22 13:18:29 776045F8 c data from add_job action=31 client c DM-7020HD
2014/02/22 13:18:30 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:34 0 --- Skipped 4 duplicated log lines ---
2014/02/22 13:18:34 776045F8 c [DVBAPI] new events occurred on 1 of 3 handlers after 10000 ms inactivity
2014/02/22 13:18:34 776045F8 c [DVBAPI] now handling fd 17 that reported event 3
2014/02/22 13:18:34 776045F8 c [DVBAPI] Readed:
2014/02/22 13:18:34 776045F8 81 70 B4 00 00 01 14 CD 16 62 4C 05 94 AA 55 81
2014/02/22 13:18:34 776045F8 21 84 01 00 01 01 02 FF FF 00 67 9B 7E 0A 60 6A
2014/02/22 13:18:34 776045F8 0D 8F 6E FA ED 62 00 00 90 8D C0 02 6D CE F7 83
2014/02/22 13:18:34 776045F8 B0 60 3B 07 7C F9 AA DD 60 19 31 CC DF AF 7E D0
2014/02/22 13:18:34 776045F8 18 E6 F1 53 26 1D EB 29 56 AD E1 7D 59 11 4D 99
2014/02/22 13:18:34 776045F8 7E E2 E6 2A F3 A0 80 06 87 A3 97 29 3A 04 78 E7
2014/02/22 13:18:34 776045F8 A8 A0 EA 0C 82 FB 30 50 5E 03 ED 9D A7 D5 AB 7B
2014/02/22 13:18:34 776045F8 18 3E 23 54 3C 89 6F D6 D9 8F 69 AE F5 D5 A5 6A
2014/02/22 13:18:34 776045F8 AA 65 82 3B 32 F0 48 71 9A 8F 12 3E C5 97 D3 0F
2014/02/22 13:18:34 776045F8 64 91 C3 2F 65 5D 92 15 67 48 3A 9A BC FD 2A 05
2014/02/22 13:18:34 776045F8 BE 9C F8 13 6B 85 DD F3 2C 44 8D 3F D9 F0 71 0B
2014/02/22 13:18:34 776045F8 2A C5 9D 56 47 A7 A5
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 ECMTYPE 81 CAID 093B PROVID 000000 ECMPID 06AD FAKECHID 0594 (unique part in ecm)
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to EVEN (CAID 093B PROVID 000000 FD 17)
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set chid to 0594 on fd 17
2014/02/22 13:18:34 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] NEW REQUEST!
2014/02/22 13:18:34 776045F8 c trying reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:34 776045F8 c 093B:000000 allowed by reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:34 776045F8 c [GET_CW] wait_time 0 caid 093B prov 000000 srvid 0594 rc 100 cacheex cl mode 0 ex1rdr 0
2014/02/22 13:18:34 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/02/22 13:18:34 776045F8 c request_cw stage=2 to reader Sky_Italia ecm hash=550F19DDA33EF8A362D523C9EC47C0BD
2014/02/22 13:18:34 776045F8 c start reader thread action 5
2014/02/22 13:18:34 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_request] reader Sky_Italia --> SENT 1
2014/02/22 13:18:34 776045F8 c Client DM-7020HD ECM dump 093B&000000/0594/0594/B7:550F19DDA33EF8A362D523C9EC47C0BD
2014/02/22 13:18:34 776045F8 81 70 B4 00 00 01 14 CD 16 62 4C 05 94 AA 55 81
2014/02/22 13:18:34 776045F8 21 84 01 00 01 01 02 FF FF 00 67 9B 7E 0A 60 6A
2014/02/22 13:18:34 776045F8 0D 8F 6E FA ED 62 00 00 90 8D C0 02 6D CE F7 83
2014/02/22 13:18:34 776045F8 B0 60 3B 07 7C F9 AA DD 60 19 31 CC DF AF 7E D0
2014/02/22 13:18:34 776045F8 18 E6 F1 53 26 1D EB 29 56 AD E1 7D 59 11 4D 99
2014/02/22 13:18:34 776045F8 7E E2 E6 2A F3 A0 80 06 87 A3 97 29 3A 04 78 E7
2014/02/22 13:18:34 776045F8 A8 A0 EA 0C 82 FB 30 50 5E 03 ED 9D A7 D5 AB 7B
2014/02/22 13:18:34 776045F8 18 3E 23 54 3C 89 6F D6 D9 8F 69 AE F5 D5 A5 6A
2014/02/22 13:18:34 776045F8 AA 65 82 3B 32 F0 48 71 9A 8F 12 3E C5 97 D3 0F
2014/02/22 13:18:34 776045F8 64 91 C3 2F 65 5D 92 15 67 48 3A 9A BC FD 2A 05
2014/02/22 13:18:34 776045F8 BE 9C F8 13 6B 85 DD F3 2C 44 8D 3F D9 F0 71 0B
2014/02/22 13:18:34 776045F8 2A C5 9D 56 47 A7 A5
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 request cw for ecm 093B&000000/0594/0594/B7:550F19DDA33EF8A362D523C9EC47C0BD
2014/02/22 13:18:34 776004F8 r data from add_job action=5 client r Sky_Italia
2014/02/22 13:18:34 776004F8 r ecm:
2014/02/22 13:18:34 776004F8 81 70 B4 00 00 01 14 CD 16 62 4C 05 94 AA 55 81
2014/02/22 13:18:34 776004F8 21 84 01 00 01 01 02 FF FF 00 67 9B 7E 0A 60 6A
2014/02/22 13:18:34 776004F8 0D 8F 6E FA ED 62 00 00 90 8D C0 02 6D CE F7 83
2014/02/22 13:18:34 776004F8 B0 60 3B 07 7C F9 AA DD 60 19 31 CC DF AF 7E D0
2014/02/22 13:18:34 776004F8 18 E6 F1 53 26 1D EB 29 56 AD E1 7D 59 11 4D 99
2014/02/22 13:18:34 776004F8 7E E2 E6 2A F3 A0 80 06 87 A3 97 29 3A 04 78 E7
2014/02/22 13:18:34 776004F8 A8 A0 EA 0C 82 FB 30 50 5E 03 ED 9D A7 D5 AB 7B
2014/02/22 13:18:34 776004F8 18 3E 23 54 3C 89 6F D6 D9 8F 69 AE F5 D5 A5 6A
2014/02/22 13:18:34 776004F8 AA 65 82 3B 32 F0 48 71 9A 8F 12 3E C5 97 D3 0F
2014/02/22 13:18:34 776004F8 64 91 C3 2F 65 5D 92 15 67 48 3A 9A BC FD 2A 05
2014/02/22 13:18:34 776004F8 BE 9C F8 13 6B 85 DD F3 2C 44 8D 3F D9 F0 71 0B
2014/02/22 13:18:34 776004F8 2A C5 9D 56 47 A7 A5
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:34 776004F8 D1 40 00 80 9C 00 7E 0A 60 6A 0D 8F 6E FA ED 62
2014/02/22 13:18:34 776004F8 00 00 90 8D C0 02 6D CE F7 83 B0 60 3B 07 7C F9
2014/02/22 13:18:34 776004F8 AA DD 60 19 31 CC DF AF 7E D0 18 E6 F1 53 26 1D
2014/02/22 13:18:34 776004F8 EB 29 56 AD E1 7D 59 11 4D 99 7E E2 E6 2A F3 A0
2014/02/22 13:18:34 776004F8 80 06 87 A3 97 29 3A 04 78 E7 A8 A0 EA 0C 82 FB
2014/02/22 13:18:34 776004F8 30 50 5E 03 ED 9D A7 D5 AB 7B 18 3E 23 54 3C 89
2014/02/22 13:18:34 776004F8 6F D6 D9 8F 69 AE F5 D5 A5 6A AA 65 82 3B 32 F0
2014/02/22 13:18:34 776004F8 48 71 9A 8F 12 3E C5 97 D3 0F 64 91 C3 2F 65 5D
2014/02/22 13:18:34 776004F8 92 15 67 48 3A 9A BC FD 2A 05 BE 9C F8 13 6B 85
2014/02/22 13:18:34 776004F8 DD F3 2C 44 8D 3F D9 F0 71 0B 2A C5 9D 56 47 A7
2014/02/22 13:18:34 776004F8 A5
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:34 776004F8 D1 40 00 80 9C
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:34 776004F8 D1 40 00 80 9C
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 40
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 156 bytes, expected len 2 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:34 776004F8 00 7E 0A 60 6A 0D 8F 6E FA ED 62 00 00 90 8D C0
2014/02/22 13:18:34 776004F8 02 6D CE F7 83 B0 60 3B 07 7C F9 AA DD 60 19 31
2014/02/22 13:18:34 776004F8 CC DF AF 7E D0 18 E6 F1 53 26 1D EB 29 56 AD E1
2014/02/22 13:18:34 776004F8 7D 59 11 4D 99 7E E2 E6 2A F3 A0 80 06 87 A3 97
2014/02/22 13:18:34 776004F8 29 3A 04 78 E7 A8 A0 EA 0C 82 FB 30 50 5E 03 ED
2014/02/22 13:18:34 776004F8 9D A7 D5 AB 7B 18 3E 23 54 3C 89 6F D6 D9 8F 69
2014/02/22 13:18:34 776004F8 AE F5 D5 A5 6A AA 65 82 3B 32 F0 48 71 9A 8F 12
2014/02/22 13:18:34 776004F8 3E C5 97 D3 0F 64 91 C3 2F 65 5D 92 15 67 48 3A
2014/02/22 13:18:34 776004F8 9A BC FD 2A 05 BE 9C F8 13 6B 85 DD F3 2C 44 8D
2014/02/22 13:18:34 776004F8 3F D9 F0 71 0B 2A C5 9D 56 47 A7 A5
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 156 char(s), chunksize 156 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:34 776004F8 00 7E 0A 60 6A 0D 8F 6E FA ED 62 00 00 90 8D C0
2014/02/22 13:18:34 776004F8 02 6D CE F7 83 B0 60 3B 07 7C F9 AA DD 60 19 31
2014/02/22 13:18:34 776004F8 CC DF AF 7E D0 18 E6 F1 53 26 1D EB 29 56 AD E1
2014/02/22 13:18:34 776004F8 7D 59 11 4D 99 7E E2 E6 2A F3 A0 80 06 87 A3 97
2014/02/22 13:18:34 776004F8 29 3A 04 78 E7 A8 A0 EA 0C 82 FB 30 50 5E 03 ED
2014/02/22 13:18:34 776004F8 9D A7 D5 AB 7B 18 3E 23 54 3C 89 6F D6 D9 8F 69
2014/02/22 13:18:34 776004F8 AE F5 D5 A5 6A AA 65 82 3B 32 F0 48 71 9A 8F 12
2014/02/22 13:18:34 776004F8 3E C5 97 D3 0F 64 91 C3 2F 65 5D 92 15 67 48 3A
2014/02/22 13:18:34 776004F8 9A BC FD 2A 05 BE 9C F8 13 6B 85 DD F3 2C 44 8D
2014/02/22 13:18:34 776004F8 3F D9 F0 71 0B 2A C5 9D 56 47 A7 A5
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 90
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:34 776004F8 90 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:34 776004F8 D3 54 00 00 59
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 92 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:34 776004F8 D3 54 00 00 59
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:34 776004F8 D3 54 00 00 59
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 54
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 89 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 89 char(s), chunksize 89 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 79 AB C5 8F D7 7E D8 80 D8 2D D7 18 63 2F D7 A7
2014/02/22 13:18:34 776004F8 97 06 FA A7 09 22 1D 17 92 EE AF 27 56 5F 48 6D
2014/02/22 13:18:34 776004F8 BF 5E D3 26 F8 A8 46 8C A9 FC 16 8D 8B 05 47 27
2014/02/22 13:18:34 776004F8 5B 08 2D 4E E1 A9 7B FC 27 05 70 37 E1 36 30 CF
2014/02/22 13:18:34 776004F8 96 DA 69 A0 D9 5A 34 4F AE 20 3A 33 8A 78 8F D5
2014/02/22 13:18:34 776004F8 90 B4 6E 66 3F 35 C4 C2 89
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 90
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:34 776004F8 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:34 776004F8 79 AB C5 8F D7 7E D8 80 D8 2D D7 18 63 2F D7 A7
2014/02/22 13:18:34 776004F8 97 06 FA A7 09 22 1D 17 92 EE AF 27 56 5F 48 6D
2014/02/22 13:18:34 776004F8 BF 5E D3 26 F8 A8 46 8C A9 FC 16 8D 8B 05 47 27
2014/02/22 13:18:34 776004F8 5B 08 2D 4E E1 A9 7B FC 27 05 70 37 E1 36 30 CF
2014/02/22 13:18:34 776004F8 96 DA 69 A0 D9 5A 34 4F AE 20 3A 33 8A 78 8F D5
2014/02/22 13:18:34 776004F8 90 B4 6E 66 3F 35 C4 C2 89 90 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] INS54:
2014/02/22 13:18:34 776004F8 D3 54 00 00 49
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] Decrypted payload
2014/02/22 13:18:34 776004F8 F0 E5 C8 9D BE 2D 2D 18 AA 55 00 00 FF 03 22 02
2014/02/22 13:18:34 776004F8 C0 00 0E 02 80 00 0F 05 02 20 00 00 00 20 04 00
2014/02/22 13:18:34 776004F8 00 00 00 25 11 00 00 00 00 00 00 00 00 00 00 00
2014/02/22 13:18:34 776004F8 00 00 00 00 00 00 2A 04 00 00 00 00 55 01 80 56
2014/02/22 13:18:34 776004F8 08 00 00 00 00 00 00 00 00
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: after csystem.do_ecm rc=1
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: ret rc=1
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2014/02/22 13:18:34 776004F8 r {client DM-7020HD, caid 093B, srvid 0594} [write_ecm_answer] cyclecheck passed! Reader: Sky_Italia rc: 0
2014/02/22 13:18:34 776004F8 r {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_answer] reader Sky_Italia rc 0, ecm time 116 ms (118 ms)
2014/02/22 13:18:34 776004F8 r start client thread action 32
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] TRACE: ecm answer for ecm hash 550F19DDA33EF8A362D523C9EC47C0BD rc=0
2014/02/22 13:18:34 776004F8 r Sky_Italia [videoguard2] ecm hash: 550F19DDA33EF8A362D523C9EC47C0BD real time: 112 ms
2014/02/22 13:18:34 776045F8 c data from add_job action=32 client c DM-7020HD
2014/02/22 13:18:34 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [send_dcw] rc 0 from reader Sky_Italia
2014/02/22 13:18:34 776045F8 c Client DM-7020HD csphash 47E3198E cw 0000000000000000F0E5C89DBE2D2D18 rc 0 093B&000000/0594/0594/B7:550F19DDA33EF8A362D523C9EC47C0BD
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 controlword received for PID #1 CAID 093B PROVID 000000 ECMPID 06AD CHID 0594 VPID 00A8
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 requested controlword for ecm 550F19DDA33EF8A362D523C9EC47C0BD on fd 17
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 writing even part (F0E5C89DBE2D2D18) of controlword, replacing expired (80E30366567E15E9)
2014/02/22 13:18:34 776045F8 c [DVBAPI] Demuxer #0 write cw1 index: 0 (ca3)
2014/02/22 13:18:34 776045F8 c DM-7020HD (093B&000000/0594/0594/B7:550F19DDA33EF8A362D523C9EC47C0BD): found (121 ms) by Sky_Italia - MTV Music
2014/02/22 13:18:34 776045F8 c cw:
2014/02/22 13:18:34 776045F8 00 00 00 00 00 00 00 00 F0 E5 C8 9D BE 2D 2D 18
2014/02/22 13:18:35 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:39 0 --- Skipped 4 duplicated log lines ---
2014/02/22 13:18:39 0 start client thread action 31
2014/02/22 13:18:39 776045F8 c data from add_job action=31 client c DM-7020HD
2014/02/22 13:18:40 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:44 0 --- Skipped 4 duplicated log lines ---
2014/02/22 13:18:44 C176C8 h WebIf: Received stale header from 192.168.2.101 (nonce=1038b811221c068adde27faf8ee49ffc, expectednonce=c803ab5737ab80d6ba44603853f0b61c, opaque=caf57af171a031bfc082341ef5c00d25).
2014/02/22 13:18:44 C176C8 h WebIf: Origin checked. Result: access from 192.168.2.101 => allowed
2014/02/22 13:18:44 776045F8 c [DVBAPI] new events occurred on 1 of 3 handlers after 10002 ms inactivity
2014/02/22 13:18:44 776045F8 c [DVBAPI] now handling fd 17 that reported event 3
2014/02/22 13:18:44 776045F8 c [DVBAPI] Readed:
2014/02/22 13:18:44 776045F8 80 70 B4 00 00 01 14 CD 16 62 51 05 94 AA 55 81
2014/02/22 13:18:44 776045F8 21 84 01 00 01 01 02 FF FF 00 6C 9B 7E 0A A4 9D
2014/02/22 13:18:44 776045F8 40 66 49 1C 74 7E 00 00 90 8D C0 02 CB 07 87 CA
2014/02/22 13:18:44 776045F8 08 75 D3 50 CD C8 5E 9C 44 50 8A D2 93 7F 5F 2C
2014/02/22 13:18:44 776045F8 9F 24 C6 4C 88 2D 3C A3 EB A3 4B 52 0A 02 2D 39
2014/02/22 13:18:44 776045F8 AB 55 25 44 1E C6 16 D3 CF A6 85 5C E2 8A B1 89
2014/02/22 13:18:44 776045F8 57 97 F6 78 E5 7C CF 64 7A DD EC C4 35 00 A9 4B
2014/02/22 13:18:44 776045F8 22 35 C4 F2 B6 C9 D3 C1 D5 DD 34 10 3A CF 3C E3
2014/02/22 13:18:44 776045F8 88 77 D0 46 F0 CD 3E 7C B1 49 F0 28 6C 7B 1C F8
2014/02/22 13:18:44 776045F8 20 41 35 4F EC 3E 91 5B 83 D4 5E E5 CF 84 16 E6
2014/02/22 13:18:44 776045F8 D3 FC D3 72 67 55 CC 3D CD 75 9A CD 94 6C F1 E2
2014/02/22 13:18:44 776045F8 11 A2 22 94 EC 42 E7
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 ECMTYPE 80 CAID 093B PROVID 000000 ECMPID 06AD FAKECHID 0594 (unique part in ecm)
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to ODD (CAID 093B PROVID 000000 FD 17)
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set chid to 0594 on fd 17
2014/02/22 13:18:44 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] NEW REQUEST!
2014/02/22 13:18:44 776045F8 c trying reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:44 776045F8 c 093B:000000 allowed by reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:44 776045F8 c [GET_CW] wait_time 0 caid 093B prov 000000 srvid 0594 rc 100 cacheex cl mode 0 ex1rdr 0
2014/02/22 13:18:44 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/02/22 13:18:44 776045F8 c request_cw stage=2 to reader Sky_Italia ecm hash=EF2CD681D3E6F4339DF01280FD847910
2014/02/22 13:18:44 776045F8 c start reader thread action 5
2014/02/22 13:18:44 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_request] reader Sky_Italia --> SENT 1
2014/02/22 13:18:44 776045F8 c Client DM-7020HD ECM dump 093B&000000/0594/0594/B7:EF2CD681D3E6F4339DF01280FD847910
2014/02/22 13:18:44 776045F8 80 70 B4 00 00 01 14 CD 16 62 51 05 94 AA 55 81
2014/02/22 13:18:44 776045F8 21 84 01 00 01 01 02 FF FF 00 6C 9B 7E 0A A4 9D
2014/02/22 13:18:44 776045F8 40 66 49 1C 74 7E 00 00 90 8D C0 02 CB 07 87 CA
2014/02/22 13:18:44 776045F8 08 75 D3 50 CD C8 5E 9C 44 50 8A D2 93 7F 5F 2C
2014/02/22 13:18:44 776045F8 9F 24 C6 4C 88 2D 3C A3 EB A3 4B 52 0A 02 2D 39
2014/02/22 13:18:44 776045F8 AB 55 25 44 1E C6 16 D3 CF A6 85 5C E2 8A B1 89
2014/02/22 13:18:44 776045F8 57 97 F6 78 E5 7C CF 64 7A DD EC C4 35 00 A9 4B
2014/02/22 13:18:44 776045F8 22 35 C4 F2 B6 C9 D3 C1 D5 DD 34 10 3A CF 3C E3
2014/02/22 13:18:44 776045F8 88 77 D0 46 F0 CD 3E 7C B1 49 F0 28 6C 7B 1C F8
2014/02/22 13:18:44 776045F8 20 41 35 4F EC 3E 91 5B 83 D4 5E E5 CF 84 16 E6
2014/02/22 13:18:44 776045F8 D3 FC D3 72 67 55 CC 3D CD 75 9A CD 94 6C F1 E2
2014/02/22 13:18:44 776045F8 11 A2 22 94 EC 42 E7
2014/02/22 13:18:44 776004F8 r data from add_job action=5 client r Sky_Italia
2014/02/22 13:18:44 776004F8 r ecm:
2014/02/22 13:18:44 776004F8 80 70 B4 00 00 01 14 CD 16 62 51 05 94 AA 55 81
2014/02/22 13:18:44 776004F8 21 84 01 00 01 01 02 FF FF 00 6C 9B 7E 0A A4 9D
2014/02/22 13:18:44 776004F8 40 66 49 1C 74 7E 00 00 90 8D C0 02 CB 07 87 CA
2014/02/22 13:18:44 776004F8 08 75 D3 50 CD C8 5E 9C 44 50 8A D2 93 7F 5F 2C
2014/02/22 13:18:44 776004F8 9F 24 C6 4C 88 2D 3C A3 EB A3 4B 52 0A 02 2D 39
2014/02/22 13:18:44 776004F8 AB 55 25 44 1E C6 16 D3 CF A6 85 5C E2 8A B1 89
2014/02/22 13:18:44 776004F8 57 97 F6 78 E5 7C CF 64 7A DD EC C4 35 00 A9 4B
2014/02/22 13:18:44 776004F8 22 35 C4 F2 B6 C9 D3 C1 D5 DD 34 10 3A CF 3C E3
2014/02/22 13:18:44 776004F8 88 77 D0 46 F0 CD 3E 7C B1 49 F0 28 6C 7B 1C F8
2014/02/22 13:18:44 776004F8 20 41 35 4F EC 3E 91 5B 83 D4 5E E5 CF 84 16 E6
2014/02/22 13:18:44 776004F8 D3 FC D3 72 67 55 CC 3D CD 75 9A CD 94 6C F1 E2
2014/02/22 13:18:44 776004F8 11 A2 22 94 EC 42 E7
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 request cw for ecm 093B&000000/0594/0594/B7:EF2CD681D3E6F4339DF01280FD847910
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:44 776004F8 D1 40 00 80 9C 00 7E 0A A4 9D 40 66 49 1C 74 7E
2014/02/22 13:18:44 776004F8 00 00 90 8D C0 02 CB 07 87 CA 08 75 D3 50 CD C8
2014/02/22 13:18:44 776004F8 5E 9C 44 50 8A D2 93 7F 5F 2C 9F 24 C6 4C 88 2D
2014/02/22 13:18:44 776004F8 3C A3 EB A3 4B 52 0A 02 2D 39 AB 55 25 44 1E C6
2014/02/22 13:18:44 776004F8 16 D3 CF A6 85 5C E2 8A B1 89 57 97 F6 78 E5 7C
2014/02/22 13:18:44 776004F8 CF 64 7A DD EC C4 35 00 A9 4B 22 35 C4 F2 B6 C9
2014/02/22 13:18:44 776004F8 D3 C1 D5 DD 34 10 3A CF 3C E3 88 77 D0 46 F0 CD
2014/02/22 13:18:44 776004F8 3E 7C B1 49 F0 28 6C 7B 1C F8 20 41 35 4F EC 3E
2014/02/22 13:18:44 776004F8 91 5B 83 D4 5E E5 CF 84 16 E6 D3 FC D3 72 67 55
2014/02/22 13:18:44 776004F8 CC 3D CD 75 9A CD 94 6C F1 E2 11 A2 22 94 EC 42
2014/02/22 13:18:44 776004F8 E7
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:44 776004F8 D1 40 00 80 9C
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:44 776004F8 D1 40 00 80 9C
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 40
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 156 bytes, expected len 2 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:44 776004F8 00 7E 0A A4 9D 40 66 49 1C 74 7E 00 00 90 8D C0
2014/02/22 13:18:44 776004F8 02 CB 07 87 CA 08 75 D3 50 CD C8 5E 9C 44 50 8A
2014/02/22 13:18:44 776004F8 D2 93 7F 5F 2C 9F 24 C6 4C 88 2D 3C A3 EB A3 4B
2014/02/22 13:18:44 776004F8 52 0A 02 2D 39 AB 55 25 44 1E C6 16 D3 CF A6 85
2014/02/22 13:18:44 776004F8 5C E2 8A B1 89 57 97 F6 78 E5 7C CF 64 7A DD EC
2014/02/22 13:18:44 776004F8 C4 35 00 A9 4B 22 35 C4 F2 B6 C9 D3 C1 D5 DD 34
2014/02/22 13:18:44 776004F8 10 3A CF 3C E3 88 77 D0 46 F0 CD 3E 7C B1 49 F0
2014/02/22 13:18:44 776004F8 28 6C 7B 1C F8 20 41 35 4F EC 3E 91 5B 83 D4 5E
2014/02/22 13:18:44 776004F8 E5 CF 84 16 E6 D3 FC D3 72 67 55 CC 3D CD 75 9A
2014/02/22 13:18:44 776004F8 CD 94 6C F1 E2 11 A2 22 94 EC 42 E7
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 156 char(s), chunksize 156 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:44 776004F8 00 7E 0A A4 9D 40 66 49 1C 74 7E 00 00 90 8D C0
2014/02/22 13:18:44 776004F8 02 CB 07 87 CA 08 75 D3 50 CD C8 5E 9C 44 50 8A
2014/02/22 13:18:44 776004F8 D2 93 7F 5F 2C 9F 24 C6 4C 88 2D 3C A3 EB A3 4B
2014/02/22 13:18:44 776004F8 52 0A 02 2D 39 AB 55 25 44 1E C6 16 D3 CF A6 85
2014/02/22 13:18:44 776004F8 5C E2 8A B1 89 57 97 F6 78 E5 7C CF 64 7A DD EC
2014/02/22 13:18:44 776004F8 C4 35 00 A9 4B 22 35 C4 F2 B6 C9 D3 C1 D5 DD 34
2014/02/22 13:18:44 776004F8 10 3A CF 3C E3 88 77 D0 46 F0 CD 3E 7C B1 49 F0
2014/02/22 13:18:44 776004F8 28 6C 7B 1C F8 20 41 35 4F EC 3E 91 5B 83 D4 5E
2014/02/22 13:18:44 776004F8 E5 CF 84 16 E6 D3 FC D3 72 67 55 CC 3D CD 75 9A
2014/02/22 13:18:44 776004F8 CD 94 6C F1 E2 11 A2 22 94 EC 42 E7
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:44 C176C8 h all debug_level=65535
2014/02/22 13:18:44 C176C8 h WebIf: Origin checked. Result: access from 192.168.2.101 => allowed
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 90
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:44 776004F8 90 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:44 776004F8 D3 54 00 00 59
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 92 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:44 776004F8 D3 54 00 00 59
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:44 776004F8 D3 54 00 00 59
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 54
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 89 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 89 char(s), chunksize 89 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 BF 19 CE 33 39 96 38 09 CC 4C 37 16 90 73 A3 20
2014/02/22 13:18:44 776004F8 F1 74 52 28 DA C9 A8 E0 7C 37 2A FD 6F 74 76 9E
2014/02/22 13:18:44 776004F8 32 06 76 6B 6F BC A9 9A 40 EA D4 4C DA 27 3D 0E
2014/02/22 13:18:44 776004F8 97 90 94 C6 89 24 EC BB CE 8B CC 2F 25 15 FD 7B
2014/02/22 13:18:44 776004F8 8A F5 7C AE E4 74 79 07 8E 2C 60 7B 4E 6D 81 23
2014/02/22 13:18:44 776004F8 CB C5 A8 F6 B9 46 06 52 B0
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 90
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:44 776004F8 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:44 776004F8 BF 19 CE 33 39 96 38 09 CC 4C 37 16 90 73 A3 20
2014/02/22 13:18:44 776004F8 F1 74 52 28 DA C9 A8 E0 7C 37 2A FD 6F 74 76 9E
2014/02/22 13:18:44 776004F8 32 06 76 6B 6F BC A9 9A 40 EA D4 4C DA 27 3D 0E
2014/02/22 13:18:44 776004F8 97 90 94 C6 89 24 EC BB CE 8B CC 2F 25 15 FD 7B
2014/02/22 13:18:44 776004F8 8A F5 7C AE E4 74 79 07 8E 2C 60 7B 4E 6D 81 23
2014/02/22 13:18:44 776004F8 CB C5 A8 F6 B9 46 06 52 B0 90 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] INS54:
2014/02/22 13:18:44 776004F8 D3 54 00 00 49
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] Decrypted payload
2014/02/22 13:18:44 776004F8 85 08 32 BF FA 1C 7B 91 AA 55 00 00 FF 03 22 02
2014/02/22 13:18:44 776004F8 C0 00 0E 02 80 00 0F 05 02 20 00 00 00 20 04 00
2014/02/22 13:18:44 776004F8 00 00 00 25 11 00 00 00 00 00 00 00 00 00 00 00
2014/02/22 13:18:44 776004F8 00 00 00 00 00 00 2A 04 00 00 00 00 55 01 80 56
2014/02/22 13:18:44 776004F8 08 00 00 00 00 00 00 00 00
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: after csystem.do_ecm rc=1
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: ret rc=1
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2014/02/22 13:18:44 776004F8 r {client DM-7020HD, caid 093B, srvid 0594} [write_ecm_answer] cyclecheck passed! Reader: Sky_Italia rc: 0
2014/02/22 13:18:44 776004F8 r {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_answer] reader Sky_Italia rc 0, ecm time 118 ms (119 ms)
2014/02/22 13:18:44 776004F8 r start client thread action 32
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] TRACE: ecm answer for ecm hash EF2CD681D3E6F4339DF01280FD847910 rc=0
2014/02/22 13:18:44 776004F8 r Sky_Italia [videoguard2] ecm hash: EF2CD681D3E6F4339DF01280FD847910 real time: 112 ms
2014/02/22 13:18:44 776045F8 c data from add_job action=32 client c DM-7020HD
2014/02/22 13:18:44 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [send_dcw] rc 0 from reader Sky_Italia
2014/02/22 13:18:44 776045F8 c Client DM-7020HD csphash E550FC14 cw 850832BFFA1C7B910000000000000000 rc 0 093B&000000/0594/0594/B7:EF2CD681D3E6F4339DF01280FD847910
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 controlword received for PID #1 CAID 093B PROVID 000000 ECMPID 06AD CHID 0594 VPID 00A8
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 requested controlword for ecm EF2CD681D3E6F4339DF01280FD847910 on fd 17
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 writing odd part (850832BFFA1C7B91) of controlword, replacing expired (5CB523347EB68DC1)
2014/02/22 13:18:44 776045F8 c [DVBAPI] Demuxer #0 write cw0 index: 0 (ca3)
2014/02/22 13:18:44 776045F8 c DM-7020HD (093B&000000/0594/0594/B7:EF2CD681D3E6F4339DF01280FD847910): found (122 ms) by Sky_Italia - MTV Music
2014/02/22 13:18:44 776045F8 c cw:
2014/02/22 13:18:44 776045F8 85 08 32 BF FA 1C 7B 91 00 00 00 00 00 00 00 00
2014/02/22 13:18:45 C176C8 h WebIf: Origin checked. Result: access from 192.168.2.101 => allowed
2014/02/22 13:18:45 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:45 C176C8 h WebIf: Origin checked. Result: access from 192.168.2.101 => allowed
2014/02/22 13:18:46 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:46 C176C8 h WebIf: Origin checked. Result: access from 192.168.2.101 => allowed
2014/02/22 13:18:47 0 --- Skipped 2 duplicated log lines ---
2014/02/22 13:18:47 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:49 0 --- Skipped 2 duplicated log lines ---
2014/02/22 13:18:49 0 start client thread action 31
2014/02/22 13:18:49 776045F8 c data from add_job action=31 client c DM-7020HD
2014/02/22 13:18:50 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:52 0 --- Skipped 2 duplicated log lines ---
2014/02/22 13:18:52 776045F8 c [DVBAPI] Demuxer #0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2014/02/22 13:18:52 776045F8 c DEVICE open (/dev/dvb/adapter0/demux3) fd 20
2014/02/22 13:18:52 776045F8 c [DVBAPI] Demuxer #0 Filter #2 started succesfully (caid 0001 provid 000001 pid 0001)
2014/02/22 13:18:52 776045F8 c [DVBAPI] Demuxer #0 has 3 ecmpids, 2 streampids, 1 ecmfilters and 1 emmfilters
2014/02/22 13:18:52 776045F8 c [DVBAPI] new events occurred on 1 of 4 handlers after 8239 ms inactivity
2014/02/22 13:18:52 776045F8 c [DVBAPI] now handling fd 20 that reported event 3
2014/02/22 13:18:52 776045F8 c [DVBAPI] Readed:
2014/02/22 13:18:52 776045F8 01 B0 1B FF FF C1 00 00 09 04 09 19 E1 2D 09 04
2014/02/22 13:18:52 776045F8 09 3B E1 2D 09 04 09 CD E1 2D 16 A6 5C 67
2014/02/22 13:18:52 776045F8 c receiving cat
2014/02/22 13:18:52 776045F8 c cat:
2014/02/22 13:18:52 776045F8 01 B0 1B FF FF C1 00 00 09 04 09 19 E1 2D 09 04
2014/02/22 13:18:52 776045F8 09 3B E1 2D 09 04 09 CD E1 2D 16 A6 5C 67
2014/02/22 13:18:52 776045F8 c Reader Sky_S02 au disabled or not enabled-> skip!
2014/02/22 13:18:52 776045F8 c Reader SRG_Millenium au disabled or not enabled-> skip!
2014/02/22 13:18:52 776045F8 c Reader ORF_Cerebro au disabled or not enabled-> skip!
2014/02/22 13:18:52 776045F8 c Reader Canal_Digitaal au disabled or not enabled-> skip!
2014/02/22 13:18:52 776045F8 c Reader MTV_Unlimited au disabled or not enabled-> skip!
2014/02/22 13:18:52 776045F8 c Reader Sky_Italia au disabled or not enabled-> skip!
2014/02/22 13:18:52 776045F8 c [DVBAPI] Demuxer #0 stop Filter #2 (fd: 20 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2014/02/22 13:18:52 776045F8 c [DVBAPI] Demuxer #0 has 3 ecmpids, 2 streampids, 1 ecmfilters and 0 emmfilters
2014/02/22 13:18:53 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:54 0 --- Skipped 1 duplicated log lines ---
2014/02/22 13:18:54 C176C8 h WebIf: Origin checked. Result: access from 192.168.2.101 => allowed
2014/02/22 13:18:54 776045F8 c [DVBAPI] new events occurred on 1 of 3 handlers after 1751 ms inactivity
2014/02/22 13:18:54 776045F8 c [DVBAPI] now handling fd 17 that reported event 3
2014/02/22 13:18:54 776045F8 c [DVBAPI] Readed:
2014/02/22 13:18:54 776045F8 81 70 B4 00 00 01 14 CD 16 62 56 05 94 AA 55 81
2014/02/22 13:18:54 776045F8 21 84 01 00 01 01 02 FF FF 00 71 9B 7E 0A 4D 98
2014/02/22 13:18:54 776045F8 5C 6D A2 63 0D B2 00 00 90 8D C0 02 F7 D0 6A D4
2014/02/22 13:18:54 776045F8 2E 94 8E 34 65 C5 5C E8 D6 91 5E B1 6F 5C 9E 50
2014/02/22 13:18:54 776045F8 14 B3 6E E2 7C 08 4B 14 01 41 D4 A8 60 5E 31 8F
2014/02/22 13:18:54 776045F8 1D FD 2C 81 9F 92 01 80 5C D1 BE C0 CE 84 2C B0
2014/02/22 13:18:54 776045F8 67 EB B7 A2 F5 1B 99 05 CB BB 86 68 2A 89 3A A1
2014/02/22 13:18:54 776045F8 01 3E 85 45 3D AD 8C 26 9A 8B 3C 58 7A DB D1 42
2014/02/22 13:18:54 776045F8 5F DB 7F EB E5 CE 9B 7F 02 25 F8 14 E8 A7 D0 19
2014/02/22 13:18:54 776045F8 2C 9B 9B 90 E1 9E 4E 78 39 A2 2F 07 38 29 10 0D
2014/02/22 13:18:54 776045F8 48 8E 20 87 8C 46 99 47 4B 52 2D EE 34 A8 61 49
2014/02/22 13:18:54 776045F8 26 AB 7D 64 41 DE 9B
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 ECMTYPE 81 CAID 093B PROVID 000000 ECMPID 06AD FAKECHID 0594 (unique part in ecm)
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to EVEN (CAID 093B PROVID 000000 FD 17)
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 Filter #1 set chid to 0594 on fd 17
2014/02/22 13:18:54 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] NEW REQUEST!
2014/02/22 13:18:54 776045F8 c trying reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:54 776045F8 c 093B:000000 allowed by reader 'Sky_Italia' filter 093B:000000
2014/02/22 13:18:54 776045F8 c [GET_CW] wait_time 0 caid 093B prov 000000 srvid 0594 rc 100 cacheex cl mode 0 ex1rdr 0
2014/02/22 13:18:54 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/02/22 13:18:54 776045F8 c request_cw stage=2 to reader Sky_Italia ecm hash=FB8859FBC1A09903E147D2CDD0203502
2014/02/22 13:18:54 776045F8 c start reader thread action 5
2014/02/22 13:18:54 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_request] reader Sky_Italia --> SENT 1
2014/02/22 13:18:54 776045F8 c Client DM-7020HD ECM dump 093B&000000/0594/0594/B7:FB8859FBC1A09903E147D2CDD0203502
2014/02/22 13:18:54 776045F8 81 70 B4 00 00 01 14 CD 16 62 56 05 94 AA 55 81
2014/02/22 13:18:54 776045F8 21 84 01 00 01 01 02 FF FF 00 71 9B 7E 0A 4D 98
2014/02/22 13:18:54 776045F8 5C 6D A2 63 0D B2 00 00 90 8D C0 02 F7 D0 6A D4
2014/02/22 13:18:54 776045F8 2E 94 8E 34 65 C5 5C E8 D6 91 5E B1 6F 5C 9E 50
2014/02/22 13:18:54 776045F8 14 B3 6E E2 7C 08 4B 14 01 41 D4 A8 60 5E 31 8F
2014/02/22 13:18:54 776045F8 1D FD 2C 81 9F 92 01 80 5C D1 BE C0 CE 84 2C B0
2014/02/22 13:18:54 776045F8 67 EB B7 A2 F5 1B 99 05 CB BB 86 68 2A 89 3A A1
2014/02/22 13:18:54 776045F8 01 3E 85 45 3D AD 8C 26 9A 8B 3C 58 7A DB D1 42
2014/02/22 13:18:54 776045F8 5F DB 7F EB E5 CE 9B 7F 02 25 F8 14 E8 A7 D0 19
2014/02/22 13:18:54 776045F8 2C 9B 9B 90 E1 9E 4E 78 39 A2 2F 07 38 29 10 0D
2014/02/22 13:18:54 776045F8 48 8E 20 87 8C 46 99 47 4B 52 2D EE 34 A8 61 49
2014/02/22 13:18:54 776045F8 26 AB 7D 64 41 DE 9B
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 request cw for ecm 093B&000000/0594/0594/B7:FB8859FBC1A09903E147D2CDD0203502
2014/02/22 13:18:54 776004F8 r data from add_job action=5 client r Sky_Italia
2014/02/22 13:18:54 776004F8 r ecm:
2014/02/22 13:18:54 776004F8 81 70 B4 00 00 01 14 CD 16 62 56 05 94 AA 55 81
2014/02/22 13:18:54 776004F8 21 84 01 00 01 01 02 FF FF 00 71 9B 7E 0A 4D 98
2014/02/22 13:18:54 776004F8 5C 6D A2 63 0D B2 00 00 90 8D C0 02 F7 D0 6A D4
2014/02/22 13:18:54 776004F8 2E 94 8E 34 65 C5 5C E8 D6 91 5E B1 6F 5C 9E 50
2014/02/22 13:18:54 776004F8 14 B3 6E E2 7C 08 4B 14 01 41 D4 A8 60 5E 31 8F
2014/02/22 13:18:54 776004F8 1D FD 2C 81 9F 92 01 80 5C D1 BE C0 CE 84 2C B0
2014/02/22 13:18:54 776004F8 67 EB B7 A2 F5 1B 99 05 CB BB 86 68 2A 89 3A A1
2014/02/22 13:18:54 776004F8 01 3E 85 45 3D AD 8C 26 9A 8B 3C 58 7A DB D1 42
2014/02/22 13:18:54 776004F8 5F DB 7F EB E5 CE 9B 7F 02 25 F8 14 E8 A7 D0 19
2014/02/22 13:18:54 776004F8 2C 9B 9B 90 E1 9E 4E 78 39 A2 2F 07 38 29 10 0D
2014/02/22 13:18:54 776004F8 48 8E 20 87 8C 46 99 47 4B 52 2D EE 34 A8 61 49
2014/02/22 13:18:54 776004F8 26 AB 7D 64 41 DE 9B
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:54 776004F8 D1 40 00 80 9C 00 7E 0A 4D 98 5C 6D A2 63 0D B2
2014/02/22 13:18:54 776004F8 00 00 90 8D C0 02 F7 D0 6A D4 2E 94 8E 34 65 C5
2014/02/22 13:18:54 776004F8 5C E8 D6 91 5E B1 6F 5C 9E 50 14 B3 6E E2 7C 08
2014/02/22 13:18:54 776004F8 4B 14 01 41 D4 A8 60 5E 31 8F 1D FD 2C 81 9F 92
2014/02/22 13:18:54 776004F8 01 80 5C D1 BE C0 CE 84 2C B0 67 EB B7 A2 F5 1B
2014/02/22 13:18:54 776004F8 99 05 CB BB 86 68 2A 89 3A A1 01 3E 85 45 3D AD
2014/02/22 13:18:54 776004F8 8C 26 9A 8B 3C 58 7A DB D1 42 5F DB 7F EB E5 CE
2014/02/22 13:18:54 776004F8 9B 7F 02 25 F8 14 E8 A7 D0 19 2C 9B 9B 90 E1 9E
2014/02/22 13:18:54 776004F8 4E 78 39 A2 2F 07 38 29 10 0D 48 8E 20 87 8C 46
2014/02/22 13:18:54 776004F8 99 47 4B 52 2D EE 34 A8 61 49 26 AB 7D 64 41 DE
2014/02/22 13:18:54 776004F8 9B
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:54 776004F8 D1 40 00 80 9C
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:54 776004F8 D1 40 00 80 9C
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 40
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 156 bytes, expected len 2 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:54 776004F8 00 7E 0A 4D 98 5C 6D A2 63 0D B2 00 00 90 8D C0
2014/02/22 13:18:54 776004F8 02 F7 D0 6A D4 2E 94 8E 34 65 C5 5C E8 D6 91 5E
2014/02/22 13:18:54 776004F8 B1 6F 5C 9E 50 14 B3 6E E2 7C 08 4B 14 01 41 D4
2014/02/22 13:18:54 776004F8 A8 60 5E 31 8F 1D FD 2C 81 9F 92 01 80 5C D1 BE
2014/02/22 13:18:54 776004F8 C0 CE 84 2C B0 67 EB B7 A2 F5 1B 99 05 CB BB 86
2014/02/22 13:18:54 776004F8 68 2A 89 3A A1 01 3E 85 45 3D AD 8C 26 9A 8B 3C
2014/02/22 13:18:54 776004F8 58 7A DB D1 42 5F DB 7F EB E5 CE 9B 7F 02 25 F8
2014/02/22 13:18:54 776004F8 14 E8 A7 D0 19 2C 9B 9B 90 E1 9E 4E 78 39 A2 2F
2014/02/22 13:18:54 776004F8 07 38 29 10 0D 48 8E 20 87 8C 46 99 47 4B 52 2D
2014/02/22 13:18:54 776004F8 EE 34 A8 61 49 26 AB 7D 64 41 DE 9B
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 156 char(s), chunksize 156 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:54 776004F8 00 7E 0A 4D 98 5C 6D A2 63 0D B2 00 00 90 8D C0
2014/02/22 13:18:54 776004F8 02 F7 D0 6A D4 2E 94 8E 34 65 C5 5C E8 D6 91 5E
2014/02/22 13:18:54 776004F8 B1 6F 5C 9E 50 14 B3 6E E2 7C 08 4B 14 01 41 D4
2014/02/22 13:18:54 776004F8 A8 60 5E 31 8F 1D FD 2C 81 9F 92 01 80 5C D1 BE
2014/02/22 13:18:54 776004F8 C0 CE 84 2C B0 67 EB B7 A2 F5 1B 99 05 CB BB 86
2014/02/22 13:18:54 776004F8 68 2A 89 3A A1 01 3E 85 45 3D AD 8C 26 9A 8B 3C
2014/02/22 13:18:54 776004F8 58 7A DB D1 42 5F DB 7F EB E5 CE 9B 7F 02 25 F8
2014/02/22 13:18:54 776004F8 14 E8 A7 D0 19 2C 9B 9B 90 E1 9E 4E 78 39 A2 2F
2014/02/22 13:18:54 776004F8 07 38 29 10 0D 48 8E 20 87 8C 46 99 47 4B 52 2D
2014/02/22 13:18:54 776004F8 EE 34 A8 61 49 26 AB 7D 64 41 DE 9B
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 90
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:54 776004F8 90 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] write to cardreader
2014/02/22 13:18:54 776004F8 D3 54 00 00 59
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 14 ETU (243 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit size 5 bytes, expected len 92 bytes, delay 0 us, timeout=243 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit:
2014/02/22 13:18:54 776004F8 D3 54 00 00 59
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Write timeout 243 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Sending:
2014/02/22 13:18:54 776004F8 D3 54 00 00 59
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Transmit succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 54
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 89 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 89 char(s), chunksize 89 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 02 C8 6E 1C 96 5C 13 7F B8 E5 11 6A F4 53 06 48
2014/02/22 13:18:54 776004F8 E5 3C B7 77 F7 A7 03 C2 CD 9E 66 43 6B 86 88 2A
2014/02/22 13:18:54 776004F8 5E 1B F6 97 98 A6 1A F3 E3 5C C2 FA 8E B2 48 6B
2014/02/22 13:18:54 776004F8 DD CB CD 8B B8 C8 97 5F 88 11 41 C9 88 5B E5 D3
2014/02/22 13:18:54 776004F8 AA 03 83 0D 68 04 08 B5 A0 FB 15 59 E5 F8 FD 6B
2014/02/22 13:18:54 776004F8 07 C9 F5 28 B1 7F C4 78 5F
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 90
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] TRACE: SW1: 90
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Setting timeout to 57600 ETU (1003146 us)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=1003146 us
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Read timeout 1003146 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IO: Receiving:
2014/02/22 13:18:54 776004F8 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] IFD: Receive succesful
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] TRACE: SW2: 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] Answer from cardreader:
2014/02/22 13:18:54 776004F8 02 C8 6E 1C 96 5C 13 7F B8 E5 11 6A F4 53 06 48
2014/02/22 13:18:54 776004F8 E5 3C B7 77 F7 A7 03 C2 CD 9E 66 43 6B 86 88 2A
2014/02/22 13:18:54 776004F8 5E 1B F6 97 98 A6 1A F3 E3 5C C2 FA 8E B2 48 6B
2014/02/22 13:18:54 776004F8 DD CB CD 8B B8 C8 97 5F 88 11 41 C9 88 5B E5 D3
2014/02/22 13:18:54 776004F8 AA 03 83 0D 68 04 08 B5 A0 FB 15 59 E5 F8 FD 6B
2014/02/22 13:18:54 776004F8 07 C9 F5 28 B1 7F C4 78 5F 90 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] INS54:
2014/02/22 13:18:54 776004F8 D3 54 00 00 49
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] Decrypted payload
2014/02/22 13:18:54 776004F8 6B 2A BC 51 8C 73 57 56 AA 55 00 00 FF 03 22 02
2014/02/22 13:18:54 776004F8 C0 00 0E 02 80 00 0F 05 02 20 00 00 00 20 04 00
2014/02/22 13:18:54 776004F8 00 00 00 25 11 00 00 00 00 00 00 00 00 00 00 00
2014/02/22 13:18:54 776004F8 00 00 00 00 00 00 2A 04 00 00 00 00 55 01 80 56
2014/02/22 13:18:54 776004F8 08 00 00 00 00 00 00 00 00
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: after csystem.do_ecm rc=1
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] cardreader_do_ecm: ret rc=1
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2014/02/22 13:18:54 776004F8 r {client DM-7020HD, caid 093B, srvid 0594} [write_ecm_answer] cyclecheck passed! Reader: Sky_Italia rc: 0
2014/02/22 13:18:54 776004F8 r {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [write_ecm_answer] reader Sky_Italia rc 0, ecm time 118 ms (120 ms)
2014/02/22 13:18:54 776004F8 r start client thread action 32
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] TRACE: ecm answer for ecm hash FB8859FBC1A09903E147D2CDD0203502 rc=0
2014/02/22 13:18:54 776004F8 r Sky_Italia [videoguard2] ecm hash: FB8859FBC1A09903E147D2CDD0203502 real time: 114 ms
2014/02/22 13:18:54 776045F8 c data from add_job action=32 client c DM-7020HD
2014/02/22 13:18:54 776045F8 c {client DM-7020HD, caid 093B, prid 000000, srvid 0594} [send_dcw] rc 0 from reader Sky_Italia
2014/02/22 13:18:54 776045F8 c Client DM-7020HD csphash 9E0CED82 cw 00000000000000006B2ABC518C735756 rc 0 093B&000000/0594/0594/B7:FB8859FBC1A09903E147D2CDD0203502
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 controlword received for PID #1 CAID 093B PROVID 000000 ECMPID 06AD CHID 0594 VPID 00A8
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 requested controlword for ecm FB8859FBC1A09903E147D2CDD0203502 on fd 17
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 writing even part (6B2ABC518C735756) of controlword, replacing expired (F0E5C89DBE2D2D18)
2014/02/22 13:18:54 776045F8 c [DVBAPI] Demuxer #0 write cw1 index: 0 (ca3)
2014/02/22 13:18:54 776045F8 c DM-7020HD (093B&000000/0594/0594/B7:FB8859FBC1A09903E147D2CDD0203502): found (123 ms) by Sky_Italia - MTV Music
2014/02/22 13:18:54 776045F8 c cw:
2014/02/22 13:18:54 776045F8 00 00 00 00 00 00 00 00 6B 2A BC 51 8C 73 57 56