Timeoutproblem mit PI + OSCAM + Easymouse + Sky S02

cooliemueller123 · 13. Mai 2013

AW: Timeoutproblem mit PI + OSCAM + Easymouse + Sky S02

Korrekt ... aber der gleiche Aufruf bei der 7887 (aus dem streamboard geholt) funktioniert und die configs werden gefunden ....
Also ist bei Deiner Version irgendetwas anders ...

Sonst noch eine Idee?
Kannst Du mir Deine config mal nennen?

cooliemueller123 · 19. Mai 2013

AW: Timeoutproblem mit PI + OSCAM + Easymouse + Sky S02

Hallo,

leider ist mein Problem immer noch nicht gelöst ... die timeouts auf der easymouse kommen immer wieder ... mal nach 1 Minute ... mal nach 1 Stunde ... mal direkt.

Hier ein Auszug aus dem orscam-log als es zu einem timeout kam:

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 ---

Das Log ist etwas gekürzt ... ich habe die ganzen Zeilen mit den Hex-Werten gelöscht (da ist jetzt jeweils eine Leerzeile) ... und zudem habe ich abcdef anstelle der langen Zeichenkette im Request gesetzt (keine Ahnung ob das Notwendig ist --> kann man das gesamte Logfile ohne Probleme posten???).

Sagt das Log etwas aus woher der timeout kommt?

Aktuell habe ich die 8645 auf dem PI im Einsatz ... aber auch bei allen anderen getesteten Versionen war das gleiche Verhalten. Die Karte läuft in meiner 800se im internen Slot mit einer OSCAM einwandfrei.

cooliemueller123 · 30. August 2013

AW: Timeoutproblem mit PI + OSCAM + Easymouse + Sky S02

Ein hoffentlich letztes Update zu diesem Thema:
Scheinbar war die easymouse defekt

Nach Austausch läuft nun der Pi ohne Hub mit der neuen easymouse absolut stabil (seit jetzt 5 Tagen).

Timeoutproblem mit PI + OSCAM + Easymouse + Sky S02

cooliemueller123

Newbie

cooliemueller123

Newbie

cooliemueller123

Newbie

Ähnliche Themen

Timeoutproblem mit PI + OSCAM + Easymouse + Sky S02

cooliemueller123

Newbie

cooliemueller123

Newbie

cooliemueller123

Newbie

Ähnliche Themen

Datenschutz & Transparenz

Datenschutz & Transparenz