2016/01/01 20:01:38 00000000 (work) add reader job action 13 queue length 2 ncplus
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:38 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/01/01 20:01:39 00000000 (work) add reader job action 13 queue length 3 ncplus
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] TRACE: ERROR: Protocol_T0_Command returns error
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] PairingECMRotation - ERROR
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] write to cardreader
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:39 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/01/01 20:01:40 00000000 (work) add reader job action 13 queue length 4 ncplus
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:40 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/01/01 20:01:41 00000000 (work) add reader job action 13 queue length 5 ncplus
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] TRACE: ERROR: Protocol_T0_Command returns error
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] cardreader_do_ecm: after csystem->do_ecm rc=0
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] cardreader_do_ecm: ret rc=0
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] cardreader_process_ecm: cardreader_do_ecm returned rc=0 (ERROR=0)
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] Error processing ecm for caid 0B01, provid 000000, srvid 0C23, servicename: Polsat HD
2016/01/01 20:01:41 42C0BDD2 r (ecm) {client user02, caid 0B01, srvid 0C23} [write_ecm_answer] cyclecheck passed! Reader: ncplus rc: 4
2016/01/01 20:01:41 42C0BDD2 r (ecm) {client user02, caid 0B01, prid 000000, srvid 0C23} [write_ecm_answer] reader ncplus rc 4, ecm time 4049 ms (4051 ms)
2016/01/01 20:01:41 4B165C2F c (ecm) {client user02, caid 0B01, prid 000000, srvid 0C23} [send_dcw] rc 4 from reader ncplus
2016/01/01 20:01:41 4B165C2F c (ecm) user01 (0B01@000000/0000/0C23/76:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx): not found (4056 ms) by ncplus - Polsat HD
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] TRACE: ecm answer for ecm hash xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx rc=4
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] ecm hash: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx real time: 4042 ms
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] write to cardreader
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:41 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/01/01 20:01:42 00000000 (work) add reader job action 13 queue length 5 ncplus
2016/01/01 20:01:42 46832EC2 c (ecm) {client wavadda, caid 0B01, srvid 290F} [write_ecm_answer] cyclecheck passed! Reader: ncplus rc: 5
2016/01/01 20:01:42 46832EC2 c (ecm) {client wavadda, caid 0B01, prid 000000, srvid 290F} [write_ecm_answer] reader ncplus rc 5, ecm time 4999 ms (5001 ms)
2016/01/01 20:01:42 46832EC2 c (reader) ncplus [conax] TRACE: ecm answer for ecm hash FAC8E841128F421DA11B339E7069B132 rc=5
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:42 46832EC2 c (ecm) wavadda (0B01@000000/0000/290F/6C:FAC8E841128F421DA11B339E7069B132): timeout (5004 ms) by ncplus
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:42 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/01/01 20:01:42 46832EC2 c (ecm) request_cw stage=2 to reader ncplus ecm hash=384B6CF8D49C582DE61B67A2546046B7
2016/01/01 20:01:42 46832EC2 c (work) add reader job action 5 queue length 6 ncplus
2016/01/01 20:01:42 46832EC2 c (ecm) {client wavadda, caid 0B01, prid 000000, srvid 290F} [write_ecm_request] reader ncplus --> SENT 1
2016/01/01 20:01:43 00000000 (work) add reader job action 13 queue length 7 ncplus
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] TRACE: ERROR: Protocol_T0_Command returns error
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] PairingECMRotation - ERROR
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] write to cardreader
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:43 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)
2016/01/01 20:01:44 00000000 (work) add reader job action 13 queue length 8 ncplus
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Timeout in IO_Serial_WaitToRead, timeout=1000336 us
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 12 ETU (1250 us)
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit size 5 bytes, expected len 1 bytes, delay 0 us, timeout=1250 us
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit:
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Write timeout 1250 us, write delay 0 us, to send 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Sending:
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Reading 5 echoed transmitted chars...
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 9990000 us, read delay 0 us, to read 5 char(s), chunksize 5 char(s)
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Receiving:
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Reading of echoed transmitted chars done!
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IFD: Transmit succesful
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IFD: Setting timeout to 9600 ETU (1000336 us)
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IFD: Receive size 1 bytes, delay 0 us, timeout=1000336 us
2016/01/01 20:01:44 42C0BDD2 r (reader) ncplus [conax] IO: Read timeout 1000336 us, read delay 0 us, to read 1 char(s), chunksize 1 char(s)