Hallo zusammen,
wie wäre es einen Thread mit den logs der 1856er?
zusammen können eventuell einen kleinen schritt in der richtige richtung gehen.
Gruß
M.
wie wäre es einen Thread mit den logs der 1856er?
zusammen können eventuell einen kleinen schritt in der richtige richtung gehen.
2023/01/04 17:36:12 7CA9760D r (reader) Tivu_1856 [nagra merlin] creating thread for device dev/sci1
2023/01/04 17:36:12 38B4972C r (reader) Tivu_1856 [nagra merlin] Reader initialized (device=dev/sci1, detect=cd, mhz=500, cardmhz=357)
2023/01/04 17:36:12 38B4972C r (reader) Tivu_1856 [nagra merlin] Reader sci internal, detected box type: gigablue
2023/01/04 17:36:13 38B4972C r (reader) Tivu_1856 [nagra merlin] card detected
2023/01/04 17:36:14 38B4972C r (reader) Tivu_1856 [internal] ATR: xx xx xx
2023/01/04 17:36:16 2529A6D2 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2023/01/04 17:36:19 38B4972C r (reader) Tivu_1856 [internal] detected card in CAK7 mode
2023/01/04 17:36:19 38B4972C r (reader) Tivu_1856 [internal] Initial AES: B7 96 0F 25 9B 6B 9B 5B 2F CB 16 9B 1F 77 31 0D
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Rom revision: DNASP450 RevW60
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Card has DT05_00
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] DT05_00 is correct
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Card has DT05_10
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] using CMD02
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] card needs FASTreinit after 36863 CMDs
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] DT05_10 is correct
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Card is starting in GLOBAL mode
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [internal] New AES: 0F 3E DD 76 71 AE 78 C3 AD 5F 97 71 D9 37 0E D1
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [internal] ready for requests
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [internal] found card system nagra merlin
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max allotted of 1
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] ROM: D N A S P 4 5 0
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] REV: R e v W 6 0
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] SER: ############
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] CAID: 187E
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] Prv.ID: 00 00 54 11 (sysid)
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |id |tier |valid from |valid to |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] +----+--------+------------+------------+
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:21 2529A6D2 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] Prv.ID: 00 00 00 00
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] Prv.ID: 00 00 54 12
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] | EMM Filters (PRIVATE!!) |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] +---------------------------------------+
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm82 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm84 : 84 00 EC |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm83U: 83 45 6F 41 81 00 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm83S: 83 45 6F 41 00 10 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm87 : 87 45 6F 41 81 00 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:12 38B4972C r (reader) Tivu_1856 [nagra merlin] Reader initialized (device=dev/sci1, detect=cd, mhz=500, cardmhz=357)
2023/01/04 17:36:12 38B4972C r (reader) Tivu_1856 [nagra merlin] Reader sci internal, detected box type: gigablue
2023/01/04 17:36:13 38B4972C r (reader) Tivu_1856 [nagra merlin] card detected
2023/01/04 17:36:14 38B4972C r (reader) Tivu_1856 [internal] ATR: xx xx xx
2023/01/04 17:36:16 2529A6D2 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2023/01/04 17:36:19 38B4972C r (reader) Tivu_1856 [internal] detected card in CAK7 mode
2023/01/04 17:36:19 38B4972C r (reader) Tivu_1856 [internal] Initial AES: B7 96 0F 25 9B 6B 9B 5B 2F CB 16 9B 1F 77 31 0D
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Rom revision: DNASP450 RevW60
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Card has DT05_00
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] DT05_00 is correct
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Card has DT05_10
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] using CMD02
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] card needs FASTreinit after 36863 CMDs
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] DT05_10 is correct
2023/01/04 17:36:20 38B4972C r (reader) Tivu_1856 [internal] Card is starting in GLOBAL mode
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [internal] New AES: 0F 3E DD 76 71 AE 78 C3 AD 5F 97 71 D9 37 0E D1
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [internal] ready for requests
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [internal] found card system nagra merlin
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max allotted of 1
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] ROM: D N A S P 4 5 0
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] REV: R e v W 6 0
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] SER: ############
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] CAID: 187E
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] Prv.ID: 00 00 54 11 (sysid)
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |id |tier |valid from |valid to |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] +----+--------+------------+------------+
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:21 2529A6D2 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] Prv.ID: 00 00 00 00
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] Prv.ID: 00 00 54 12
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] | EMM Filters (PRIVATE!!) |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] +---------------------------------------+
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm82 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm84 : 84 00 EC |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm83U: 83 45 6F 41 81 00 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm83S: 83 45 6F 41 00 10 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] |emm87 : 87 45 6F 41 81 00 |
2023/01/04 17:36:21 38B4972C r (reader) Tivu_1856 [nagra merlin] -----------------------------------------
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] NEW REQUEST!
2023/01/04 17:38:40 2529A6D2 c (ecm) [GET_CW] wait_time 0 caid 1856 prov 000000 srvid 007A rc 100 cacheex cl mode 0 ex1rdr 0
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0, preferlocalcards 2
2023/01/04 17:38:40 2529A6D2 c (ecm) request_cw stage=2 to reader Tivu_1856 ecm hash=6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 2529A6D2 c (work) start reader thread action 5
2023/01/04 17:38:40 2529A6D2 c (main) starting thread client work
2023/01/04 17:38:40 2529A6D2 c (main) client work thread started
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_request] reader Tivu_1856 --> SENT 1
2023/01/04 17:38:40 2529A6D2 c (ecm) Client dvbapi ECM dump 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 2529A6D2 c (ecm) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:40 2529A6D2 c (ecm) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:40 2529A6D2 c (ecm) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:40 2529A6D2 c (ecm) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:40 2529A6D2 c (ecm) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:40 2529A6D2 c (ecm) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:40 2529A6D2 c (ecm) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:40 2529A6D2 c (ecm) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:40 2529A6D2 c (ecm) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:40 2529A6D2 c (ecm) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:40 2529A6D2 c (ecm) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 request controlword for ecm 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 657CB573 r (work) data from add_job action=5 client r Tivu_1856
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Setting timeout to 139 ETU (889 us)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Transmit size 202 bytes, delay 0 us, timeout=889 us
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Transmit:
2023/01/04 17:38:40 657CB573 r (reader) 00 40 C6 80 CA 00 00 C0 1E FB 04 1A 30 62 72 8B
2023/01/04 17:38:40 657CB573 r (reader) 84 A4 54 2C EC C7 DC 39 36 94 AA A8 4F DC 35 5D
2023/01/04 17:38:40 657CB573 r (reader) 2A 6A 75 E8 26 54 3F 84 39 CF F7 37 C5 5F C5 18
2023/01/04 17:38:40 657CB573 r (reader) F9 4A 50 E1 56 3E 67 97 C9 A2 F2 57 5F CD 93 3C
2023/01/04 17:38:40 657CB573 r (reader) ED 20 02 6F 55 B2 2D 46 44 AD DC 78 6F A6 DF E3
2023/01/04 17:38:40 657CB573 r (reader) 5E 3F 5C 3D 70 CC 11 EA 3A 28 B9 B7 C1 95 68 FE
2023/01/04 17:38:40 657CB573 r (reader) B3 BC 1C A7 9D 43 E6 3A 5A 4B BA A7 B6 AE 40 20
2023/01/04 17:38:40 657CB573 r (reader) C8 3F 96 0D 6E 7C 68 A0 50 84 91 A3 E6 4A 79 54
2023/01/04 17:38:40 657CB573 r (reader) 5D 82 81 3D 7F 0D 3A 8F A9 78 61 CE 70 EC 10 21
2023/01/04 17:38:40 657CB573 r (reader) BA 7F 1E 48 55 64 AD 92 41 20 9F DE AB 80 A0 C4
2023/01/04 17:38:40 657CB573 r (reader) 14 B5 0D C9 42 B3 0F 6A 4C 34 F9 05 96 39 B3 C6
2023/01/04 17:38:40 657CB573 r (reader) F3 10 C8 8C 38 70 4C 89 82 07 1D 27 6D 60 D4 3A
2023/01/04 17:38:40 657CB573 r (reader) 9B 65 5B 00 06 8B DC A1 B0 3A
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Write timeout 889 us, write delay 0 us, to send 202 char(s), chunksize 202 char(s)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Sending:
2023/01/04 17:38:40 657CB573 r (reader) 00 40 C6 80 CA 00 00 C0 1E FB 04 1A 30 62 72 8B
2023/01/04 17:38:40 657CB573 r (reader) 84 A4 54 2C EC C7 DC 39 36 94 AA A8 4F DC 35 5D
2023/01/04 17:38:40 657CB573 r (reader) 2A 6A 75 E8 26 54 3F 84 39 CF F7 37 C5 5F C5 18
2023/01/04 17:38:40 657CB573 r (reader) F9 4A 50 E1 56 3E 67 97 C9 A2 F2 57 5F CD 93 3C
2023/01/04 17:38:40 657CB573 r (reader) ED 20 02 6F 55 B2 2D 46 44 AD DC 78 6F A6 DF E3
2023/01/04 17:38:40 657CB573 r (reader) 5E 3F 5C 3D 70 CC 11 EA 3A 28 B9 B7 C1 95 68 FE
2023/01/04 17:38:40 657CB573 r (reader) B3 BC 1C A7 9D 43 E6 3A 5A 4B BA A7 B6 AE 40 20
2023/01/04 17:38:40 657CB573 r (reader) C8 3F 96 0D 6E 7C 68 A0 50 84 91 A3 E6 4A 79 54
2023/01/04 17:38:40 657CB573 r (reader) 5D 82 81 3D 7F 0D 3A 8F A9 78 61 CE 70 EC 10 21
2023/01/04 17:38:40 657CB573 r (reader) BA 7F 1E 48 55 64 AD 92 41 20 9F DE AB 80 A0 C4
2023/01/04 17:38:40 657CB573 r (reader) 14 B5 0D C9 42 B3 0F 6A 4C 34 F9 05 96 39 B3 C6
2023/01/04 17:38:40 657CB573 r (reader) F3 10 C8 8C 38 70 4C 89 82 07 1D 27 6D 60 D4 3A
2023/01/04 17:38:40 657CB573 r (reader) 9B 65 5B 00 06 8B DC A1 B0 3A
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Transmit successful
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Sending block I(1,0)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Setting timeout to 357131 ETU (2285638 us)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive size 4 bytes, delay 0 us, timeout=2285638 us
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Read timeout 2285638 us, read delay 0 us, to read 4 char(s), chunksize 4 char(s)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Receiving:
2023/01/04 17:38:40 657CB573 r (reader) 00 40 B2 04
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive successful
2023/01/04 17:38:40 00000000 >> OSCam << cardserver log switched, version 1.20_svn, build r11716-798 (arm-newnigma2-linux-gnueabihf-libusb)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive size 178 bytes, delay 0 us, timeout=2285638 us
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Read timeout 2285638 us, read delay 0 us, to read 178 char(s), chunksize 178 char(s)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Receiving:
2023/01/04 17:38:40 657CB573 r (reader) 50 A8 15 E9 32 01 5D 17 82 55 B7 3E BC 98 57 8C
2023/01/04 17:38:40 657CB573 r (reader) 6D 9E D9 5A 66 03 9C 9C C6 FE 91 9D F8 D4 9E 33
2023/01/04 17:38:40 657CB573 r (reader) 38 9B 3D A1 45 03 31 31 B3 7A 04 CE 47 22 C5 C5
2023/01/04 17:38:40 657CB573 r (reader) 88 FF E7 3B 3C 1A A2 AB 1C B7 AB D5 A3 02 DB 18
2023/01/04 17:38:40 657CB573 r (reader) CC AF C4 FF D8 36 67 D5 B0 8A 58 1D 8E 1A 89 1B
2023/01/04 17:38:40 657CB573 r (reader) C4 75 37 FE 8E 0B DE 0D F0 10 54 0A 56 16 08 44
2023/01/04 17:38:40 657CB573 r (reader) B2 AE 4C E0 75 A3 BB 62 9A 1F C7 B8 6C A3 52 9A
2023/01/04 17:38:40 657CB573 r (reader) 70 F7 01 9B AC 97 9E E5 D6 C0 23 C4 DE 99 50 80
2023/01/04 17:38:40 657CB573 r (reader) 77 A1 AF 01 A2 B8 FE EE 8B BD 3D 59 F7 AE D7 75
2023/01/04 17:38:40 657CB573 r (reader) B0 CE B1 BB E7 31 05 A1 7F 02 11 19 5A BF 83 F9
2023/01/04 17:38:40 657CB573 r (reader) 64 A6 9C 56 F1 85 9C E9 E1 6D 88 BD 94 B3 B0 90
2023/01/04 17:38:40 657CB573 r (reader) 00 BE
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive successful
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Protocol: Received block I(1,0)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] Answer from cardreader:
2023/01/04 17:38:40 657CB573 r (reader) 04 50 A8 15 E9 32 01 5D 17 82 55 B7 3E BC 98 57
2023/01/04 17:38:40 657CB573 r (reader) 8C 6D 9E D9 5A 66 03 9C 9C C6 FE 91 9D F8 D4 9E
2023/01/04 17:38:40 657CB573 r (reader) 33 38 9B 3D A1 45 03 31 31 B3 7A 04 CE 47 22 C5
2023/01/04 17:38:40 657CB573 r (reader) C5 88 FF E7 3B 3C 1A A2 AB 1C B7 AB D5 A3 02 DB
2023/01/04 17:38:40 657CB573 r (reader) 18 CC AF C4 FF D8 36 67 D5 B0 8A 58 1D 8E 1A 89
2023/01/04 17:38:40 657CB573 r (reader) 1B C4 75 37 FE 8E 0B DE 0D F0 10 54 0A 56 16 08
2023/01/04 17:38:40 657CB573 r (reader) 44 B2 AE 4C E0 75 A3 BB 62 9A 1F C7 B8 6C A3 52
2023/01/04 17:38:40 657CB573 r (reader) 9A 70 F7 01 9B AC 97 9E E5 D6 C0 23 C4 DE 99 50
2023/01/04 17:38:40 657CB573 r (reader) 80 77 A1 AF 01 A2 B8 FE EE 8B BD 3D 59 F7 AE D7
2023/01/04 17:38:40 657CB573 r (reader) 75 B0 CE B1 BB E7 31 05 A1 7F 02 11 19 5A BF 83
2023/01/04 17:38:40 657CB573 r (reader) F9 64 A6 9C 56 F1 85 9C E9 E1 6D 88 BD 94 B3 B0
2023/01/04 17:38:40 657CB573 r (reader) 90 00
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] Decrypted ECM Answer:
2023/01/04 17:38:40 657CB573 r (reader) 6E C2 50 63 00 00 36 85 0E 74 A8 DB 83 C0 FF FF
2023/01/04 17:38:40 657CB573 r (reader) FF FF FF FF FF FF FF CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] card got wrong ECM
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_ecm: after csystem->do_ecm rc=0
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_ecm: ret rc=0
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_process_ecm: cardreader_do_ecm returned rc=0 (ERROR=0)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] Error processing ecm for caid 1856, provid 000000, srvid 007A, servicename: Canale5 HD
2023/01/04 17:38:40 657CB573 r (ecm) {client dvbapi, caid 1856, srvid 007A} [write_ecm_answer] cyclecheck passed! Reader: Tivu_1856 rc: 4
2023/01/04 17:38:40 657CB573 r (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_answer] reader Tivu_1856 rc 4, ecm time 66 ms (73 ms)
2023/01/04 17:38:40 657CB573 r (work) start client thread action 32
2023/01/04 17:38:40 657CB573 r (main) starting thread client work
2023/01/04 17:38:40 657CB573 r (main) client work thread started
2023/01/04 17:38:40 2529A6D2 c (work) data from add_job action=32 client c dvbapi
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [send_dcw] rc 4 from reader Tivu_1856
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] TRACE: ecm answer for ecm hash 6897D4DF744646CA294CDDEB318783A6 rc=4
2023/01/04 17:38:40 2529A6D2 c (ecm) Client dvbapi csphash C9139062 cw 00000000000000000000000000000000 rc 4 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 no control word received for PID 2 CAID 1856 PROVID 000000 ECMPID 1466 CHID 0000 VPID 0422
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 requested controlword for ecm 6897D4DF744646CA294CDDEB318783A6 on fd 14
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 not interested in response ecmhash 6897D4DF744646CA294CDDEB318783A6 (delivered cw is empty!)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 14 api: 0, caid: 1856, provid: 000000, ecmpid: 1466)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] ecm hash: 6897D4DF744646CA294CDDEB318783A6 real time: 63 ms
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:14)
2023/01/04 17:38:40 2529A6D2 c (ecm) dvbapi (1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6): not found (74 ms) by Tivu_1856 - Canale5 HD (lg)
2023/01/04 17:38:40 2529A6D2 c (ecm) cw:
2023/01/04 17:38:40 2529A6D2 c (ecm) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2023/01/04 17:38:40 00000000 (main) starting thread client work
2023/01/04 17:38:40 00000000 (main) client work thread started
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2023/01/04 17:38:40 2529A6D2 c (dvbapi) New events occurred on 1 of 3 handlers after 513 ms inactivity
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Now handling fd 14 that reported event 32
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 has 4 ecmpids, 9 streampids, 0 ecmfilters and 0 of max 63 emmfilters
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 prio ecmpid 1 183E@000000:1402:0000 weight: 6 (file)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 prio ecmpid 0 183D@000000:139E:0000 weight: 5 (file)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 prio ecmpid 2 1856@000000:1466:0000 weight: 4 (file)
2023/01/04 17:38:40 2529A6D2 c (chk) caid 183D not found in caidlist reader Tivu_1856
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 ignore ecmpid 0 183D@000000:139E:10000 (no matching reader)
2023/01/04 17:38:40 2529A6D2 c (chk) caid 183E not found in caidlist reader Tivu_1856
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 ignore ecmpid 1 183E@000000:1402:10000 (no matching reader)
2023/01/04 17:38:40 2529A6D2 c (chk) caid 09CD not found in caidlist reader Tivu_1856
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 ignore ecmpid 3 09CD@000000:1722:10000 (no matching reader)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 sorting the ecmpids took 0 ms
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 3 disabled ecmpids!
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 1856 PROVID 000000 ECMPID 1466 ANY CHID PMTPID 00DE VPID 0422
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 try to start new filter for caid: 1856, provid: 000000, pid: 1466
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 14)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 Filter 1 started successfully (caid 1856 provid 000000 pid 1466)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94 DC FD
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F 5B 40
2023/01/04 17:38:41 2529A6D2 c (dvbapi) D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E 8A 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5 6C 5E
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00 81 30 AC
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E 60 1F 7A
2023/01/04 17:38:41 2529A6D2 c (dvbapi) C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4 90 53 62
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56 08 1A A4
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0 75 AD BF
2023/01/04 17:38:41 2529A6D2 c (dvbapi) DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8 02 DA 97
2023/01/04 17:38:41 2529A6D2 c (dvbapi) AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6 2C 73 63
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94 DC FD 42
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F 5B 40 D5
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E 8A 00 BD
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5 6C 5E 9D
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 86 D8 9F 8D AE 47 0B 04 00 00 40 00 81 30 AC 05
2023/01/04 17:38:41 2529A6D2 c (dvbapi) A4 00 D0 07 F6 06 22 A3 05 9A E0 3E 60 1F 7A C5
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 25 0E 12 21 C0 6A 44 EB A8 58 77 A4 90 53 62 58
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 41 3B F5 AF 1D 88 49 DA BF D6 40 56 08 1A A4 3B
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0 75 AD BF DC
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8 02 DA 97 AD
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6 2C 73 63 5D
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94 DC FD 42 19
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F 5B 40 D5 22
2023/01/04 17:38:41 2529A6D2 c (dvbapi) C3 BB 68 CD A8 39 D6 50 EF 71 51 3E 8A 00 BD 76
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5 6C 5E 9D 86
2023/01/04 17:38:41 2529A6D2 c (dvbapi) D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 filter1[0] = 80, filter mask[0] = F0, flt&mask = 80 , buffer[0] = 81, buffer[0] & mask = 80
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 filter 1 fetched ECM data (length = 0x0AF):
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:41 2529A6D2 c (dvbapi) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 ECMTYPE 81 CAID 1856 PROVID 000000 ECMPID 1466 FAKECHID 0000 (unique part in ecm)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 Filter 1 set ecmtable to EVEN (CAID 1856 PROVID 000000 FD 14)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 Filter 1 set chid to ANY CHID on fd 14
2023/01/04 17:38:41 00000000 >> OSCam << cardserver log switched, version 1.20_svn, build r11716-798 (arm-newnigma2-linux-gnueabihf-libusb)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 requesting same ecm again (previous result was not found!)
2023/01/04 17:38:41 2529A6D2 c (ecm) [ecm_cache] ecm_cache_init_done 0 cfg.ecm_cache_size: 0 cfg.ecm_cache_memory 0 MiB
2023/01/04 17:38:41 2529A6D2 c (ecm) get cw for ecm:
2023/01/04 17:38:41 2529A6D2 c (ecm) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:41 2529A6D2 c (ecm) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:41 2529A6D2 c (ecm) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:41 2529A6D2 c (ecm) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:41 2529A6D2 c (ecm) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:41 2529A6D2 c (ecm) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:41 2529A6D2 c (ecm) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:41 2529A6D2 c (ecm) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:41 2529A6D2 c (ecm) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] NEW REQUEST!
2023/01/04 17:38:41 2529A6D2 c (ecm) [GET_CW] wait_time 0 caid 1856 prov 000000 srvid 007A rc 100 cacheex cl mode 0 ex1rdr 0
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0, preferlocalcards 2
2023/01/04 17:38:41 2529A6D2 c (ecm) request_cw stage=2 to reader Tivu_1856 ecm hash=6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 2529A6D2 c (work) start reader thread action 5
2023/01/04 17:38:41 2529A6D2 c (main) starting thread client work
2023/01/04 17:38:41 2529A6D2 c (main) client work thread started
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_request] reader Tivu_1856 --> SENT 1
2023/01/04 17:38:41 2529A6D2 c (ecm) Client dvbapi ECM dump 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 2529A6D2 c (ecm) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:41 2529A6D2 c (ecm) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:41 2529A6D2 c (ecm) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:41 2529A6D2 c (ecm) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:41 2529A6D2 c (ecm) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:41 2529A6D2 c (ecm) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:41 2529A6D2 c (ecm) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:41 2529A6D2 c (ecm) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:41 2529A6D2 c (ecm) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 request controlword for ecm 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 657CB573 r (work) data from add_job action=5 client r Tivu_1856
2023/01/04 17:38:41 657CB573 r (reader) {client dvbapi, caid 1856, prid 000000, srvid 007A} [reader_get_ecm] ecm already sent to reader Tivu_1856 (NOK)
2023/01/04 17:38:41 657CB573 r (ecm) {client dvbapi, caid 1856, srvid 007A} [write_ecm_answer] cyclecheck passed! Reader: Tivu_1856 rc: 4
2023/01/04 17:38:41 657CB573 r (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_answer] reader Tivu_1856 rc 4, ecm time 1 ms (2 ms)
2023/01/04 17:38:41 657CB573 r (work) start client thread action 32
2023/01/04 17:38:41 657CB573 r (main) starting thread client work
2023/01/04 17:38:41 657CB573 r (main) client work thread started
2023/01/04 17:38:41 2529A6D2 c (work) data from add_job action=32 client c dvbapi
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [send_dcw] rc 4 from reader Tivu_1856
2023/01/04 17:38:41 2529A6D2 c (ecm) Client dvbapi csphash C9139062 cw 00000000000000000000000000000000 rc 4 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 no control word received for PID 2 CAID 1856 PROVID 000000 ECMPID 1466 CHID 0000 VPID 0422
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 requested controlword for ecm 6897D4DF744646CA294CDDEB318783A6 on fd 14
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 not interested in response ecmhash 6897D4DF744646CA294CDDEB318783A6 (delivered cw is empty!)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 14 api: 0, caid: 1856, provid: 000000, ecmpid: 1466)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:14)
2023/01/04 17:38:41 2529A6D2 c (ecm) dvbapi (1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6): not found (2 ms) by Tivu_1856 - Canale5 HD
2023/01/04 17:38:40 2529A6D2 c (ecm) [GET_CW] wait_time 0 caid 1856 prov 000000 srvid 007A rc 100 cacheex cl mode 0 ex1rdr 0
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0, preferlocalcards 2
2023/01/04 17:38:40 2529A6D2 c (ecm) request_cw stage=2 to reader Tivu_1856 ecm hash=6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 2529A6D2 c (work) start reader thread action 5
2023/01/04 17:38:40 2529A6D2 c (main) starting thread client work
2023/01/04 17:38:40 2529A6D2 c (main) client work thread started
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_request] reader Tivu_1856 --> SENT 1
2023/01/04 17:38:40 2529A6D2 c (ecm) Client dvbapi ECM dump 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 2529A6D2 c (ecm) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:40 2529A6D2 c (ecm) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:40 2529A6D2 c (ecm) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:40 2529A6D2 c (ecm) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:40 2529A6D2 c (ecm) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:40 2529A6D2 c (ecm) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:40 2529A6D2 c (ecm) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:40 2529A6D2 c (ecm) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:40 2529A6D2 c (ecm) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:40 2529A6D2 c (ecm) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:40 2529A6D2 c (ecm) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 request controlword for ecm 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 657CB573 r (work) data from add_job action=5 client r Tivu_1856
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Setting timeout to 139 ETU (889 us)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Transmit size 202 bytes, delay 0 us, timeout=889 us
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Transmit:
2023/01/04 17:38:40 657CB573 r (reader) 00 40 C6 80 CA 00 00 C0 1E FB 04 1A 30 62 72 8B
2023/01/04 17:38:40 657CB573 r (reader) 84 A4 54 2C EC C7 DC 39 36 94 AA A8 4F DC 35 5D
2023/01/04 17:38:40 657CB573 r (reader) 2A 6A 75 E8 26 54 3F 84 39 CF F7 37 C5 5F C5 18
2023/01/04 17:38:40 657CB573 r (reader) F9 4A 50 E1 56 3E 67 97 C9 A2 F2 57 5F CD 93 3C
2023/01/04 17:38:40 657CB573 r (reader) ED 20 02 6F 55 B2 2D 46 44 AD DC 78 6F A6 DF E3
2023/01/04 17:38:40 657CB573 r (reader) 5E 3F 5C 3D 70 CC 11 EA 3A 28 B9 B7 C1 95 68 FE
2023/01/04 17:38:40 657CB573 r (reader) B3 BC 1C A7 9D 43 E6 3A 5A 4B BA A7 B6 AE 40 20
2023/01/04 17:38:40 657CB573 r (reader) C8 3F 96 0D 6E 7C 68 A0 50 84 91 A3 E6 4A 79 54
2023/01/04 17:38:40 657CB573 r (reader) 5D 82 81 3D 7F 0D 3A 8F A9 78 61 CE 70 EC 10 21
2023/01/04 17:38:40 657CB573 r (reader) BA 7F 1E 48 55 64 AD 92 41 20 9F DE AB 80 A0 C4
2023/01/04 17:38:40 657CB573 r (reader) 14 B5 0D C9 42 B3 0F 6A 4C 34 F9 05 96 39 B3 C6
2023/01/04 17:38:40 657CB573 r (reader) F3 10 C8 8C 38 70 4C 89 82 07 1D 27 6D 60 D4 3A
2023/01/04 17:38:40 657CB573 r (reader) 9B 65 5B 00 06 8B DC A1 B0 3A
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Write timeout 889 us, write delay 0 us, to send 202 char(s), chunksize 202 char(s)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Sending:
2023/01/04 17:38:40 657CB573 r (reader) 00 40 C6 80 CA 00 00 C0 1E FB 04 1A 30 62 72 8B
2023/01/04 17:38:40 657CB573 r (reader) 84 A4 54 2C EC C7 DC 39 36 94 AA A8 4F DC 35 5D
2023/01/04 17:38:40 657CB573 r (reader) 2A 6A 75 E8 26 54 3F 84 39 CF F7 37 C5 5F C5 18
2023/01/04 17:38:40 657CB573 r (reader) F9 4A 50 E1 56 3E 67 97 C9 A2 F2 57 5F CD 93 3C
2023/01/04 17:38:40 657CB573 r (reader) ED 20 02 6F 55 B2 2D 46 44 AD DC 78 6F A6 DF E3
2023/01/04 17:38:40 657CB573 r (reader) 5E 3F 5C 3D 70 CC 11 EA 3A 28 B9 B7 C1 95 68 FE
2023/01/04 17:38:40 657CB573 r (reader) B3 BC 1C A7 9D 43 E6 3A 5A 4B BA A7 B6 AE 40 20
2023/01/04 17:38:40 657CB573 r (reader) C8 3F 96 0D 6E 7C 68 A0 50 84 91 A3 E6 4A 79 54
2023/01/04 17:38:40 657CB573 r (reader) 5D 82 81 3D 7F 0D 3A 8F A9 78 61 CE 70 EC 10 21
2023/01/04 17:38:40 657CB573 r (reader) BA 7F 1E 48 55 64 AD 92 41 20 9F DE AB 80 A0 C4
2023/01/04 17:38:40 657CB573 r (reader) 14 B5 0D C9 42 B3 0F 6A 4C 34 F9 05 96 39 B3 C6
2023/01/04 17:38:40 657CB573 r (reader) F3 10 C8 8C 38 70 4C 89 82 07 1D 27 6D 60 D4 3A
2023/01/04 17:38:40 657CB573 r (reader) 9B 65 5B 00 06 8B DC A1 B0 3A
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Transmit successful
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Sending block I(1,0)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Setting timeout to 357131 ETU (2285638 us)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive size 4 bytes, delay 0 us, timeout=2285638 us
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Read timeout 2285638 us, read delay 0 us, to read 4 char(s), chunksize 4 char(s)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Receiving:
2023/01/04 17:38:40 657CB573 r (reader) 00 40 B2 04
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive successful
2023/01/04 17:38:40 00000000 >> OSCam << cardserver log switched, version 1.20_svn, build r11716-798 (arm-newnigma2-linux-gnueabihf-libusb)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive size 178 bytes, delay 0 us, timeout=2285638 us
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Read timeout 2285638 us, read delay 0 us, to read 178 char(s), chunksize 178 char(s)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IO: Receiving:
2023/01/04 17:38:40 657CB573 r (reader) 50 A8 15 E9 32 01 5D 17 82 55 B7 3E BC 98 57 8C
2023/01/04 17:38:40 657CB573 r (reader) 6D 9E D9 5A 66 03 9C 9C C6 FE 91 9D F8 D4 9E 33
2023/01/04 17:38:40 657CB573 r (reader) 38 9B 3D A1 45 03 31 31 B3 7A 04 CE 47 22 C5 C5
2023/01/04 17:38:40 657CB573 r (reader) 88 FF E7 3B 3C 1A A2 AB 1C B7 AB D5 A3 02 DB 18
2023/01/04 17:38:40 657CB573 r (reader) CC AF C4 FF D8 36 67 D5 B0 8A 58 1D 8E 1A 89 1B
2023/01/04 17:38:40 657CB573 r (reader) C4 75 37 FE 8E 0B DE 0D F0 10 54 0A 56 16 08 44
2023/01/04 17:38:40 657CB573 r (reader) B2 AE 4C E0 75 A3 BB 62 9A 1F C7 B8 6C A3 52 9A
2023/01/04 17:38:40 657CB573 r (reader) 70 F7 01 9B AC 97 9E E5 D6 C0 23 C4 DE 99 50 80
2023/01/04 17:38:40 657CB573 r (reader) 77 A1 AF 01 A2 B8 FE EE 8B BD 3D 59 F7 AE D7 75
2023/01/04 17:38:40 657CB573 r (reader) B0 CE B1 BB E7 31 05 A1 7F 02 11 19 5A BF 83 F9
2023/01/04 17:38:40 657CB573 r (reader) 64 A6 9C 56 F1 85 9C E9 E1 6D 88 BD 94 B3 B0 90
2023/01/04 17:38:40 657CB573 r (reader) 00 BE
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Receive successful
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] IFD: Protocol: Received block I(1,0)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] Answer from cardreader:
2023/01/04 17:38:40 657CB573 r (reader) 04 50 A8 15 E9 32 01 5D 17 82 55 B7 3E BC 98 57
2023/01/04 17:38:40 657CB573 r (reader) 8C 6D 9E D9 5A 66 03 9C 9C C6 FE 91 9D F8 D4 9E
2023/01/04 17:38:40 657CB573 r (reader) 33 38 9B 3D A1 45 03 31 31 B3 7A 04 CE 47 22 C5
2023/01/04 17:38:40 657CB573 r (reader) C5 88 FF E7 3B 3C 1A A2 AB 1C B7 AB D5 A3 02 DB
2023/01/04 17:38:40 657CB573 r (reader) 18 CC AF C4 FF D8 36 67 D5 B0 8A 58 1D 8E 1A 89
2023/01/04 17:38:40 657CB573 r (reader) 1B C4 75 37 FE 8E 0B DE 0D F0 10 54 0A 56 16 08
2023/01/04 17:38:40 657CB573 r (reader) 44 B2 AE 4C E0 75 A3 BB 62 9A 1F C7 B8 6C A3 52
2023/01/04 17:38:40 657CB573 r (reader) 9A 70 F7 01 9B AC 97 9E E5 D6 C0 23 C4 DE 99 50
2023/01/04 17:38:40 657CB573 r (reader) 80 77 A1 AF 01 A2 B8 FE EE 8B BD 3D 59 F7 AE D7
2023/01/04 17:38:40 657CB573 r (reader) 75 B0 CE B1 BB E7 31 05 A1 7F 02 11 19 5A BF 83
2023/01/04 17:38:40 657CB573 r (reader) F9 64 A6 9C 56 F1 85 9C E9 E1 6D 88 BD 94 B3 B0
2023/01/04 17:38:40 657CB573 r (reader) 90 00
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] Decrypted ECM Answer:
2023/01/04 17:38:40 657CB573 r (reader) 6E C2 50 63 00 00 36 85 0E 74 A8 DB 83 C0 FF FF
2023/01/04 17:38:40 657CB573 r (reader) FF FF FF FF FF FF FF CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC CC
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] card got wrong ECM
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_ecm: after csystem->do_ecm rc=0
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_ecm: ret rc=0
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_process_ecm: cardreader_do_ecm returned rc=0 (ERROR=0)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] Error processing ecm for caid 1856, provid 000000, srvid 007A, servicename: Canale5 HD
2023/01/04 17:38:40 657CB573 r (ecm) {client dvbapi, caid 1856, srvid 007A} [write_ecm_answer] cyclecheck passed! Reader: Tivu_1856 rc: 4
2023/01/04 17:38:40 657CB573 r (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_answer] reader Tivu_1856 rc 4, ecm time 66 ms (73 ms)
2023/01/04 17:38:40 657CB573 r (work) start client thread action 32
2023/01/04 17:38:40 657CB573 r (main) starting thread client work
2023/01/04 17:38:40 657CB573 r (main) client work thread started
2023/01/04 17:38:40 2529A6D2 c (work) data from add_job action=32 client c dvbapi
2023/01/04 17:38:40 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [send_dcw] rc 4 from reader Tivu_1856
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] TRACE: ecm answer for ecm hash 6897D4DF744646CA294CDDEB318783A6 rc=4
2023/01/04 17:38:40 2529A6D2 c (ecm) Client dvbapi csphash C9139062 cw 00000000000000000000000000000000 rc 4 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 no control word received for PID 2 CAID 1856 PROVID 000000 ECMPID 1466 CHID 0000 VPID 0422
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 requested controlword for ecm 6897D4DF744646CA294CDDEB318783A6 on fd 14
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 not interested in response ecmhash 6897D4DF744646CA294CDDEB318783A6 (delivered cw is empty!)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 14 api: 0, caid: 1856, provid: 000000, ecmpid: 1466)
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] ecm hash: 6897D4DF744646CA294CDDEB318783A6 real time: 63 ms
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:14)
2023/01/04 17:38:40 2529A6D2 c (ecm) dvbapi (1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6): not found (74 ms) by Tivu_1856 - Canale5 HD (lg)
2023/01/04 17:38:40 2529A6D2 c (ecm) cw:
2023/01/04 17:38:40 2529A6D2 c (ecm) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2023/01/04 17:38:40 00000000 (main) starting thread client work
2023/01/04 17:38:40 00000000 (main) client work thread started
2023/01/04 17:38:40 657CB573 r (reader) Tivu_1856 [nagra merlin] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2023/01/04 17:38:40 2529A6D2 c (dvbapi) New events occurred on 1 of 3 handlers after 513 ms inactivity
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Now handling fd 14 that reported event 32
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 has 4 ecmpids, 9 streampids, 0 ecmfilters and 0 of max 63 emmfilters
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 prio ecmpid 1 183E@000000:1402:0000 weight: 6 (file)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 prio ecmpid 0 183D@000000:139E:0000 weight: 5 (file)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 prio ecmpid 2 1856@000000:1466:0000 weight: 4 (file)
2023/01/04 17:38:40 2529A6D2 c (chk) caid 183D not found in caidlist reader Tivu_1856
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 ignore ecmpid 0 183D@000000:139E:10000 (no matching reader)
2023/01/04 17:38:40 2529A6D2 c (chk) caid 183E not found in caidlist reader Tivu_1856
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 ignore ecmpid 1 183E@000000:1402:10000 (no matching reader)
2023/01/04 17:38:40 2529A6D2 c (chk) caid 09CD not found in caidlist reader Tivu_1856
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 ignore ecmpid 3 09CD@000000:1722:10000 (no matching reader)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 sorting the ecmpids took 0 ms
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 1 enabled and 3 disabled ecmpids!
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 1856 PROVID 000000 ECMPID 1466 ANY CHID PMTPID 00DE VPID 0422
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 try to start new filter for caid: 1856, provid: 000000, pid: 1466
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 14)
2023/01/04 17:38:40 2529A6D2 c (dvbapi) Demuxer 0 Filter 1 started successfully (caid 1856 provid 000000 pid 1466)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94 DC FD
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F 5B 40
2023/01/04 17:38:41 2529A6D2 c (dvbapi) D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E 8A 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5 6C 5E
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00 81 30 AC
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E 60 1F 7A
2023/01/04 17:38:41 2529A6D2 c (dvbapi) C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4 90 53 62
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56 08 1A A4
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0 75 AD BF
2023/01/04 17:38:41 2529A6D2 c (dvbapi) DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8 02 DA 97
2023/01/04 17:38:41 2529A6D2 c (dvbapi) AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6 2C 73 63
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94 DC FD 42
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F 5B 40 D5
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E 8A 00 BD
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5 6C 5E 9D
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 86 D8 9F 8D AE 47 0B 04 00 00 40 00 81 30 AC 05
2023/01/04 17:38:41 2529A6D2 c (dvbapi) A4 00 D0 07 F6 06 22 A3 05 9A E0 3E 60 1F 7A C5
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 25 0E 12 21 C0 6A 44 EB A8 58 77 A4 90 53 62 58
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 41 3B F5 AF 1D 88 49 DA BF D6 40 56 08 1A A4 3B
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0 75 AD BF DC
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8 02 DA 97 AD
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6 2C 73 63 5D
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94 DC FD 42 19
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F 5B 40 D5 22
2023/01/04 17:38:41 2529A6D2 c (dvbapi) C3 BB 68 CD A8 39 D6 50 EF 71 51 3E 8A 00 BD 76
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5 6C 5E 9D 86
2023/01/04 17:38:41 2529A6D2 c (dvbapi) D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 filter1[0] = 80, filter mask[0] = F0, flt&mask = 80 , buffer[0] = 81, buffer[0] & mask = 80
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 filter 1 fetched ECM data (length = 0x0AF):
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:41 2529A6D2 c (dvbapi) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:41 2529A6D2 c (dvbapi) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 ECMTYPE 81 CAID 1856 PROVID 000000 ECMPID 1466 FAKECHID 0000 (unique part in ecm)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 Filter 1 set ecmtable to EVEN (CAID 1856 PROVID 000000 FD 14)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 Filter 1 set chid to ANY CHID on fd 14
2023/01/04 17:38:41 00000000 >> OSCam << cardserver log switched, version 1.20_svn, build r11716-798 (arm-newnigma2-linux-gnueabihf-libusb)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 requesting same ecm again (previous result was not found!)
2023/01/04 17:38:41 2529A6D2 c (ecm) [ecm_cache] ecm_cache_init_done 0 cfg.ecm_cache_size: 0 cfg.ecm_cache_memory 0 MiB
2023/01/04 17:38:41 2529A6D2 c (ecm) get cw for ecm:
2023/01/04 17:38:41 2529A6D2 c (ecm) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:41 2529A6D2 c (ecm) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:41 2529A6D2 c (ecm) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:41 2529A6D2 c (ecm) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:41 2529A6D2 c (ecm) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:41 2529A6D2 c (ecm) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:41 2529A6D2 c (ecm) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:41 2529A6D2 c (ecm) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:41 2529A6D2 c (ecm) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] NEW REQUEST!
2023/01/04 17:38:41 2529A6D2 c (ecm) [GET_CW] wait_time 0 caid 1856 prov 000000 srvid 007A rc 100 cacheex cl mode 0 ex1rdr 0
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0, preferlocalcards 2
2023/01/04 17:38:41 2529A6D2 c (ecm) request_cw stage=2 to reader Tivu_1856 ecm hash=6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 2529A6D2 c (work) start reader thread action 5
2023/01/04 17:38:41 2529A6D2 c (main) starting thread client work
2023/01/04 17:38:41 2529A6D2 c (main) client work thread started
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_request] reader Tivu_1856 --> SENT 1
2023/01/04 17:38:41 2529A6D2 c (ecm) Client dvbapi ECM dump 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 2529A6D2 c (ecm) 81 30 AC 05 A4 00 D0 07 F6 06 22 A3 05 9A E0 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 60 1F 7A C5 25 0E 12 21 C0 6A 44 EB A8 58 77 A4
2023/01/04 17:38:41 2529A6D2 c (ecm) 90 53 62 58 41 3B F5 AF 1D 88 49 DA BF D6 40 56
2023/01/04 17:38:41 2529A6D2 c (ecm) 08 1A A4 3B 4D 0A F8 34 81 3C 2F 50 6F 5C ED E0
2023/01/04 17:38:41 2529A6D2 c (ecm) 75 AD BF DC 4E 62 34 08 94 4F 46 B6 E2 C2 1B A8
2023/01/04 17:38:41 2529A6D2 c (ecm) 02 DA 97 AD 57 70 AD 14 04 B3 2E 4A 8B 54 98 A6
2023/01/04 17:38:41 2529A6D2 c (ecm) 2C 73 63 5D 75 69 C8 20 EC 46 F1 C9 73 4A 0C 94
2023/01/04 17:38:41 2529A6D2 c (ecm) DC FD 42 19 33 FB 67 61 54 C8 6D 3F DF 24 7C 4F
2023/01/04 17:38:41 2529A6D2 c (ecm) 5B 40 D5 22 C3 BB 68 CD A8 39 D6 50 EF 71 51 3E
2023/01/04 17:38:41 2529A6D2 c (ecm) 8A 00 BD 76 99 D5 B8 4B D4 AD B2 D6 C6 4C 16 C5
2023/01/04 17:38:41 2529A6D2 c (ecm) 6C 5E 9D 86 D8 9F 8D AE 47 0B 04 00 00 40 00
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 request controlword for ecm 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 657CB573 r (work) data from add_job action=5 client r Tivu_1856
2023/01/04 17:38:41 657CB573 r (reader) {client dvbapi, caid 1856, prid 000000, srvid 007A} [reader_get_ecm] ecm already sent to reader Tivu_1856 (NOK)
2023/01/04 17:38:41 657CB573 r (ecm) {client dvbapi, caid 1856, srvid 007A} [write_ecm_answer] cyclecheck passed! Reader: Tivu_1856 rc: 4
2023/01/04 17:38:41 657CB573 r (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [write_ecm_answer] reader Tivu_1856 rc 4, ecm time 1 ms (2 ms)
2023/01/04 17:38:41 657CB573 r (work) start client thread action 32
2023/01/04 17:38:41 657CB573 r (main) starting thread client work
2023/01/04 17:38:41 657CB573 r (main) client work thread started
2023/01/04 17:38:41 2529A6D2 c (work) data from add_job action=32 client c dvbapi
2023/01/04 17:38:41 2529A6D2 c (ecm) {client dvbapi, caid 1856, prid 000000, srvid 007A} [send_dcw] rc 4 from reader Tivu_1856
2023/01/04 17:38:41 2529A6D2 c (ecm) Client dvbapi csphash C9139062 cw 00000000000000000000000000000000 rc 4 1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 no control word received for PID 2 CAID 1856 PROVID 000000 ECMPID 1466 CHID 0000 VPID 0422
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 requested controlword for ecm 6897D4DF744646CA294CDDEB318783A6 on fd 14
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 not interested in response ecmhash 6897D4DF744646CA294CDDEB318783A6 (delivered cw is empty!)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 14 api: 0, caid: 1856, provid: 000000, ecmpid: 1466)
2023/01/04 17:38:41 2529A6D2 c (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:14)
2023/01/04 17:38:41 2529A6D2 c (ecm) dvbapi (1856@000000/0000/007A/AF:6897D4DF744646CA294CDDEB318783A6): not found (2 ms) by Tivu_1856 - Canale5 HD
Gruß
M.
: found (135 ms) by 1856 - Italia1 HD (tier NULL | CWPK0) (lg)
Schade
