Opened 11 years ago

Closed 11 years ago

#361 closed defect (fixed)

Error with readers in mipsel binaries from svn1234 and subsequent

Reported by: Spaeleus Owned by:
Priority: major Component: Reader
Severity: medium Keywords:
Cc: Sensitive: no

Description

From svn1234 (trunk) my dm8000 (sky it 0919) stopped working.
with 1234 oscam starts, but Cannot open device: /dev/sci0:

-------------------------------------------------------------------------------
>> OSCam <<  cardserver started at Fri Jan 15 21:03:00 2010
-------------------------------------------------------------------------------
2010/01/15 21:03:00  31732 s   version=0.99.4svn, build #1234, system=mips-dream
box-linux
2010/01/15 21:03:00  31732 s   max. clients=29, client max. idle=120 sec
2010/01/15 21:03:00  31732 s   max. logsize=unlimited
2010/01/15 21:03:00  31732 s   client timeout=5000 ms, fallback timeout=2500 ms,
 cache delay=0 ms
2010/01/15 21:03:00  31732 s   shared memory initialized (size=477276, fd=3)
2010/01/15 21:03:00  31732 s   auth size=4740
2010/01/15 21:03:00  31732 s   services reloaded: 0 services freed, 20 services
loaded
2010/01/15 21:03:00  31732 s   userdb reloaded: 0 accounts freed, 7 accounts loa
ded, 7 expired
2010/01/15 21:03:00  31732 s   signal handling initialized (type=sysv)
2010/01/15 21:03:00  31732 s   500 service-id's loaded
2010/01/15 21:03:00  31732 s   monitor: initialized (fd=7, port=988)
2010/01/15 21:03:00  31732 s   camd 3.3x: disabled
2010/01/15 21:03:00  31732 s   camd 3.5x: disabled
2010/01/15 21:03:00  31732 s   cs378x: disabled
2010/01/15 21:03:00  31732 s   newcamd: initialized (fd=8, port=34000, crypted)
2010/01/15 21:03:00  31732 s   CAID: 0919
2010/01/15 21:03:00  31732 s   provid #0: 000000
2010/01/15 21:03:00  31732 s   radegast: disabled
2010/01/15 21:03:00  31732 s   resolver thread started
2010/01/15 21:03:00  31732 s   logger started (pid=31734)
2010/01/15 21:03:00  31732 s   resolver started (pid=31735, delay=30 sec)
2010/01/15 21:03:00  31732 s   reader started (pid=31736, device=/dev/sci0)
2010/01/15 21:03:00  31732 s   Waiting for local card init ....
2010/01/15 21:03:00  31734 l   starting client -2 with ip 127.0.0.1
2010/01/15 21:03:00  31736 r02 starting client 0 with ip 127.0.0.1
2010/01/15 21:03:00  31736 r02 [tuxbox] Cannot open device: /dev/sci0
2010/01/15 21:03:00  31736 r02 ct_init on /dev/sci0: -10
2010/01/15 21:03:03  31732 s   Init for all local cards done !
2010/01/15 21:03:03  31732 s   anti cascading disabled
2010/01/15 21:03:03  31732 s   client(1) connect from 88.149.224.202 (pid=31740,
 pipfd=13)
2010/01/15 21:03:03  31740 c01 starting client 1 with ip 88.149.224.202
2010/01/15 21:03:03  31740 c01 client connected to 34000 port
2010/01/15 21:03:03  31740 c01 nmr(): len=0, errno=0
2010/01/15 21:03:03  31740 c01 nmr: 1 return 0
2010/01/15 21:03:03  31740 c01 tcp_conn_close(): fd=4, is_server=1
2010/01/15 21:03:03  31740 c01 received 0 bytes from client
2010/01/15 21:03:03  31740 c01 Connection closed to client
2010/01/15 21:03:03  31740 c01 bad client login request
2010/01/15 21:03:04  31732 s   client(1) connect from 192.168.0.11 (pid=31741, p
ipfd=13)
2010/01/15 21:03:04  31741 c01 starting client 1 with ip 192.168.0.11
2010/01/15 21:03:04  31741 c01 client connected to 34000 port
2010/01/15 21:03:04  31741 c01 nmr(): len=2, errno=0
2010/01/15 21:03:04  31741 c01 nmr: autodetect: newcamd525 used
2010/01/15 21:03:04  31741 c01 received 45 bytes from client
2010/01/15 21:03:04  31741 c01 43 43 E0 00 28 37 30 32 35 00 24 31 24 61 62 63
2010/01/15 21:03:04            64 65 66 67 68 24 48 7A 58 47 47 31 50 4D 77 72
2010/01/15 21:03:04            75 2E 59 33 73 72 59 37 69 54 58 2E 00
2010/01/15 21:03:04  31741 c01 account->usr=8000
2010/01/15 21:03:04  31741 c01 account->usr=800
2010/01/15 21:03:04  31741 c01 account->usr=7025
2010/01/15 21:03:04  31741 c01 account->pwd=$1$abcdefgh$HzXGG1PMwru.Y3srY7iTX.
2010/01/15 21:03:04  31741 c01 encrypted newcamd:34000-client 192.168.0.11 grant
ed (7025, au=lower)
2010/01/15 21:03:04  31741 c01 user 7025 authenticated successfully (using clien
t 4343)
2010/01/15 21:03:04  31741 c01 AU wont be used on this port -> disable AU
2010/01/15 21:03:04  31741 c01 send 15 bytes to client
2010/01/15 21:03:04  31741 c01 00 0D 00 00 00 00 00 00 00 00 00 00 E1 00 00
2010/01/15 21:03:04  31741 c01 nmr(): len=2, errno=0
2010/01/15 21:03:04  31741 c01 received 5 bytes from client
2010/01/15 21:03:04  31741 c01 00 00 E3 00 00
2010/01/15 21:03:04  31741 c01 client[4].7025 nfilts=0, filt.caid=0919
2010/01/15 21:03:04  31741 c01 send 27 bytes to client
2010/01/15 21:03:04  31741 c01 00 19 00 00 00 00 00 00 00 00 00 00 E4 00 0C 0E
2010/01/15 21:03:04            09 19 00 00 00 00 00 00 00 00 00
2010/01/15 21:03:04  31732 s   client(2) connect from 192.168.0.13 (pid=31742, p
ipfd=14)
2010/01/15 21:03:04  31742 c02 starting client 2 with ip 192.168.0.13
2010/01/15 21:03:04  31742 c02 client connected to 34000 port
2010/01/15 21:03:04  31742 c02 nmr(): len=2, errno=0
2010/01/15 21:03:04  31742 c02 nmr: autodetect: newcamd525 used
2010/01/15 21:03:04  31742 c02 received 44 bytes from client
2010/01/15 21:03:04  31742 c02 43 43 E0 00 27 38 30 30 00 24 31 24 61 62 63 64
2010/01/15 21:03:04            65 66 67 68 24 39 32 64 38 69 32 72 4B 6D 74 38
2010/01/15 21:03:04            32 38 79 76 5A 6F 7A 66 65 46 2E 00
2010/01/15 21:03:04  31742 c02 account->usr=8000
2010/01/15 21:03:04  31742 c02 account->usr=800
2010/01/15 21:03:04  31742 c02 account->pwd=$1$abcdefgh$92d8i2rKmt828yvZozfeF.
2010/01/15 21:03:04  31742 c02 encrypted newcamd:34000-client 192.168.0.13 grant
ed (800, au=lower)
2010/01/15 21:03:04  31742 c02 user 800 authenticated successfully (using client
 4343)
2010/01/15 21:03:04  31742 c02 AU wont be used on this port -> disable AU
2010/01/15 21:03:04  31742 c02 send 15 bytes to client
2010/01/15 21:03:04  31742 c02 00 0D 00 00 00 00 00 00 00 00 00 00 E1 00 00
2010/01/15 21:03:04  31742 c02 nmr(): len=2, errno=0

With 1235 & subsequents, oscam doesn't start at all:

-------------------------------------------------------------------------------
>> OSCam <<  cardserver started at Fri Jan 15 21:02:05 2010
-------------------------------------------------------------------------------
2010/01/15 21:02:05  31671 s   version=0.99.4svn, build #1235, system=mips-dream
box-linux
2010/01/15 21:02:05  31671 s   max. clients=29, client max. idle=120 sec
2010/01/15 21:02:05  31671 s   max. logsize=unlimited
2010/01/15 21:02:05  31671 s   client timeout=5000 ms, fallback timeout=2500 ms,
 cache delay=0 ms
2010/01/15 21:02:05  31671 s   shared memory initialized (size=477276, fd=3)
2010/01/15 21:02:05  31671 s   auth size=4740
2010/01/15 21:02:05  31671 s   services reloaded: 0 services freed, 20 services
loaded
2010/01/15 21:02:05  31671 s   userdb reloaded: 0 accounts freed, 7 accounts loa
ded, 7 expired
2010/01/15 21:02:05  31671 s   signal handling initialized (type=sysv)
2010/01/15 21:02:05  31671 s   500 service-id's loaded
2010/01/15 21:02:05  31671 s   monitor: initialized (fd=7, port=988)
2010/01/15 21:02:05  31671 s   camd 3.3x: disabled
2010/01/15 21:02:05  31671 s   camd 3.5x: disabled
2010/01/15 21:02:05  31671 s   cs378x: disabled
2010/01/15 21:02:05  31671 s   newcamd: initialized (fd=8, port=34000, crypted)
2010/01/15 21:02:05  31671 s   CAID: 0919
2010/01/15 21:02:05  31671 s   provid #0: 000000
2010/01/15 21:02:05  31671 s   radegast: disabled
2010/01/15 21:02:05  31671 s   resolver thread started
2010/01/15 21:02:05  31671 s   logger started (pid=31673)
2010/01/15 21:02:05  31671 s   resolver started (pid=31674, delay=30 sec)
2010/01/15 21:02:05  31671 s   reader started (pid=31675, device=/dev/sci0)
2010/01/15 21:02:05  31671 s   Waiting for local card init ....
2010/01/15 21:02:05  31673 l   starting client -2 with ip 127.0.0.1
2010/01/15 21:02:05  31674 n   starting client -1 with ip 127.0.0.1
2010/01/15 21:02:05  31675 r02 starting client 0 with ip 127.0.0.1
2010/01/15 21:02:05  31675 r02 exit with signal 8
2010/01/15 21:02:05  31671 s   PANIC: reader lost !! (pid=31675)
2010/01/15 21:02:05  31671 s   exit with signal 1
2010/01/15 21:02:05  31671 s   cardserver down
root@dm8000:~# oscam -d63&

Thx

Change History (4)

comment:1 by rockerduck, 11 years ago

Severity: highmedium

Similar problem with ppc tuxbox binary in a IPBox 350:
latest working was svn1235 (monitor-improvement branch)

2010/01/15 23:56:18    223 s   version=0.99.4svn, build #1244, system=powerpc-dreambox-linux, nice=-1, compiled by rockerduck
2010/01/15 23:56:18    223 s   max. clients=29, client max. idle=120 sec
2010/01/15 23:56:18    223 s   max. logsize=unlimited
2010/01/15 23:56:18    223 s   client timeout=5000 ms, fallback timeout=2500 ms, cache delay=0 ms
2010/01/15 23:56:18    223 s   shared memory initialized (size=543340, fd=3)
2010/01/15 23:56:18    223 s   auth size=4740
2010/01/15 23:56:18    223 s   Cannot open file "/var/tuxbox/config/oscam.services" (errno=2)
2010/01/15 23:56:18    223 s   userdb reloaded: 0 accounts freed, 3 accounts loaded, 0 expired
2010/01/15 23:56:18    223 s   signal handling initialized (type=sysv)
2010/01/15 23:56:18    223 s   233 service-id's loaded
2010/01/15 23:56:18    223 s   22 lengths for caid guessing loaded
2010/01/15 23:56:18    223 s   monitor: disabled
2010/01/15 23:56:18    223 s   camd 3.3x: disabled
2010/01/15 23:56:18    223 s   camd 3.5x: initialized (fd=7, port=xxxxx)
2010/01/15 23:56:18    223 s   cs378x: disabled
2010/01/15 23:56:18    223 s   newcamd: initialized (fd=8, port=xxxxx, crypted)
2010/01/15 23:56:18    223 s   CAID: 093B
2010/01/15 23:56:18    223 s   provid #0: 000000
2010/01/15 23:56:18    223 s   radegast: disabled
2010/01/15 23:56:18    223 s   resolver thread started
2010/01/15 23:56:18    223 s   logger started (pid=225)
2010/01/15 23:56:18    223 s   resolver started (pid=226, delay=30 sec)
2010/01/15 23:56:18    223 s   http started (pid=227)
2010/01/15 23:56:18    223 s   reader started (pid=228, device=/dev/sci0)
2010/01/15 23:56:18    223 s   Waiting for local card init ....
2010/01/15 23:56:18    227 h   HTTP Server listening on port 90
2010/01/15 23:56:20    228 r03 [tuxbox] Cannot open device: /dev/sci0
2010/01/15 23:56:21    223 s   Init for all local cards done !
2010/01/15 23:56:21    223 s   anti cascading disabled
2010/01/15 23:56:24    223 s   client(1) connect from xxxxxxxxxx (pid=229, pipfd=14)
2010/01/15 23:56:24    229 c01 encrypted newcamd:xxxxx-client xxxxxxxx granted (xxxxx, au=skyit)
2010/01/15 23:56:24    229 c01 user xxxxxx authenticated successfully (using client 4343)
2010/01/15 23:56:24    229 c01 AU wont be used on this port -> disable AU
2010/01/15 23:57:21    228 r03 [tuxbox] Cannot open device: /dev/sci0
2010/01/15 23:58:22    228 r03 [tuxbox] Cannot open device: /dev/sci0

comment:2 by pacco, 11 years ago

Have the same problem on sh4 using internal readers.
For me this patch solved the problem:

Index: csctapi/io_serial.c
===================================================================
--- csctapi/io_serial.c	(Revision 1242)
+++ csctapi/io_serial.c	(Arbeitskopie)
@@ -1032,7 +1032,7 @@
 static void IO_Serial_Clear (IO_Serial * io)
 {
 	reader[ridx].handle = -1;
-	reader[ridx].typ = 0;
+	//reader[ridx].typ = 0;
 	memset (io->PnP_id, 0, IO_SERIAL_PNPID_SIZE);
 	io->PnP_id_size = 0;
 	wr = 0;

Basically in that function the reader type is reset and so forgotten.
Following that a wrong init is tried for the internal readers, which fails.

comment:3 by Spaeleus, 11 years ago

Still error, both with svn1245 from trunk & svn1246 from monitor-improvement:

root@dm8000:~# oscam1245 -d63&
root@dm8000:~# Warning: keyword 'httpport' in monitor section not recognized
Warning: keyword 'httpuser' in monitor section not recognized
Warning: keyword 'httppwd' in monitor section not recognized
Warning: keyword 'httprefresh' in monitor section not recognized

-------------------------------------------------------------------------------
>> OSCam <<  cardserver started at Sat Jan 16 11:19:45 2010
-------------------------------------------------------------------------------
2010/01/16 11:19:45  20016 s   version=0.99.4svn, build #1245, system=mips-dream
box-linux
2010/01/16 11:19:45  20016 s   max. clients=29, client max. idle=120 sec
2010/01/16 11:19:45  20016 s   max. logsize=unlimited
2010/01/16 11:19:45  20016 s   client timeout=5000 ms, fallback timeout=2500 ms,
 cache delay=0 ms
2010/01/16 11:19:45  20016 s   shared memory initialized (size=477340, fd=3)
2010/01/16 11:19:45  20016 s   auth size=4740
2010/01/16 11:19:45  20016 s   services reloaded: 0 services freed, 20 services
loaded
2010/01/16 11:19:45  20016 s   userdb reloaded: 0 accounts freed, 7 accounts loa
ded, 7 expired
2010/01/16 11:19:45  20016 s   signal handling initialized (type=sysv)
2010/01/16 11:19:45  20016 s   1034 service-id's loaded
2010/01/16 11:19:45  20016 s   monitor: initialized (fd=7, port=988)
2010/01/16 11:19:45  20016 s   camd 3.3x: disabled
2010/01/16 11:19:45  20016 s   camd 3.5x: disabled
2010/01/16 11:19:45  20016 s   cs378x: disabled
2010/01/16 11:19:45  20016 s   newcamd: initialized (fd=8, port=34000, crypted)
2010/01/16 11:19:45  20016 s   CAID: 0919
2010/01/16 11:19:45  20016 s   provid #0: 000000
2010/01/16 11:19:45  20016 s   radegast: disabled
2010/01/16 11:19:45  20016 s   resolver thread started
2010/01/16 11:19:45  20016 s   logger started (pid=20018)
2010/01/16 11:19:45  20016 s   resolver started (pid=20019, delay=30 sec)
2010/01/16 11:19:45  20016 s   reader started (pid=20020, device=/dev/sci0)
2010/01/16 11:19:45  20016 s   Waiting for local card init ....
2010/01/16 11:19:45  20018 l   starting client -2 with ip 127.0.0.1
2010/01/16 11:19:45  20019 n   starting client -1 with ip 127.0.0.1
2010/01/16 11:19:45  20020 r02 starting client 0 with ip 127.0.0.1
2010/01/16 11:19:45  20020 r02 exit with signal 8
2010/01/16 11:19:45  20016 s   PANIC: reader lost !! (pid=20020)
2010/01/16 11:19:45  20016 s   exit with signal 1
2010/01/16 11:19:45  20016 s   cardserver down
root@dm8000:~# oscam1246 -d63&
[1] - Done(1)                    oscam1245 -d63
root@dm8000:~#
-------------------------------------------------------------------------------
>> OSCam <<  cardserver started at Sat Jan 16 11:19:56 2010
-------------------------------------------------------------------------------
2010/01/16 11:19:56  20031 s   version=0.99.4svn, build #1246S, system=mips-drea
mbox-linux
2010/01/16 11:19:56  20031 s   max. clients=29, client max. idle=120 sec
2010/01/16 11:19:56  20031 s   max. logsize=unlimited
2010/01/16 11:19:56  20031 s   client timeout=5000 ms, fallback timeout=2500 ms,
 cache delay=0 ms
2010/01/16 11:19:56  20031 s   shared memory initialized (size=543340, fd=3)
2010/01/16 11:19:56  20031 s   auth size=4740
2010/01/16 11:19:56  20031 s   services reloaded: 0 services freed, 20 services
loaded
2010/01/16 11:19:56  20031 s   userdb reloaded: 0 accounts freed, 7 accounts loa
ded, 0 expired
2010/01/16 11:19:56  20031 s   signal handling initialized (type=sysv)
2010/01/16 11:19:56  20031 s   1034 service-id's loaded
2010/01/16 11:19:56  20031 s   monitor: initialized (fd=7, port=988)
2010/01/16 11:19:56  20031 s   camd 3.3x: disabled
2010/01/16 11:19:56  20031 s   camd 3.5x: disabled
2010/01/16 11:19:56  20031 s   cs378x: disabled
2010/01/16 11:19:56  20031 s   newcamd: initialized (fd=8, port=34000, crypted)
2010/01/16 11:19:56  20031 s   CAID: 0919
2010/01/16 11:19:56  20031 s   provid #0: 000000
2010/01/16 11:19:56  20031 s   radegast: disabled
2010/01/16 11:19:56  20031 s   resolver thread started
2010/01/16 11:19:56  20031 s   logger started (pid=20034)
2010/01/16 11:19:56  20031 s   resolver started (pid=20035, delay=30 sec)
2010/01/16 11:19:56  20031 s   http started (pid=20036)
2010/01/16 11:19:56  20034 l   starting client -2 with ip 127.0.0.1
2010/01/16 11:19:56  20035 n   starting client -1 with ip 127.0.0.1
2010/01/16 11:19:56  20036 h   starting client 0 with ip 127.0.0.1
2010/01/16 11:19:56  20031 s   reader started (pid=20037, device=/dev/sci0)
2010/01/16 11:19:56  20031 s   Waiting for local card init ....
2010/01/16 11:19:56  20036 h   HTTP Server listening on port 8080
2010/01/16 11:19:56  20037 r03 starting client 0 with ip 127.0.0.1
2010/01/16 11:19:56  20037 r03 exit with signal 8
2010/01/16 11:19:56  20031 s   PANIC: reader lost !! (pid=20037)
2010/01/16 11:19:56  20031 s   exit with signal 1
2010/01/16 11:19:56  20031 s   cardserver down

comment:4 by alno, 11 years ago

Component: Reader
Resolution: fixed
Sensitive: unset
Status: newclosed

no feedback - assume fixed

Note: See TracTickets for help on using tickets.