 |
        |
This Question is Not Answered
1 "correct" answer available (5 pts) 2 "helpful" answers available (1 pts)
2 Replies
Last post:
Feb 4, 2009 11:04 PM by
kwanyeung
Guest
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"
Sent: Wednesday, February 04, 2009 3:46 PM
To:
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 ([phoneA at test dot com]) and
phoneB([phoneB at test dot com])
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
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"
Sent: Wednesday, February 04, 2009 3:46 PM
To:
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 ([phoneA at test dot com]) and
phoneB([phoneB at test dot com])
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
Thank you for replying me
Below is the log about the case. what i have done is
1. [kwan@tat-share.techsoft.com] makes a call to [kwan-lite2@tat-share.techsoft.com]
2. then, [kwan-lite2@tat-share.techsoft.com] accept the call. then they talk each other
3. [kwan@tat-share.techsoft.com] holds the call, however, [kwan-lite2@tat-share.techsoft.com] does not know the call is held by remote party.
4. [kwan@tat-share.techsoft.com] unholds the call
5 [kwan@tat-share.techsoft.com] 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:kwan-lite2@tat-share.techsoft.com 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:kwan-lite2@tat-share.techsoft.com SIP/2.0
2009/02/05 11:48:30.453 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:30.453 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>
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:kwan-lite2@tat-share.techsoft.com 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:kwan-lite2@tat-share.techsoft.com SIP/2.0
2009/02/05 11:48:30.453 DBG: [CID=0x0a20] TRANSACTION: (IST) INVITE sip:kwan-lite2@tat-share.techsoft.com SIP/2.0 State: 0
2009/02/05 11:48:30.453 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(INVITE sip:kwan-lite2@tat-share.techsoft.com 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:kwan-lite2@tat-share.techsoft.com SIP/2.0 )
2009/02/05 11:48:30.468 DTL: [CID=0x0a20] Event: ---> Inbound - INVITE sip:kwan-lite2@tat-share.techsoft.com 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:kwan@tat-share.techsoft.com AOR: sip:kwan-lite2@tat-share.techsoft.com 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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:30.500 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>
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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:30.937 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>
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:kwan-lite2@tat-share.techsoft.com 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:kwan-lite2@tat-share.techsoft.com SIP/2.0
2009/02/05 11:48:31.125 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:31.125 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>
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:kwan-lite2@tat-share.techsoft.com 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:kwan-lite2@tat-share.techsoft.com SIP/2.0
2009/02/05 11:48:31.125 DTL: [CID=0x0a20] IST(264062016) Event(SIPMessage) - INVITE sip:kwan-lite2@tat-share.techsoft.com SIP/2.0
2009/02/05 11:48:31.125 DBG: [CID=0x0a20] TRANSACTION: (IST) INVITE sip:kwan-lite2@tat-share.techsoft.com 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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:31.125 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>
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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:31.375 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:31.390 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:32.796 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:32.796 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:32.812 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;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: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:32.875 DBG: [CID=0x0a20]
2009/02/05 11:48:32.875 DBG: [CID=0x0a20]
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Finding transaction for ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Unable to find ACK Transaction 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075adc45cdb7a6fd18109efdd9a22df79cf9|z9hG4bKac11075a00000021498a622b000059500000000a|ACK
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a622b000059500000000a|ACK
2009/02/05 11:48:32.875 DTL: [CID=0x0a20] Event: ---> UnknownTransaction - ACK
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:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000021498a622b000059500000000a;rport=49152;received=172.17.7.90
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: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:32.875 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:32.875 DBG: [CID=0x0a20]
2009/02/05 11:48:32.875 DBG: [CID=0x0a20]
2009/02/05 11:48:35.375 DBG: [CID=0x0e79] NIST(264062013) Timer J( 32000 ms ) EXPIRED
2009/02/05 11:48:35.375 DTL: [CID=0x0e79] NIST(264062013) Event( Timer-J ) Interval: 32000
2009/02/05 11:48:35.375 DTL: [CID=0x0e79] NIST(264062013) StateCompleted->StateTerminated
2009/02/05 11:48:35.375 DTL: [CID=0x0e79] NIST(264062013) Event(Final)
2009/02/05 11:48:35.375 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** NIST|N2Y5ODhmYmJjZWMxMDE0MjhjYTIzZGIwNGQ2NTJmMzM.|z9hG4bK-d8754z-ef46ab23cf445d20-1---d8754z-|REGISTER
2009/02/05 11:48:35.375 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:48:35.375 DBG: [CID=0x0e79] TRANSACTION: (NIST) DESTROYED
2009/02/05 11:48:35.375 DTL: [CID=0x0e79] NIST(264062013) *** DESTROYED *** - NIST|N2Y5ODhmYmJjZWMxMDE0MjhjYTIzZGIwNGQ2NTJmMzM.|z9hG4bK-d8754z-ef46ab23cf445d20-1---d8754z-|REGISTER
2009/02/05 11:48:35.656 DBG: [CID=0x0e79] NIST(264062014) Timer J( 32000 ms ) EXPIRED
2009/02/05 11:48:35.656 DTL: [CID=0x0e79] NIST(264062014) Event( Timer-J ) Interval: 32000
2009/02/05 11:48:35.656 DTL: [CID=0x0e79] NIST(264062014) StateCompleted->StateTerminated
2009/02/05 11:48:35.656 DTL: [CID=0x0e79] NIST(264062014) Event(Final)
2009/02/05 11:48:35.656 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** NIST|N2Y5ODhmYmJjZWMxMDE0MjhjYTIzZGIwNGQ2NTJmMzM.|z9hG4bK-d8754z-7c781e3f4b31c049-1---d8754z-|REGISTER
2009/02/05 11:48:35.656 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:48:35.656 DBG: [CID=0x0e79] TRANSACTION: (NIST) DESTROYED
2009/02/05 11:48:35.656 DTL: [CID=0x0e79] NIST(264062014) *** DESTROYED *** - NIST|N2Y5ODhmYmJjZWMxMDE0MjhjYTIzZGIwNGQ2NTJmMzM.|z9hG4bK-d8754z-7c781e3f4b31c049-1---d8754z-|REGISTER
2009/02/05 11:48:35.765 DBG: [CID=0x0e9a] NIST(264062015) Timer J( 32000 ms ) EXPIRED
2009/02/05 11:48:35.765 DTL: [CID=0x0e9a] NIST(264062015) Event( Timer-J ) Interval: 32000
2009/02/05 11:48:35.765 DTL: [CID=0x0e9a] NIST(264062015) StateCompleted->StateTerminated
2009/02/05 11:48:35.765 DTL: [CID=0x0e9a] NIST(264062015) Event(Final)
2009/02/05 11:48:35.765 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** NIST|NzI3OTc0MmFmZTU1MjIxZmI3ODU5ZWUxOWVkYzJjNzE.|z9hG4bK-d8754z-e56f9f4c33312102-1---d8754z-|SUBSCRIBE
2009/02/05 11:48:35.765 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:48:35.765 DBG: [CID=0x0e9a] TRANSACTION: (NIST) DESTROYED
2009/02/05 11:48:35.765 DTL: [CID=0x0e9a] NIST(264062015) *** DESTROYED *** - NIST|NzI3OTc0MmFmZTU1MjIxZmI3ODU5ZWUxOWVkYzJjNzE.|z9hG4bK-d8754z-e56f9f4c33312102-1---d8754z-|SUBSCRIBE
2009/02/05 11:48:37.812 DBG: [CID=0x0a20] IST(264062016) Timer I( 5000 ms ) EXPIRED
2009/02/05 11:48:37.812 DTL: [CID=0x0a20] IST(264062016) Event( Timer-I ) Interval: 5000
2009/02/05 11:48:37.812 DTL: [CID=0x0a20] IST(264062016) Event(Final)
2009/02/05 11:48:37.812 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE
2009/02/05 11:48:37.812 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:48:37.812 DBG: [CID=0x0a20] TRANSACTION: (IST) DESTROYED
2009/02/05 11:48:37.812 DTL: [CID=0x0a20] IST(264062016) *** DESTROYED *** - IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000021498a62280000215b00000005|INVITE
2009/02/05 11:48:44.156 INF: [CID=0x0a20] <<< INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 SRC: 172.17.7.90:49152:UDP enc=0 bytes=838
2009/02/05 11:48:44.156 DBG: [CID=0x0a20]
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000023498a6236000061930000000b
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] CSeq: 2 INVITE
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Supported: replaces, norefersub, timer
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Content-Type: application/sdp
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Content-Length: 239
2009/02/05 11:48:44.156 DBG: [CID=0x0a20]
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] v=0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] o=- 3442794664 3442794665 IN IP4 172.17.7.90
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] s=SJphone
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] t=0 0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] m=audio 49154 RTP/AVP 3 101
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] c=IN IP4 0.0.0.0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] a=fmtp:101 0-16
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] a=setup:active
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] a=sendonly
2009/02/05 11:48:44.156 DBG: [CID=0x0a20]
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Finding transaction for INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000023498a6236000061930000000b|INVITE
2009/02/05 11:48:44.156 DTL: [CID=0x0a20] IST(264062018) *** CREATED *** - IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000023498a6236000061930000000b|INVITE
2009/02/05 11:48:44.156 DTL: [CID=0x0a20] IST(264062018) Event(SIPMessage) - INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] TRANSACTION: (IST) INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 State: 0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0)
2009/02/05 11:48:44.156 DTL: [CID=0x0a20] IST(264062018) StateIdle->StateProceeding
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] Event: B2BUserAgent::ProcessEvent( INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 )
2009/02/05 11:48:44.156 DTL: [CID=0x0a20] Event: ---> Inbound - INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] *** MESSAGE ARRIVAL *** for SIP Session 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:44.156 DBG: [CID=0x06cb] CREATED via=172.17.7.110:5060 for target=172.17.7.90 protocol=UDP
2009/02/05 11:48:44.156 INF: [CID=0x0a20] *** RTP Session CREATED *** l-addr=172.17.7.110 r-addr=127.0.0.1/172.17.7.90 r-port=49154
2009/02/05 11:48:44.156 DTL: [CID=0x0a20] Found IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000023498a6236000061930000000b|INVITE for SIP/2.0 200 OK
2009/02/05 11:48:44.156 DTL: [CID=0x0a20] IST(264062018) Event(SIPMessage) - SIP/2.0 200 OK
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] TRANSACTION: (IST) SIP/2.0 200 OK State: 2
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] IST(264062018) Timer G STOPPED
2009/02/05 11:48:44.156 DBG: [CID=0x0a20] IST(264062018) Timer H STOPPED
2009/02/05 11:48:44.171 INF: [CID=0x0a20] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=812
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] SIP/2.0 200 OK
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;iid=6049;branch=z9hG4bKac11075a00000023498a6236000061930000000b;rport=49152;received=172.17.7.90
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] CSeq: 2 INVITE
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Server: OpenSBC v1.1.5-42
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Content-Type: application/sdp
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Content-Length: 364
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] v=0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] o=- 3442794664 3442794664 IN IP4 172.17.7.90
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] s=SJphone
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] t=0 0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] m=audio 30002 RTP/AVP 3 97 98 8 0 101
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=rtpmap:97 iLBC/8000
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=fmtp:98 mode=20
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=rtpmap:8 PCMA/8000
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=rtpmap:0 PCMU/8000
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=fmtp:101 0-16
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=setup:active
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] a=sendrecv
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 PWL: [CID=0x0000] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=812
2009/02/05 11:48:44.171 DTL: [CID=0x0a20] IST(264062018) StateProceeding->StateConfirmed
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] IST(264062018) Timer I( 5000 ms ) STARTED
2009/02/05 11:48:44.171 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:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000023498a623600007d610000000e
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] CSeq: 2 ACK
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Finding transaction for ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Unable to find ACK Transaction 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075adc45cdb7a6fd18109efdd9a22df79cf9|z9hG4bKac11075a00000023498a623600007d610000000e|ACK
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000023498a623600007d610000000e|ACK
2009/02/05 11:48:44.171 DTL: [CID=0x0a20] Event: ---> UnknownTransaction - ACK
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000023498a623600007d610000000e;rport=49152;received=172.17.7.90
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] CSeq: 2 ACK
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:44.171 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:44.171 DBG: [CID=0x0a20]
2009/02/05 11:48:49.171 DBG: [CID=0x0a20] IST(264062018) Timer I( 5000 ms ) EXPIRED
2009/02/05 11:48:49.171 DTL: [CID=0x0a20] IST(264062018) Event( Timer-I ) Interval: 5000
2009/02/05 11:48:49.171 DTL: [CID=0x0a20] IST(264062018) Event(Final)
2009/02/05 11:48:49.171 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000023498a6236000061930000000b|INVITE
2009/02/05 11:48:49.171 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:48:49.171 DBG: [CID=0x0a20] TRANSACTION: (IST) DESTROYED
2009/02/05 11:48:49.171 DTL: [CID=0x0a20] IST(264062018) *** DESTROYED *** - IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000023498a6236000061930000000b|INVITE
2009/02/05 11:48:55.593 INF: [CID=0x0a20] <<< INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 SRC: 172.17.7.90:49152:UDP enc=0 bytes=961
2009/02/05 11:48:55.593 DBG: [CID=0x0a20]
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000025498a624100005a800000000f
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] CSeq: 3 INVITE
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Supported: replaces, norefersub, timer
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Content-Type: application/sdp
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Content-Length: 362
2009/02/05 11:48:55.593 DBG: [CID=0x0a20]
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] v=0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] o=- 3442794664 3442794666 IN IP4 172.17.7.90
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] s=SJphone
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] t=0 0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] m=audio 49154 RTP/AVP 3 97 98 8 0 101
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] c=IN IP4 172.17.7.90
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:97 iLBC/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=fmtp:98 mode=20
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:8 PCMA/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:0 PCMU/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=fmtp:101 0-16
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=setup:active
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=sendrecv
2009/02/05 11:48:55.593 DBG: [CID=0x0a20]
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Finding transaction for INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000025498a624100005a800000000f|INVITE
2009/02/05 11:48:55.593 DTL: [CID=0x0a20] IST(264062019) *** CREATED *** - IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000025498a624100005a800000000f|INVITE
2009/02/05 11:48:55.593 DTL: [CID=0x0a20] IST(264062019) Event(SIPMessage) - INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] TRANSACTION: (IST) INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 State: 0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0)
2009/02/05 11:48:55.593 DTL: [CID=0x0a20] IST(264062019) StateIdle->StateProceeding
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Event: B2BUserAgent::ProcessEvent( INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 )
2009/02/05 11:48:55.593 DTL: [CID=0x0a20] Event: ---> Inbound - INVITE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] *** MESSAGE ARRIVAL *** for SIP Session 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:55.593 DBG: [CID=0x06cb] CREATED via=172.17.7.110:5060 for target=172.17.7.90 protocol=UDP
2009/02/05 11:48:55.593 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:55.593 DTL: [CID=0x0a20] Found IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000025498a624100005a800000000f|INVITE for SIP/2.0 200 OK
2009/02/05 11:48:55.593 DTL: [CID=0x0a20] IST(264062019) Event(SIPMessage) - SIP/2.0 200 OK
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] TRANSACTION: (IST) SIP/2.0 200 OK State: 2
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] IST(264062019) Timer G STOPPED
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] IST(264062019) Timer H STOPPED
2009/02/05 11:48:55.593 INF: [CID=0x0a20] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=812
2009/02/05 11:48:55.593 DBG: [CID=0x0a20]
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] SIP/2.0 200 OK
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;iid=6049;branch=z9hG4bKac11075a00000025498a624100005a800000000f;rport=49152;received=172.17.7.90
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] CSeq: 3 INVITE
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Server: OpenSBC v1.1.5-42
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Content-Type: application/sdp
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] Content-Length: 364
2009/02/05 11:48:55.593 DBG: [CID=0x0a20]
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] v=0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] o=- 3442794664 3442794664 IN IP4 172.17.7.90
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] s=SJphone
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] t=0 0
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] m=audio 30002 RTP/AVP 3 97 98 8 0 101
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] c=IN IP4 172.17.7.110
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:3 GSM/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:97 iLBC/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:98 iLBC/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=fmtp:98 mode=20
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:8 PCMA/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:0 PCMU/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=rtpmap:101 telephone-event/8000
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=fmtp:101 0-16
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=setup:active
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] a=sendrecv
2009/02/05 11:48:55.593 DBG: [CID=0x0a20]
2009/02/05 11:48:55.593 PWL: [CID=0x0000] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=812
2009/02/05 11:48:55.593 DTL: [CID=0x0a20] IST(264062019) StateProceeding->StateConfirmed
2009/02/05 11:48:55.593 DBG: [CID=0x0a20] IST(264062019) Timer I( 5000 ms ) STARTED
2009/02/05 11:48:55.609 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:55.609 DBG: [CID=0x0a20]
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000025498a624200000dc600000012
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] CSeq: 3 ACK
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:55.609 DBG: [CID=0x0a20]
2009/02/05 11:48:55.609 DBG: [CID=0x0a20]
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Finding transaction for ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Unable to find ACK Transaction 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075adc45cdb7a6fd18109efdd9a22df79cf9|z9hG4bKac11075a00000025498a624200000dc600000012|ACK
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000025498a624200000dc600000012|ACK
2009/02/05 11:48:55.609 DTL: [CID=0x0a20] Event: ---> UnknownTransaction - ACK
2009/02/05 11:48:55.609 DBG: [CID=0x0a20]
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] ACK sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000025498a624200000dc600000012;rport=49152;received=172.17.7.90
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] CSeq: 3 ACK
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:55.609 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:55.609 DBG: [CID=0x0a20]
2009/02/05 11:48:55.609 DBG: [CID=0x0a20]
2009/02/05 11:48:55.828 PWL: [CID=0x0000] RTP Abnormal change of sequence numbers, adjusting to expect 7985 ssrc=946642959
2009/02/05 11:48:56.875 INF: [CID=0x0a20] <<< BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 SRC: 172.17.7.90:49152:UDP enc=0 bytes=560
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;branch=z9hG4bKac11075a00000027498a62430000634400000013
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] CSeq: 4 BYE
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.90:49152>
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Route: <sip:kwan-lite2@172.17.7.110:5060;lr>
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] User-Agent: SJphone/1.65.377a (SJ Labs)
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Supported: replaces, norefersub, timer
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Finding transaction for BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000027498a62430000634400000013|BYE
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NIST(264062020) *** CREATED *** - NIST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000027498a62430000634400000013|BYE
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NIST(264062020) Event(SIPMessage) - BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] TRANSACTION: (NIST) BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 State: 0
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NIST(264062020) StateIdle->StateTrying
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Event: SIPStack::Enqueue(BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0)
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Event: B2BUserAgent::ProcessEvent( BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0 )
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] Event: ---> Inbound - BYE sip:kwan-lite2@172.17.7.110:5060 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] *** MESSAGE ARRIVAL *** for SIP Session 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] Found NIST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000027498a62430000634400000013|BYE for SIP/2.0 200 OK
2009/02/05 11:48:56.875 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:56.875 DBG: [CID=0x0a20] Finding transaction for BYE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9|BYE
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NICT(264062021) *** CREATED *** - NICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9|BYE
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NIST(264062020) Event(SIPMessage) - SIP/2.0 200 OK
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] TRANSACTION: (NIST) SIP/2.0 200 OK State: 1
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NIST(264062020)HandleStateTrying->StateCompleted
2009/02/05 11:48:56.875 INF: [CID=0x0a20] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=412
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] SIP/2.0 200 OK
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] From: "unknown" <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=dc45cdb7a6fd18109efdd9a22df79cf9
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.90:49152;iid=6049;branch=z9hG4bKac11075a00000027498a62430000634400000013;rport=49152;received=172.17.7.90
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] CSeq: 4 BYE
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Server: OpenSBC v1.1.5-42
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 PWL: [CID=0x0000] >>> SIP/2.0 200 OK DST: 172.17.7.90:49152:UDP SRC=172.17.7.110:5061 enc=0 bytes=412
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] NIST(264062020) Timer J( 32000 ms ) STARTED
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NICT(264062021) Event(SIPMessage) - BYE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] TRANSACTION: (NICT) BYE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0 State: 0
2009/02/05 11:48:56.875 DTL: [CID=0x0a20] NICT(264062021) StateIdle->StateTrying(BYE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0)
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] NICT(264062021) Timer E( 500 ms ) STARTED
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] NICT(264062021) Timer F( 10000 ms ) STARTED
2009/02/05 11:48:56.875 INF: [CID=0x0a20] >>> BYE 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=490
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] BYE sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8 SIP/2.0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] From: <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=bf20135a
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;iid=6051;branch=z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9;uas-addr=172.17.7.90;rport
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] CSeq: 2 BYE
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Contact: <sip:kwan@172.17.7.110:5060>
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] User-Agent: OpenSBC v1.1.5-42
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Max-Forwards: 70
2009/02/05 11:48:56.875 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 DBG: [CID=0x0a20]
2009/02/05 11:48:56.875 INF: [CID=0x0a20] *** CALL TEAR DOWN *** 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-connection
2009/02/05 11:48:56.875 INF: [CID=0x0a20] *** RTP PROXY STOPPED ***
2009/02/05 11:48:56.890 INF: [CID=0x0a20] *** RTP PROXY STOPPED ***
2009/02/05 11:48:56.890 INF: [CID=0x0e7d] *** B2BUA CONNECTION OnDestroySession ***
2009/02/05 11:48:56.890 INF: [CID=0x0a20] *** RTP (Audio) Statistics *** addr=172.17.7.110:30000->172.17.7.90:49154 enc=0 rx=627 tx=1198 lost=0 outOfOrder=0 late=0 rxTime=134/11462 txTime=20/30 jitter=29/1386
2009/02/05 11:48:56.890 DTL: [CID=0x06cb] *** QUEUED FOR DELETION *** SIPSession: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:48:56.890 INF: [CID=0x0a20] *** RTP (Audio) Statistics *** addr=172.17.7.110:30002->172.17.7.90:4410 enc=0 rx=1198 tx=627 lost=0 outOfOrder=11 late=0 rxTime=20/30 txTime=134/11462 jitter=3/24
2009/02/05 11:48:56.890 DTL: [CID=0x06cb] *** QUEUED FOR DELETION *** SIPSession: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001
2009/02/05 11:48:56.890 DTL: [CID=0x06cb] *** QUEUED FOR DELETION *** SIPSession: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-connection
2009/02/05 11:48:56.890 DBG: [CID=0x0000] GC: First Stale Object SIPSession
2009/02/05 11:48:57.000 INF: [CID=0x0a20] <<< SIP/2.0 200 OK SRC: 172.17.7.90:24742:UDP enc=0 bytes=466
2009/02/05 11:48:57.000 DBG: [CID=0x0a20]
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] SIP/2.0 200 OK
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] From: <sip:kwan@tat-share.techsoft.com>;tag=6842946254
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] To: <sip:kwan-lite2@tat-share.techsoft.com>;tag=bf20135a
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] Via: SIP/2.0/UDP 172.17.7.110:5060;iid=6051;branch=z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9;uas-addr=172.17.7.90;rport=5060
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] CSeq: 2 BYE
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] Call-ID: 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] Contact: <sip:kwan-lite2@172.17.7.90:24742;rinstance=2818a5703040a9c8>
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] User-Agent: X-Lite release 1100l stamp 47546
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] Content-Length: 0
2009/02/05 11:48:57.000 DBG: [CID=0x0a20]
2009/02/05 11:48:57.000 DBG: [CID=0x0a20]
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] Finding transaction for SIP/2.0 200 OK
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] Setting Transaction ID to 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9|BYE
2009/02/05 11:48:57.000 DTL: [CID=0x0a20] Found NICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9|BYE for SIP/2.0 200 OK
2009/02/05 11:48:57.000 DTL: [CID=0x0a20] NICT(264062021) Event(SIPMessage) - SIP/2.0 200 OK
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] TRANSACTION: (NICT) SIP/2.0 200 OK State: 1
2009/02/05 11:48:57.000 DTL: [CID=0x0a20] NICT(264062021) StateTrying->StateCompleted
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] NICT(264062021) Timer E STOPPED
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] NICT(264062021) Timer F STOPPED
2009/02/05 11:48:57.000 DBG: [CID=0x0a20] NICT(264062021) Timer K( 5000 ms ) STARTED
2009/02/05 11:49:00.593 DBG: [CID=0x0a20] IST(264062019) Timer I( 5000 ms ) EXPIRED
2009/02/05 11:49:00.593 DTL: [CID=0x0a20] IST(264062019) Event( Timer-I ) Interval: 5000
2009/02/05 11:49:00.593 DTL: [CID=0x0a20] IST(264062019) Event(Final)
2009/02/05 11:49:00.593 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000025498a624100005a800000000f|INVITE
2009/02/05 11:49:00.593 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:49:00.593 DBG: [CID=0x0a20] TRANSACTION: (IST) DESTROYED
2009/02/05 11:49:00.593 DTL: [CID=0x0a20] IST(264062019) *** DESTROYED *** - IST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000025498a624100005a800000000f|INVITE
2009/02/05 11:49:01.890 DBG: [CID=0x0000] GC: First Stale Object B2BUACall
2009/02/05 11:49:01.890 DBG: [CID=0x0000] GC: First Stale Object B2BUACall Leg 2
2009/02/05 11:49:01.890 INF: [CID=0x0e7d] *** DESTROYED B2BUA CONNECTION *** 0x00D5A978
2009/02/05 11:49:01.890 INF: [CID=0x0e7d] *** COUNTERS *** ICT=1 NICT=1 IST=0 NIST=2 TIMERS=11 CALL=0 CONN=0 REG=0 RTP=0 QUEUE=1 CACHE=1 GC=7 TOTALCONN=1 TOTALREG=0 TOTALSZR=1 AVGDUR=24072 HIGHDUR=24072 IDLETIME=32
2009/02/05 11:49:01.890 DBG: [CID=0x0a20] CONNECTION: Session DESTROYED
2009/02/05 11:49:01.890 INF: [CID=0x0a20] *** DESTROYED CALL *** 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a
2009/02/05 11:49:01.890 DBG: [CID=0x0a20] CALL: (inbound) : Session DESTROYED
2009/02/05 11:49:01.890 INF: [CID=0x0a20] *** DESTROYED CALL *** 5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001
2009/02/05 11:49:01.890 DBG: [CID=0x0a20] CALL: (outbound) : Session DESTROYED
2009/02/05 11:49:02.000 DBG: [CID=0x0a20] NICT(264062021) Timer K( 5000 ms ) EXPIRED
2009/02/05 11:49:02.000 DTL: [CID=0x0a20] NICT(264062021) Event( Timer-K ) Interval: 5000
2009/02/05 11:49:02.000 DTL: [CID=0x0a20] NICT(264062021) Event(Final)
2009/02/05 11:49:02.000 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** NICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9|BYE
2009/02/05 11:49:02.000 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:49:02.000 DBG: [CID=0x0a20] TRANSACTION: (NICT) DESTROYED
2009/02/05 11:49:02.000 DTL: [CID=0x0a20] NICT(264062021) *** DESTROYED *** - NICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKcc2ef4b7a6fd18109efed9a22df79cf9|BYE
2009/02/05 11:49:04.796 DBG: [CID=0x0a20] ICT(264062017) Timer D( 32000 ms ) EXPIRED
2009/02/05 11:49:04.796 DTL: [CID=0x0a20] ICT(264062017) Event( Timer-D ) Interval: 32000
2009/02/05 11:49:04.796 DTL: [CID=0x0a20] ICT(264062017) Event(Final)
2009/02/05 11:49:04.796 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE
2009/02/05 11:49:04.796 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:49:04.796 DBG: [CID=0x0a20] TRANSACTION: (ICT) DESTROYED
2009/02/05 11:49:04.796 DTL: [CID=0x0a20] ICT(264062017) *** DESTROYED *** - ICT|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a-0x0001|z9hG4bKf5e9cbb7a6fd18109efdd9a22df79cf9|INVITE
2009/02/05 11:49:28.875 DBG: [CID=0x0a20] NIST(264062020) Timer J( 32000 ms ) EXPIRED
2009/02/05 11:49:28.875 DTL: [CID=0x0a20] NIST(264062020) Event( Timer-J ) Interval: 32000
2009/02/05 11:49:28.875 DTL: [CID=0x0a20] NIST(264062020) StateCompleted->StateTerminated
2009/02/05 11:49:28.875 DTL: [CID=0x0a20] NIST(264062020) Event(Final)
2009/02/05 11:49:28.875 DTL: [CID=0x0000] *** REMOVED TRANSACTION *** NIST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000027498a62430000634400000013|BYE
2009/02/05 11:49:28.875 DBG: [CID=0x0000] GC: First Stale Object SIPTransaction
2009/02/05 11:49:28.875 DBG: [CID=0x0a20] TRANSACTION: (NIST) DESTROYED
2009/02/05 11:49:28.875 DTL: [CID=0x0a20] NIST(264062020) *** DESTROYED *** - NIST|5AA21F9A8C014B018DC47F402AF6D7EE0xac11075a|z9hG4bKac11075a00000027498a62430000634400000013|BYE