Hello All,

I am trying to SUBSCRIBE to a dialog state agent server for dialog state
events and I am getting a "900 Internal NUA Error" callback event (as shown
in the summary below), and the SUBSCRIBE message is never transmitted.
Earlier in the program (as is also shown below), I successfully implemented
a SUBSCRIBE to the SIP Proxy for message-summary events.

I am using sofia-sip version 1.12.4.  Any idea why this is happening?  Could
this be a bug?

Best Regards,
Jerry




su_init()
su_home_init(appl->home=0x1000d450)
su_root_create(magic=0x0)
su_port_create() called
su_port_create() returns 0x1008d6c0
su_root_threading(self=0x1008e0c8, enable=0)
nua_create(root=0x1008e0c8, callback=0x41ec1c, magic=0x10002370,
url='sip:206.80.111.23:5061')
nua_handle(nua=0x1008e150, hmagic=0x10002370,
url='sip:[EMAIL PROTECTED]:5060')
nua_register(nh=0x10092df8, SIPTAG_FROM(sip:[EMAIL PROTECTED]:5060),
SIPTAG_CONTACT(sip:[EMAIL PROTECTED]:5061),
         NUTAG_M_DISPLAY(4088661000))
nua_subscribe(nh=0x10093200,
         SIPTAG_FROM(sip:[EMAIL PROTECTED]:5060),
SIPTAG_EXPIRES(3600),
         SIPTAG_CONTACT(sip:[EMAIL PROTECTED]:5061),
SIPTAG_EVENT(message-summary),
         SIPTAG_ACCEPT(application/simple-message-summary))
nua_handle(nua=0x1008e150, hmagic=0x10002370,
url='sip:[EMAIL PROTECTED]:5060')
nua_notifier(nh=0x10093648, NUTAG_URL(sip:[EMAIL PROTECTED]:5061),
         SIPTAG_EVENT(dialog;sla;include-session-description),
         SIPTAG_CONTENT_TYPE(application/dialog-info+xml),
         SIPTAG_PAYLOAD(...)):
<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="0"
state="full" entity="sip:408Algorithmics/MIPS FPU Emulator v1.5
[EMAIL PROTECTED]:5060">
</dialog-info>

ce_ProcSipEventCallback: Rcvd event for nua=0x1008e150, magic=0x10002370,
nh=0x10093648, hmagic=0x10002370, sip=0x1009a444
   nua_i_subscription event: 200 OK (pMkData->mk=MK1=lineH=0x1008e150)
   tSubscriberState=nea_embryonic
nua_handle(nua=0x1008e150, hmagic=0x10002370, url='State_Agent
sip:[EMAIL PROTECTED])
nua_subscribe(nh=0x1009a2f0, SIPTAG_TO(State_Agent
sip:[EMAIL PROTECTED]:5096),
         SIPTAG_FROM(sip:[EMAIL PROTECTED]:5060),
SIPTAG_EXPIRES(3600),
         SIPTAG_CONTACT(sip:[EMAIL PROTECTED]:5061),
SIPTAG_EVENT(dialog;sla;include-session-description),
         SIPTAG_ACCEPT(application/dialog-info+xml))
nua: nua_subscribe: entering
nua: nua_event: entering
tport_wakeup_pri(0x1008fea0): events IN
tport_recv_event(0x1008fea0)
tport_recv_iovec(0x1008fea0) msg 0x1009f5a0 from (udp/206.80.111.23:5061)
has 65536 bytes, veclen = 1
tport_deliver(0x1008fea0): msg 0x1009f5a0 (503 bytes) from
udp/206.229.26.51:5061/sip next=(nil)
nta: received SUBSCRIBE sip:[EMAIL PROTECTED]:5061 SIP/2.0 (CSeq 3)
nta: canonizing sip:[EMAIL PROTECTED]:5061 with contact
nta: SUBSCRIBE (3) going to existing leg
nua: nua_stack_event: entering
nua(0x10093648): i_subscription 200 OK
tport_tsend(0x1008fea0) tpn = UDP/206.229.26.51:5096
tport_resolve addrinfo = 206.229.26.51:5096
tport_by_addrinfo(0x1008fea0): not found by name UDP/206.229.26.51:5096
tport_vsend(0x1008fea0): 417 bytes of 417 to UDP/206.229.26.51:5096
tport_vsend returned 417
nta: sent 200 OK for SUBSCRIBE (3)
nta: timer E fired, retransmit NOTIFY (9624874)
tport_tsend(0x1008fea0) tpn = */206.229.26.51:5096
tport_resolve addrinfo = 206.229.26.51:5096
tport_by_addrinfo(0x1008fea0): not found by name */206.229.26.51:5096
tport_vsend(0x1008fea0): 762 bytes of 762 to */206.229.26.51:5096
tport_vsend returned 762
nta: resent NOTIFY (9624874) to */206.229.26.51:5096
tport_release(0x1008fea0): 0x1009b738 by 0x1009c040 with (nil)
tport_pend(0x1008fea0): pending 0x1009b738 for udp/206.80.111.23:5061
(already 1)
tport_wakeup_pri(0x1008fea0): events IN
tport_recv_event(0x1008fea0)
tport_recv_iovec(0x1008fea0) msg 0x100a16b0 from (udp/206.80.111.23:5061)
has 65536 bytes, veclen = 1
tport_deliver(0x1008fea0): msg 0x100a16b0 (557 bytes) from
udp/206.229.26.51:5061/sip next=(nil)
nta: received NOTIFY sip:[EMAIL PROTECTED]:5061 SIP/2.0 (CSeq 2)
nta: canonizing sip:[EMAIL PROTECTED]:5061 with contact
nta: NOTIFY (2) going to existing leg
nua: nua_stack_process_request: entering
nua: nua_stack_process_notify: entering
tport_tsend(0x1008fea0) tpn = UDP/206.229.26.51:5097
tport_resolve addrinfo = 206.229.26.51:5097
tport_by_addrinfo(0x1008fea0): not found by name UDP/206.229.26.51:5097
tport_vsend(0x1008fea0): 479 bytes of 479 to UDP/206.229.26.51:5097
tport_vsend returned 479
nta: sent 200 OK for NOTIFY (2)
nua: nua_stack_event: entering
nua(0x10093200): i_notify 200 OK
nua(0x10093200): nua_stack_process_notify: active ()
nua(): refresh subscribe after 1724 seconds (in [900..2700])
nta_outgoing_timer: 1/2 resent, 0/2 tout, 0/3 term, 0/5 free
tport_wakeup_pri(0x1008fea0): events IN
tport_recv_event(0x1008fea0)
tport_recv_iovec(0x1008fea0) msg 0x100a3158 from (udp/206.80.111.23:5061)
has 65536 bytes, veclen = 1
tport_deliver(0x1008fea0): msg 0x100a3158 (280 bytes) from
udp/206.229.26.51:5061/sip next=(nil)
nta: received 100 Trying for REGISTER (9624874)
nta: 100 Trying going to a transaction
nta: 100 Trying is duplicate response to 9624874 REGISTER
    Via: SIP/2.0/UDP 206.80.111.23:5061 ;branch=z9hG4bK3p37F9eDSQt7r
nua(0x1009a2f0): signal r_subscribe
nua: nua_stack_set_params: entering
soa_clone(static::0x1008e818, 0x1008e3b8, 0x1009a2f0) called
soa_set_params(static::0x100a3158, ...) called
soa_set_params(static::0x100a3158, ...) called
nua: nua_stack_event: entering
nua(0x1009a2f0): r_subscribe 900 Internal NUA Error
nua: nua_event: entering

ce_ProcSipEventCallback: Rcvd event for nua=0x1008e150, magic=0x10002370,
nh=0x10093648, hmagic=0x10002370, sip=0x1009f63c
   nua_i_subscription event: 200 OK (pMkData->mk=MK1=lineH=0x1008e150)
   DEBUG_SIP_MSG: From: State_Agent sip:[EMAIL PROTECTED]
   tSubscriberState=nea_embryonic
ce_LaHasSubscribed: mkData[LA1].blaSub2SrvrH=0x1009a2f0
   Handled Event Locally...
nua: nua_event: entering

ce_ProcSipEventCallback: Rcvd event for nua=0x1008e150, magic=0x10002370,
nh=0x10093200, hmagic=0x10002370, sip=0x100a174c
   nua_i_notify event: 200 OK (pMkData->mk=MK1=lineH=0x1008e150)
tport_wakeup_pri(0x1008fea0): events IN
tport_recv_event(0x1008fea0)
tport_recv_iovec(0x1008fea0) msg 0x100a3410 from (udp/206.80.111.23:5061)
has 65536 bytes, veclen = 1
tport_deliver(0x1008fea0): msg 0x100a3410 (392 bytes) from
udp/206.229.26.51:5061/sip next=(nil)
nta: received 200 OK for REGISTER (9624874)
nta: 200 OK going to a transaction
nta: 200 OK is duplicate response to 9624874 REGISTER
    Via: SIP/2.0/UDP 206.80.111.23:5061 ;branch=z9hG4bK3p37F9eDSQt7r
tport_wakeup_pri(0x1008fea0): events IN
tport_recv_event(0x1008fea0)
tport_recv_iovec(0x1008fea0) msg 0x100a3410 from (udp/206.80.111.23:5061)
has 65536 bytes, veclen = 1
tport_deliver(0x1008fea0): msg 0x100a3410 (385 bytes) from
udp/206.229.26.51:5061/sip next=(nil)
nta: received 100 Trying for SUBSCRIBE (9624874)
nta: 100 Trying going to a transaction
nta_outgoing: RTT is tport_release(0x1008fea0): 0x1009e080 by 0x1009e768
with 0x100a3410 (preliminary)
nua: nua_event: entering

ce_ProcSipEventCallback: Rcvd event for nua=0x1008e150, magic=0x10002370,
nh=0x1009a2f0, hmagic=0x10002370, sip=0x0
   nua_r_subscribe event: 900 Internal NUA Error
(pMkData->mk=MK1=lineH=0x1008e150)

<<attachment: winmail.dat>>

-------------------------------------------------------------------------
This SF.net email is sponsored by DB2 Express
Download DB2 Express C - the FREE version of DB2 express and take
control of your XML. No limits. Just data. Click to get it now.
http://sourceforge.net/powerbar/db2/
_______________________________________________
Sofia-sip-devel mailing list
Sofia-sip-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/sofia-sip-devel

Reply via email to