Solved: srcp bug - 5300 OK

Moderator: Moderators

Solved: srcp bug - 5300 OK

Postby Richard-TX » 07.06.2013, 15:16

I was running 5300 and there are no problems with that.

I upgraded to 5397 and when I start rocrail, messages scroll by at an insane rate.

Ultimately it crashes srcpd. I see rocrail is stuck in a loop.

here is an excerpt



.
.
.
102 INFO 1 LOCK GA 466 0
102 INFO 1 LOCK GA 467 0
102 INFO 1 LOCK GA 468 0
.
.
then srcpd crashes and rocrail says:

Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
.
.
.
.


I monitored the srcpd info channel and saw this:

1370612863.527 200 OK GO 4
1370612845.921 100 INFO 0 DESCRIPTION SESSION SERVER TIME GM
1370612845.531 101 INFO 0 TIME 0 0
1370612845.930 100 INFO 1 DESCRIPTION GA GL FB SM POWER LOCK DESCRIPTION
1370612845.930 100 INFO 1 POWER ON AUTO POWER ON
1370612848.485 101 INFO 1 GA 40 P
1370612848.485 100 INFO 1 GA 40 1 1
1370612845.930 100 INFO 2 DESCRIPTION GA GL FB SM POWER LOCK DESCRIPTION
1370612845.930 100 INFO 2 POWER ON AUTO POWER ON
1370612847.280 100 INFO 2 FB 1 1
1370612847.290 100 INFO 2 FB 8 1
1370612847.296 100 INFO 2 FB 12 1
1370612847.297 100 INFO 2 FB 13 1
1370612847.300 100 INFO 2 FB 15 1
1370612845.945 100 INFO 3 DESCRIPTION GA GL FB SM POWER LOCK DESCRIPTION
1370612845.945 100 INFO 3 POWER ON AUTO POWER ON
1370612845.947 100 INFO 4 DESCRIPTION GA GL FB SM POWER LOCK DESCRIPTION
1370612845.947 100 INFO 4 POWER ON AUTO POWER ON
1370612874.176 101 INFO 0 SESSION 5 INFO
1370612874.639 102 INFO 1 LOCK GA 1 0
1370612874.641 102 INFO 1 LOCK GA 2 0
1370612874.641 102 INFO 1 LOCK GA 3 0
1370612874.643 102 INFO 1 LOCK GA 4 0
1370612874.643 102 INFO 1 LOCK GA 5 0
1370612874.643 102 INFO 1 LOCK GA 6 0
1370612874.643 102 INFO 1 LOCK GA 7 0
1370612874.643 102 INFO 1 LOCK GA 8 0
1370612874.651 102 INFO 1 LOCK GA 9 0
1370612874.651 102 INFO 1 LOCK GA 10 0
1370612874.651 102 INFO 1 LOCK GA 11 0
.
.
.
.
.


Rob, if you need more data, let me know. The rocrail trace isn't too informative because it fills up (exceeds file size limit) so quickly.

Richard
You do not have the required permissions to view the files attached to this post.
Last edited by Richard-TX on 09.06.2013, 08:44, edited 1 time in total.
Richard-TX
 

Postby rjversluis » 07.06.2013, 15:30

fixed in 5393.
Best Regards, Rob.
:!: PS: Do not forget to attach the usual files.
:!: PS: Nicht vergessen die übliche Dateien an zu hängen.
[ macOS - Linux] - [ N: CBus - CAN-GCA ] - [ 0: RocNetNode - GCA-Pi ]
rjversluis
Site Admin
 

Postby Richard-TX » 07.06.2013, 15:35

Fantastic!!!!


Thanks Rob!
Richard-TX
 

Postby rjversluis » 07.06.2013, 15:38

SRCP became two sub libraries: TCP and Serial.
So I touched a lot of things.
The serial connection support is for an Arduino project.


http://wiki.rocrail.net/doku.php?id=srcp-en
http://forum.rocrail.net/viewtopic.php?t=5930
Best Regards, Rob.
:!: PS: Do not forget to attach the usual files.
:!: PS: Nicht vergessen die übliche Dateien an zu hängen.
[ macOS - Linux] - [ N: CBus - CAN-GCA ] - [ 0: RocNetNode - GCA-Pi ]
rjversluis
Site Admin
 

Postby Richard-TX » 07.06.2013, 23:26

I was wondering why anyone would use srcpd over serial lines. It would not be my choice.

Here is an interesting fact.

There are actually 3 I/O buses on the Raspberry Pi. One SPI bus and two I2C buses. With two I2c buses, that means that there could be almost 2000 ports that the Rpi can control.

Imagine 1,984 servos controlled by a single Rpi.

One can control an Arduino from a Raspberry using the SPI bus.

On my project I wil going to have one I2C bus controlling the switch servos and the other I2c bus controlling the lights.
Richard-TX
 

Postby Richard-TX » 08.06.2013, 05:13

Sorry Rob, not fixed.

1370612874.639 102 INFO 1 LOCK GA 1 0
1370612874.641 102 INFO 1 LOCK GA 2 0
1370612874.641 102 INFO 1 LOCK GA 3 0
1370612874.643 102 INFO 1 LOCK GA 4 0
1370612874.643 102 INFO 1 LOCK GA 5 0
1370612874.643 102 INFO 1 LOCK GA 6 0
.
.
.
.
Richard-TX
 

Postby rjversluis » 08.06.2013, 06:07

What is wrong with those commands?
Its INFO.

I only fixed this:

Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
Other side has closed connection.
.
.
.


BTW: You forgot to attach traces.
Best Regards, Rob.
:!: PS: Do not forget to attach the usual files.
:!: PS: Nicht vergessen die übliche Dateien an zu hängen.
[ macOS - Linux] - [ N: CBus - CAN-GCA ] - [ 0: RocNetNode - GCA-Pi ]
rjversluis
Site Admin
 

Postby Richard-TX » 08.06.2013, 13:25

here it is
You do not have the required permissions to view the files attached to this post.
Richard-TX
 

Postby Richard-TX » 08.06.2013, 14:03

I finally got a trace that may be meaningful.

It was not easy. Grabbing the beginning of something that is generating 500 messages a second is a challenge.
You do not have the required permissions to view the files attached to this post.
Richard-TX
 

Postby rjversluis » 08.06.2013, 14:14

I still do not get your point.
Which lines are offending?

BTW: Debug trace level should be switch off if you post trace files.
Best Regards, Rob.
:!: PS: Do not forget to attach the usual files.
:!: PS: Nicht vergessen die übliche Dateien an zu hängen.
[ macOS - Linux] - [ N: CBus - CAN-GCA ] - [ 0: RocNetNode - GCA-Pi ]
rjversluis
Site Admin
 

Postby Richard-TX » 08.06.2013, 14:24

What is happening is that the lock messages are out of control.


In just a few seconds I am up to:


.
.
.

foreader: [1370697792.358 102 INFO 1 LOCK GA 1619 0 ]
inforeader: [1370697792.358 102 INFO 1 LOCK GA 1620 0 ]
inforeader: [1370697792.358 102 INFO 1 LOCK GA 1621 0 ]
inforeader: [1370697792.358 102 INFO 1 LOCK GA 1622 0 ]
inforeader: [1370697792.358 102 INFO 1 LOCK GA 1623 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1624 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1625 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1626 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1627 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1628 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1629 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1630 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1631 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1632 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1633 0 ]
inforeader: [1370697792.359 102 INFO 1 LOCK GA 1634 0 ]
.
.
.
.
Richard-TX
 

Postby rjversluis » 08.06.2013, 14:28

where do these LOCK message come from? SRCPD?
Rocrail does not generate those lines.
Best Regards, Rob.
:!: PS: Do not forget to attach the usual files.
:!: PS: Nicht vergessen die übliche Dateien an zu hängen.
[ macOS - Linux] - [ N: CBus - CAN-GCA ] - [ 0: RocNetNode - GCA-Pi ]
rjversluis
Site Admin
 

Postby Richard-TX » 08.06.2013, 14:31

rjversluis wrote:I still do not get your point.
Which lines are offending?

BTW: Debug trace level should be switch off if you post trace files.


Debug trace level is grayed out Rob. I have trace level "info" checked.
Richard-TX
 

Postby Richard-TX » 08.06.2013, 14:34

rjversluis wrote:where do these LOCK message come from? SRCPD?
Rocrail does not generate those lines.


Give me a few minutes for me find out what is really going on.
Richard-TX
 

Postby rjversluis » 08.06.2013, 14:35

what triggers your srcpd to send "INFO 1 LOCK GA" ?

[EDIT]
I'm using the original srcpd and it does not send your LOCK lines...
Best Regards, Rob.
:!: PS: Do not forget to attach the usual files.
:!: PS: Nicht vergessen die übliche Dateien an zu hängen.
[ macOS - Linux] - [ N: CBus - CAN-GCA ] - [ 0: RocNetNode - GCA-Pi ]
rjversluis
Site Admin
 

Next

Return to srcp