[SIP Beyond VoIP] Can not add participant to Sylk Server

[Onur DOLU]

Any root cause?

onur,

-----Original Message-----
From: Saúl Ibarra Corretgé [mailto:saul at ag-projects.com] 
Sent: Friday, October 19, 2012 5:06 PM
To: Onur DOLU
Cc: sipbeyondvoip at lists.ag-projects.com
Subject: Re: [SIP Beyond VoIP] Can not add participant to Sylk Server


On Oct 19, 2012, at 12:03 PM, Onur DOLU wrote:

> Hi all,
>  
> When I try to add participant from sipsimple client, sylk server does not initiate INVITE to transferred party.
> (Note: REFER, initiated from sipsimple client, is proxied over my SIP PROXY & REGISTRAR to sylk server. I could paste REFER message that received by sylk server)
>  
> I see below logs on sylk servers core_trace.txt
>  
> 2012-10-19 15:42:48.763882 [sylk-server 16182] (5) sip_endpoint.c: Processing incoming message: Request msg REFER/cseq=13702 (rdata0x4b3b828)
> 2012-10-19 15:42:48.764233 [sylk-server 16182] (5)   tsx0x4a6acb8: Transaction created for Request msg REFER/cseq=13702 (rdata0x4b3b828)
> 2012-10-19 15:42:48.764419 [sylk-server 16182] (5)   tsx0x4a6acb8: Incoming Request msg REFER/cseq=13702 (rdata0x4b3b828) in state Null
> 2012-10-19 15:42:48.764547 [sylk-server 16182] (5)   tsx0x4a6acb8: State changed from Null to Trying, event=RX_MSG
> 2012-10-19 15:42:48.765276 [sylk-server 16182] (5)   dlg0x4b745d8: Transaction tsx0x4a6acb8 state changed to Trying
> 2012-10-19 15:42:48.765424 [sylk-server 16182] (5)   dlg0x4b745d8: UAS dialog created
> 2012-10-19 15:42:48.765611 [sylk-server 16182] (5)   dlg0x4b745d8: Session count inc to 1 by mod-core
> 2012-10-19 15:42:48.765964 [sylk-server 16182] (5)   dlg0x4b745d8: Module mod-evsub added as dialog usage, data=0x4be9be8
> 2012-10-19 15:42:48.766291 [sylk-server 16182] (5) evsub0x4bf69c8: UAS subscription created, using dialog dlg0x4b745d8
> 2012-10-19 15:42:48.766442 [sylk-server 16182] (5)   dlg0x4b745d8: Session count inc to 3 by mod-evsub
> 2012-10-19 15:42:48.766515 [sylk-server 16182] (5)       endpoint: Response msg 500/REFER/cseq=13702 (tdta0x4bf9740) created
> 2012-10-19 15:42:48.774067 [sylk-server 16182] (5)   dlg0x4b745d8: Sending Response msg 202/REFER/cseq=13702 (tdta0x4bf9740)
> 2012-10-19 15:42:48.774412 [sylk-server 16182] (5)   tsx0x4a6acb8: Sending Response msg 202/REFER/cseq=13702 (tdta0x4bf9740) in state Trying
> 2012-10-19 15:42:48.774702 [sylk-server 16182] (5)  sip_resolve.c: Target '47.168.85.116:5060' type=UDP resolved to '47.168.85.116:5060' type=UDP (UDP transport)
> 2012-10-19 15:42:48.775410 [sylk-server 16182] (5)   tsx0x4a6acb8: State changed from Trying to Completed, event=TX_MSG
> 2012-10-19 15:42:48.775914 [sylk-server 16182] (5)   dlg0x4b745d8: Transaction tsx0x4a6acb8 state changed to Completed
> 2012-10-19 15:42:48.776668 [sylk-server 16182] (5)       endpoint: Request msg NOTIFY/cseq=12481 (tdta0x7ff9b011f410) created.
> 2012-10-19 15:42:48.777182 [sylk-server 16182] (5)   dlg0x4b745d8: Sending Request msg NOTIFY/cseq=12481 (tdta0x7ff9b011f410)
> 2012-10-19 15:42:48.777269 [sylk-server 16182] (5) tsx0x7ff9b0113: Transaction created for Request msg NOTIFY/cseq=12480 (tdta0x7ff9b011f410)
> 2012-10-19 15:42:48.777348 [sylk-server 16182] (5) tsx0x7ff9b0113: Sending Request msg NOTIFY/cseq=12480 (tdta0x7ff9b011f410) in state Null
> 2012-10-19 15:42:48.777489 [sylk-server 16182] (5)  sip_resolve.c: Target '47.168.85.116:5060' type=Unspecified resolved to '47.168.85.116:5060' type=UDP (UDP transport)
> 2012-10-19 15:42:48.778363 [sylk-server 16182] (5) tsx0x7ff9b0113: State changed from Null to Calling, event=TX_MSG
> 2012-10-19 15:42:48.778442 [sylk-server 16182] (5)   dlg0x4b745d8: Transaction tsx0x7ff9b01132b8 state changed to Calling
> 2012-10-19 15:42:48.779256 [sylk-server 16182] (4) evsub0x4bf69c8: Subscription state changed NULL --> ACTIVE
> 2012-10-19 15:42:48.779656 [sylk-server 16182] (5) sip_endpoint.c: Processing incoming message: Response msg 100/NOTIFY/cseq=12480 (rdata0x4b3b828)
> 2012-10-19 15:42:48.779840 [sylk-server 16182] (5) tsx0x7ff9b0113: Incoming Response msg 100/NOTIFY/cseq=12480 (rdata0x4b3b828) in state Calling
> 2012-10-19 15:42:48.780120 [sylk-server 16182] (5) tsx0x7ff9b0113: State changed from Calling to Proceeding, event=RX_MSG
> 2012-10-19 15:42:48.780298 [sylk-server 16182] (5)   dlg0x4b745d8: Received Response msg 100/NOTIFY/cseq=12480 (rdata0x4b3b828)
> 2012-10-19 15:42:48.780730 [sylk-server 16182] (5)   dlg0x4b745d8: Transaction tsx0x7ff9b01132b8 state changed to Proceeding
> 2012-10-19 15:42:52.774908 [sylk-server 16182] (5) tsx0x7ff9b0113: Retransmit timer event
> 2012-10-19 15:42:52.775009 [sylk-server 16182] (5) tsx0x7ff9b0113: Retransmiting Request msg NOTIFY/cseq=12480 (tdta0x7ff9b011f410), count=0, restart?=1
> 2012-10-19 15:42:52.775827 [sylk-server 16182] (5) sip_endpoint.c: Processing incoming message: Response msg 100/NOTIFY/cseq=12480 (rdata0x4b3b828)
> 2012-10-19 15:42:52.776001 [sylk-server 16182] (5) tsx0x7ff9b0113: Incoming Response msg 100/NOTIFY/cseq=12480 (rdata0x4b3b828) in state Proceeding
> 2012-10-19 15:42:52.776146 [sylk-server 16182] (5) tsx0x7ff9b0113: State changed from Proceeding to Proceeding, event=RX_MSG
> 2012-10-19 15:42:52.776819 [sylk-server 16182] (5)   dlg0x4b745d8: Received Response msg 100/NOTIFY/cseq=12480 (rdata0x4b3b828)
> 2012-10-19 15:42:52.776913 [sylk-server 16182] (5)   dlg0x4b745d8: Transaction tsx0x7ff9b01132b8 state changed to Proceeding
>  

Please attach the SIP and notifications traces, the core trace doesn't show what could be going wrong.


Regards,

--
Saúl Ibarra Corretgé
AG Projects



-------------- next part --------------
An embedded and charset-unspecified text was scrubbed...
Name: sylkREFERsipTraces.txt
URL: <http://lists.ag-projects.com/pipermail/sipbeyondvoip/attachments/20121022/cabfa695/attachment-0002.txt>
-------------- next part --------------
An embedded and charset-unspecified text was scrubbed...
Name: sylkREFERntfTraces.txt
URL: <http://lists.ag-projects.com/pipermail/sipbeyondvoip/attachments/20121022/cabfa695/attachment-0003.txt>