Open Source Sip: [OpenSIPStack] [SF] RTP fault ...

Up to Discussions in OpenSIPStack

4 Replies Last post: Jun 3, 2008 8:16 PM by Guest

Guest

May 22, 2008 10:20 AM

[OpenSIPStack] [SF] RTP fault

Guest

1. May 22, 2008 10:20 AM

in response to: Guest

Re: [OpenSIPStack] [SF] RTP fault

Hi

Log (for pwlib - level 6) - in attachments

Joegen E. Baclor wrote:

Hmmn. Strange. Seems like the codec from the previous call has not
been destroyed. Can you send me a maximum level log of two consecutive
calls right after fresh startup of your SoftPhone?

H.Kropf wrote:

can you put a break-point in
OpalTranscoder::ConvertFrames() and figure out where exactly it fails?

I can

bool OpalMediaPatch::Sink::WriteFrame(RTP_DataFrame & sourceFrame)
{
......
if (!primaryCodec->ConvertFrames(sourceFrame, intermediateFrames))
{
PTRACE(1, "Patch\tMedia conversion (primary) failed");
return false;
}
......
}

BOOL OpalTranscoder::ConvertFrames(const RTP_DataFrame & input,
RTP_DataFrameList & output)
{
.......
return Convert(input, output[0]);
}

BOOL OpalFlexiTranscoder::Convert( const RTP_DataFrame & input,
RTP_DataFrame & output)
{
return m_Transcoder->Convert( input, output );
}

BOOL OpalFramedTranscoder::Convert(const RTP_DataFrame & input,
RTP_DataFrame & output)
{
....
while (inputLength > 0)
{
......
if (!ConvertFrame(inputPtr, consumed, outputPtr, created))
return FALSE;
.......
}
.......
}

BOOL OpalFramedTranscoder::ConvertFrame(const BYTE * inputPtr, PINDEX &
/*consumed*/, BYTE * outputPtr, PINDEX & /*created*/)
{
return ConvertFrame(inputPtr, outputPtr);
}

BOOL Opal_PCM_G729::ConvertFrame(const BYTE * src, BYTE * dst)
{
if (voiceAgeEncoderInUse != this) return FALSE; // !!!!!!!!!!!!
<<<=== this place
......
}

Hi,

Are you a C++ developer? If so, can you put a break-point in
OpalTranscoder::ConvertFrames() and figure out where exactly it fails?

Joegen

H.Kropf wrote:

Hello

After a last update of library from CVS (2008-05-20), my softphone (on
OSS library) makes only one successful call after start. In next calls
there is no voice. In PTRACE-log there are many such records

Media Patch:1eb9410 PWL: CID=0x0000 Patch Media conversion (primary)
failed
Media Patch:1eb9410 PWL: CID=0x0000 Patch Media conversion (primary)
failed
Media Patch:1eb9410 PWL: CID=0x0000 Patch Media conversion (primary)
failed
Media Patch:1eb9410 PWL: CID=0x0000 Patch Media conversion (primary)
failed

In the previous version (CVS 2008-05-12) this problem did not exist

This SF.net email is sponsored by: Microsoft
Defy all challenges. Microsoft(R) Visual Studio 2008.
http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
_______________________________________________
opensipstack-devel mailing list
opensipstack-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/opensipstack-devel

2008/05/21 11:39:21.817 IPshka.com INF: CID=0x0000 SIP Stack CREATED
2008/05/21 11:39:27.098 IPshka.com DTL: CID=0x0000 Starting UDP Transport on *:5061
2008/05/21 11:39:27.130 IPshka.com DTL: CID=0x0000 *** TRANSPORT STARTED *** Listener: *:5061
2008/05/21 11:39:27.130 IPshka.com DTL: CID=0x0000 Starting TCP Transport on *:5061
2008/05/21 11:39:27.161 IPshka.com DTL: CID=0x0000 *** TRANSPORT STARTED *** Listener: *:5061
2008/05/21 11:39:27.473 IPshka.com DBG: CID=0x0902 Session CREATED
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x06cb CREATED via=10.0.1.13:5061 for target=193.28.184.13 protocol=UDP
2008/05/21 11:39:27.505 IPshka.com INF: CID=0x0902 *** CREATED *** CLIENT REGISTER Session REGISTER-olden1@ipshka.com
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb Finding transaction for REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb Setting Transaction ID to 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb *** CREATING TRANSACTION (NICT) ***
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb Message: REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb Call-Id: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.505 IPshka.com DBG: CID=0x0ceb
2008/05/21 11:39:27.536 IPshka.com DTL: CID=0x0ceb NICT(2222871559) *** CREATED *** - NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.551 Transaction DTL: CID=0x0ceb NICT(2222871559) Event(SIPMessage) - REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.551 Transaction DBG: CID=0x0ceb TRANSACTION: (NICT) REGISTER sip:ipshka.com SIP/2.0 State: 0
2008/05/21 11:39:27.551 Transaction DTL: CID=0x0ceb NICT(2222871559) StateIdle->StateTrying(REGISTER sip:ipshka.com SIP/2.0)
2008/05/21 11:39:27.567 Transaction DBG: CID=0x0ceb NICT(2222871559) Timer E( 500 ms ) STARTED
2008/05/21 11:39:27.567 Transaction DBG: CID=0x0ceb NICT(2222871559) Timer F( 10000 ms ) STARTED
2008/05/21 11:39:27.567 Transport (OUTBOUND) INF: CID=0x0ceb >>> REGISTER sip:ipshka.com SIP/2.0 DST: 193.28.184.13:5060:UDP SRC: 10.0.1.13:5061 enc=0 bytes=568
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb To: 100008
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bKaf76f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb CSeq: 1 REGISTER
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Contact: "100008" <sip:100008@10.0.1.13:5061;transport=udp>
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb User-Agent: OpenSIPStack v1.1.7-23
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Expires: 3600
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Max-Forwards: 70
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Allow: INVITE, BYE, CANCEL, ACK, REFER, MESSAGE, INFO, NOTIFY, OPTIONS, PRACK
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb Content-Length: 0
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.567 Transport (OUTBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) INF: CID=0x0ceb <<< SIP/2.0 100 Trying SRC: 193.28.184.13:5060:UDP enc=0 bytes=420
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb SIP/2.0 100 Trying
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb To: 100008
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bKaf76f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport=5061;received=193.28.184.10
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb CSeq: 1 REGISTER
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Server: OpenSER (1.3.0-notls (x86_64/linux))
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Content-Length: 0
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Finding transaction for SIP/2.0 100 Trying
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Setting Transaction ID to 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.583 Transport (INBOUND) DTL: CID=0x0ceb Found NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER for SIP/2.0 100 Trying
2008/05/21 11:39:27.583 Transport (INBOUND) INF: CID=0x0ceb <<< SIP/2.0 401 Unauthorized SRC: 193.28.184.13:5060:UDP enc=0 bytes=575
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb SIP/2.0 401 Unauthorized
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb To: 100008 ;tag=8e373578fa68a199c630c28b25cb902f.1041
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bKaf76f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport=5061;received=193.28.184.10
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb CSeq: 1 REGISTER
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Server: OpenSER (1.3.0-notls (x86_64/linux))
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb WWW-Authenticate: Digest realm="ipshka.com", nonce="4833e0cd518415fa88899c3ac747417b78d22eca", qop="auth"
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Content-Length: 0
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Finding transaction for SIP/2.0 401 Unauthorized
2008/05/21 11:39:27.583 Transport (INBOUND) DBG: CID=0x0ceb Setting Transaction ID to 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.583 Transport (INBOUND) DTL: CID=0x0ceb Found NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER for SIP/2.0 401 Unauthorized
2008/05/21 11:39:27.598 Transaction DTL: CID=0x0ceb NICT(2222871559) Event(SIPMessage) - SIP/2.0 100 Trying
2008/05/21 11:39:27.598 Transaction DBG: CID=0x0ceb TRANSACTION: (NICT) SIP/2.0 100 Trying State: 1
2008/05/21 11:39:27.598 Transaction DTL: CID=0x0ceb NICT(2222871559) StateTrying->StateProceeding
2008/05/21 11:39:27.598 Transaction DBG: CID=0x0ceb Event: SIPStack::Enqueue(SIP/2.0 100 Trying)
2008/05/21 11:39:27.598 UserAgent DTL: CID=0x0ceb Event: ---> Inbound - SIP/2.0 100 Trying
2008/05/21 11:39:27.614 Transaction DTL: CID=0x0ceb NICT(2222871559) Event(SIPMessage) - SIP/2.0 401 Unauthorized
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb TRANSACTION: (NICT) SIP/2.0 401 Unauthorized State: 2
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb Event: SIPStack::Enqueue(SIP/2.0 401 Unauthorized)
2008/05/21 11:39:27.614 Transaction DTL: CID=0x0ceb NICT(2222871559) StateProceeding->StateCompleted
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb NICT(2222871559) Timer E STOPPED
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb NICT(2222871559) Timer F STOPPED
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb NICT(2222871559) Timer K( 5000 ms ) STARTED
2008/05/21 11:39:27.614 UserAgent DTL: CID=0x0ceb Event: ---> Inbound - SIP/2.0 401 Unauthorized
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 SIP/2.0 401 Unauthorized
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 To: 100008 ;tag=8e373578fa68a199c630c28b25cb902f.1041
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bKaf76f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport=5061;received=193.28.184.10
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 CSeq: 1 REGISTER
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 Server: OpenSER (1.3.0-notls (x86_64/linux))
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 WWW-Authenticate: Digest realm="ipshka.com", nonce="4833e0cd518415fa88899c3ac747417b78d22eca", qop="auth"
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902 Content-Length: 0
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0902
2008/05/21 11:39:27.614 UserAgent INF: CID=0x0ceb REGISTER: Registration being authenticated
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb Finding transaction for REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb Setting Transaction ID to 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb *** CREATING TRANSACTION (NICT) ***
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb Message: REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb Call-Id: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.614 UserAgent DBG: CID=0x0ceb
2008/05/21 11:39:27.614 UserAgent DTL: CID=0x0ceb NICT(2222871560) *** CREATED *** - NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.614 Transaction DTL: CID=0x0ceb NICT(2222871560) Event(SIPMessage) - REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb TRANSACTION: (NICT) REGISTER sip:ipshka.com SIP/2.0 State: 0
2008/05/21 11:39:27.614 Transaction DTL: CID=0x0ceb NICT(2222871560) StateIdle->StateTrying(REGISTER sip:ipshka.com SIP/2.0)
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb NICT(2222871560) Timer E( 500 ms ) STARTED
2008/05/21 11:39:27.614 Transaction DBG: CID=0x0ceb NICT(2222871560) Timer F( 10000 ms ) STARTED
2008/05/21 11:39:27.630 Transport (OUTBOUND) INF: CID=0x0ceb >>> REGISTER sip:ipshka.com SIP/2.0 DST: 193.28.184.13:5060:UDP SRC: 10.0.1.13:5061 enc=0 bytes=772
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb REGISTER sip:ipshka.com SIP/2.0
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb To: 100008
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bK69a1f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb CSeq: 2 REGISTER
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Contact: "100008" <sip:100008@10.0.1.13:5061;transport=udp>
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb User-Agent: OpenSIPStack v1.1.7-23
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Expires: 3600
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Max-Forwards: 70
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Authorization: Digest username="olden1", realm="ipshka.com", nonce="4833e0cd518415fa88899c3ac747417b78d22eca", uri="sip:ipshka.com", response="6af13561c2f0c59a13deab2de71590e0", opaque="", algorithm=MD5
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Allow: INVITE, BYE, CANCEL, ACK, REFER, MESSAGE, INFO, NOTIFY, OPTIONS, PRACK
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb Content-Length: 0
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.630 Transport (OUTBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.630 Transport (INBOUND) INF: CID=0x0ceb <<< SIP/2.0 100 Trying SRC: 193.28.184.13:5060:UDP enc=0 bytes=420
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb SIP/2.0 100 Trying
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb To: 100008
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bK69a1f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport=5061;received=193.28.184.10
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb CSeq: 2 REGISTER
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb Server: OpenSER (1.3.0-notls (x86_64/linux))
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb Content-Length: 0
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb Finding transaction for SIP/2.0 100 Trying
2008/05/21 11:39:27.630 Transport (INBOUND) DBG: CID=0x0ceb Setting Transaction ID to 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.645 Transport (INBOUND) DTL: CID=0x0ceb Found NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER for SIP/2.0 100 Trying
2008/05/21 11:39:27.645 Transport (INBOUND) INF: CID=0x0ceb <<< SIP/2.0 200 OK SRC: 193.28.184.13:5060:UDP enc=0 bytes=552
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb SIP/2.0 200 OK
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb To: 100008 ;tag=8e373578fa68a199c630c28b25cb902f.536d
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bK69a1f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport=5061;received=193.28.184.10
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb CSeq: 2 REGISTER
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Contact: <sip:100008@10.0.1.13:5061;transport=udp>;expires=3600;rcv="sip:193.28.184.10:5061"
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Server: OpenSER (1.3.0-notls (x86_64/linux))
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Content-Length: 0
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Finding transaction for SIP/2.0 200 OK
2008/05/21 11:39:27.645 Transport (INBOUND) DBG: CID=0x0ceb Setting Transaction ID to 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:27.645 Transport (INBOUND) DTL: CID=0x0ceb Found NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER for SIP/2.0 200 OK
2008/05/21 11:39:27.645 Transaction DTL: CID=0x0ceb NICT(2222871560) Event(SIPMessage) - SIP/2.0 100 Trying
2008/05/21 11:39:27.645 Transaction DBG: CID=0x0ceb TRANSACTION: (NICT) SIP/2.0 100 Trying State: 1
2008/05/21 11:39:27.645 Transaction DTL: CID=0x0ceb NICT(2222871560) StateTrying->StateProceeding
2008/05/21 11:39:27.645 Transaction DBG: CID=0x0ceb Event: SIPStack::Enqueue(SIP/2.0 100 Trying)
2008/05/21 11:39:27.645 UserAgent DTL: CID=0x0ceb Event: ---> Inbound - SIP/2.0 100 Trying
2008/05/21 11:39:27.661 Transaction DTL: CID=0x0ceb NICT(2222871560) Event(SIPMessage) - SIP/2.0 200 OK
2008/05/21 11:39:27.661 Transaction DBG: CID=0x0ceb TRANSACTION: (NICT) SIP/2.0 200 OK State: 2
2008/05/21 11:39:27.661 Transaction DBG: CID=0x0ceb Event: SIPStack::Enqueue(SIP/2.0 200 OK)
2008/05/21 11:39:27.661 UserAgent DTL: CID=0x0ceb Event: ---> Inbound - SIP/2.0 200 OK
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 SIP/2.0 200 OK
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 From: 100008 ;tag=9570f9179cfb18109778b5877be8f082
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 To: 100008 ;tag=8e373578fa68a199c630c28b25cb902f.536d
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 Via: SIP/2.0/UDP 10.0.1.13:5061;iid=2713;branch=z9hG4bK69a1f9179cfb18109778b5877be8f082;uas-addr=193.28.184.13;rport=5061;received=193.28.184.10
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 CSeq: 2 REGISTER
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 Call-ID: 9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 Contact: <sip:100008@10.0.1.13:5061;transport=udp>;expires=3600;rcv="sip:193.28.184.10:5061"
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 Server: OpenSER (1.3.0-notls (x86_64/linux))
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902 Content-Length: 0
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902
2008/05/21 11:39:27.661 UserAgent DBG: CID=0x0902
2008/05/21 11:39:27.661 Transaction DTL: CID=0x0ceb NICT(2222871560) StateProceeding->StateCompleted
2008/05/21 11:39:27.661 Transaction DBG: CID=0x0ceb NICT(2222871560) Timer E STOPPED
2008/05/21 11:39:27.661 Transaction DBG: CID=0x0ceb NICT(2222871560) Timer F STOPPED
2008/05/21 11:39:27.661 Transaction DBG: CID=0x0ceb NICT(2222871560) Timer K( 5000 ms ) STARTED
2008/05/21 11:39:27.677 UserAgent INF: CID=0x0ceb REGISTER: Registration Accepted
2008/05/21 11:39:32.614 SIP Timer Thread DBG: CID=0x0ceb NICT(2222871559) Timer K( 5000 ms ) EXPIRED
2008/05/21 11:39:32.614 Transaction DTL: CID=0x0ceb NICT(2222871559) Event( Timer-K ) Interval: 5000
2008/05/21 11:39:32.614 Transaction DTL: CID=0x0ceb NICT(2222871559) Event(Final)
2008/05/21 11:39:32.614 Transaction DTL: CID=0x0000 *** REMOVED TRANSACTION *** NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:32.614 Transaction Cleaner DBG: CID=0x0000 GC: First Stale Object SIPTransaction
2008/05/21 11:39:32.630 GC::Collector DBG: CID=0x0ceb TRANSACTION: (NICT) DESTROYED
2008/05/21 11:39:32.630 GC::Collector DTL: CID=0x0ceb NICT(2222871559) *** DESTROYED *** - NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bKaf76f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:32.661 SIP Timer Thread DBG: CID=0x0ceb NICT(2222871560) Timer K( 5000 ms ) EXPIRED
2008/05/21 11:39:32.661 Transaction DTL: CID=0x0ceb NICT(2222871560) Event( Timer-K ) Interval: 5000
2008/05/21 11:39:32.661 Transaction DTL: CID=0x0ceb NICT(2222871560) Event(Final)
2008/05/21 11:39:32.661 Transaction DTL: CID=0x0000 *** REMOVED TRANSACTION *** NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:32.661 Transaction Cleaner DBG: CID=0x0000 GC: First Stale Object SIPTransaction
2008/05/21 11:39:32.661 GC::Collector DBG: CID=0x0ceb TRANSACTION: (NICT) DESTROYED
2008/05/21 11:39:32.661 GC::Collector DTL: CID=0x0ceb NICT(2222871560) *** DESTROYED *** - NICT|9570f917-9cfb-1810-9ad2-dd0473763361@ipshka.com|z9hG4bK69a1f9179cfb18109778b5877be8f082|REGISTER
2008/05/21 11:39:38.286 Transport (INBOUND) INF: CID=0x0870 <<< OPTIONS sip:193.28.184.10:5061 SIP/2.0 SRC: 193.28.184.13:5060:UDP enc=0 bytes=241
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 From: sip:pinger@ipshka.com;tag=c7f3a574
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 To: sip:193.28.184.10:5061
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 CSeq: 1 OPTIONS
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Call-ID: 4d0b6755-ff8845d-6c962@193.28.184.13
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Content-Length: 0
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Finding transaction for OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Setting Transaction ID to 4d0b6755-ff8845d-6c962@193.28.184.13|0|OPTIONS|c7f3a574|1
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 *** CREATING TRANSACTION (NIST) ***
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Message: OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870 Call-Id: 4d0b6755-ff8845d-6c962@193.28.184.13
2008/05/21 11:39:38.286 Transport (INBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.286 Transport (INBOUND) DTL: CID=0x0870 NIST(2222871561) *** CREATED *** - NIST|4d0b6755-ff8845d-6c962@193.28.184.13|0|OPTIONS|c7f3a574|1
2008/05/21 11:39:38.286 Transaction DTL: CID=0x0870 NIST(2222871561) Event(SIPMessage) - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:39:38.286 Transaction DBG: CID=0x0870 TRANSACTION: (NIST) OPTIONS sip:193.28.184.10:5061 SIP/2.0 State: 0
2008/05/21 11:39:38.286 Transaction DTL: CID=0x0870 NIST(2222871561) StateIdle->StateTrying
2008/05/21 11:39:38.286 Transaction DBG: CID=0x0870 Event: SIPStack::Enqueue(OPTIONS sip:193.28.184.10:5061 SIP/2.0)
2008/05/21 11:39:38.286 UserAgent DTL: CID=0x0870 Event: ---> Inbound - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:39:38.286 UserAgent DBG: CID=0x06cb *** NULL SESSION *** CallSessionManager::OnCreateServerSession() got a None-INVITE request.
2008/05/21 11:39:38.286 UserAgent DBG: CID=0x06cb *** MESSAGE ARRIVAL *** No Session available to handle OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:39:38.286 UserAgent DTL: CID=0x0870 Found NIST|4d0b6755-ff8845d-6c962@193.28.184.13|0|OPTIONS|c7f3a574|1 for SIP/2.0 200 OK
2008/05/21 11:39:38.286 Transaction DTL: CID=0x0870 NIST(2222871561) Event(SIPMessage) - SIP/2.0 200 OK
2008/05/21 11:39:38.286 Transaction DBG: CID=0x0870 TRANSACTION: (NIST) SIP/2.0 200 OK State: 1
2008/05/21 11:39:38.302 Transaction DTL: CID=0x0870 NIST(2222871561)HandleStateTrying->StateCompleted
2008/05/21 11:39:38.302 Transport (OUTBOUND) INF: CID=0x0870 >>> SIP/2.0 200 OK DST: 193.28.184.13:5060:UDP SRC: 10.0.1.13:5061 enc=0 bytes=332
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 SIP/2.0 200 OK
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 From: sip:pinger@ipshka.com;tag=c7f3a574
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 To: sip:193.28.184.10:5061
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0;rport=5060;received=193.28.184.13
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 CSeq: 1 OPTIONS
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 Call-ID: 4d0b6755-ff8845d-6c962@193.28.184.13
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 Allow: INVITE, ACK, CANCEL, OPTIONS, INFO, MESSAGE, BYE, REFER, NOTIFY, OPTIONS
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870 Content-Length: 0
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.302 Transport (OUTBOUND) DBG: CID=0x0870
2008/05/21 11:39:38.302 Transaction DBG: CID=0x0870 NIST(2222871561) Timer J( 32000 ms ) STARTED
2008/05/21 11:40:07.288 Transport (INBOUND) INF: CID=0x080c <<< OPTIONS sip:193.28.184.10:5061 SIP/2.0 SRC: 193.28.184.13:5060:UDP enc=0 bytes=241
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c From: sip:pinger@ipshka.com;tag=eef3a574
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c To: sip:193.28.184.10:5061
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c CSeq: 1 OPTIONS
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Call-ID: 4d0b6755-179845d-3e962@193.28.184.13
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Content-Length: 0
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Finding transaction for OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Setting Transaction ID to 4d0b6755-179845d-3e962@193.28.184.13|0|OPTIONS|eef3a574|1
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c *** CREATING TRANSACTION (NIST) ***
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Message: OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c Call-Id: 4d0b6755-179845d-3e962@193.28.184.13
2008/05/21 11:40:07.288 Transport (INBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.288 Transport (INBOUND) DTL: CID=0x080c NIST(2222871562) *** CREATED *** - NIST|4d0b6755-179845d-3e962@193.28.184.13|0|OPTIONS|eef3a574|1
2008/05/21 11:40:07.288 Transaction DTL: CID=0x080c NIST(2222871562) Event(SIPMessage) - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:07.288 Transaction DBG: CID=0x080c TRANSACTION: (NIST) OPTIONS sip:193.28.184.10:5061 SIP/2.0 State: 0
2008/05/21 11:40:07.288 Transaction DTL: CID=0x080c NIST(2222871562) StateIdle->StateTrying
2008/05/21 11:40:07.288 Transaction DBG: CID=0x080c Event: SIPStack::Enqueue(OPTIONS sip:193.28.184.10:5061 SIP/2.0)
2008/05/21 11:40:07.288 UserAgent DTL: CID=0x080c Event: ---> Inbound - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:07.288 UserAgent DBG: CID=0x06cb *** NULL SESSION *** CallSessionManager::OnCreateServerSession() got a None-INVITE request.
2008/05/21 11:40:07.288 UserAgent DBG: CID=0x06cb *** MESSAGE ARRIVAL *** No Session available to handle OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:07.304 UserAgent DTL: CID=0x080c Found NIST|4d0b6755-179845d-3e962@193.28.184.13|0|OPTIONS|eef3a574|1 for SIP/2.0 200 OK
2008/05/21 11:40:07.304 Transaction DTL: CID=0x080c NIST(2222871562) Event(SIPMessage) - SIP/2.0 200 OK
2008/05/21 11:40:07.304 Transaction DBG: CID=0x080c TRANSACTION: (NIST) SIP/2.0 200 OK State: 1
2008/05/21 11:40:07.304 Transaction DTL: CID=0x080c NIST(2222871562)HandleStateTrying->StateCompleted
2008/05/21 11:40:07.304 Transport (OUTBOUND) INF: CID=0x080c >>> SIP/2.0 200 OK DST: 193.28.184.13:5060:UDP SRC: 10.0.1.13:5061 enc=0 bytes=332
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c SIP/2.0 200 OK
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c From: sip:pinger@ipshka.com;tag=eef3a574
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c To: sip:193.28.184.10:5061
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0;rport=5060;received=193.28.184.13
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c CSeq: 1 OPTIONS
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c Call-ID: 4d0b6755-179845d-3e962@193.28.184.13
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c Allow: INVITE, ACK, CANCEL, OPTIONS, INFO, MESSAGE, BYE, REFER, NOTIFY, OPTIONS
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c Content-Length: 0
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.304 Transport (OUTBOUND) DBG: CID=0x080c
2008/05/21 11:40:07.304 Transaction DBG: CID=0x080c NIST(2222871562) Timer J( 32000 ms ) STARTED
2008/05/21 11:40:10.257 SIP Timer Thread DBG: CID=0x0870 NIST(2222871561) Timer J( 32000 ms ) EXPIRED
2008/05/21 11:40:10.257 Transaction DTL: CID=0x0870 NIST(2222871561) Event( Timer-J ) Interval: 32000
2008/05/21 11:40:10.257 Transaction DTL: CID=0x0870 NIST(2222871561) StateCompleted->StateTerminated
2008/05/21 11:40:10.257 Transaction DTL: CID=0x0870 NIST(2222871561) Event(Final)
2008/05/21 11:40:10.257 Transaction DTL: CID=0x0000 *** REMOVED TRANSACTION *** NIST|4d0b6755-ff8845d-6c962@193.28.184.13|0|OPTIONS|c7f3a574|1
2008/05/21 11:40:10.273 Transaction Cleaner DBG: CID=0x0000 GC: First Stale Object SIPTransaction
2008/05/21 11:40:10.273 GC::Collector DBG: CID=0x0870 TRANSACTION: (NIST) DESTROYED
2008/05/21 11:40:10.273 GC::Collector DTL: CID=0x0870 NIST(2222871561) *** DESTROYED *** - NIST|4d0b6755-ff8845d-6c962@193.28.184.13|0|OPTIONS|c7f3a574|1
2008/05/21 11:40:36.290 Transport (INBOUND) INF: CID=0x082c <<< OPTIONS sip:193.28.184.10:5061 SIP/2.0 SRC: 193.28.184.13:5060:UDP enc=0 bytes=241
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c From: sip:pinger@ipshka.com;tag=0604a574
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c To: sip:193.28.184.10:5061
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c CSeq: 1 OPTIONS
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Call-ID: 4d0b6755-3e9845d-00a62@193.28.184.13
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Content-Length: 0
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Finding transaction for OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Setting Transaction ID to 4d0b6755-3e9845d-00a62@193.28.184.13|0|OPTIONS|0604a574|1
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c *** CREATING TRANSACTION (NIST) ***
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Message: OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c Call-Id: 4d0b6755-3e9845d-00a62@193.28.184.13
2008/05/21 11:40:36.290 Transport (INBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.290 Transport (INBOUND) DTL: CID=0x082c NIST(2222871563) *** CREATED *** - NIST|4d0b6755-3e9845d-00a62@193.28.184.13|0|OPTIONS|0604a574|1
2008/05/21 11:40:36.290 Transaction DTL: CID=0x082c NIST(2222871563) Event(SIPMessage) - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:36.290 Transaction DBG: CID=0x082c TRANSACTION: (NIST) OPTIONS sip:193.28.184.10:5061 SIP/2.0 State: 0
2008/05/21 11:40:36.290 Transaction DTL: CID=0x082c NIST(2222871563) StateIdle->StateTrying
2008/05/21 11:40:36.290 Transaction DBG: CID=0x082c Event: SIPStack::Enqueue(OPTIONS sip:193.28.184.10:5061 SIP/2.0)
2008/05/21 11:40:36.290 UserAgent DTL: CID=0x082c Event: ---> Inbound - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:36.305 UserAgent DBG: CID=0x06cb *** NULL SESSION *** CallSessionManager::OnCreateServerSession() got a None-INVITE request.
2008/05/21 11:40:36.305 UserAgent DBG: CID=0x06cb *** MESSAGE ARRIVAL *** No Session available to handle OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:40:36.305 UserAgent DTL: CID=0x082c Found NIST|4d0b6755-3e9845d-00a62@193.28.184.13|0|OPTIONS|0604a574|1 for SIP/2.0 200 OK
2008/05/21 11:40:36.305 Transaction DTL: CID=0x082c NIST(2222871563) Event(SIPMessage) - SIP/2.0 200 OK
2008/05/21 11:40:36.305 Transaction DBG: CID=0x082c TRANSACTION: (NIST) SIP/2.0 200 OK State: 1
2008/05/21 11:40:36.305 Transaction DTL: CID=0x082c NIST(2222871563)HandleStateTrying->StateCompleted
2008/05/21 11:40:36.305 Transport (OUTBOUND) INF: CID=0x082c >>> SIP/2.0 200 OK DST: 193.28.184.13:5060:UDP SRC: 10.0.1.13:5061 enc=0 bytes=332
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c SIP/2.0 200 OK
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c From: sip:pinger@ipshka.com;tag=0604a574
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c To: sip:193.28.184.10:5061
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0;rport=5060;received=193.28.184.13
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c CSeq: 1 OPTIONS
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c Call-ID: 4d0b6755-3e9845d-00a62@193.28.184.13
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c Allow: INVITE, ACK, CANCEL, OPTIONS, INFO, MESSAGE, BYE, REFER, NOTIFY, OPTIONS
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c Content-Length: 0
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.305 Transport (OUTBOUND) DBG: CID=0x082c
2008/05/21 11:40:36.321 Transaction DBG: CID=0x082c NIST(2222871563) Timer J( 32000 ms ) STARTED
2008/05/21 11:40:39.259 SIP Timer Thread DBG: CID=0x080c NIST(2222871562) Timer J( 32000 ms ) EXPIRED
2008/05/21 11:40:39.259 Transaction DTL: CID=0x080c NIST(2222871562) Event( Timer-J ) Interval: 32000
2008/05/21 11:40:39.259 Transaction DTL: CID=0x080c NIST(2222871562) StateCompleted->StateTerminated
2008/05/21 11:40:39.259 Transaction DTL: CID=0x080c NIST(2222871562) Event(Final)
2008/05/21 11:40:39.259 Transaction DTL: CID=0x0000 *** REMOVED TRANSACTION *** NIST|4d0b6755-179845d-3e962@193.28.184.13|0|OPTIONS|eef3a574|1
2008/05/21 11:40:39.259 Transaction Cleaner DBG: CID=0x0000 GC: First Stale Object SIPTransaction
2008/05/21 11:40:39.259 GC::Collector DBG: CID=0x080c TRANSACTION: (NIST) DESTROYED
2008/05/21 11:40:39.259 GC::Collector DTL: CID=0x080c NIST(2222871562) *** DESTROYED *** - NIST|4d0b6755-179845d-3e962@193.28.184.13|0|OPTIONS|eef3a574|1
2008/05/21 11:41:05.292 Transport (INBOUND) INF: CID=0x085b <<< OPTIONS sip:193.28.184.10:5061 SIP/2.0 SRC: 193.28.184.13:5060:UDP enc=0 bytes=241
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b From: sip:pinger@ipshka.com;tag=2d04a574
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b To: sip:193.28.184.10:5061
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b CSeq: 1 OPTIONS
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Call-ID: 4d0b6755-55a845d-d1a62@193.28.184.13
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Content-Length: 0
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Finding transaction for OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Setting Transaction ID to 4d0b6755-55a845d-d1a62@193.28.184.13|0|OPTIONS|2d04a574|1
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b *** CREATING TRANSACTION (NIST) ***
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Message: OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b Call-Id: 4d0b6755-55a845d-d1a62@193.28.184.13
2008/05/21 11:41:05.292 Transport (INBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.292 Transport (INBOUND) DTL: CID=0x085b NIST(2222871564) *** CREATED *** - NIST|4d0b6755-55a845d-d1a62@193.28.184.13|0|OPTIONS|2d04a574|1
2008/05/21 11:41:05.307 Transaction DTL: CID=0x085b NIST(2222871564) Event(SIPMessage) - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:41:05.307 Transaction DBG: CID=0x085b TRANSACTION: (NIST) OPTIONS sip:193.28.184.10:5061 SIP/2.0 State: 0
2008/05/21 11:41:05.307 Transaction DTL: CID=0x085b NIST(2222871564) StateIdle->StateTrying
2008/05/21 11:41:05.307 Transaction DBG: CID=0x085b Event: SIPStack::Enqueue(OPTIONS sip:193.28.184.10:5061 SIP/2.0)
2008/05/21 11:41:05.307 UserAgent DTL: CID=0x085b Event: ---> Inbound - OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:41:05.307 UserAgent DBG: CID=0x06cb *** NULL SESSION *** CallSessionManager::OnCreateServerSession() got a None-INVITE request.
2008/05/21 11:41:05.307 UserAgent DBG: CID=0x06cb *** MESSAGE ARRIVAL *** No Session available to handle OPTIONS sip:193.28.184.10:5061 SIP/2.0
2008/05/21 11:41:05.307 UserAgent DTL: CID=0x085b Found NIST|4d0b6755-55a845d-d1a62@193.28.184.13|0|OPTIONS|2d04a574|1 for SIP/2.0 200 OK
2008/05/21 11:41:05.307 Transaction DTL: CID=0x085b NIST(2222871564) Event(SIPMessage) - SIP/2.0 200 OK
2008/05/21 11:41:05.307 Transaction DBG: CID=0x085b TRANSACTION: (NIST) SIP/2.0 200 OK State: 1
2008/05/21 11:41:05.307 Transaction DTL: CID=0x085b NIST(2222871564)HandleStateTrying->StateCompleted
2008/05/21 11:41:05.323 Transport (OUTBOUND) INF: CID=0x085b >>> SIP/2.0 200 OK DST: 193.28.184.13:5060:UDP SRC: 10.0.1.13:5061 enc=0 bytes=332
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b SIP/2.0 200 OK
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b From: sip:pinger@ipshka.com;tag=2d04a574
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b To: sip:193.28.184.10:5061
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b Via: SIP/2.0/UDP 193.28.184.13:5060;branch=0;rport=5060;received=193.28.184.13
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b CSeq: 1 OPTIONS
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b Call-ID: 4d0b6755-55a845d-d1a62@193.28.184.13
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b Allow: INVITE, ACK, CANCEL, OPTIONS, INFO, MESSAGE, BYE, REFER, NOTIFY, OPTIONS
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b Content-Length: 0
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.323 Transport (OUTBOUND) DBG: CID=0x085b
2008/05/21 11:41:05.323 Transaction DBG: CID=0x085b NIST(2222871564) Timer J( 32000 ms ) STARTED
2008/05/21 11:41:08.260 SIP Timer Thread DBG: CID=0x082c NIST(2222871563) Timer J( 32000 ms ) EXPIRED
2008/05/21 11:41:08.260 Transaction DTL: CID=0x082c NIST(2222871563) Event( Timer-J ) Interval: 32000
2008/05/21 11:41:08.260 Transaction DTL: CID=0x082c NIST(2222871563) StateCompleted->StateTerminated
2008/05/21 11:41:08.260 Transaction DTL: CID=0x082c NIST(2222871563) Event(Final)
2008/05/21 11:41:08.260 Transaction DTL: CID=0x0000 *** REMOVED TRANSACTION *** NIST|4d0b6755-3e9845d-00a62@193.28.184.13|0|OPTIONS|0604a574|1
2008/05/21 11:41:08.260 Transaction Cleaner DBG: CID=0x0000 GC: First Stale Object SIPTransaction
2008/05/21 11:41:08.260 GC::Collector DBG: CID=0x082c TRANSACTION: (NIST) DESTROYED
2008/05/21 11:41:08.260 GC::Collector DTL: CID=0x082c NIST(2222871563) *** DESTROYED *** - NIST|4d0b6755-3e9845d-00a62@193.28.184.13|0|OPTIONS|0604a574|1
2008/05/21 11:41:15.620 IPshka.com DBG: CID=0x08f2 Session CREATED
2008/05/21 11:41:15.620 IPshka.com INF: CID=0x08f2 *** CREATED (UAC) CALL *** 586f9e18-9cfb-1810-9ad2-dd0473763361
2008/05/21 11:41:15.620 IPshka.com DBG: CID=0x06cb CREATED via=10.0.1.13:5061 for target=193.28.184.13 protocol=UDP
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2 Finding transaction for INVITE sip:810380673584814@ipshka.com SIP/2.0
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2 Setting Transaction ID to 586f9e18-9cfb-1810-9ad2-dd0473763361|z9hG4bK586f9e189cfb18109778b5877be8f082|INVITE
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2 *** CREATING TRANSACTION (ICT) ***
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2 Message: INVITE sip:810380673584814@ipshka.com SIP/2.0
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2 Call-Id: 586f9e18-9cfb-1810-9ad2-dd0473763361
2008/05/21 11:41:15.730 IPshka.com DBG: CID=0x08f2
2008/05/21