[OpenSER-Users] Log errors when processing a contact list with RLSmodule

Pablo Guijarro Enríquez pge at moviquity.com
Thu Apr 17 18:03:51 CEST 2008


Thanks, Anca, that was it :)

Now presence information is shown in both the SIP and the XMPP client, but
there are still some estrange behaviours in openser.

First, when I start the SIP client with the XMPP client already online, some
kind of loop occurs, as you can see in the log attached. The following
NOTIFY message is sent again and again for a while, changing just the
from-tag, branch and call-id:

NOTIFY sip:pge354*xmpp.domain at xmpp-gw SIP/2.0
Via: SIP/2.0/UDP 10.95.43.31;branch=z9hG4bK1d12.1b727435.0
To: sip:pge354*xmpp.domain at xmpp-gw;tag=533cb9e91f4b999cf76861cbb9ed54ed-38b3
From: sip:354354 at openser.domain;tag=10.1700.1208442687.20
CSeq: 2 NOTIFY
Call-ID: 6ce7eb86-1701 at 10.95.43.31
Content-Length: 471
User-Agent: OpenSER (1.3.1-notls (i386/linux))
Max-Forwards: 70
Event: presence
Contact: <sip:10.95.43.31>
Subscription-State: active;expires=2631
Content-Type: application/pidf+xml
<...>


The first couple of them get the following response, but not all the others,
that get no answer:

SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.95.43.31;branch=z9hG4bK1d12.1b727435.0
To: sip:pge354*xmpp.domain at xmpp-gw;tag=533cb9e91f4b999cf76861cbb9ed54ed-38b3
From: sip:354354 at openser.domain;tag=10.1700.1208442687.20
CSeq: 2 NOTIFY
Call-ID: 6ce7eb86-1701 at 10.95.43.31
Server: OpenSER (1.3.1-notls (i386/linux))
Content-Length: 0


It seems that the responses are not taken into account, or maybe it is
related with the other thing I find weird, the fact that pua and presentity
tables in Mysql database grows continuously with registries that are much
like already existing ones. Sample of the pua table:

| 18432 | sip:pge354*xmpp.domain at xmpp-gw    |         |     1 | 1208449465 |
0 |    8 | a.1208441749.1702.41.0 |            |                      |
|                       |                                       |    0 |
|                      |       0 |               |

| 18428 | sip:pge354*xmpp.domain at xmpp-gw    |         |     1 | 1208449357 |
0 |    8 | a.1208441749.1701.25.0 | 0xbf9787bc |                      |
|                       |                                       |    0 |
NULL         |                      |       0 |               |

| 18429 | sip:354354 at openser.domain |         |     1 | 1208449356 |
0 |   16 |                        |            |
sip:pge354*xmpp.domain at xmpp-gw | 6ce7eb87-1700 at 10.95.43.31 |
10.1700.1208445755.35 | 533cb9e91f4b999cf76861cbb9ed54ed-9c6c |   10 | NULL
|                      |       0 |               |

| 18420 | sip:pge354*xmpp.domain at xmpp-gw    |         |     1 | 1208446132 |
0 |    8 | a.1208441749.1700.12.0 | 0xbf9787bc |                      |
|                       |                                       |    0 |
|                      |       0 |               |

| 18427 | sip:800094 at openser.domain |         |     1 | 1208449357 |
1208449345 |   16 |                        |            |
sip:pge354*xmpp.domain at xmpp-gw | 6ce7eb87-1701 at 10.95.43.31 |
10.1703.1208445756.21 | 533cb9e91f4b999cf76861cbb9ed54ed-463c |   10 |
|                      |       0 |               |

| 18426 | sip:800094 at openser.domain |         |     1 | 1208449357 |
1208449355 |   16 |                        |            |
sip:pge354*xmpp.domain at xmpp-gw | 6ce7eb9f                  |
10.1700.1208445756.36 | 533cb9e91f4b999cf76861cbb9ed54ed-6582 |   10 |
| sip:pge354*xmpp.domain at xmpp-gw |       0 |               |

| 18423 | sip:pge354*xmpp.domain at xmpp-gw    |         |     1 | 1208446287 |
0 |    8 | a.1208441749.1701.17.0 |            |                      |
|                       |                                       |    0 |
|                      |       0 |               |

| 18425 | sip:354354 at openser.domain |         |     1 | 1208449228 |
0 |   16 |                        |            |
sip:pge354*xmpp.domain at xmpp-gw | 6ce7eb98                  |
10.1700.1208445628.32 | 533cb9e91f4b999cf76861cbb9ed54ed-da39 |   10 |
| sip:pge354*xmpp.domain at xmpp-gw |       0 |               |

| 18438 | sip:354354 at openser.domain |         |     1 | 1208449387 |
0 |   16 |                        |            |
sip:pge354*xmpp.domain at xmpp-gw | 6ce7eb91-1703 at 10.95.43.31 |
10.1703.1208445918.32 | 533cb9e91f4b999cf76861cbb9ed54ed-7095 |   10 | NULL
|                      |       0 |               


Every time the XMPP client changes its presence state, one registry is added
to the presentity table. Sample:

| 783 | pge354*xmpp.domain | xmpp-gw           | presence |
a.1208441749.1701.36.1 | 1208449478 |    1208445878 | <?xml version="1.0"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf"
xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model"
xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid"
xmlns:c="urn:ietf:params:xml:ns:pidf:cipid"
entity="pres:pge354*xmpp.domain at xmpp-gw">
  <tuple id="0xbf9787bc">
    <status>
      <basic>open</basic>
    </status>
  </tuple>
</presence>
 
|
| 785 | pge354*xmpp.domain | xmpp-gw           | presence |
a.1208441749.1702.45.0 | 1208449517 |    1208445917 | <?xml version="1.0"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf"
xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model"
xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid"
xmlns:c="urn:ietf:params:xml:ns:pidf:cipid"
entity="pres:pge354*xmpp.domain at xmpp-gw">
  <tuple id="0xbf9787bc">
    <status>
      <basic>open</basic>
    </status>
  </tuple>
</presence>
 
|
| 786 | pge354*xmpp.domain | xmpp-gw           | presence |
a.1208441749.1702.52.1 | 1208450140 |    1208446540 | <?xml version="1.0"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf"
xmlns:dm="urn:ietf:params:xml:ns:pidf:data-model"
xmlns:rpid="urn:ietf:params:xml:ns:pidf:rpid"
xmlns:c="urn:ietf:params:xml:ns:pidf:cipid"
entity="pres:pge354*xmpp.domain at xmpp-gw">
  <tuple id="0xbf9787bc">
    <status>
      <basic>open</basic>
    </status>
  </tuple>
  <note>away</note>
  <person id="0xbf9787bc">
    <activities/>
    <note>away</note>
  </person>
</presence>


How can I solve all this issues?

Regards,
Pablo


-----Mensaje original-----
De: Pablo Guijarro Enríquez [mailto:pge at moviquity.com] 
Enviado el: jueves, 17 de abril de 2008 10:14
Para: 'Anca Vamanu'
CC: 'users at lists.openser.org'
Asunto: RE: [OpenSER-Users] Log errors when processing a contact list with
RLSmodule

Hi Anca,

Oops, you are right, sorry :p Now errors have disappeared, but there is
something wrong. The notify messages sent as a result of the subscribe ones
generated by the rls module for each of the contacts in the list are
rejected with 404 responses. For example:


SUBSCRIBE sip:800129 at comm.hi.inet SIP/2.0
Via: SIP/2.0/UDP 10.95.43.31;branch=z9hG4bK16cd.9a07a1d1.0
To: sip:800129 at comm.hi.inet
From: sip:354354 at comm.hi.inet;tag=533cb9e91f4b999cf76861cbb9ed54ed-1a1a
CSeq: 10 SUBSCRIBE
Call-ID: 42e7a6e1-31560 at 10.95.43.31
Content-Length: 0
User-Agent: OpenSER (1.3.1-notls (i386/linux))
Max-Forwards: 70
Event: presence
Contact: <sip:10.95.43.31>
Expires: 3610
Max-Forwards: 70
Support: eventlist


NOTIFY sip:10.95.43.31 SIP/2.0
Via: SIP/2.0/UDP 10.95.43.31;branch=z9hG4bK975a.bb2427c3.0
To: sip:354354 at comm.hi.inet;tag=533cb9e91f4b999cf76861cbb9ed54ed-1a1a
From: sip:800129 at comm.hi.inet;tag=10.31561.1208325872.1
CSeq: 1 NOTIFY
Call-ID: 42e7a6e1-31560 at 10.95.43.31
Content-Length: 0
User-Agent: OpenSER (1.3.1-notls (i386/linux))
Max-Forwards: 70
Event: presence
Contact: <sip:10.95.43.31>
Subscription-State: active;expires=3600


SIP/2.0 404 Not here
Via: SIP/2.0/UDP 10.95.43.31;branch=z9hG4bK975a.bb2427c3.0
To: sip:354354 at comm.hi.inet;tag=533cb9e91f4b999cf76861cbb9ed54ed-1a1a
From: sip:800129 at comm.hi.inet;tag=10.31561.1208325872.1
CSeq: 1 NOTIFY
Call-ID: 42e7a6e1-31560 at 10.95.43.31
Server: OpenSER (1.3.1-notls (i386/linux))
Content-Length: 0


What could be the reason for this to happen? It seems that openser does not
want to handle that message or something... I have tried setting an alias
for 10.95.43.31 in openser configuration file, but that did not work either.

Log file is huge, so I cannot attach this whole part, just the end of it.
Feel free to ask whatever data you may want to ckeck.

Regards,
Pablo


-----Mensaje original-----
De: Anca Vamanu [mailto:anca at voice-system.ro] 
Enviado el: viernes, 11 de abril de 2008 15:41
Para: Pablo Guijarro Enríquez
CC: users at lists.openser.org
Asunto: Re: [OpenSER-Users] Log errors when processing a contact list with
RLS module

Hi Pablo,

It is exactly the same error you mentioned with pua_xmpp :). RLS also 
depends on pua and since you have changed it .. You need to run a 'make 
proper' in the rls module directory and then compile it again.

regards,
Anca


Pablo Guijarro Enríquez wrote:
>
> Hi,
>
>  
>
> I am running openser v1.3.1 and I cannot get the RLS module to work 
> properly when handling a contact list already retrieved from database. 
> Some errors related with the pua module appear in the log when the 
> server seems to be trying to generate the subscribe requests for each 
> of the contacts in the list (see attached, lines 60 to 62).
>
>  
>
> Apr 10 13:02:23 comm ./openser[20184]: ERROR:pua:subs_build_hdr: 
> getting event from list
>
> Apr 10 13:02:23 comm ./openser[20184]: ERROR:pua:send_subscribe: while 
> building extra headers
>
> Apr 10 13:02:23 comm ./openser[20184]: 
> ERROR:rls:process_list_and_exec:  infunction given as a parameter
>
>  
>
> Those requests are never sent. What could this be due to?
>
>  
>
> Thanks!
>
>  
>
> Pablo
>
>  
>
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> Users at lists.openser.org
> http://lists.openser.org/cgi-bin/mailman/listinfo/users
>   

-------------- next part --------------
A non-text attachment was scrubbed...
Name: ser1.log
Type: application/octet-stream
Size: 32369 bytes
Desc: not available
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20080417/fab6b6ae/attachment.obj>


More information about the sr-users mailing list