Thread: [OpenSBC] hold call in Full mode
Brought to you by:
joegenbaclor
|
From: OpenSBC F. <ope...@op...> - 2009-02-04 07:46:58
|
Hi all, i'm new to using OpenSBC. i have questions about holding a call in my case, i use OpenSBC as a SIP proxy (run in Full Mode). And there are two SIP softphone registered to it. Suppose the two phones are phoneA ([ph...@te...]) and phoneB([ph...@te...]) the case is that phoneA dial to phoneB and the dialog is established already and they can talk to each other. The problem is that when the user press "HOLD" button in phoneA, phoneB doesn't know the call is held by phoneA. i read the log from both soft phones. I find that after phoneA sending re-Invite to proxy and the proxy reply OK to phoneA but the proxy doesn't send the re-Invite request to phoneB, so phoneB doesn't know phoneA requesting call hold. i want to ask what is the reason for the proxy not sending request to phoneB and how can i fix it such that holding call can be successful. Thank you very much in advance |
|
From: Joegen B. <jb...@so...> - 2009-02-04 09:06:53
|
OpenSBC does not generate a 200 Ok for INVITE locally. It must come from the UAS before it gets relayed. Why don't you post the level 5 OpenSBC log so we could see what really happened. Joegen -------------------------------------------------- From: "OpenSBC Forum" <ope...@op...> Sent: Wednesday, February 04, 2009 3:46 PM To: <ope...@li...> Subject: [OpenSBC] hold call in Full mode > > Hi all, i'm new to using OpenSBC. i have questions about holding a call > > > in my case, i use OpenSBC as a SIP proxy (run in Full Mode). And there are > two SIP softphone registered to it. > > > Suppose the two phones are phoneA ([ph...@te...]) and > phoneB([ph...@te...]) > > > the case is that phoneA dial to phoneB and the dialog is established > already and they can talk to each other. The problem is that when the user > press "HOLD" button in phoneA, phoneB doesn't know the call is held by > phoneA. > > > i read the log from both soft phones. I find that after phoneA sending > re-Invite to proxy and the proxy reply OK to phoneA but the proxy doesn't > send the re-Invite request to phoneB, so phoneB doesn't know phoneA > requesting call hold. > > > i want to ask what is the reason for the proxy not sending request to > phoneB and how can i fix it such that holding call can be successful. > > > Thank you very much in advance > > |
|
From: OpenSBC F. <ope...@op...> - 2009-02-05 04:05:44
|
Thank you for replying me Below is the log about the case. what i have done is 1. [kw...@ta...] makes a call to [kwa...@ta...] 2. then, [kwa...@ta...] accept the call. then they talk each other 3. [kw...@ta...] holds the call, however, [kwa...@ta...] does not know the call is held by remote party. 4. [kw...@ta...] unholds the call 5 [kw...@ta...] hangs up the call hope that you can help me. thank you in advance 2009/02/05 11:48:30.453 INF: [CID=0x0a20] <<< INVITE sip:kwa...@ta... SIP/2.0 SRC: 172.17.7.90:49152:UDP enc=0 bytes=883 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] To: <sip:kwa...@ta...> 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000021498a62280000215b00000005 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152> 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs) 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Max-Forwards: 70 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Supported: replaces, norefersub, timer 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Content-Type: application/sdp 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Content-Length: 362 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] v=0 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] o=- 3442794664 3442794664 IN IP4 172.17.7.90 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] s=SJphone 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] t=0 0 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] m=audio 49154 RTP/AVP 3 97 98 8 0 101 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=rtpmap:97 iLBC/8000 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=fmtp:98 mode=20 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=rtpmap:8 PCMA/8000 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=rtpmap:0 PCMU/8000 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=fmtp:101 0-16 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=setup:active 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] a=sendrecv 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Finding transaction for INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE 2009/02/05 11:48:30.453 DTL: [CID=0x0a20] IST(264062016) *** CREATED *** - IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE 2009/02/05 11:48:30.453 DTL: [CID=0x0a20] IST(264062016) Event(SIPMessage) - INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] TRANSACTION: (IST) INVITE sip:kwa...@ta... SIP/2.0 State: 0 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(INVITE sip:kwa...@ta... SIP/2.0) 2009/02/05 11:48:30.453 DTL: [CID=0x0a20] IST(264062016) StateIdle->StateProceeding 2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Event: B2BUserAgent::ProcessEvent( INVITE sip:kwa...@ta... SIP/2.0 ) 2009/02/05 11:48:30.468 DTL: [CID=0x0a20] Event: ---> Inbound - INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:30.468 DBG: [CID=0x0a20] Session CREATED 2009/02/05 11:48:30.468 INF: [CID=0x0a20] *** CREATED (UAS) CALL *** 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:30.468 DBG: [CID=0x0e7d] Multidirectional Session CREATED 2009/02/05 11:48:30.468 DBG: [CID=0x0e7d] B2BUAConnection Created 0x00D5A978 2009/02/05 11:48:30.468 DBG: [CID=0x0e7d] *** COUNTERS *** (Constructor)ICT=0 NICT=0 IST=1 NIST=4 TIMERS=8 CALL=1 CONN=1 REG=0 RTP=0 QUEUE=0 CACHE=1 GC=5 TOTALCONN=1 TOTALREG=0 TOTALSZR=0 AVGDUR=0 HIGHDUR=0 IDLETIME=0 2009/02/05 11:48:30.484 INF: [CID=0x0a20] *** SINGLE REGISTRATION FOUND *** -->> Callee: sip:kw...@ta... AOR: sip:kwa...@ta... BINDING:sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 2009/02/05 11:48:30.484 DBG: [CID=0x0a20] *** MESSAGE ARRIVAL *** for SIP Session 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:30.484 DBG: [CID=0x0a20] Session CREATED 2009/02/05 11:48:30.484 INF: [CID=0x0a20] *** CREATED (UAC) CALL *** 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:30.484 DBG: [CID=0x06cb] CREATED via=172.17.7.110:5060 for target=172.17.7.90 protocol=UDP 2009/02/05 11:48:30.484 INF: [CID=0x0a20] *** RTP Session CREATED *** l-addr=172.17.7.110 r-addr=172.17.7.90/172.17.7.90 r-port=49154 2009/02/05 11:48:30.484 DBG: [CID=0x06cb] CREATED via=172.17.7.110:5060 for target=172.17.7.90 protocol=UDP 2009/02/05 11:48:30.484 DBG: [CID=0x0a20] RTP: Second Leg offer being set from First Leg SDP 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] RTP: (Audio) First Leg Offer being translated to 172.17.7.110:30002 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Finding transaction for INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE 2009/02/05 11:48:30.500 DTL: [CID=0x0a20] ICT(264062017) *** CREATED *** - ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE 2009/02/05 11:48:30.500 DTL: [CID=0x0a20] ICT(264062017) Event(SIPMessage) - INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] TRANSACTION: (ICT) INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 State: 0 2009/02/05 11:48:30.500 INF: [CID=0x0a20] >>> INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 DST: 172.17.7.90:24742:UDP SRC: 172.17.7.110:5060 enc=0 bytes=929 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] To: <sip:kwa...@ta...> 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;iid=6051;branch=z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9;uas-addr=172.17.7.90;rport 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.110:5060> 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] User-Agent: OpenSBC v1.1.5-42 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Max-Forwards: 69 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Supported: replaces, norefersub, timer 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Content-Type: application/sdp 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] Content-Length: 364 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] v=0 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] o=- 3442794664 3442794664 IN IP4 172.17.7.90 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] s=SJphone 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] t=0 0 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] m=audio 30002 RTP/AVP 3 97 98 8 0 101 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=rtpmap:97 iLBC/8000 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=fmtp:98 mode=20 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=rtpmap:8 PCMA/8000 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=rtpmap:0 PCMU/8000 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=fmtp:101 0-16 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=setup:active 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] a=sendrecv 2009/02/05 11:48:30.500 DBG: [CID=0x0a20] 2009/02/05 11:48:30.515 DBG: [CID=0x0a20] Finding transaction for INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:30.515 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE 2009/02/05 11:48:30.515 DTL: [CID=0x0a20] Found ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE for INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:30.515 DTL: [CID=0x0a20] ICT(264062017) Event(SIPMessage) - INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:30.515 DBG: [CID=0x0a20] TRANSACTION: (ICT) INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 State: 0 2009/02/05 11:48:30.515 DTL: [CID=0x0a20] ICT(264062017) StateIdle->StateCalling(INVITE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0) 2009/02/05 11:48:30.515 DBG: [CID=0x0a20] ICT(264062017) Timer A( 500 ms ) STARTED 2009/02/05 11:48:30.515 DBG: [CID=0x0a20] ICT(264062017) Timer B( 32000 ms ) STARTED 2009/02/05 11:48:30.515 DBG: [CID=0x0a20] Event: Setting UA Core [Call] to handle event INVITE 2009/02/05 11:48:30.515 DTL: [CID=0x0a20] Event: ---> TransportWrite - INVITE 2009/02/05 11:48:30.937 INF: [CID=0x0a20] <<< SIP/2.0 100 Trying SRC: 172.17.7.90:24742:UDP enc=0 bytes=352 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] SIP/2.0 100 Trying 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] To: <sip:kwa...@ta...> 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;iid=6051;branch=z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9;uas-addr=172.17.7.90;rport=5060 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] Content-Length: 0 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] Finding transaction for SIP/2.0 100 Trying 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE 2009/02/05 11:48:30.937 DTL: [CID=0x0a20] Found ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE for SIP/2.0 100 Trying 2009/02/05 11:48:30.937 DTL: [CID=0x0a20] ICT(264062017) Event(SIPMessage) - SIP/2.0 100 Trying 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] TRANSACTION: (ICT) SIP/2.0 100 Trying State: 1 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] ICT(264062017) Timer A STOPPED 2009/02/05 11:48:30.937 DBG: [CID=0x0a20] ICT(264062017) Timer B STOPPED 2009/02/05 11:48:30.937 DTL: [CID=0x0a20] ICT(264062017) StateCalling->StateProceeding(SIP/2.0 100 Trying) 2009/02/05 11:48:31.125 INF: [CID=0x0a20] <<< INVITE sip:kwa...@ta... SIP/2.0 SRC: 172.17.7.90:49152:UDP enc=0 bytes=883 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] To: <sip:kwa...@ta...> 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000021498a62280000215b00000005 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152> 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs) 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Max-Forwards: 70 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Supported: replaces, norefersub, timer 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Content-Type: application/sdp 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Content-Length: 362 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] v=0 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] o=- 3442794664 3442794664 IN IP4 172.17.7.90 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] s=SJphone 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] t=0 0 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] m=audio 49154 RTP/AVP 3 97 98 8 0 101 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=rtpmap:97 iLBC/8000 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=fmtp:98 mode=20 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=rtpmap:8 PCMA/8000 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=rtpmap:0 PCMU/8000 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=fmtp:101 0-16 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=setup:active 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] a=sendrecv 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Finding transaction for INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE 2009/02/05 11:48:31.125 DTL: [CID=0x0a20] Found IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE for INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:31.125 DTL: [CID=0x0a20] IST(264062016) Event(SIPMessage) - INVITE sip:kwa...@ta... SIP/2.0 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] TRANSACTION: (IST) INVITE sip:kwa...@ta... SIP/2.0 State: 2 2009/02/05 11:48:31.125 INF: [CID=0x0a20] >>> SIP/2.0 100 Trying DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=346 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] SIP/2.0 100 Trying 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] To: <sip:kwa...@ta...> 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000021498a62280000215b00000005;rport=49152;received=172.17.7.90 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] Content-Length: 0 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] 2009/02/05 11:48:31.125 DBG: [CID=0x0a20] 2009/02/05 11:48:31.125 PWL: [CID=0x0000] >>> SIP/2.0 100 Trying DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=346 2009/02/05 11:48:31.375 INF: [CID=0x0a20] <<< SIP/2.0 180 Ringing SRC: 172.17.7.90:24742:UDP enc=0 bytes=483 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] SIP/2.0 180 Ringing 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] To: <sip:kwa...@ta...>;tag=bf20135a 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;iid=6051;branch=z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9;uas-addr=172.17.7.90;rport=5060 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Contact: <sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8> 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] User-Agent: X-Lite release 1100l stamp 47546 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Content-Length: 0 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Finding transaction for SIP/2.0 180 Ringing 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE 2009/02/05 11:48:31.375 DTL: [CID=0x0a20] Found ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE for SIP/2.0 180 Ringing 2009/02/05 11:48:31.375 DTL: [CID=0x0a20] ICT(264062017) Event(SIPMessage) - SIP/2.0 180 Ringing 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] TRANSACTION: (ICT) SIP/2.0 180 Ringing State: 2 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] ICT(264062017) Timer A STOPPED 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] ICT(264062017) Timer B STOPPED 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(SIP/2.0 180 Ringing) 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Event: B2BUserAgent::ProcessEvent( SIP/2.0 180 Ringing ) 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] Event: Setting UA Core [Call] to handle event INVITE 2009/02/05 11:48:31.375 DTL: [CID=0x0a20] Event: ---> Inbound - SIP/2.0 180 Ringing 2009/02/05 11:48:31.375 DBG: [CID=0x0a20] *** MESSAGE ARRIVAL *** for SIP Session 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:31.375 DTL: [CID=0x0a20] NAT: Setting target address from sip:kwan@172.17.7.90:49152 to 172.17.7.90:49152 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Finding transaction for SIP/2.0 180 Ringing 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE 2009/02/05 11:48:31.390 DTL: [CID=0x0a20] Found IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE for SIP/2.0 180 Ringing 2009/02/05 11:48:31.390 DTL: [CID=0x0a20] IST(264062016) Event(SIPMessage) - SIP/2.0 180 Ringing 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] TRANSACTION: (IST) SIP/2.0 180 Ringing State: 2 2009/02/05 11:48:31.390 INF: [CID=0x0a20] >>> SIP/2.0 180 Ringing DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=511 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] SIP/2.0 180 Ringing 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] To: <sip:kwa...@ta...>;tag=dc45cdb7a6fd18109efdd9a22df79cf9 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;iid=6049;branch=z9hG4bKac11075a00000021498a62280000215b00000005;rport=49152;received=172.17.7.90 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Contact: <sip:kwan-lite2@172.17.7.110:5060> 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Server: OpenSBC v1.1.5-42 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] User-Agent: X-Lite release 1100l stamp 47546 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] Content-Length: 0 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] 2009/02/05 11:48:31.390 DBG: [CID=0x0a20] 2009/02/05 11:48:31.390 PWL: [CID=0x0000] >>> SIP/2.0 180 Ringing DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=511 2009/02/05 11:48:32.796 INF: [CID=0x0a20] <<< SIP/2.0 200 OK SRC: 172.17.7.90:24742:UDP enc=0 bytes=804 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] SIP/2.0 200 OK 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] To: <sip:kwa...@ta...>;tag=bf20135a 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;iid=6051;branch=z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9;uas-addr=172.17.7.90;rport=5060 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Contact: <sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8> 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] User-Agent: X-Lite release 1100l stamp 47546 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Content-Type: application/sdp 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Content-Length: 210 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] v=0 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] o=- 9 2 IN IP4 172.17.7.90 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] s=CounterPath X-Lite 3.0 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] t=0 0 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] m=audio 4410 RTP/AVP 3 98 8 0 101 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] a=fmtp:101 0-15 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] a=sendrecv 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Finding transaction for SIP/2.0 200 OK 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE 2009/02/05 11:48:32.796 DTL: [CID=0x0a20] Found ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE for SIP/2.0 200 OK 2009/02/05 11:48:32.796 DTL: [CID=0x0a20] ICT(264062017) Event(SIPMessage) - SIP/2.0 200 OK 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] TRANSACTION: (ICT) SIP/2.0 200 OK State: 2 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] ICT(264062017) Timer A STOPPED 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] ICT(264062017) Timer B STOPPED 2009/02/05 11:48:32.796 DTL: [CID=0x0a20] ICT(264062017) StateProceeding->StateConnected(SIP/2.0 200 OK) 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(SIP/2.0 200 OK) 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] ICT(264062017) Timer D( 32000 ms ) STARTED 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Event: B2BUserAgent::ProcessEvent( SIP/2.0 200 OK ) 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Event: Setting UA Core [Call] to handle event INVITE 2009/02/05 11:48:32.796 DTL: [CID=0x0a20] Event: ---> Inbound - SIP/2.0 200 OK 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] *** MESSAGE ARRIVAL *** for SIP Session 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:32.796 DTL: [CID=0x0a20] *** INIT DIALOG (UAC) *** OpenSBC Main Trunk 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:32.796 DBG: [CID=0x06cb] CREATED via=172.17.7.110:5060 for target=172.17.7.90 protocol=UDP 2009/02/05 11:48:32.796 INF: [CID=0x0a20] *** RTP Session CREATED *** l-addr=172.17.7.110 r-addr=172.17.7.90/172.17.7.110 r-port=4410 2009/02/05 11:48:32.796 INF: [CID=0x0a20] *** CALL ESTABLISHED *** 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:32.796 DTL: [CID=0x0a20] NAT: Setting target address from sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 to 172.17.7.90:24742 2009/02/05 11:48:32.796 INF: [CID=0x0a20] >>> ACK sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 DST: 172.17.7.90:24742:UDP SRC: 172.17.7.110:5060 enc=0 bytes=432 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] ACK sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] From: <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] To: <sip:kwa...@ta...>;tag=bf20135a 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;branch=z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9;uas-addr=172.17.7.90;rport 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] CSeq: 1 ACK 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.110:5060> 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] Content-Length: 0 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] 2009/02/05 11:48:32.796 DBG: [CID=0x0a20] 2009/02/05 11:48:32.812 DTL: [CID=0x0a20] *** INIT DIALOG (UAS) *** OpenSBC Main Trunk 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Finding transaction for SIP/2.0 200 OK 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE 2009/02/05 11:48:32.812 DTL: [CID=0x0a20] Found IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE for SIP/2.0 200 OK 2009/02/05 11:48:32.812 DTL: [CID=0x0a20] IST(264062016) Event(SIPMessage) - SIP/2.0 200 OK 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] TRANSACTION: (IST) SIP/2.0 200 OK State: 2 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] IST(264062016) Timer G STOPPED 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] IST(264062016) Timer H STOPPED 2009/02/05 11:48:32.812 INF: [CID=0x0a20] *** RTP PROXY STARTED *** 2009/02/05 11:48:32.812 INF: [CID=0x0a20] *** RTP PROXY STARTED *** 2009/02/05 11:48:32.812 INF: [CID=0x0a20] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=888 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] SIP/2.0 200 OK 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] To: <sip:kwa...@ta...>;tag=dc45cdb7a6fd18109efdd9a22df79cf9 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;iid=6049;branch=z9hG4bKac11075a00000021498a62280000215b00000005;rport=49152;received=172.17.7.90 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] CSeq: 1 INVITE 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Contact: <sip:kwan-lite2@172.17.7.110:5060> 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Record-Route: <sip:kwan-lite2@172.17.7.110:5060;lr> 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Server: OpenSBC v1.1.5-42 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] User-Agent: X-Lite release 1100l stamp 47546 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Content-Type: application/sdp 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] Content-Length: 213 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] v=0 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] o=- 9 2 IN IP4 172.17.7.110 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] s=CounterPath X-Lite 3.0 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] t=0 0 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] m=audio 30000 RTP/AVP 3 98 8 0 101 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] a=fmtp:101 0-15 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] a=sendrecv 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] 2009/02/05 11:48:32.812 PWL: [CID=0x0000] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=888 2009/02/05 11:48:32.812 DTL: [CID=0x0a20] IST(264062016) StateProceeding->StateConfirmed 2009/02/05 11:48:32.812 DBG: [CID=0x0a20] IST(264062016) Timer I( 5000 ms ) STARTED 2009/02/05 11:48:32.875 INF: [CID=0x0a20] <<< ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 SRC: 172.17.7.90:49152:UDP enc=0 bytes=522 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] From: "unknown" <sip:kw...@ta...>;tag=6842946254 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] To: <sip:kwa...@ta...>;tag=dc45cdb7a6fd18109efdd9a22df79cf9 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000021498a622b000059500000000a 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] CSeq: 1 ACK 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152> 2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Route: <... [truncated message content] |