I'm trying hard to debug the xmpp-2-SIP SIMPLE presence issue. I have
opensips 1.5.1 and Jabberd2 server installed on same physical box. I have
configured pua_xmpp, pua and xmpp module on used the example config given
for pua_xmpp module. I'm able to send MESSAGE back and forth between sip and
xmpp buddy. XMPP (Pidgin) client can detect the presence of sip buddy. But
The SIP Client (opensips server ) is not getting any kind of presence status
from xmpp server. I get the below error when running this setup. I'm not
sure if opensips server is subscribing to the xmpp buddy first of all. When
the XMPP buddy goes offline/online I can see nothing (no debug info) being
printed on the console of openeips server.

Please any one , please help to debug this xmpp to sip cominication issue. I
really apprecaite your help.

On Fri, Jun 26, 2009 at 11:03 AM, mani sivaraman <mani.opens...@gmail.com>wrote:

> The space is presence only here in the email (due to some formatting
> issue). The cfg file on opensips server does not have any space in between.
> I get presence.winfo NOTIFY. I'm missing only the presence NOTIFY. I see the
> repeated error like this one
>
> ERROR:presence:get_stored_info: record not found in hash_table
> ERROR:presence:handle_subscribe: getting stored info
>
> In the below logs, I always see "for event presence.winfo", but no "for
> event presence". This means that there are is lot of activity for watcher
> Info Subscribe and NOTIFY. But nothing for "presence" event. Also the method
> pua_xmpp_req_winfo sounds more like this will send subscribe/notify for
> winfo, not for preesnce event. IS there a seperate method to call to request
> subscribe for preesnce event. Or do you call presence subscribe in this same
> function.
>
> This could be the reason why there are no SUBSCRIBEs or presence NOTIFIEs
> back. Please tell me what this error is, os that I can try to debug this.
> Coudl you do paid support for setting up pua_xmpp module ? Or If you can't
> could you point any one else who can do this. I'm under pressure to complete
> this. Any
>
> information reg. consultation is appreciated.
>
> Here is the full debug.
>
> Listening on
>              udp: 172.16.0.139 [172.16.0.139]:5060
> Aliases:
>              *: sips01.smithmicro.com:*
>
> Jun 26 10:41:27 [25843] NOTICE:presence:child_init: init_child [0]  pid
> [25843]
> sips01:/usr/local/etc/opensips# Jun 26 10:42:47 [25845]
> INFO:presence:send_notify_request: NOTIFY sip:jabb1*xmpp.smithm icro.com@
> sip-xmpp.smithmicro.com via
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:rbox...@sip s01.smithmicro.com for event presence
> Jun 26 10:42:47 [25847] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb1*xmpp.smithmicro....@sip-xmpp. smithmicro.com>
> Jun 26 10:42:47 [25847] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:42:47 [25846] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com  via sip:jabb1*
> xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event  presence
> Jun 26 10:42:47 [25844] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb1*xmpp.smithmicro....@sip-xmpp. smithmicro.com>
> Jun 26 10:42:47 [25844] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:43:03 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:43:03 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:43:03 [25846] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:43:03 [25846] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:43:03 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:43:03 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:43:03 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com  via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:43:03 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com  via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:43:04 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com  via
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:rbox...@sips01.smithmicro.com <sip%3arbox...@sips01.smithmicro.com>for 
> event pre sence
> Jun 26 10:43:04 [25844] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb2*xmpp.smithmicro....@sip-xmpp. smithmicro.com>
> Jun 26 10:43:04 [25844] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:43:04 [25846] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com  via
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event  presence
> Jun 26 10:43:04 [25844] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb2*xmpp.smithmicro....@sip-xmpp. smithmicro.com>
> Jun 26 10:43:04 [25844] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> sips01:/usr/local/etc/opensips# Jun 26 10:44:39 [25844]
> ERROR:presence:get_stored_info: record not found in hash_table
> Jun 26 10:44:39 [25844] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:44:39 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:44:39 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:44:39 [25844] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:44:39 [25844] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:44:39 [25845] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:44:39 [25845] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:44:39 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:44:39 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:44:39 [25847] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:45:20 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:jabb1*
> xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence
> Jun 26 10:45:20 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com>
> Jun 26 10:45:20 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:45:20 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence
> Jun 26 10:45:20 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com>
> Jun 26 10:45:20 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:45:20 [25846] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of 
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence.winfo
> Jun 26 10:45:20 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of 
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence.winfo
> Jun 26 10:45:20 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of 
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence
> Jun 26 10:45:20 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of sip:mani_openfire*dsdev-xmpp.smsi....@sip-xmpp.smithmicro.comfor 
> event presence
> Jun 26 10:45:20 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:mani_openfire*dsdev-xmpp.smsi....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:mani_openfire*dsdev-xmpp.smsi.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:45:21 [25847] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com for
> event presence
> Jun 26 10:45:21 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:45:21 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:45:21 [25847] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:45:21 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com for
> event presence
> Jun 26 10:45:21 [25845] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:45:21 [25845] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:45:21 [25846] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:45:21 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on
> behalf of 
> sip:rbox...@sips01.smithmicro.com<sip%3arbox...@sips01.smithmicro.com>for 
> event presence
> Jun 26 10:45:24 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence
> Jun 26 10:45:24 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com on behalf of
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence
> Jun 26 10:45:24 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com>
> Jun 26 10:45:24 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:45:24 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'To' header ALREADY
> PARSED:<sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com>
> Jun 26 10:45:24 [25846] ERROR:pua_xmpp:Notify2Xmpp: 'From' header not
> parsed
> Jun 26 10:45:24 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>via
>  sip:msivara...@172.16.1.125:7675;transport=udp
> on behalf of 
> sip:msivara...@sips01.smithmicro.com<sip%3amsivara...@sips01.smithmicro.com>for
>  event presence
> Jun 26 10:46:14 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:46:14 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:46:14 [25845] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:46:14 [25845] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:46:14 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:46:14 [25847] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:46:14 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:46:14 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:47:49 [25844] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:47:49 [25844] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:47:49 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:47:49 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:47:49 [25844] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:47:49 [25844] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:47:49 [25845] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:47:49 [25846] INFO:presence:send_notify_request: NOTIFY
> sip:jabb1*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb1*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:47:49 [25847] INFO:presence:send_notify_request: NOTIFY
> sip:jabb2*xmpp.smithmicro....@sip-xmpp.smithmicro.com via sip:
> 172.16.0.139:5060 on behalf of sip:jabb2*xmpp.smithmicro.com@
> sip-xmpp.smithmicro.com for event presence.winfo
> Jun 26 10:49:25 [25847] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:49:25 [25847] ERROR:presence:handle_subscribe: getting stored
> info
> Jun 26 10:49:25 [25846] ERROR:presence:get_stored_info: record not found in
> hash_table
> Jun 26 10:49:25 [25846] ERROR:presence:handle_subscribe: getting stored
> info
>
>
_______________________________________________
Users mailing list
Users@lists.opensips.org
http://lists.opensips.org/cgi-bin/mailman/listinfo/users

Reply via email to