17/05/2013 16:45:05 0 s [OSCAM] new event 1 occurred on fd 5 after 3081 ms inactivity
17/05/2013 16:45:05 0 s got 180 bytes on port 27242 from ip 192.168.178.47:2820 client NULL
17/05/2013 16:45:05 0 s start client thread action 26
17/05/2013 16:45:05 0 s add client job action 22 queue length 1 anonymous
17/05/2013 16:45:05 76F158 c data from add_job action=26 client c anonymous
17/05/2013 16:45:05 76F158 c encrypted camd35-client 192.168.178.47 granted (dream, au=auto (2 reader))
17/05/2013 16:45:05 76F158 c received 176 bytes from client
17/05/2013 16:45:05 76F158 c matching_reader became slot attribute of 1
17/05/2013 16:45:05 76F158 c [GET_CW] wait_time 0 caid 1702 prov 000000 srvid 000B rc 100 cacheex cl mode 0 ex1rdr 0
17/05/2013 16:45:05 76F158 c request_cw stage=2 to reader
easymouse ecm hash=abcdef
17/05/2013 16:45:05 76F158 c start reader thread action 5
17/05/2013 16:45:05 76C9B8 r data from add_job action=5 client r
easymouse
17/05/2013 16:45:05 76C9B8 r ecm:
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] cardreader_do_ecm: cardreader_do_checkhealth returned rc=1
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] write to cardreader
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 12 ETU (2232 us)
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IFD: Transmit size 148 bytes, delay 0 us, timeout=2232 us
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IFD: Transmit:
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Write timeout 2232 us, write delay 0 us, to send 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Sending:
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Reading 148 echoed transmitted chars...
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Read timeout 9990000 us, read delay 0 us, to read 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Receiving:
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Reading of echoed transmitted chars done!
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IFD: Transmit succesful
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 9600 ETU (1785600 us)
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IFD: Receive size 8 bytes, delay 0 us, timeout=1785600 us
17/05/2013 16:45:05 76C9B8 r
easymouse [irdeto] IO: Read timeout 1785600 us, read delay 0 us, to read 8 char(s), chunksize 8 char(s)
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Timeout in IO_Serial_WaitToRead, timeout=1785600 us
17/05/2013 16:45:07 76C9B8 r ERROR, function call reader->crdr.receive(reader, data, size, delay, timeout) returns error.
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 12 ETU (2232 us)
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IFD: Transmit size 148 bytes, delay 0 us, timeout=2232 us
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IFD: Transmit:
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Write timeout 2232 us, write delay 0 us, to send 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Sending:
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Reading 148 echoed transmitted chars...
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Read timeout 9990000 us, read delay 0 us, to read 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Receiving:
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Reading of echoed transmitted chars done!
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IFD: Transmit succesful
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 9600 ETU (1785600 us)
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IFD: Receive size 8 bytes, delay 0 us, timeout=1785600 us
17/05/2013 16:45:07 76C9B8 r
easymouse [irdeto] IO: Read timeout 1785600 us, read delay 0 us, to read 8 char(s), chunksize 8 char(s)
17/05/2013 16:45:08 0 fallback for dream 1702&000000/0000/000B/93:abcdef
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Timeout in IO_Serial_WaitToRead, timeout=1785600 us
17/05/2013 16:45:09 76C9B8 r ERROR, function call reader->crdr.receive(reader, data, size, delay, timeout) returns error.
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] TRACE: ERROR: Protocol_T14_Command returns error
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] write to cardreader
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 12 ETU (2232 us)
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IFD: Transmit size 148 bytes, delay 0 us, timeout=2232 us
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IFD: Transmit:
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Write timeout 2232 us, write delay 0 us, to send 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Sending:
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Reading 148 echoed transmitted chars...
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Read timeout 9990000 us, read delay 0 us, to read 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Receiving:
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Reading of echoed transmitted chars done!
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IFD: Transmit succesful
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 9600 ETU (1785600 us)
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IFD: Receive size 8 bytes, delay 0 us, timeout=1785600 us
17/05/2013 16:45:09 76C9B8 r
easymouse [irdeto] IO: Read timeout 1785600 us, read delay 0 us, to read 8 char(s), chunksize 8 char(s)
17/05/2013 16:45:10 0 timeout for dream 1702&000000/0000/000B/93:abcdef
17/05/2013 16:45:10 0 start client thread action 24
17/05/2013 16:45:10 76F158 c data from add_job action=24 client c dream
17/05/2013 16:45:10 76F158 c send 32 bytes to dream
17/05/2013 16:45:10 76F158 c
easymouse [irdeto] EMM: caid 1702 has no provider
17/05/2013 16:45:10 76F158 c dream emm-request sent (reader=
easymouse, caid=1702, auprovid=000000)
17/05/2013 16:45:10 76F158 c send 144 bytes to dream
17/05/2013 16:45:10 0 --- Skipped 1 duplicated log lines ---
17/05/2013 16:45:10 76F158 c dream (1702&000000/0000/000B/93:abcdef): timeout (5002 ms) by
easymouse - Sky Cinema +1
17/05/2013 16:45:10 76F158 c cw:
17/05/2013 16:45:10 76F158 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Timeout in IO_Serial_WaitToRead, timeout=1785600 us
17/05/2013 16:45:11 76C9B8 r ERROR, function call reader->crdr.receive(reader, data, size, delay, timeout) returns error.
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 12 ETU (2232 us)
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IFD: Transmit size 148 bytes, delay 0 us, timeout=2232 us
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IFD: Transmit:
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Write timeout 2232 us, write delay 0 us, to send 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Sending:
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Reading 148 echoed transmitted chars...
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Read timeout 9990000 us, read delay 0 us, to read 148 char(s), chunksize 148 char(s)
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Receiving:
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Reading of echoed transmitted chars done!
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IFD: Transmit succesful
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IFD: Setting timeout to 9600 ETU (1785600 us)
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IFD: Receive size 8 bytes, delay 0 us, timeout=1785600 us
17/05/2013 16:45:11 76C9B8 r
easymouse [irdeto] IO: Read timeout 1785600 us, read delay 0 us, to read 8 char(s), chunksize 8 char(s)
17/05/2013 16:45:12 75A6C0 h WebIf: Origin checked. Result: access from 192.168.178.171 => allowed
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] IO: Timeout in IO_Serial_WaitToRead, timeout=1785600 us
17/05/2013 16:45:13 76C9B8 r ERROR, function call reader->crdr.receive(reader, data, size, delay, timeout) returns error.
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] TRACE: ERROR: Protocol_T14_Command returns error
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] cardreader_do_ecm: after csystem.do_ecm rc=0
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] cardreader_do_ecm: ret rc=0
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] cardreader_process_ecm: cardreader_do_ecm returned rc=0 (ERROR=0)
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] Error processing ecm for caid 1702, srvid 000B, servicename: Sky Cinema +1
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] ecm hash: abcdef real time: 7884 ms
17/05/2013 16:45:13 76C9B8 r start client thread action 24
17/05/2013 16:45:13 76F158 c data from add_job action=24 client c dream
17/05/2013 16:45:13 76F158 c
easymouse [irdeto] TRACE: ecm answer for ecm hash abcdef rc=4
17/05/2013 16:45:13 76C9B8 r
easymouse [irdeto] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
17/05/2013 16:45:22 0 --- Skipped 8 duplicated log lines ---