linphone-developers
[Top][All Lists]
Advanced

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

[Linphone-developers] PSTN call via (G711) to BlackBerry Linphone Applic


From: Anurag Mishra
Subject: [Linphone-developers] PSTN call via (G711) to BlackBerry Linphone Application issue
Date: Thu, 8 Dec 2011 17:39:47 +0530

Hi Sir,

I am using your Linphone for BlackBerry Application version-1.0.0 and i am using BlackBerry Bold 9780 OS supported  6.0  .and i implemented G 711 Codec and Place PSTN call successfully.
and connected   But one way voice problem . my problem is caller end not hear any Voice But callee hear My voice clearly.
So please help me what is the problem in My application.. and one another problem is that when we place the call after some time 
40 to 60 second BlackBerry Device is being hang. and Error Message is  " App error 603 Reset"  
So please help me what is the problem.......


see Error Log Message below....


[0.0] 1323343224152 :: Setting Branch id : z9hG4bK7d758179ce5bc2ade3786471df676348
[0.0] 1323343224160 :: Creating Client Transaction For Dialog-Initiating request (INVITE)
[0.0] 1323343224168 :: [SIPTransactionStack] Creating dialog for transaction sip4me.gov.nist.siplite.stack[0.0] address@hidden
[0.0] 1323343224180 :: Transaction Added address@hidden to dialo[0.0] g address@hidden tags: ly4uLzoHW / null
[0.0] 1323343224191 :: TID = z9hg4bk7d758179ce5bc2ade3786471df676348/false
[0.0] 1323343224200 :: Sending request directly through Client Transaction
[0.0] 1323343224208 :: Setting Branch id : z9hG4bK7d758179ce5bc2ade3786471df676348
[0.0] 1323343224217 :: setState address@hidden 2
[0.0] 1323343224228 :: Sending message to [aa.ss.sd.ff:5060/UDP]
[0.0] INVITE sip:address@hidden SIP/2.0

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 INVITE

[0.0] To: <sip:address@hidden>

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport;branch=z9hG4bK7d758179ce5bc2ade3786471df676348

[0.0] Max-Forwards: 70

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Route: <sip:aa.ss.sd.ff;lr>

[0.0] Contact: <sip:address@hidden:15755>

[0.0] Content-Type: application/sdp

[0.0] Content-Length: 188

[0.0] 

[0.0] v=0

[0.0] o=blackberry 1323343224023 1323343224023 IN IP4 192.168.1.99

[0.0] s=Phone call

[0.0] c=IN IP4 192.168.1.99

[0.0] t=0 0

[0.0] t=0 0

[0.0] m=audio 4000 RTP/AVP 0

[0.0] a=rtpmap:0 PCMU/8000/1

[0.0] a=fmtp:0 pcma/8000/1

[0.0]   to be sent to  
[0.0] Softphone-Info:Call button pressed by saurabh.
[0.0] 1323343224905 :: SIPTransactionStack: creating new Response SIP/2.0 100 Trying

[0.0] 
[0.0] 1323343224926 :: Found Transaction address@hidden for SIP/[0.0] 2.0 100 Trying

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport=15755;branch=z9hG4bK7d758179ce5bc2ade3786471df676348;receive[0.0] d=192.168.1.99

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 INVITE

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343225001 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343225014 :: processing SIP/2.0 100 Trying

[0.0] current state = 2
[0.0] 1323343225030 :: addRoute: dialogState: address@hidden = -1
[0.0] 1323343225040 :: setState address@hidden 3
[0.0] 1323343225050 :: PROCESSING INCOMING RESPONSESIP/2.0 100 Trying

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport=15755;branch=z9hG4bK7d758179ce5bc2ade3786471df676348;receive[0.0] d=192.168.1.99

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 INVITE

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343225119 :: Transaction = address@hidden
[0.0] 1323343225128 :: handleEvent address@hidden
[0.0] currentTransaction = address@hidden
[0.0] this.sipListener = address@hidden
[0.0] 1323343225156 :: Adding event to EventScanner queue: sip4me.gov.nist.siplite.stack.ClientTransaction[0.0] @2af497e2
[0.0] 1323343225168 :: EventScanner waking up!
[0.0] 1323343225176 :: Processing address@hidden nevents 1
[0.0] Sal-Warn:Unexpected answer [100 sip:address@hidden
[0.0] 1323343225194 :: EventScanner going to sleep!
[0.0] 1323343225225 :: SIPTransactionStack: creating new Response SIP/2.0 401 Unauthorized

[0.0] 
[0.0] 1323343225246 :: Found Transaction address@hidden for SIP/[0.0] 2.0 401 Unauthorized

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bK7d758179ce5bc2ade3[0.0] 786471df676348

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 INVITE

[0.0] Server: Sippy

[0.0] WWW-Authenticate: Digest realm="aa.ss.sd.ff",nonce="4b998f019160623aa8d1bd95408fe6d025c3"

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343225337 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343225349 :: processing SIP/2.0 401 Unauthorized

[0.0] current state = 3
[0.0] 1323343225364 :: addRoute: dialogState: address@hidden = -1
[0.0] 1323343225373 :: Setting dialog state for address@hidden to 4
[0.0] 1323343225381 :: New dialog state is 4dialogId = address@hidden:134756[0.0] address@hidden:ly4ulzohw:address@hidden
[0.0] 1323343225394 :: setState address@hidden 6
[0.0] 1323343225403 :: Terminating transaction
[0.0] 1323343225417 :: Sending message to [aa.ss.sd.ff:5060/UDP]
[0.0] ACK sip:address@hidden SIP/2.0

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 ACK

[0.0] To: <sip:address@hidden>

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport;branch=z9hG4bK7d758179ce5bc2ade3786471df676348

[0.0] Max-Forwards: 70

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Contact: <sip:address@hidden:15755>

[0.0] Route: <sip:aa.ss.sd.ff;lr>

[0.0] Content-Length: 0

[0.0] 

[0.0]   to be sent to  
[0.0] 1323343225517 :: setState address@hidden 4
[0.0] 1323343225530 :: PROCESSING INCOMING RESPONSESIP/2.0 401 Unauthorized

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bK7d758179ce5bc2ade3[0.0] 786471df676348

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 INVITE

[0.0] Server: Sippy

[0.0] WWW-Authenticate: Digest realm="aa.ss.sd.ff",nonce="4b998f019160623aa8d1bd95408fe6d025c3"

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343225623 :: Transaction = address@hidden
[0.0] 1323343225633 :: handleEvent address@hidden
[0.0] currentTransaction = address@hidden
[0.0] this.sipListener = address@hidden
[0.0] 1323343225656 :: Adding event to EventScanner queue: sip4me.gov.nist.siplite.stack.ClientTransaction[0.0] @2af497e2
[0.0] 1323343225667 :: EventScanner waking up!
[0.0] 1323343225675 :: Processing address@hidden nevents 1
[0.0] 1323343225684 :: setting state of SipDialog to 3
[0.0] 1323343225692 :: Authorization is required but no Credentials were set for this client connection
[0.0] 1323343225707 :: Authentication is needed for request: INVITE sip:address@hidden SIP/[0.0] 2.0

[0.0] 
[0.0] 1323343225729 :: Creating new authenticated request with credentials
[0.0] 1323343225741 :: DigestClientAuthentication, generateResponse(): Trying to generate a response for t[0.0] he user: 13475605032 , with the realm: aa.ss.sd.ff
[0.0] 1323343225751 :: DigestClientAuthentication, generateResponse(), userName:13475605032!
[0.0] 1323343225757 :: DigestClientAuthentication, generateResponse(), realm:aa.ss.sd.ff!
[0.0] 1323343225764 :: DigestClientAuthentication, generateResponse(), password:r23437m1!
[0.0] 1323343225770 :: DigestClientAuthentication, generateResponse(), uri:sip:address@hidden[0.0] 32!
[0.0] 1323343225779 :: DigestClientAuthentication, generateResponse(), nonce:4b998f019160623aa8d1bd95408fe[0.0] 6d025c3!
[0.0] 1323343225789 :: DigestClientAuthentication, generateResponse(), method:INVITE!
[0.0] 1323343225797 :: DigestClientAuthentication, generateResponse(): response generated: 37c8fdfe7839d2d[0.0] cb59201b5dcd59641
[0.0] 1323343225807 :: [SipClientConnection] Sending request INVITE
[0.0] 1323343225819 :: could not find existing transaction for INVITE sip:address@hidden SI[0.0] P/2.0

[0.0] 
[0.0] 1323343225839 :: Getting dialog for address@hidden:address@hidden 111.132:qpvsyz26r:address@hidden
[0.0] 1323343225851 :: could not find existing dialog for INVITE sip:address@hidden SIP/2.0[0.0] 

[0.0]  and dialogID: address@hidden:address@hidden:qpvsyz26r:009[0.0] address@hidden
[0.0] 1323343225873 :: create hop for aa.ss.sd.ff:5060/udp
[0.0] 1323343225881 :: NextHop based on Route:aa.ss.sd.ff:5060/udp
[0.0] 1323343225893 :: createMessageChannel aa.ss.sd.ff:5060/udp processor sip4me.gov.nist.siplite.stac[0.0] address@hidden
[0.0] 1323343225907 :: Creating clientTransaction address@hidden
[0.0] 1323343225920 :: hop = aa.ss.sd.ff:5060/udp ; ct address@hidden ef48230b for topmostVia: Via: SIP/2.0/UDP 192.168.2.5:5060;rport;branch=z9hG4bK7d758179ce5bc2ade3786[0.0] 471df676348

[0.0] 
[0.0] 1323343225944 :: Setting Branch id : z9hG4bKb58c212748ce32e05393b57ed92751de
[0.0] 1323343225954 :: Creating Client Transaction For Dialog-Initiating request (INVITE)
[0.0] 1323343225962 :: [SIPTransactionStack] Creating dialog for transaction sip4me.gov.nist.siplite.stack[0.0] address@hidden
[0.0] 1323343225974 :: Transaction Added address@hidden to dialo[0.0] g address@hidden tags: qpVsYz26r / null
[0.0] 1323343225987 :: TID = z9hg4bkb58c212748ce32e05393b57ed92751de/false
[0.0] 1323343225995 :: Sending request directly through Client Transaction
[0.0] 1323343226003 :: Setting Branch id : z9hG4bKb58c212748ce32e05393b57ed92751de
[0.0] 1323343226012 :: setState address@hidden 2
[0.0] 1323343226025 :: Sending message to [aa.ss.sd.ff:5060/UDP]
[0.0] INVITE sip:address@hidden SIP/2.0

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] To: <sip:address@hidden>

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport;branch=z9hG4bKb58c212748ce32e05393b57ed92751de

[0.0] Max-Forwards: 70

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Route: <sip:aa.ss.sd.ff;lr>

[0.0] Contact: <sip:address@hidden:15755>

[0.0] Content-Type: application/sdp

[0.0] Authorization: Digest username="13475605032",realm="aa.ss.sd.ff",uri="sip:address@hidden 11.132",algorithm=MD5,nonce="4b998f019160623aa8d1bd95408fe6d025c3",response="37c8fdfe7839d2dcb59201b[0.0] 5dcd59641"

[0.0] Content-Length: 188

[0.0] 

[0.0] v=0

[0.0] o=blackberry 1323343224023 1323343224023 IN IP4 192.168.1.99

[0.0] s=Phone call

[0.0] c=IN IP4 192.168.1.99

[0.0] t=0 0

[0.0] t=0 0

[0.0] m=audio 4000 RTP/AVP 0

[0.0] a=rtpmap:0 PCMU/8000/1

[0.0] a=fmtp:0 pcma/8000/1

[0.0]   to be sent to  
[0.0] 1323343226211 :: EventScanner going to sleep!
[0.0] 1323343226241 :: SIPTransactionStack: creating new Response SIP/2.0 401 Unauthorized

[0.0] 
[0.0] 1323343226262 :: Found Transaction address@hidden for SIP/[0.0] 2.0 401 Unauthorized

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bK7d758179ce5bc2ade3[0.0] 786471df676348

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 INVITE

[0.0] Server: Sippy

[0.0] WWW-Authenticate: Digest realm="aa.ss.sd.ff",nonce="4b998f019160623aa8d1bd95408fe6d025c3"

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343226359 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343226372 :: processing SIP/2.0 401 Unauthorized

[0.0] current state = 4
[0.0] 1323343226387 :: addRoute: dialogState: address@hidden = 4
[0.0] 1323343226401 :: Sending message to [aa.ss.sd.ff:5060/UDP]
[0.0] ACK sip:address@hidden SIP/2.0

[0.0] Call-Id: address@hidden

[0.0] CSeq: 1 ACK

[0.0] To: <sip:address@hidden>

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport;branch=z9hG4bK7d758179ce5bc2ade3786471df676348

[0.0] Max-Forwards: 70

[0.0] From: <sip:address@hidden>;tag=ly4uLzoHW

[0.0] Contact: <sip:address@hidden:15755>

[0.0] Route: <sip:aa.ss.sd.ff;lr>

[0.0] Content-Length: 0

[0.0] 

[0.0]   to be sent to  
[0.0] SIM cache not loaded
[0.0] 1323343226702 :: SIPTransactionStack: creating new Response SIP/2.0 100 Trying

[0.0] 
[0.0] 1323343226722 :: Found Transaction address@hidden for SIP/[0.0] 2.0 100 Trying

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport=15755;branch=z9hG4bKb58c212748ce32e05393b57ed92751de;receive[0.0] d=192.168.1.99

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343226797 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343226808 :: processing SIP/2.0 100 Trying

[0.0] current state = 2
[0.0] 1323343226824 :: addRoute: dialogState: address@hidden = -1
[0.0] 1323343226832 :: setState address@hidden 3
[0.0] 1323343226844 :: PROCESSING INCOMING RESPONSESIP/2.0 100 Trying

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport=15755;branch=z9hG4bKb58c212748ce32e05393b57ed92751de;receive[0.0] d=192.168.1.99

[0.0] To: <sip:address@hidden>

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343226915 :: Transaction = address@hidden
[0.0] 1323343226927 :: handleEvent address@hidden
[0.0] currentTransaction = address@hidden
[0.0] this.sipListener = address@hidden
[0.0] 1323343226949 :: Adding event to EventScanner queue: sip4me.gov.nist.siplite.stack.ClientTransaction[0.0] @ef48230b
[0.0] 1323343226962 :: EventScanner waking up!
[0.0] 1323343226971 :: Processing address@hidden nevents 1
[0.0] Sal-Warn:Unexpected answer [100 sip:address@hidden
[0.0] 1323343226991 :: EventScanner going to sleep!
[0.0] 1323343227788 :: SIPTransactionStack: creating new Response SIP/2.0 180 Ringing

[0.0] 
[0.0] 1323343227810 :: Found Transaction address@hidden for SIP/[0.0] 2.0 180 Ringing

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bKb58c212748ce32e053[0.0] 93b57ed92751de

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Server: Sippy

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343227899 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343227912 :: processing SIP/2.0 180 Ringing

[0.0] current state = 3
[0.0] 1323343227932 :: addRoute: dialogState: address@hidden = -1
[0.0] 1323343227941 :: putDialog address@hidden with dialogId=acec8ab833c06[0.0] address@hidden:address@hidden:qpvsyz26r:address@hidden:y[0.0] 2syg4jz3dhpddrm.i
[0.0] 1323343227957 :: Setting dialog state for address@hidden to 1
[0.0] 1323343227967 :: New dialog state is 1dialogId = address@hidden:134756[0.0] address@hidden:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343227981 :: PROCESSING INCOMING RESPONSESIP/2.0 180 Ringing

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bKb58c212748ce32e053[0.0] 93b57ed92751de

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Server: Sippy

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343228066 :: Transaction = address@hidden
[0.0] 1323343228075 :: handleEvent address@hidden
[0.0] currentTransaction = address@hidden
[0.0] this.sipListener = address@hidden
[0.0] 1323343228100 :: Adding event to EventScanner queue: sip4me.gov.nist.siplite.stack.ClientTransaction[0.0] @ef48230b
[0.0] 1323343228112 :: EventScanner waking up!
[0.0] 1323343228121 :: Processing address@hidden nevents 1
[0.0] MSM[0]: created session
[0.0] MSM[0]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 0] [size: 65536]
[0.0] [STREAM] allocating stream [index: 0] [size: 65536]
[0.0] [STREAM] allocated stream [index: 0] [handle: 3083] [size: 65536]
[0.0] null:_ss=3083 PID=293
[0.0] MN: load 0
[0.0] MN: init0(16777216, 0, 1, 65535)=0
[0.0] MSM[0]: Stream 3083 watermark remain=0 avail=65536
[0.0] [STREAM] write [handle: 3083] 53126 bytes written
[0.0] MSM[0]: Stream Streaming session: 3083 wrote 53126
[0.0] MP: h=16777216,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(16777216)=0
[0.0] MP: h=16777216,s=LG: -sNMD
[0.0] MP: h=16777216,s=LG: +mLod(293):120
[0.0] MP: h=16777216,s=LG: -> LD
[0.0] MN: getPlayableStreams0(16777216)=65537
[0.0] MP: h=16777216,s=LD: -mLod
[0.0] MN: getLength0(16777216)=3317
[0.0] MN: getPlayableStreams0(16777216)=65537
[0.0] MN: isSeekable0(16777216)=1
[0.0] MP: h=16777216,s=LD: statUpdEn true
[0.0] MN: slewVolume(16777216, 70, 1)=0
[0.0] MP: h=16777216,s=LD: volChange 70
[0.0] MN: slewVolume(16777216, 70, 1)=0
[0.0] AR: add source 14
[0.0] AR: setAudioMode 34
[0.0] 3rd Party explicitly set sink.
[0.0] MP: h=16777216,s=LD: +play(293):293
[0.0] MN: play0(16777216) is audio, NO check for active pause
[0.0] MN: play0(16777216)=0
[0.0] MP: h=16777216,s=LD: -> PL
[0.0] MP: h=16777216,s=PL: -play
[0.0] 1323343228462 :: EventScanner going to sleep!
[0.0] MP: h=16777216,s=PL: volChange 70
[0.0] MP: h=16777216,s=PL: mStat: 0
[0.0] MN: slewVolume(16777216, 70, 1)=0
[0.0] SMP[2058874016,MP: h=16777216]: BUFFERING = 0
[0.0] SMP[2058874016,MP: h=16777216]: BUFFERING = 100
[0.0] MP: h=16777216,s=PL: volChange 70
[0.0] MP: h=16777216,s=PL: mStat: -1
[0.0] MP: h=16777216,s=PL: -> LD
[0.0] MP: h=16777216,s=LD: +unld(293):120
[0.0] MP: h=16777216,s=LD: -> UG
[0.0] MN: unload0(16777216)=0 pauseHandle=0
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=16777216 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MP: h=16777216,s=UG: +mStp(293):120
[0.0] MP: h=16777216,s=UG: +unlC
[0.0] MN: finalize0(16777216)
[0.0] MN: unload 1
[0.0] MP: h=16777216,s=UG: -> UD
[0.0] MSM[0]: release
[0.0] MSM[0]: Stream 3083 sink done
[0.0] MSM[0]: Stream Streaming session: 3083 sendSourceEnded called
[0.0] MP: h=16777216,s=UD: -unld
[0.0] AR: remove source 14
[0.0] AR: setAudioMode 32
[0.0] MSM[0]: RT exit
[0.0] [STREAM] releasing buffer [index: 0] [handle: 3083]
[0.0] MSM[0]: already released
[0.0] MSM[0]: already released
[0.0] MSM[0]: already released
[0.0] MP: h=16777216,s=UD: -unlC
[0.0] MP: h=16777216,s=UD: -mStp
[0.0] MSM[0]: created session
[0.0] MSM[0]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 0] [size: 65536]
[0.0] [STREAM] allocating stream [index: 0] [size: 65536]
[0.0] [STREAM] allocated stream [index: 0] [handle: 3339] [size: 65536]
[0.0] null:_ss=3339 PID=120
[0.0] MN: load 0
[0.0] MN: init0(33554432, 0, 1, 65535)=0
[0.0] MSM[0]: Stream 3339 watermark remain=0 avail=65536
[0.0] [STREAM] write [handle: 3339] 53126 bytes written
[0.0] MSM[0]: Stream Streaming session: 3339 wrote 53126
[0.0] MP: h=33554432,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(33554432)=0
[0.0] MP: h=33554432,s=LG: -sNMD
[0.0] MP: h=33554432,s=LG: +mLod(120):120
[0.0] MP: h=33554432,s=LG: -> LD
[0.0] MN: getPlayableStreams0(33554432)=65537
[0.0] MP: h=33554432,s=LD: -mLod
[0.0] MN: getLength0(33554432)=3317
[0.0] MN: getPlayableStreams0(33554432)=65537
[0.0] MN: isSeekable0(33554432)=1
[0.0] MP: h=33554432,s=LD: statUpdEn true
[0.0] MN: slewVolume(33554432, 70, 1)=0
[0.0] AR: add source 14
[0.0] AR: setAudioMode 34
[0.0] 3rd Party explicitly set sink.
[0.0] MP: h=33554432,s=LD: +play(120):120
[0.0] MN: play0(33554432) is audio, NO check for active pause
[0.0] MN: play0(33554432)=0
[0.0] MP: h=33554432,s=LD: -> PL
[0.0] MP: h=33554432,s=PL: -play
[0.0] MP: h=33554432,s=PL: volChange 70
[0.0] MN: slewVolume(33554432, 70, 1)=0
[0.0] MP: h=33554432,s=PL: mStat: 0
[0.0] SMP[2058874016,MP: h=33554432]: BUFFERING = 0
[0.0] SMP[2058874016,MP: h=33554432]: BUFFERING = 100
[0.0] MP: h=33554432,s=PL: volChange 70
[0.0] MP: h=33554432,s=PL: mStat: -1
[0.0] MP: h=33554432,s=PL: -> LD
[0.0] MP: h=33554432,s=LD: +unld(120):120
[0.0] MP: h=33554432,s=LD: -> UG
[0.0] MN: unload0(33554432)=0 pauseHandle=0
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=33554432 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MP: h=33554432,s=UG: +mStp(120):120
[0.0] MP: h=33554432,s=UG: +unlC
[0.0] MN: finalize0(33554432)
[0.0] MN: unload 1
[0.0] MP: h=33554432,s=UG: -> UD
[0.0] MSM[0]: release
[0.0] MSM[0]: Stream 3339 sink done
[0.0] MSM[0]: Stream Streaming session: 3339 sendSourceEnded called
[0.0] MP: h=33554432,s=UD: -unld
[0.0] AR: remove source 14
[0.0] AR: setAudioMode 32
[0.0] MSM[0]: RT exit
[0.0] [STREAM] releasing buffer [index: 0] [handle: 3339]
[0.0] MSM[0]: already released
[0.0] MSM[0]: already released
[0.0] MSM[0]: already released
[0.0] MP: h=33554432,s=UD: -unlC
[0.0] MP: h=33554432,s=UD: -mStp
[0.0] MSM[1]: created session
[0.0] MSM[1]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 0] [size: 65536]
[0.0] [STREAM] allocating stream [index: 0] [size: 65536]
[0.0] [STREAM] allocated stream [index: 0] [handle: 3595] [size: 65536]
[0.0] null:_ss=3595 PID=120
[0.0] MN: load 0
[0.0] MN: init0(50331648, 0, 1, 65535)=0
[0.0] MSM[1]: Stream 3595 watermark remain=0 avail=65536
[0.0] [STREAM] write [handle: 3595] 53126 bytes written
[0.0] MSM[1]: Stream Streaming session: 3595 wrote 53126
[0.0] MP: h=50331648,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(50331648)=0
[0.0] MP: h=50331648,s=LG: -sNMD
[0.0] MP: h=50331648,s=LG: +mLod(120):120
[0.0] MP: h=50331648,s=LG: -> LD
[0.0] MN: getPlayableStreams0(50331648)=65537
[0.0] MP: h=50331648,s=LD: -mLod
[0.0] MN: getLength0(50331648)=3317
[0.0] MN: getPlayableStreams0(50331648)=65537
[0.0] MN: isSeekable0(50331648)=1
[0.0] MP: h=50331648,s=LD: statUpdEn true
[0.0] MN: slewVolume(50331648, 70, 1)=0
[0.0] AR: add source 14
[0.0] AR: setAudioMode 34
[0.0] 3rd Party explicitly set sink.
[0.0] MP: h=50331648,s=LD: +play(120):120
[0.0] MN: play0(50331648) is audio, NO check for active pause
[0.0] MN: play0(50331648)=0
[0.0] MP: h=50331648,s=LD: -> PL
[0.0] MP: h=50331648,s=PL: -play
[0.0] MP: h=50331648,s=PL: volChange 70
[0.0] MN: slewVolume(50331648, 70, 1)=0
[0.0] MP: h=50331648,s=PL: mStat: 0
[0.0] SMP[2058874016,MP: h=50331648]: BUFFERING = 0
[0.0] SMP[2058874016,MP: h=50331648]: BUFFERING = 100
[0.0] MP: h=50331648,s=PL: volChange 70
[0.0] MP: h=50331648,s=PL: mStat: -1
[0.0] MP: h=50331648,s=PL: -> LD
[0.0] MP: h=50331648,s=LD: +unld(120):120
[0.0] MP: h=50331648,s=LD: -> UG
[0.0] MN: unload0(50331648)=0 pauseHandle=0
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=50331648 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MP: h=50331648,s=UG: +mStp(120):120
[0.0] MP: h=50331648,s=UG: +unlC
[0.0] MN: finalize0(50331648)
[0.0] MN: unload 1
[0.0] MP: h=50331648,s=UG: -> UD
[0.0] MSM[1]: release
[0.0] MSM[1]: Stream 3595 sink done
[0.0] MSM[1]: Stream Streaming session: 3595 sendSourceEnded called
[0.0] MP: h=50331648,s=UD: -unld
[0.0] AR: remove source 14
[0.0] AR: setAudioMode 32
[0.0] MSM[1]: RT exit
[0.0] [STREAM] releasing buffer [index: 0] [handle: 3595]
[0.0] MSM[1]: already released
[0.0] MSM[1]: already released
[0.0] MSM[1]: already released
[0.0] MP: h=50331648,s=UD: -unlC
[0.0] MP: h=50331648,s=UD: -mStp
[0.0] MSM[2]: created session
[0.0] MSM[2]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 0] [size: 65536]
[0.0] [STREAM] allocating stream [index: 0] [size: 65536]
[0.0] [STREAM] allocated stream [index: 0] [handle: 3851] [size: 65536]
[0.0] null:_ss=3851 PID=120
[0.0] MN: load 0
[0.0] MN: init0(67108864, 0, 1, 65535)=0
[0.0] [STREAM] write [handle: 3851] 53126 bytes written
[0.0] MSM[2]: Stream Streaming session: 3851 wrote 53126
[0.0] MP: h=67108864,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(67108864)=0
[0.0] MP: h=67108864,s=LG: -sNMD
[0.0] MSM[2]: Stream 3851 watermark remain=0 avail=65536
[0.0] MP: h=67108864,s=LG: +mLod(120):120
[0.0] MP: h=67108864,s=LG: -> LD
[0.0] MN: getPlayableStreams0(67108864)=65537
[0.0] MP: h=67108864,s=LD: -mLod
[0.0] MN: getLength0(67108864)=3317
[0.0] MN: getPlayableStreams0(67108864)=65537
[0.0] MN: isSeekable0(67108864)=1
[0.0] MP: h=67108864,s=LD: statUpdEn true
[0.0] MN: slewVolume(67108864, 70, 1)=0
[0.0] AR: add source 14
[0.0] AR: setAudioMode 34
[0.0] 3rd Party explicitly set sink.
[0.0] MP: h=67108864,s=LD: +play(120):120
[0.0] MN: play0(67108864) is audio, NO check for active pause
[0.0] MN: play0(67108864)=0
[0.0] MP: h=67108864,s=LD: -> PL
[0.0] MP: h=67108864,s=PL: -play
[0.0] MP: h=67108864,s=PL: volChange 70
[0.0] MN: slewVolume(67108864, 70, 1)=0
[0.0] MP: h=67108864,s=PL: mStat: 0
[0.0] SMP[2058874016,MP: h=67108864]: BUFFERING = 0
[0.0] SMP[2058874016,MP: h=67108864]: BUFFERING = 100
[0.0] MP: h=67108864,s=PL: volChange 70
[0.0] 1323343243766 :: SIPTransactionStack: creating new Response SIP/2.0 180 Ringing

[0.0] 
[0.0] 1323343243788 :: Found Transaction address@hidden for SIP/[0.0] 2.0 180 Ringing

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bKb58c212748ce32e053[0.0] 93b57ed92751de

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Server: Sippy

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343243874 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343243887 :: processing SIP/2.0 180 Ringing

[0.0] current state = 3
[0.0] 1323343243903 :: addRoute: dialogState: address@hidden = 1
[0.0] 1323343243919 :: PROCESSING INCOMING RESPONSESIP/2.0 180 Ringing

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bKb58c212748ce32e053[0.0] 93b57ed92751de

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Server: Sippy

[0.0] Content-Length: 0

[0.0] 

[0.0] 
[0.0] 1323343244002 :: Transaction = address@hidden
[0.0] 1323343244012 :: handleEvent address@hidden
[0.0] currentTransaction = address@hidden
[0.0] this.sipListener = address@hidden
[0.0] 1323343244034 :: Adding event to EventScanner queue: sip4me.gov.nist.siplite.stack.ClientTransaction[0.0] @ef48230b
[0.0] 1323343244047 :: EventScanner waking up!
[0.0] 1323343244055 :: Processing address@hidden nevents 1
[0.0] MP: h=67108864,s=PL: mStat: -1
[0.0] MP: h=67108864,s=PL: -> LD
[0.0] MP: h=67108864,s=LD: +unld(120):120
[0.0] MP: h=67108864,s=LD: -> UG
[0.0] MN: unload0(67108864)=0 pauseHandle=0
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=67108864 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MP: h=67108864,s=UG: +mStp(120):120
[0.0] MP: h=67108864,s=UG: +unlC
[0.0] MN: finalize0(67108864)
[0.0] MN: unload 1
[0.0] MP: h=67108864,s=UG: -> UD
[0.0] MSM[2]: release
[0.0] MSM[2]: Stream 3851 sink done
[0.0] MSM[2]: Stream Streaming session: 3851 sendSourceEnded called
[0.0] MSM[1]: created session
[0.0] MSM[1]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 1] [size: 65536]
[0.0] [STREAM] allocating stream [index: 1] [size: 65536]
[0.0] [STREAM] allocated stream [index: 1] [handle: 4108] [size: 65536]
[0.0] null:_ss=4108 PID=293
[0.0] MN: load 0
[0.0] MN: init0(83886080, 0, 1, 65535)=0
[0.0] MP: h=67108864,s=UD: -unld
[0.0] AR: remove source 14
[0.0] AR: setAudioMode 32
[0.0] MSM[2]: RT exit
[0.0] MN: slewVolume(83886080, 70, 1)=0
[0.0] [STREAM] releasing buffer [index: 0] [handle: 3851]
[0.0] MSM[2]: already released
[0.0] MSM[2]: already released
[0.0] MSM[2]: already released
[0.0] MP: h=67108864,s=UD: -unlC
[0.0] MP: h=67108864,s=UD: -mStp
[0.0] MP: h=83886080,s=LG: volChange 70
[0.0] [STREAM] write [handle: 4108] 53126 bytes written
[0.0] MSM[1]: Stream Streaming session: 4108 wrote 53126
[0.0] MSM[1]: Stream 4108 watermark remain=0 avail=65536
[0.0] MP: h=83886080,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(83886080)=0
[0.0] MP: h=83886080,s=LG: -sNMD
[0.0] MP: h=83886080,s=LG: +mLod(293):120
[0.0] MP: h=83886080,s=LG: -> LD
[0.0] MN: getPlayableStreams0(83886080)=65537
[0.0] MP: h=83886080,s=LD: -mLod
[0.0] MN: getLength0(83886080)=3317
[0.0] MN: getPlayableStreams0(83886080)=65537
[0.0] MN: isSeekable0(83886080)=1
[0.0] MSM[3]: created session
[0.0] MSM[3]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 1] [size: 65536]
[0.0] [STREAM] allocating stream [index: 1] [size: 65536]
[0.0] [STREAM] allocated stream [index: 1] [handle: 4363] [size: 65536]
[0.0] null:_ss=4363 PID=120
[0.0] MN: load 1
[0.0] MN: init0(100663297, 0, 1, 65535)=0
[0.0] MP: h=83886080,s=LD: statUpdEn true
[0.0] MSM[3]: Stream 4363 watermark remain=0 avail=65536
[0.0] MN: slewVolume(83886080, 70, 1)=0
[0.0] MN: slewVolume(100663297, 70, 1)=0
[0.0] MP: h=83886080,s=LD: volChange 70
[0.0] [STREAM] write [handle: 4363] 53126 bytes written
[0.0] MSM[3]: Stream Streaming session: 4363 wrote 53126
[0.0] MN: slewVolume(83886080, 70, 1)=0
[0.0] AR: add source 14
[0.0] AR: setAudioMode 34
[0.0] 3rd Party explicitly set sink.
[0.0] SIM cache not loaded
[0.0] MP: h=83886080,s=LD: +play(293):293
[0.0] MN: play0(83886080) is audio, NO check for active pause
[0.0] MN: play0(83886080)=0
[0.0] MP: h=83886080,s=LD: -> PL
[0.0] MP: h=83886080,s=PL: -play
[0.0] MP: h=100663297,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(100663297)=0
[0.0] MP: h=100663297,s=LG: -sNMD
[0.0] MN: slewVolume(83886080, 70, 1)=0
[0.0] 1323343244709 :: EventScanner going to sleep!
[0.0] MP: h=83886080,s=PL: volChange 70
[0.0] MN: slewVolume(100663297, 70, 1)=0
[0.0] MP: h=100663297,s=LG: +mLod(120):120
[0.0] MP: h=100663297,s=LG: -> LD
[0.0] MN: getPlayableStreams0(100663297)=65537
[0.0] MP: h=100663297,s=LD: -mLod
[0.0] MN: getLength0(100663297)=3317
[0.0] MN: getPlayableStreams0(100663297)=65537
[0.0] MP: h=83886080,s=PL: volChange 70
[0.0] MN: isSeekable0(100663297)=1
[0.0] MP: h=83886080,s=PL: mStat: 0
[0.0] MP: h=100663297,s=LD: statUpdEn true
[0.0] MN: slewVolume(100663297, 70, 1)=0
[0.0] AR: source 14is already added
[0.0] MP: h=100663297,s=LD: +play(120):120
[0.0] MN: play0(100663297) is audio, NO check for active pause
[0.0] MN: play0(100663297)=0
[0.0] MP: h=100663297,s=LD: -> PL
[0.0] MP: h=100663297,s=PL: -play
[0.0] SMP[585234753,MP: h=83886080]: BUFFERING = 0
[0.0] SMP[585234753,MP: h=83886080]: BUFFERING = 100
[0.0] SMP[2058874016,MP: h=100663297]: BUFFERING = 0
[0.0] SMP[2058874016,MP: h=100663297]: BUFFERING = 100
[0.0] MP: h=83886080,s=PL: volChange 70
[0.0] MP: h=100663297,s=PL: volChange 70
[0.0] MP: h=100663297,s=PL: volChange 70
[0.0] SIM cache not loaded
[0.0] MP: h=83886080,s=PL: mStat: -1
[0.0] MP: h=83886080,s=PL: -> LD
[0.0] MP: h=83886080,s=LD: +unld(293):120
[0.0] MP: h=83886080,s=LD: -> UG
[0.0] MN: unload0(83886080)=0 pauseHandle=0
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=83886080 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MP: h=83886080,s=UG: +mStp(293):120
[0.0] MP: h=83886080,s=UG: +unlC
[0.0] MN: finalize0(83886080)
[0.0] MN: unload 2
[0.0] MP: h=83886080,s=UG: -> UD
[0.0] MSM[1]: release
[0.0] MSM[1]: Stream 4108 sink done
[0.0] MSM[1]: Stream Streaming session: 4108 sendSourceEnded called
[0.0] MP: h=83886080,s=UD: -unld
[0.0] AR: source 14still active
[0.0] MSM[1]: RT exit
[0.0] [STREAM] releasing buffer [index: 0] [handle: 4108]
[0.0] MSM[1]: already released
[0.0] MSM[1]: already released
[0.0] MSM[1]: already released
[0.0] MP: h=83886080,s=UD: -unlC
[0.0] MP: h=83886080,s=UD: -mStp
[0.0] MSM[4]: created session
[0.0] MSM[4]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 1] [size: 65536]
[0.0] [STREAM] allocating stream [index: 1] [size: 65536]
[0.0] [STREAM] allocated stream [index: 1] [handle: 4620] [size: 65536]
[0.0] null:_ss=4620 PID=120
[0.0] MN: load 1
[0.0] MN: init0(117440512, 0, 1, 65535)=0
[0.0] MSM[4]: Stream 4620 watermark remain=0 avail=65536
[0.0] MP: h=100663297,s=PL: mStat: -1
[0.0] MP: h=100663297,s=PL: -> LD
[0.0] [STREAM] write [handle: 4620] 53126 bytes written
[0.0] MSM[4]: Stream Streaming session: 4620 wrote 53126
[0.0] MP: h=100663297,s=LD: +unld(120):120
[0.0] MP: h=117440512,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(117440512)=0
[0.0] MP: h=117440512,s=LG: -sNMD
[0.0] MP: h=100663297,s=LD: -> UG
[0.0] MN: unload0(100663297)=0 pauseHandle=0
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=100663297 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MP: h=117440512,s=LG: +mLod(120):120
[0.0] MP: h=117440512,s=LG: -> LD
[0.0] MN: getPlayableStreams0(117440512)=65537
[0.0] MP: h=117440512,s=LD: -mLod
[0.0] MN: getLength0(117440512)=3317
[0.0] MSM[3]: Stream 4363 sink done
[0.0] MSM[3]: Stream Streaming session: 4363 sendSourceEnded called
[0.0] MN: getPlayableStreams0(117440512)=65537
[0.0] MP: h=100663297,s=UG: +mStp(120):120
[0.0] MP: h=100663297,s=UG: +unlC
[0.0] MN: finalize0(100663297)
[0.0] MN: unload 2
[0.0] MP: h=100663297,s=UG: -> UD
[0.0] MSM[3]: release
[0.0] MN: isSeekable0(117440512)=1
[0.0] MSM[3]: RT exit
[0.0] MP: h=100663297,s=UD: -unld
[0.0] AR: remove source 14
[0.0] AR: setAudioMode 32
[0.0] [STREAM] releasing buffer [index: 0] [handle: 4363]
[0.0] MSM[3]: already released
[0.0] MSM[3]: already released
[0.0] MSM[3]: already released
[0.0] MP: h=100663297,s=UD: -unlC
[0.0] MP: h=100663297,s=UD: -mStp
[0.0] MN: slewVolume(117440512, 70, 1)=0
[0.0] MP: h=117440512,s=LD: statUpdEn true
[0.0] MP: h=117440512,s=LD: volChange 70
[0.0] MN: slewVolume(117440512, 70, 1)=0
[0.0] AR: add source 14
[0.0] AR: setAudioMode 34
[0.0] 3rd Party explicitly set sink.
[0.0] MP: h=117440512,s=LD: +play(120):120
[0.0] MN: play0(117440512) is audio, NO check for active pause
[0.0] MN: play0(117440512)=0
[0.0] MP: h=117440512,s=LD: -> PL
[0.0] MP: h=117440512,s=PL: -play
[0.0] MP: h=117440512,s=PL: volChange 70
[0.0] MN: slewVolume(117440512, 70, 1)=0
[0.0] MP: h=117440512,s=PL: mStat: 0
[0.0] MSM[5]: created session
[0.0] MSM[5]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 1] [size: 65536]
[0.0] [STREAM] allocating stream [index: 1] [size: 65536]
[0.0] [STREAM] allocated stream [index: 1] [handle: 4875] [size: 65536]
[0.0] null:_ss=4875 PID=120
[0.0] MN: load 1
[0.0] MN: init0(134217729, 0, 1, 65535)=0
[0.0] MSM[5]: Stream 4875 watermark remain=0 avail=65536
[0.0] SMP[585234753,MP: h=117440512]: BUFFERING = 0
[0.0] [STREAM] write [handle: 4875] 53126 bytes written
[0.0] MSM[5]: Stream Streaming session: 4875 wrote 53126
[0.0] MP: h=134217729,s=LG: +sNMD
[0.0] MN: signifyNoMoreData0(134217729)=0
[0.0] MP: h=134217729,s=LG: -sNMD
[0.0] SMP[585234753,MP: h=117440512]: BUFFERING = 100
[0.0] MP: h=117440512,s=PL: volChange 70
[0.0] MP: h=134217729,s=LG: +mLod(120):120
[0.0] MP: h=134217729,s=LG: -> LD
[0.0] MN: getPlayableStreams0(134217729)=65537
[0.0] MP: h=134217729,s=LD: -mLod
[0.0] 1323343249082 :: SIPTransactionStack: creating new Response SIP/2.0 200 OK

[0.0] 
[0.0] 1323343249108 :: Found Transaction address@hidden for SIP/[0.0] 2.0 200 OK

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bKb58c212748ce32e053[0.0] 93b57ed92751de

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] Contact: "Anonymous" <sip:aa.ss.sd.ff:5061>

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Content-Type: application/sdp

[0.0] Server: Sippy

[0.0] H323-credit-time: 3600

[0.0] Content-Length: 202

[0.0] 

[0.0] v=0

[0.0] o=Sippy 761216896 1 IN IP4 aa.ss.sd.ff

[0.0] s=SBCSIPUAS SIP STACK v1.0

[0.0] t=0 0

[0.0] m=audio 42400 RTP/AVP 0

[0.0] c=IN IP4 aa.ss.sd.ff

[0.0] a=rtpmap:0 PCMU/8000

[0.0] a=sqn:0

[0.0] a=cdsc:1 image udptl t38

[0.0] a=sendrecv

[0.0] 
[0.0] 1323343249296 :: MessageProcessor = address@hidden/sip4m[0.0] address@hidden
[0.0] 1323343249308 :: processing SIP/2.0 200 OK

[0.0] current state = 3
[0.0] 1323343249325 :: addRoute: dialogState: address@hidden = 1
[0.0] 1323343249334 :: Dialog.setRemoteTarget: "Anonymous" <sip:aa.ss.sd.ff:5061>
[0.0] 1323343249344 :: Setting dialog state for address@hidden to 2
[0.0] 1323343249354 :: New dialog state is 2dialogId = address@hidden:134756[0.0] address@hidden:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343249366 :: setState address@hidden 6
[0.0] 1323343249376 :: Terminating transaction
[0.0] 1323343249389 :: PROCESSING INCOMING RESPONSESIP/2.0 200 OK

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;received=192.168.1.99;rport=15755;branch=z9hG4bKb58c212748ce32e053[0.0] 93b57ed92751de

[0.0] Record-Route: <sip:aa.ss.sd.ff;lr>

[0.0] Contact: "Anonymous" <sip:aa.ss.sd.ff:5061>

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 INVITE

[0.0] Content-Type: application/sdp

[0.0] Server: Sippy

[0.0] H323-credit-time: 3600

[0.0] Content-Length: 202

[0.0] 

[0.0] v=0

[0.0] o=Sippy 761216896 1 IN IP4 aa.ss.sd.ff

[0.0] s=SBCSIPUAS SIP STACK v1.0

[0.0] t=0 0

[0.0] m=audio 42400 RTP/AVP 0

[0.0] c=IN IP4 aa.ss.sd.ff

[0.0] a=rtpmap:0 PCMU/8000

[0.0] a=sqn:0

[0.0] a=cdsc:1 image udptl t38

[0.0] a=sendrecv

[0.0] 
[0.0] 1323343249578 :: Transaction = address@hidden
[0.0] 1323343249588 :: handleEvent address@hidden
[0.0] currentTransaction = address@hidden
[0.0] this.sipListener = address@hidden
[0.0] 1323343249613 :: Adding event to EventScanner queue: sip4me.gov.nist.siplite.stack.ClientTransaction[0.0] @ef48230b
[0.0] 1323343249625 :: EventScanner waking up!
[0.0] 1323343249634 :: Processing address@hidden nevents 1
[0.0] 1323343249643 :: setting state of SipDialog to 2
[0.0] 1323343249686 :: [SipClientConnection] Sending request ACK
[0.0] 1323343249696 :: could not find existing transaction for ACK sip:aa.ss.sd.ff:5061 SIP/2.0

[0.0] 
[0.0] 1323343249712 :: Getting dialog for address@hidden:address@hidden 111.132:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343249725 :: getRouteList address@hidden:13475605032@208.65.111.13[0.0] 2:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343249738 :: ----->>> 
[0.0] 1323343249745 :: getRouteList for address@hidden
[0.0] 1323343249753 :: RouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343249768 :: myRouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343249784 :: ----->>> 
[0.0] 1323343249798 :: getRouteList address@hidden:13475605032@208.65.111.13[0.0] 2:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343249809 :: ----->>> 
[0.0] 1323343249818 :: getRouteList for address@hidden
[0.0] 1323343249827 :: RouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343249844 :: myRouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343249860 :: ----->>> 
[0.0] 1323343249867 :: create hop for aa.ss.sd.ff:5060/udp
[0.0] 1323343249876 :: createMessageChannel aa.ss.sd.ff:5060/udp processor sip4me.gov.nist.siplite.stac[0.0] address@hidden
[0.0] 1323343249890 :: Creating clientTransaction address@hidden
[0.0] 1323343249903 :: Setting Branch id : z9hG4bK6b52d090628561884f580346eb823fa1
[0.0] 1323343249913 :: address@hidden
[0.0] 1323343249922 :: setting from tag For outgoing ACK= qpVsYz26r
[0.0] 1323343249930 :: setting ToHeader tag for outgoing ACK = y2syg4jz3dhpddrm.i
[0.0] 1323343249939 :: getRouteList address@hidden:13475605032@208.65.111.13[0.0] 2:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343249951 :: ----->>> 
[0.0] 1323343249961 :: getRouteList for address@hidden
[0.0] 1323343249969 :: RouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343249985 :: myRouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343250002 :: ----->>> 
[0.0] 1323343250011 :: getRouteList address@hidden:13475605032@208.65.111.13[0.0] 2:qpvsyz26r:address@hidden:y2syg4jz3dhpddrm.i
[0.0] 1323343250025 :: ----->>> 
[0.0] 1323343250034 :: getRouteList for address@hidden
[0.0] 1323343250044 :: RouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343250060 :: myRouteList = Route: <sip:aa.ss.sd.ff;lr>

[0.0] 
[0.0] 1323343250077 :: ----->>> 
[0.0] 1323343250086 :: create hop for aa.ss.sd.ff:5060/udp
[0.0] 1323343250095 :: createMessageChannel aa.ss.sd.ff:5060/udp processor sip4me.gov.nist.siplite.stac[0.0] address@hidden
[0.0] 1323343250110 :: Creating clientTransaction address@hidden
[0.0] 1323343250124 :: Setting Branch id : z9hG4bK6b52d090628561884f580346eb823fa1
[0.0] 1323343250134 :: Setting Branch id : z9hG4bK6b52d090628561884f580346eb823fa1
[0.0] 1323343250144 :: setState address@hidden 6
[0.0] 1323343250154 :: Terminating transaction
[0.0] 1323343250169 :: Sending message to [aa.ss.sd.ff:5060/UDP]
[0.0] ACK sip:aa.ss.sd.ff:5061 SIP/2.0

[0.0] Call-Id: address@hidden

[0.0] CSeq: 2 ACK

[0.0] To: <sip:address@hidden>;tag=y2syg4jz3dhpddrm.i

[0.0] Via: SIP/2.0/UDP 192.168.2.5:5060;rport;branch=z9hG4bK6b52d090628561884f580346eb823fa1

[0.0] Max-Forwards: 70

[0.0] From: <sip:address@hidden>;tag=qpVsYz26r

[0.0] Contact: <sip:address@hidden:15755>

[0.0] Authorization: Digest username="13475605032",realm="aa.ss.sd.ff",uri="sip:address@hidden 11.132",algorithm=MD5,nonce="4b998f019160623aa8d1bd95408fe6d025c3",response="37c8fdfe7839d2dcb59201b[0.0] 5dcd59641"

[0.0] Route: <sip:aa.ss.sd.ff;lr>

[0.0] Content-Length: 0

[0.0] 

[0.0]   to be sent to  
[0.0] 1323343250273 :: setState address@hidden 6
[0.0] 1323343250283 :: Terminating transaction
[0.0] JVM: bklt @366195: timer
[0.0] JVM: bklt[1] @366195: usrIdle 1, usrTime 30, usrAct 1
[0.0] JVM: bklt[1] @366195: chkIdle 51, currTime 30
[0.0] JVM: bklt @366195: setTimer 29
[0.0] 1323343250333 :: Removing clientTransaction address@hidden
[0.0] 1323343250345 :: Removing clientTransaction address@hidden
[0.0] 1323343250384 :: SIPTransactionStack: creating new Response SIP/2.0 200 OK

[0.0] 
[0.0] 1323343250404 :: null sipServerResponse!
[0.0] MN: getLength0(134217729)=3317
[0.0] MN: getPlayableStreams0(134217729)=65537
[0.0] MN: isSeekable0(134217729)=1
[0.0] MN: slewVolume(117440512, 0, 1)=0
[0.0] MP: h=117440512,s=PL: +paus(120):293
[0.0] 1323343250491 :: SIPTransactionStack: creating new Response SIP/2.0 200 OK

[0.0] 
[0.0] 1323343250510 :: null sipServerResponse!
[0.0] MN: pause0(117440512)=0
[0.0] MP: h=117440512,s=PL: -> PA
[0.0] MP: h=134217729,s=LD: statUpdEn true
[0.0] MP: h=117440512,s=PA: volChange 0
[0.0] MN: slewVolume(134217729, 70, 1)=0
[0.0] AR: source 14is already added
[0.0] MP: h=134217729,s=LD: +play(120):120
[0.0] MN: play0(134217729) is audio, NO check for active pause
[0.0] MN: play0(134217729)=0
[0.0] MP: h=134217729,s=LD: -> PL
[0.0] MP: h=134217729,s=PL: -play
[0.0] MP: h=117440512,s=PA: +mPC
[0.0] MP: h=117440512,s=PA: -> LD
[0.0] MP: h=117440512,s=LD: -mPC
[0.0] MP: h=117440512,s=LD: -paus
[0.0] AR: source 14still active
[0.0] MP: h=134217729,s=PL: volChange 70
[0.0] MP: h=134217729,s=PL: mStat: 0
[0.0] MP: h=117440512,s=LD: +unld(120):293
[0.0] MP: h=117440512,s=LD: -> UG
[0.0] MN: unload0(117440512)=0 pauseHandle=0
[0.0] SIM cache not loaded
[0.0] SMP[2058874016,MP: h=134217729]: BUFFERING = 0
[0.0] SMP[2058874016,MP: h=134217729]: BUFFERING = 100
[0.0] MN: MEDIA_STOPPED received
[0.0] MN: handle=117440512 bitmapHandle=0 thumbnailHandle=2147483647
[0.0] MSM[5]: Stream 4875 watermark remain=0 avail=65536
[0.0] MP: h=117440512,s=UG: +mStp(120):120
[0.0] MP: h=117440512,s=UG: +unlC
[0.0] MN: finalize0(117440512)
[0.0] MN: unload 2
[0.0] MP: h=117440512,s=UG: -> UD
[0.0] MSM[4]: release
[0.0] MSM[4]: Stream 4620 sink done
[0.0] MSM[4]: Stream Streaming session: 4620 sendSourceEnded called
[0.0] MP: h=117440512,s=UD: -unld
[0.0] MSM[4]: RT exit
[0.0] [STREAM] releasing buffer [index: 0] [handle: 4620]
[0.0] MSM[4]: already released
[0.0] MSM[4]: already released
[0.0] MSM[4]: already released
[0.0] MP: h=117440512,s=UD: -unlC
[0.0] MP: h=117440512,s=UD: -mStp
[0.0] AR: add source 12
[0.0] AR: setAudioMode 9
[0.0] SIM cache not loaded
[0.0] MSM[2]: created session
[0.0] MSM[2]: ----- initializeStream
[0.0] [STREAM] allocating buffer [index: 1] [size: 65536]
[0.0] [STREAM] allocating stream [index: 1] [size: 65536]
[0.0] [STREAM] allocated stream [index: 1] [handle: 5132] [size: 65536]
[0.0] MN: setRecordParameters(1,20)=0
[0.0] MSM[2]: Starting streaming session 5132
[0.0] 1323343251314 :: EventScanner going to sleep!
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] SIM cache not loaded
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] SIM cache not loaded
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] SIM cache not loaded
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] MSM[2]: Stream 5132 new data
[0.0] Application net_rim_services_impl(9) is not responding; process terminated
[0.0] 
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] d d03
[0.0] 
[0.0] VM:THMNx=118,r=0xC7C0000,t=java.lang.Object
[0.0] VM:THMNx=127,r=0xC784C00,t=net.rim.vm.MessageQueue
[0.0] VM:THMNx=127,r=0x80A5000,t=net.rim.device.api.system.ApplicationManagerImpl$ApplicationProcessContai[0.0] ner
[0.0] VM:THMNx=118,r=0x125EDC00,t=net.rim.device.internal.media.resource.manager.MediaResourceManagerImpl$[0.0] StreamingSessionImpl$ReadThread$OSInputStream
[0.0] VM:THMNx=118,r=0xB38E000,t=net.rim.device.internal.media.resource.manager.MediaResourceManagerImpl
[0.0] VM:THMNx=24,r=0x1261D800,t=net.rim.device.internal.util.RingBuffer
[0.0] VM:THDRr=native
[0.0] VM:THDLv=0
[0.0] VM:+BORK
[0.0] App Error 603
[0.0] Service startup process died


reply via email to

[Prev in Thread] Current Thread [Next in Thread]