2016/04/06 21:31:41 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:31:41 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:42 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:31:42 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:43 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:31:43 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:44 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:31:44 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:45 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] write to cardreader
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 15 ETU (116 us)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit size 5 bytes, expected len 7 bytes, delay 0 us, timeout=116 us
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=d1
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Write timeout 116 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Sending:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Reading 5 echoed transmitted chars...
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Reading of echoed transmitted chars done!
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit succesful
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=74
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=c5
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 4 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 4 char(s), chunksize 4 char(s)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=4 buf[0]=ff
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=f6
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] TRACE: SW1: 90
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=ff
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] TRACE: SW2: 00
2016/04/06 21:31:45 17E78E8A r (reader) skyc [videoguard2] Answer from cardreader:
2016/04/06 21:31:47 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:47 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:48 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:48 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:49 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:49 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:50 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:50 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:51 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:51 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:52 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:52 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:53 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:53 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:54 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:54 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:55 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:55 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:56 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:56 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:57 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] write to cardreader
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 15 ETU (116 us)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit size 5 bytes, expected len 7 bytes, delay 0 us, timeout=116 us
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=d1
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Write timeout 116 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Sending:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Reading 5 echoed transmitted chars...
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Reading of echoed transmitted chars done!
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit succesful
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=74
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=c5
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 4 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 4 char(s), chunksize 4 char(s)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=4 buf[0]=ff
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=f6
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] TRACE: SW1: 90
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=ff
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] TRACE: SW2: 00
2016/04/06 21:31:57 17E78E8A r (reader) skyc [videoguard2] Answer from cardreader:
2016/04/06 21:31:58 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:58 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:31:59 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:31:59 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:00 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:00 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:01 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:01 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:02 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:02 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:03 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:03 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:04 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:04 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:05 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:05 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:06 17E78E8A r (reader) skyc [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2016/04/06 21:32:06 17E78E8A r (ecm) {client user1, caid 098E, srvid 007B} [write_ecm_answer] cyclecheck passed! Reader: skyc rc: 0
2016/04/06 21:32:06 17E78E8A r (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [write_ecm_answer] reader skyc rc 0, ecm time 126 ms (127 ms)
2016/04/06 21:32:06 303ACEE7 c (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [send_dcw] rc 0 from reader skyc
2016/04/06 21:32:06 303ACEE7 c (ecm) user1 (098E@000000/16AC/007B/A2:2D15F07620FD6E6ED00B8BE6A80BEEB5:0F06000000
: found (128 ms) by skyc - TNT Serie HD
2016/04/06 21:32:06 17E78E8A r (reader) skyc [videoguard2] TRACE: ecm answer for ecm hash 2D15F07620FD6E6ED00B8BE6A80BEEB5 rc=0
2016/04/06 21:32:06 17E78E8A r (reader) skyc [videoguard2] ecm hash: 2D15F07620FD6E6ED00B8BE6A80BEEB5 real time: 125 ms
2016/04/06 21:32:07 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:07 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:08 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:09 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] write to cardreader
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 15 ETU (116 us)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit size 5 bytes, expected len 7 bytes, delay 0 us, timeout=116 us
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=d1
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Write timeout 116 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Sending:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Reading 5 echoed transmitted chars...
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Reading of echoed transmitted chars done!
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit succesful
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=74
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=c5
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 4 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 4 char(s), chunksize 4 char(s)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=4 buf[0]=ff
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=f6
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] TRACE: SW1: 90
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=ff
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] TRACE: SW2: 00
2016/04/06 21:32:09 17E78E8A r (reader) skyc [videoguard2] Answer from cardreader:
2016/04/06 21:32:10 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:11 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:12 00000000 (work) add reader job action 11 queue length 1 skyc
2016/04/06 21:32:12 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:12 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:13 00000000 (work) add reader job action 11 queue length 1 skyc
2016/04/06 21:32:13 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:13 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:15 00000000 (work) add reader job action 11 queue length 1 skyc
2016/04/06 21:32:15 17E78E8A r (work) data from add_job action=13 client r skyc
2016/04/06 21:32:15 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:16 17E78E8A r (reader) skyc [videoguard2] Decrypted payload
2016/04/06 21:32:16 17E78E8A r (reader) skyc [videoguard2] cardreader_do_ecm: after csystem->do_ecm rc=1
2016/04/06 21:32:16 17E78E8A r (reader) skyc [videoguard2] cardreader_do_ecm: ret rc=1
2016/04/06 21:32:16 17E78E8A r (reader) skyc [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2016/04/06 21:32:16 17E78E8A r (ecm) {client user1, caid 098E, srvid 007B} [write_ecm_answer] cyclecheck passed! Reader: skyc rc: 0
2016/04/06 21:32:16 17E78E8A r (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [write_ecm_answer] reader skyc rc 0, ecm time 129 ms (129 ms)
2016/04/06 21:32:16 17E78E8A r (reader) skyc [videoguard2] TRACE: ecm answer for ecm hash F0D3C9B5604F8947163ACCB21276D879 rc=0
2016/04/06 21:32:16 303ACEE7 c (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [send_dcw] rc 0 from reader skyc
2016/04/06 21:32:16 17E78E8A r (reader) skyc [videoguard2] ecm hash: F0D3C9B5604F8947163ACCB21276D879 real time: 127 ms
2016/04/06 21:32:16 303ACEE7 c (ecm) user1 (098E@000000/16AC/007B/A2:F0D3C9B5604F8947163ACCB21276D879:0F06000000
: found (130 ms) by skyc - TNT Serie HD
2016/04/06 21:32:17 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:17 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:18 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:18 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:19 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:19 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:20 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:20 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=4 buf[0]=ff
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=f6
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] TRACE: SW1: 90
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=ff
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] TRACE: SW2: 00
2016/04/06 21:32:21 17E78E8A r (reader) skyc [videoguard2] Answer from cardreader:
2016/04/06 21:32:22 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:22 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:23 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:23 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:24 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:24 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:25 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:25 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:26 00000000 (work) add reader job action 13 queue length 1 skyc
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:26 303ACEE7 c (ecm) request_cw stage=3 to reader skyc ecm hash=6B09C3A2739B92319DE1F0046A52EF94
2016/04/06 21:32:26 303ACEE7 c (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [write_ecm_request] reader skyc --> SENT 1
2016/04/06 21:32:26 17E78E8A r (work) data from add_job action=5 client r skyc
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] write to cardreader
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 15 ETU (116 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=116 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=d1
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Write timeout 116 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Sending:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Reading 5 echoed transmitted chars...
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Reading of echoed transmitted chars done!
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=74
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=fd
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 15 ETU (116 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit size 130 bytes, expected len 2 bytes, delay 0 us, timeout=116 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=130 buf[0]=00
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Write timeout 116 us, write delay 0 us, to send 130 char(s), chunksize 130 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Sending:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Reading 130 echoed transmitted chars...
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 9990000 us, read delay 0 us, to read 130 char(s), chunksize 130 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Reading of echoed transmitted chars done!
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=130 buf[0]=ff
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=f6
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] TRACE: SW1: 90
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=ff
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] TRACE: SW2: 00
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] Answer from cardreader:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] write to cardreader
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 15 ETU (116 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit size 5 bytes, expected len 85 bytes, delay 0 us, timeout=116 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=d3
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Write timeout 116 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Sending:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Reading 5 echoed transmitted chars...
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Reading of echoed transmitted chars done!
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Transmit succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=5 buf[0]=34
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=d5
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 82 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:26 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 82 char(s), chunksize 82 char(s)
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=82 buf[0]=ec
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=f6
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] TRACE: SW1: 90
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Setting timeout to 76800 ETU (595200 us)
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Receive size 1 bytes, delay 0 us, timeout=595200 us
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IO: Read timeout 595200 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IO: Receiving:
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: Receive succesful
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] IFD: ICC_Async_InvertBuffer: size=1 buf[0]=ff
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] TRACE: SW2: 00
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] Answer from cardreader:
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] Decrypted payload
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] cardreader_do_ecm: after csystem->do_ecm rc=1
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] cardreader_do_ecm: ret rc=1
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] cardreader_process_ecm: cardreader_do_ecm returned rc=1 (ERROR=0)
2016/04/06 21:32:27 17E78E8A r (ecm) {client user1, caid 098E, srvid 007B} [write_ecm_answer] cyclecheck passed! Reader: skyc rc: 0
2016/04/06 21:32:27 17E78E8A r (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [write_ecm_answer] reader skyc rc 0, ecm time 129 ms (130 ms)
2016/04/06 21:32:27 303ACEE7 c (ecm) {client user1, caid 098E, prid 000000, srvid 007B} [send_dcw] rc 0 from reader skyc
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] TRACE: ecm answer for ecm hash 6B09C3A2739B92319DE1F0046A52EF94 rc=0
2016/04/06 21:32:27 17E78E8A r (reader) skyc [videoguard2] ecm hash: 6B09C3A2739B92319DE1F0046A52EF94 real time: 127 ms
2016/04/06 21:32:27 303ACEE7 c (ecm) user1 (098E@000000/16AC/007B/A2:6B09C3A2739B92319DE1F0046A52EF94:0F06000000
: found (131 ms) by skyc - TNT Serie HD