Skip to content

Instantly share code, notes, and snippets.

@jasjisdo

jasjisdo/GSEMySipApp-Call-answer.log Secret

Last active August 29, 2015 14:07
Show Gist options
  • Save jasjisdo/87959957568f3404ea9e to your computer and use it in GitHub Desktop.
Save jasjisdo/87959957568f3404ea9e to your computer and use it in GitHub Desktop.
Download ZIP
Raw
GossipExample-startCall.log
16:50:09.586 os_core_unix.c !pjlib 2.2.1-svn for POSIX initialized
16:50:09.595 sip_endpoint.c .Creating endpoint instance...
16:50:09.596 pjlib .select() I/O Queue created (0x17956d3c)
16:50:09.596 sip_endpoint.c .Module "mod-msg-print" registered
16:50:09.596 sip_transport. .Transport manager created.
16:50:09.596 pjsua_core.c .PJSUA state changed: NULL --> CREATED
16:50:09.599 sip_endpoint.c .Module "mod-pjsua-log" registered
16:50:09.599 sip_endpoint.c .Module "mod-tsx-layer" registered
16:50:09.599 sip_endpoint.c .Module "mod-stateful-util" registered
16:50:09.599 sip_endpoint.c .Module "mod-ua" registered
16:50:09.599 sip_endpoint.c .Module "mod-100rel" registered
16:50:09.599 sip_endpoint.c .Module "mod-pjsua" registered
16:50:09.600 sip_endpoint.c .Module "mod-invite" registered
16:50:09.600 coreaudio_dev. .. dev_id 0: iPhone IO device (in=1, out=1) 8000Hz
16:50:09.600 coreaudio_dev. ..core audio initialized
16:50:09.601 pjlib ..select() I/O Queue created (0x17985214)
16:50:09.603 speex_codec.c ..Adjusting quality to 5 for uwb
16:50:09.604 conference.c ..Creating conference bridge with 12 ports
16:50:09.605 Master/sound ..Using delay buffer with WSOLA.
16:50:09.640 sip_endpoint.c .Module "mod-evsub" registered
16:50:09.641 sip_endpoint.c .Module "mod-presence" registered
16:50:09.641 evsub.c .Event pkg "presence" registered by mod-presence
16:50:09.641 sip_endpoint.c .Module "mod-mwi" registered
16:50:09.641 evsub.c .Event pkg "message-summary" registered by mod-mwi
16:50:09.641 sip_endpoint.c .Module "mod-refer" registered
16:50:09.641 evsub.c .Event pkg "refer" registered by mod-refer
16:50:09.641 sip_endpoint.c .Module "mod-pjsua-pres" registered
16:50:09.641 sip_endpoint.c .Module "mod-pjsua-im" registered
16:50:09.641 sip_endpoint.c .Module "mod-pjsua-options" registered
16:50:09.641 pjsua_core.c .1 SIP worker threads created
16:50:09.641 pjsua_core.c .pjsua version 2.2.1-svn for initialized
16:50:09.641 pjsua_core.c .PJSUA state changed: CREATED --> INIT
16:50:09.643 pjsua_core.c SIP UDP socket reachable at 10.0.6.197:58851
16:50:09.643 udp0x1798f800 SIP UDP transport started, published address is 10.0.6.197:58851
16:50:09.644 pjsua_acc.c Adding account: id=sip:chakrit@sip2sip.info
16:50:09.644 pjsua_acc.c .Account sip:chakrit@sip2sip.info added with id 0
16:50:09.644 pjsua_core.c PJSUA state changed: INIT --> STARTING
16:50:09.644 sip_endpoint.c .Module "mod-unsolicited-mwi" registered
16:50:09.644 pjsua_core.c .PJSUA state changed: STARTING --> RUNNING
16:50:12.641 pjsua_acc.c Acc 0: setting registration..
16:50:12.642 endpoint .Request msg REGISTER/cseq=24122 (tdta0x179bd200) created.
16:50:12.643 tsx0x17973c64 ..Transaction created for Request msg REGISTER/cseq=24123 (tdta0x179bd200)
16:50:12.643 tsx0x17973c64 .Sending Request msg REGISTER/cseq=24123 (tdta0x179bd200) in state Null
16:50:12.643 sip_resolve.c ..Starting async DNS SRV query: target=_sip._udp.proxy.sipthor.net, transport=Unspecified, port=0
16:50:12.643 _sip._udp.prox ..Starting async DNS SRV query_job: target=_sip._udp.proxy.sipthor.net:5060
16:50:12.644 resolver.c ..Nameserver 8.8.8.8:53 state changed Active --> Probing
16:50:12.645 resolver.c ..Transmitting 45 bytes to NS 0 (8.8.8.8:53): DNS SRV query for _sip._udp.proxy.sipthor.net: Success
16:50:12.645 tsx0x17973c64 ..State changed from Null to Calling, event=TX_MSG
2014-10-13 16:50:12.646 GossipExample[294:60b] Gossip: dispatchRegistrationStarted(0, 1)
16:50:12.655 pjsua_acc.c .Acc 0: Registration sent
16:50:12.655 pjsua_acc.c Acc 0: setting online status to 1..
16:50:12.719 resolver.c !Received 98 bytes DNS response from 8.8.8.8:53
16:50:12.719 resolver.c Nameserver 8.8.8.8:53 state changed Probing --> Active
16:50:12.719 _sip._udp.prox DNS SRV resolution failed for _sip._udp.proxy.sipthor.net: DNS "Name Error" (PJLIB_UTIL_EDNS_NXDOMAIN)
16:50:12.719 _sip._udp.prox DNS SRV resolution failed for _sip._udp.proxy.sipthor.net, trying resolving A record for proxy.sipthor.net
16:50:12.719 _sip._udp.prox Starting async DNS A query_job for proxy.sipthor.net
16:50:12.720 resolver.c Transmitting 35 bytes to NS 0 (8.8.8.8:53): DNS A query for proxy.sipthor.net: Success
16:50:12.736 resolver.c Received 83 bytes DNS response from 8.8.8.8:53
16:50:12.736 resolver.c Nameserver 8.8.8.8:53 state changed Active --> Active
16:50:12.736 _sip._udp.prox DNS A for proxy.sipthor.net: 81.23.228.129
16:50:12.736 _sip._udp.prox Additional DNS A for proxy.sipthor.net: 85.17.186.7
16:50:12.737 _sip._udp.prox Additional DNS A for proxy.sipthor.net: 81.23.228.150
16:50:12.737 _sip._udp.prox Server resolution complete, 1 server entry(s) found
16:50:12.737 pjsua_core.c TX 524 bytes Request msg REGISTER/cseq=24123 (tdta0x179bd200) to UDP 81.23.228.129:5060:
REGISTER sip:sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 10.0.6.197:58851;rport;branch=z9hG4bKPjI1F4vFY-BJLW1ts.5ZVCtIbybQlcVec0
Route: <sip:proxy.sipthor.net;lr>
Max-Forwards: 70
From: <sip:chakrit@sip2sip.info>;tag=ftwVARAE7187RUruqJ8fm5RsZobWjFt3
To: <sip:chakrit@sip2sip.info>
Call-ID: F5ygseMcGuYNRLM287LvPHe.XtMO1r3W
CSeq: 24123 REGISTER
Contact: <sip:chakrit@10.0.6.197:58851;ob>
Expires: 300
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Content-Length: 0
--end msg--
16:50:12.767 sip_endpoint.c Processing incoming message: Response msg 401/REGISTER/cseq=24123 (rdata0x1799a014)
16:50:12.767 pjsua_core.c .RX 513 bytes Response msg 401/REGISTER/cseq=24123 (rdata0x1799a014) from UDP 81.23.228.129:5060:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.0.6.197:58851;received=130.149.154.36;rport=58851;branch=z9hG4bKPjI1F4vFY-BJLW1ts.5ZVCtIbybQlcVec0
From: <sip:chakrit@sip2sip.info>;tag=ftwVARAE7187RUruqJ8fm5RsZobWjFt3
To: <sip:chakrit@sip2sip.info>;tag=e7d4d6b46afb9bf88242924a8d869ebf.4480
Call-ID: F5ygseMcGuYNRLM287LvPHe.XtMO1r3W
CSeq: 24123 REGISTER
WWW-Authenticate: Digest realm="sip2sip.info", nonce="543be6c34d4dbce934cd8e0c61cf90c65c041465"
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:50:12.768 tsx0x17973c64 .Incoming Response msg 401/REGISTER/cseq=24123 (rdata0x1799a014) in state Calling
16:50:12.768 tsx0x17973c64 ..State changed from Calling to Completed, event=RX_MSG
16:50:12.768 pjsua_acc.c ....IP address change detected for account 0 (10.0.6.197:58851 --> 130.149.154.36:58851). Updating registration (using method 4)
16:50:12.768 tsx0x179bf264 ....Transaction created for Request msg REGISTER/cseq=24124 (tdta0x179bd200)
16:50:12.769 tsx0x179bf264 ...Sending Request msg REGISTER/cseq=24124 (tdta0x179bd200) in state Null
16:50:12.769 endpoint ....Request msg REGISTER/cseq=24124 (tdta0x179bd200): skipping target resolution because address is already set
16:50:12.769 pjsua_core.c ....TX 715 bytes Request msg REGISTER/cseq=24124 (tdta0x179bd200) to UDP 81.23.228.129:5060:
REGISTER sip:sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:58851;rport;branch=z9hG4bKPjRwBITJicu3ufsu3qczs88J3BiU5w-.-C
Route: <sip:proxy.sipthor.net;lr>
Max-Forwards: 70
From: <sip:chakrit@sip2sip.info>;tag=ftwVARAE7187RUruqJ8fm5RsZobWjFt3
To: <sip:chakrit@sip2sip.info>
Call-ID: F5ygseMcGuYNRLM287LvPHe.XtMO1r3W
CSeq: 24124 REGISTER
Contact: <sip:chakrit@130.149.154.36:58851;ob>
Expires: 300
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Authorization: Digest username="chakrit", realm="sip2sip.info", nonce="543be6c34d4dbce934cd8e0c61cf90c65c041465", uri="sip:sip2sip.info", response="a7250920ebe24cba8711771a4c0a47d9"
Content-Length: 0
--end msg--
16:50:12.784 tsx0x179bf264 ....State changed from Null to Calling, event=TX_MSG
16:50:12.833 sip_endpoint.c Processing incoming message: Response msg 200/REGISTER/cseq=24124 (rdata0x1799a014)
16:50:12.834 pjsua_core.c .RX 729 bytes Response msg 200/REGISTER/cseq=24124 (rdata0x1799a014) from UDP 81.23.228.129:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 130.149.154.36:58851;received=130.149.154.36;rport=58851;branch=z9hG4bKPjRwBITJicu3ufsu3qczs88J3BiU5w-.-C
From: <sip:chakrit@sip2sip.info>;tag=ftwVARAE7187RUruqJ8fm5RsZobWjFt3
To: <sip:chakrit@sip2sip.info>;tag=e7d4d6b46afb9bf88242924a8d869ebf.9c9f
Call-ID: F5ygseMcGuYNRLM287LvPHe.XtMO1r3W
CSeq: 24124 REGISTER
Contact: <sip:chakrit@130.149.154.36:58851;ob>;expires=300;received="sip:81.23.228.129:5060;target=%73%69%70:%31%33%30.%31%34%39.%31%35%34.%33%36:%35%38%38%35%31", <sip:chakrit@130.149.154.36:51155;ob>;expires=101;received="sip:81.23.228.129:5060;target=%73%69%70:%31%33%30.%31%34%39.%31%35%34.%33%36:%35%31%31%35%35"
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:50:12.834 tsx0x179bf264 .Incoming Response msg 200/REGISTER/cseq=24124 (rdata0x1799a014) in state Calling
16:50:12.842 tsx0x179bf264 ..State changed from Calling to Completed, event=RX_MSG
16:50:12.843 pjsua_acc.c ....SIP outbound status for acc 0 is not active
16:50:12.843 pjsua_acc.c ....sip:chakrit@sip2sip.info: registration success, status=200 (OK), will re-register in 300 seconds
16:50:12.843 pjsua_acc.c ....Keep-alive timer started for acc 0, destination:81.23.228.129:5060, interval:15s
2014-10-13 16:50:12.843 GossipExample[294:3c07] Gossip: dispatchRegistrationState(0)
16:50:17.786 tsx0x17973c64 Timeout timer event
16:50:17.786 tsx0x17973c64 .State changed from Completed to Terminated, event=TIMER
16:50:17.786 tsx0x17973c64 Timeout timer event
16:50:17.786 tsx0x17973c64 .State changed from Terminated to Destroyed, event=TIMER
16:50:17.786 tsx0x17973c64 Transaction destroyed!
16:50:17.843 tsx0x179bf264 Timeout timer event
16:50:17.843 tsx0x179bf264 .State changed from Completed to Terminated, event=TIMER
16:50:17.843 tsx0x179bf264 Timeout timer event
16:50:17.843 tsx0x179bf264 .State changed from Terminated to Destroyed, event=TIMER
16:50:17.843 tdta0x179bd200 ..Destroying txdata Request msg REGISTER/cseq=24124 (tdta0x179bd200)
16:50:17.844 tsx0x179bf264 Transaction destroyed!
2014-10-13 16:50:18.176 GossipExample[294:60b] Gossip: ringbackWithSoundNamed: /var/mobile/Applications/CBE224D4-6262-45D8-995D-F6703DFD8169/GossipExample.app/ringtone.wav
16:50:18.179 pjsua_aud.c !Creating playlist with 1 file(s)..
16:50:18.180 wav_playlist.c .WAV playlist 'WAV playlist' created: samp.rate=44100, ch=2, bufsize=4KB
16:50:18.180 resample.c .resample created: high qualiy, small filter, in/out rate=44100/16000
16:50:18.180 resample.c .resample created: high qualiy, small filter, in/out rate=16000/44100
16:50:18.180 pjsua_aud.c .Playlist created, id=0, slot=1
16:50:19.290 pjsua_call.c Making call with acc #0 to sip:223281800@sip2sip.info
16:50:19.290 pjsua_aud.c .Set sound device: capture=-1, playback=-2
16:50:19.291 pjsua_aud.c ..Opening sound device PCM@16000/1/20ms
16:50:19.291 coreaudio_dev. ...Using RemoteIO audio unit
16:50:19.573 coreaudio_dev. ...core audio stream started
16:50:19.585 dlg0x179e4064 .UAC dialog created
16:50:19.586 dlg0x179e4064 ..Session count inc to 2 by mod-pjsua
16:50:19.586 pjsua_media.c .Call 0: initializing media..
16:50:19.587 pjsua_media.c ..RTP socket reachable at 10.0.6.197:4000
16:50:19.587 pjsua_media.c ..RTCP socket reachable at 10.0.6.197:4001
16:50:19.587 pjsua_media.c ..Media index 0 selected for audio call 0
16:50:19.587 dlg0x179e4064 ..Session count dec to 2 by mod-pjsua
16:50:19.588 dlg0x179e4064 .Module mod-invite added as dialog usage, data=0x179f82bc
16:50:19.588 dlg0x179e4064 ..Session count inc to 4 by mod-invite
16:50:19.588 dlg0x179e4064 .Module mod-100rel added as dialog usage, data=0x17a46520
16:50:19.588 dlg0x179e4064 .100rel module attached
16:50:19.588 inv0x179e4064 .UAC invite session created for dialog dlg0x179e4064
16:50:19.588 endpoint .Request msg INVITE/cseq=29430 (tdta0x17a48e00) created.
16:50:19.588 inv0x179e4064 ..Sending Request msg INVITE/cseq=29430 (tdta0x17a48e00)
16:50:19.594 coreaudio_dev. !Recorder thread started, (371 frames)
16:50:19.599 os_core_unix.c Info: possibly re-registering existing thread
16:50:19.599 coreaudio_dev. !Player thread started, (372 frames)
16:50:19.600 dlg0x179e4064 !...Sending Request msg INVITE/cseq=29430 (tdta0x17a48e00)
16:50:19.600 tsx0x17a3e064 ....Transaction created for Request msg INVITE/cseq=29429 (tdta0x17a48e00)
16:50:19.600 tsx0x17a3e064 ...Sending Request msg INVITE/cseq=29429 (tdta0x17a48e00) in state Null
16:50:19.600 sip_resolve.c ....Starting async DNS SRV query: target=_sip._udp.proxy.sipthor.net, transport=Unspecified, port=0
16:50:19.600 _sip._udp.prox ....Starting async DNS SRV query_job: target=_sip._udp.proxy.sipthor.net:5060
16:50:19.600 resolver.c ....Picked up DNS SRV record for _sip._udp.proxy.sipthor.net from cache, ttl=53
16:50:19.600 _sip._udp.prox ....DNS SRV resolution failed for _sip._udp.proxy.sipthor.net: DNS "Name Error" (PJLIB_UTIL_EDNS_NXDOMAIN)
16:50:19.601 _sip._udp.prox ....DNS SRV resolution failed for _sip._udp.proxy.sipthor.net, trying resolving A record for proxy.sipthor.net
16:50:19.601 _sip._udp.prox ....Starting async DNS A query_job for proxy.sipthor.net
16:50:19.601 resolver.c ....Picked up DNS A record for proxy.sipthor.net from cache, ttl=19
16:50:19.601 _sip._udp.prox ....DNS A for proxy.sipthor.net: 81.23.228.129
16:50:19.601 _sip._udp.prox ....Additional DNS A for proxy.sipthor.net: 85.17.186.7
16:50:19.601 _sip._udp.prox ....Additional DNS A for proxy.sipthor.net: 81.23.228.150
16:50:19.601 _sip._udp.prox ....Server resolution complete, 1 server entry(s) found
16:50:19.601 pjsua_core.c ....TX 1082 bytes Request msg INVITE/cseq=29429 (tdta0x17a48e00) to UDP 81.23.228.129:5060:
INVITE sip:223281800@sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:58851;rport;branch=z9hG4bKPjLdrzHMu-azCLSXMXHGtv9XtKerKu6b6j
Max-Forwards: 70
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info
Contact: <sip:chakrit@130.149.154.36:58851;ob>
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29429 INVITE
Route: <sip:proxy.sipthor.net;lr>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
Content-Type: application/sdp
Content-Length: 443
v=0
o=- 3622200619 3622200619 IN IP4 10.0.6.197
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 98 97 99 104 3 0 8 96
c=IN IP4 10.0.6.197
b=TIAS:64000
a=rtcp:4001 IN IP4 10.0.6.197
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:97 speex/8000
a=rtpmap:99 speex/32000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
--end msg--
16:50:19.602 tsx0x17a3e064 ....State changed from Null to Calling, event=TX_MSG
16:50:19.602 dlg0x179e4064 .....Transaction tsx0x17a3e064 state changed to Calling
2014-10-13 16:50:19.602 GossipExample[294:60b] Gossip: dispatchCallState(0)
16:50:19.648 sip_endpoint.c !Processing incoming message: Response msg 100/INVITE/cseq=29429 (rdata0x1799a014)
16:50:19.649 pjsua_core.c .RX 374 bytes Response msg 100/INVITE/cseq=29429 (rdata0x1799a014) from UDP 81.23.228.129:5060:
SIP/2.0 100 Giving a try
Via: SIP/2.0/UDP 130.149.154.36:58851;received=130.149.154.36;rport=58851;branch=z9hG4bKPjLdrzHMu-azCLSXMXHGtv9XtKerKu6b6j
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29429 INVITE
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:50:19.649 tsx0x17a3e064 .Incoming Response msg 100/INVITE/cseq=29429 (rdata0x1799a014) in state Calling
16:50:19.649 tsx0x17a3e064 ..State changed from Calling to Proceeding, event=RX_MSG
16:50:19.649 dlg0x179e4064 ...Received Response msg 100/INVITE/cseq=29429 (rdata0x1799a014)
16:50:19.649 dlg0x179e4064 ...Transaction tsx0x17a3e064 state changed to Proceeding
16:50:19.649 sip_endpoint.c Processing incoming message: Response msg 407/INVITE/cseq=29429 (rdata0x1799a014)
16:50:19.692 pjsua_core.c .RX 532 bytes Response msg 407/INVITE/cseq=29429 (rdata0x1799a014) from UDP 81.23.228.129:5060:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 130.149.154.36:58851;received=130.149.154.36;rport=58851;branch=z9hG4bKPjLdrzHMu-azCLSXMXHGtv9XtKerKu6b6j
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info;tag=e7d4d6b46afb9bf88242924a8d869ebf.9ca7
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29429 INVITE
Proxy-Authenticate: Digest realm="sip2sip.info", nonce="543be6caf2d10ee3454043f277b3a29166716339"
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:50:19.692 tsx0x17a3e064 .Incoming Response msg 407/INVITE/cseq=29429 (rdata0x1799a014) in state Proceeding
16:50:19.692 endpoint ..Request msg ACK/cseq=29429 (tdta0x17a4de00) created.
16:50:19.692 pjsua_core.c ..TX 412 bytes Request msg ACK/cseq=29429 (tdta0x17a4de00) to UDP 81.23.228.129:5060:
ACK sip:223281800@sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:58851;rport;branch=z9hG4bKPjLdrzHMu-azCLSXMXHGtv9XtKerKu6b6j
Max-Forwards: 70
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info;tag=e7d4d6b46afb9bf88242924a8d869ebf.9ca7
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29429 ACK
Route: <sip:proxy.sipthor.net;lr>
Content-Length: 0
--end msg--
16:50:19.698 tsx0x17a3e064 ..State changed from Proceeding to Completed, event=RX_MSG
16:50:19.698 dlg0x179e4064 ...Received Response msg 407/INVITE/cseq=29429 (rdata0x1799a014)
16:50:19.698 dlg0x179e4064 ...Transaction tsx0x17a3e064 state changed to Completed
16:50:19.698 inv0x179e4064 .....Sending Request msg INVITE/cseq=29429 (tdta0x17a48e00)
16:50:19.698 dlg0x179e4064 ......Sending Request msg INVITE/cseq=29429 (tdta0x17a48e00)
16:50:19.698 tsx0x179e7a64 .......Transaction created for Request msg INVITE/cseq=29430 (tdta0x17a48e00)
16:50:19.698 tsx0x179e7a64 ......Sending Request msg INVITE/cseq=29430 (tdta0x17a48e00) in state Null
16:50:19.698 endpoint .......Request msg INVITE/cseq=29430 (tdta0x17a48e00): skipping target resolution because address is already set
16:50:19.699 pjsua_core.c .......TX 1281 bytes Request msg INVITE/cseq=29430 (tdta0x17a48e00) to UDP 81.23.228.129:5060:
INVITE sip:223281800@sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:58851;rport;branch=z9hG4bKPjKWM5zgL5HJ.lHmftXtaBEFWmo2BHMHI5
Max-Forwards: 70
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info
Contact: <sip:chakrit@130.149.154.36:58851;ob>
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29430 INVITE
Route: <sip:proxy.sipthor.net;lr>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
Proxy-Authorization: Digest username="chakrit", realm="sip2sip.info", nonce="543be6caf2d10ee3454043f277b3a29166716339", uri="sip:223281800@sip2sip.info", response="2d84f8d6952ed099e73098e256d47055"
Content-Type: application/sdp
Content-Length: 443
v=0
o=- 3622200619 3622200619 IN IP4 10.0.6.197
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 98 97 99 104 3 0 8 96
c=IN IP4 10.0.6.197
b=TIAS:64000
a=rtcp:4001 IN IP4 10.0.6.197
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:97 speex/8000
a=rtpmap:99 speex/32000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
--end msg--
16:50:19.699 tsx0x179e7a64 .......State changed from Null to Calling, event=TX_MSG
16:50:19.699 dlg0x179e4064 ........Transaction tsx0x179e7a64 state changed to Calling
16:50:19.723 sip_endpoint.c Processing incoming message: Response msg 100/INVITE/cseq=29430 (rdata0x1799a014)
16:50:19.723 pjsua_core.c .RX 374 bytes Response msg 100/INVITE/cseq=29430 (rdata0x1799a014) from UDP 81.23.228.129:5060:
SIP/2.0 100 Giving a try
Via: SIP/2.0/UDP 130.149.154.36:58851;received=130.149.154.36;rport=58851;branch=z9hG4bKPjKWM5zgL5HJ.lHmftXtaBEFWmo2BHMHI5
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29430 INVITE
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:50:19.723 tsx0x179e7a64 .Incoming Response msg 100/INVITE/cseq=29430 (rdata0x1799a014) in state Calling
16:50:19.723 tsx0x179e7a64 ..State changed from Calling to Proceeding, event=RX_MSG
16:50:19.723 dlg0x179e4064 ...Received Response msg 100/INVITE/cseq=29430 (rdata0x1799a014)
16:50:19.723 dlg0x179e4064 ...Transaction tsx0x179e7a64 state changed to Proceeding
16:50:21.207 sip_endpoint.c Processing incoming message: Response msg 200/INVITE/cseq=29430 (rdata0x1799a014)
16:50:21.208 pjsua_core.c .RX 1200 bytes Response msg 200/INVITE/cseq=29430 (rdata0x1799a014) from UDP 81.23.228.129:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 130.149.154.36:58851;rport=58851;received=130.149.154.36;branch=z9hG4bKPjKWM5zgL5HJ.lHmftXtaBEFWmo2BHMHI5
Record-Route: <sip:81.23.228.129;lr;ftag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k;did=86c.6b270d77>
Record-Route: <sip:81.23.228.150;lr;ftag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k;did=86c.897b5b75>
Record-Route: <sip:81.23.228.129;lr;ftag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k;did=86c.5b270d77>
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
From: <sip:chakrit@sip2sip.info>;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: <sip:223281800@sip2sip.info>;tag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g
CSeq: 29430 INVITE
Contact: <sip:223281800@130.149.154.36:52573;ob>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800;refresher=uac
Require: timer
Content-Type: application/sdp
Content-Length: 273
v=0
o=- 3622200621 3622200622 IN IP4 10.0.6.137
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 52848 RTP/AVP 98 96
c=IN IP4 85.17.186.7
b=TIAS:64000
a=rtcp:52849 IN IP4 85.17.186.7
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
--end msg--
16:50:21.208 tsx0x179e7a64 .Incoming Response msg 200/INVITE/cseq=29430 (rdata0x1799a014) in state Proceeding
16:50:21.208 tsx0x179e7a64 ..State changed from Proceeding to Terminated, event=RX_MSG
16:50:21.208 dlg0x179e4064 ...Received Response msg 200/INVITE/cseq=29430 (rdata0x1799a014)
16:50:21.208 dlg0x179e4064 ....Route-set updated
16:50:21.208 dlg0x179e4064 ....Route-set frozen
16:50:21.209 dlg0x179e4064 ...Transaction tsx0x179e7a64 state changed to Terminated
2014-10-13 16:50:21.209 GossipExample[294:3c07] Gossip: dispatchCallState(0)
16:50:21.227 pjsua_aud.c .....Conf connect: 1 --> 0
16:50:21.227 conference.c ......Port 1 (WAV playlist) transmitting to port 0 (iPhone IO device)
16:50:21.230 inv0x179e4064 ....Got SDP answer in Response msg 200/INVITE/cseq=29430 (rdata0x1799a014)
16:50:21.230 inv0x179e4064 ....SDP negotiation done, status=0
16:50:21.230 pjsua_call.c .....Call 0: remote NAT type is 0 (Unknown)
16:50:21.230 pjsua_media.c .....Call 0: updating media..
16:50:21.230 pjsua_aud.c ......Audio channel update..
16:50:21.231 strm0x17a50e14 .......VAD temporarily disabled
16:50:21.231 rtp.c .......pjmedia_rtp_session_init: ses=0x17a546a4, default_pt=98, ssrc=0x1ad8a578
16:50:21.231 rtp.c .......pjmedia_rtp_session_init: ses=0x17a54e5c, default_pt=98, ssrc=0x1ad8a578
16:50:21.231 stream.c .......Stream strm0x17a50e14 created
16:50:21.231 strm0x17a50e14 .......Encoder stream started
16:50:21.231 strm0x17a50e14 .......Decoder stream started
16:50:21.234 pjsua_media.c ......Audio updated, stream #0: speex (sendrecv)
16:50:21.246 strm0x17a50e14 !Start talksprut..
2014-10-13 16:50:21.234 GossipExample[294:3c07] Gossip: dispatchCallMediaState(0)
16:50:21.258 pjsua_aud.c !.....Conf connect: 2 --> 0
16:50:21.258 conference.c ......Port 2 (sip:223281800@sip2sip.info) transmitting to port 0 (iPhone IO device)
16:50:21.258 pjsua_aud.c .....Conf connect: 0 --> 2
16:50:21.259 conference.c ......Port 0 (iPhone IO device) transmitting to port 2 (sip:223281800@sip2sip.info)
16:50:21.259 inv0x179e4064 ....Received Response msg 200/INVITE/cseq=29430 (rdata0x1799a014), sending ACK
16:50:21.259 endpoint ....Request msg ACK/cseq=29430 (tdta0x17a56800) created.
16:50:21.259 dlg0x179e4064 .....Sending Request msg ACK/cseq=29430 (tdta0x17a56800)
16:50:21.259 sip_resolve.c .....Target '81.23.228.129:0' type=Unspecified resolved to '81.23.228.129:5060' type=UDP (UDP transport)
16:50:21.259 pjsua_core.c .....TX 641 bytes Request msg ACK/cseq=29430 (tdta0x17a56800) to UDP 81.23.228.129:5060:
ACK sip:223281800@130.149.154.36:52573;ob SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:58851;rport;branch=z9hG4bKPj.ETMiPaVr2FmtYbVX5UKNNoj7bFGY9B7
Max-Forwards: 70
From: sip:chakrit@sip2sip.info;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
To: sip:223281800@sip2sip.info;tag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 29430 ACK
Route: <sip:81.23.228.129;lr;ftag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k;did=86c.5b270d77>
Route: <sip:81.23.228.150;lr;ftag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k;did=86c.897b5b75>
Route: <sip:81.23.228.129;lr;ftag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k;did=86c.6b270d77>
Content-Length: 0
--end msg--
16:50:21.267 strm0x17a50e14 !Jitter buffer is bufferring (prefetch=0), plc invoked
16:50:21.276 strm0x17a50e14 !RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0
2014-10-13 16:50:21.261 GossipExample[294:3c07] Gossip: dispatchCallState(0)
16:50:21.279 pjsua_aud.c !.....Conf disconnect: 1 -x- 0
16:50:21.279 conference.c ......Port 1 (WAV playlist) stop transmitting to port 0 (iPhone IO device)
16:50:21.284 tsx0x179e7a64 Timeout timer event
16:50:21.285 tsx0x179e7a64 .State changed from Terminated to Destroyed, event=TIMER
16:50:21.285 tsx0x179e7a64 Transaction destroyed!
16:50:21.290 strm0x17a50e14 !Jitter buffer starts returning normal frames (after 1 empty/lost)
16:50:21.319 strm0x17a50e14 Jitter buffer empty (prefetch=0), plc invoked
16:50:21.331 sip_endpoint.c !Processing incoming message: Request msg BYE/cseq=22541 (rdata0x1799a014)
16:50:21.332 pjsua_core.c .RX 844 bytes Request msg BYE/cseq=22541 (rdata0x1799a014) from UDP 81.23.228.129:5060:
BYE sip:chakrit@130.149.154.36:58851;ob SIP/2.0
Record-Route: <sip:81.23.228.129;lr;ftag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g>
Record-Route: <sip:81.23.228.150;lr;ftag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g>
Record-Route: <sip:81.23.228.129;lr;ftag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g>
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bKdc0f.8351b125.0
Via: SIP/2.0/UDP 81.23.228.150:5060;branch=z9hG4bKdc0f.6d62f1e1.0
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bKdc0f.7351b125.0
Via: SIP/2.0/UDP 130.149.154.36:52573;received=130.149.154.36;rport=52573;branch=z9hG4bKPjmagoWDtmqgsmSsVv4Vx0yHJsUnDOCLc7
Max-Forwards: 67
From: <sip:223281800@sip2sip.info>;tag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g
To: <sip:chakrit@sip2sip.info>;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
CSeq: 22541 BYE
Content-Length: 0
--end msg--
16:50:21.332 dlg0x179e4064 .Received Request msg BYE/cseq=22541 (rdata0x1799a014)
16:50:21.332 tsx0x179e7a64 ...Transaction created for Request msg BYE/cseq=22541 (rdata0x1799a014)
16:50:21.333 tsx0x179e7a64 ..Incoming Request msg BYE/cseq=22541 (rdata0x1799a014) in state Null
16:50:21.333 tsx0x179e7a64 ...State changed from Null to Trying, event=RX_MSG
16:50:21.333 dlg0x179e4064 ....Transaction tsx0x179e7a64 state changed to Trying
16:50:21.333 endpoint .....Response msg 200/BYE/cseq=22541 (tdta0x17a59800) created
16:50:21.334 dlg0x179e4064 ......Sending Response msg 200/BYE/cseq=22541 (tdta0x17a59800)
16:50:21.334 tsx0x179e7a64 ......Sending Response msg 200/BYE/cseq=22541 (tdta0x17a59800) in state Trying
16:50:21.334 sip_resolve.c .......Target '81.23.228.129:5060' type=UDP resolved to '81.23.228.129:5060' type=UDP (UDP transport)
16:50:21.334 pjsua_core.c .......TX 816 bytes Response msg 200/BYE/cseq=22541 (tdta0x17a59800) to UDP 81.23.228.129:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 81.23.228.129:5060;received=81.23.228.129;branch=z9hG4bKdc0f.8351b125.0
Via: SIP/2.0/UDP 81.23.228.150:5060;branch=z9hG4bKdc0f.6d62f1e1.0
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bKdc0f.7351b125.0
Via: SIP/2.0/UDP 130.149.154.36:52573;rport=52573;received=130.149.154.36;branch=z9hG4bKPjmagoWDtmqgsmSsVv4Vx0yHJsUnDOCLc7
Record-Route: <sip:81.23.228.129;lr;ftag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g>
Record-Route: <sip:81.23.228.150;lr;ftag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g>
Record-Route: <sip:81.23.228.129;lr;ftag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g>
Call-ID: mX9D0DHpUQ-MRDAYWUVEzOy-mfoIZCNk
From: <sip:223281800@sip2sip.info>;tag=G3x9J9MXca6CAHultIsHt4AKJYEglm8g
To: <sip:chakrit@sip2sip.info>;tag=VJUvCpE5MJYr6YK0tNllbrWMMGkYIy1k
CSeq: 22541 BYE
Content-Length: 0
--end msg--
16:50:21.343 tsx0x179e7a64 .......State changed from Trying to Completed, event=TX_MSG
16:50:21.343 dlg0x179e4064 ........Transaction tsx0x179e7a64 state changed to Completed
2014-10-13 16:50:21.343 GossipExample[294:3c07] Gossip: dispatchCallState(0)
16:50:21.351 pjsua_media.c ......Call 0: deinitializing media..
16:50:21.352 strm0x17a50e14 ........JB summary:
size=0/eff=0 prefetch=0 level=0
delay (min/max/avg/dev)=20/20/20/0 ms
burst (min/max/avg/dev)=0/0/0/0 frames
lost=0 discard=0 empty=3
16:50:21.353 pjsua_media.c ........Media stream call00:0 is destroyed
16:50:21.357 tdta0x17a56800 .....Destroying txdata Request msg ACK/cseq=29430 (tdta0x17a56800)
16:50:21.357 tdta0x17a48e00 .....Destroying txdata Request msg INVITE/cseq=29430 (tdta0x17a48e00)
16:50:21.357 dlg0x179e4064 ......Session count dec to 3 by mod-invite
16:50:22.351 pjsua_aud.c Closing sound device after idle for 1 second(s)
16:50:22.360 pjsua_aud.c .Closing iPhone IO device sound playback device and iPhone IO device sound capture device
16:50:22.502 coreaudio_dev. .core audio stream stopped
16:50:24.062 pjsua_aud.c !Destroying player 0..
16:50:27.845 pjsua_acc.c !Sending 2 bytes keep-alive packet for acc 0 to 81.23.228.129:5060
16:50:27.846 tdta0x17a0d000 Destroying txdata raw
Raw
GSEMySipApp-Call-answer.log
2014-10-13 16:46:41.928 MyMyGossipExample[240:60b] view Load
2014-10-13 16:46:41.933 MyMyGossipExample[240:60b] ringfile: ringtone.wav
16:46:41.936 os_core_unix.c !pjlib 2.2.1-svn for POSIX initialized
16:46:41.937 sip_endpoint.c .Creating endpoint instance...
16:46:41.937 pjlib .select() I/O Queue created (0x16c1573c)
16:46:41.938 sip_endpoint.c .Module "mod-msg-print" registered
16:46:41.938 sip_transport. .Transport manager created.
16:46:41.938 pjsua_core.c .PJSUA state changed: NULL --> CREATED
16:46:41.940 sip_endpoint.c .Module "mod-pjsua-log" registered
16:46:41.940 sip_endpoint.c .Module "mod-tsx-layer" registered
16:46:41.940 sip_endpoint.c .Module "mod-stateful-util" registered
16:46:41.940 sip_endpoint.c .Module "mod-ua" registered
16:46:41.940 sip_endpoint.c .Module "mod-100rel" registered
16:46:41.940 sip_endpoint.c .Module "mod-pjsua" registered
16:46:41.940 sip_endpoint.c .Module "mod-invite" registered
16:46:41.941 coreaudio_dev. .. dev_id 0: iPhone IO device (in=1, out=1) 8000Hz
16:46:41.941 coreaudio_dev. ..core audio initialized
16:46:41.942 pjlib ..select() I/O Queue created (0x16c00214)
16:46:41.942 speex_codec.c ..Adjusting quality to 5 for uwb
16:46:41.943 conference.c ..Creating conference bridge with 12 ports
16:46:41.943 Master/sound ..Using delay buffer with WSOLA.
16:46:41.981 sip_endpoint.c .Module "mod-evsub" registered
16:46:41.981 sip_endpoint.c .Module "mod-presence" registered
16:46:41.981 evsub.c .Event pkg "presence" registered by mod-presence
16:46:41.981 sip_endpoint.c .Module "mod-mwi" registered
16:46:41.981 evsub.c .Event pkg "message-summary" registered by mod-mwi
16:46:41.982 sip_endpoint.c .Module "mod-refer" registered
16:46:41.982 evsub.c .Event pkg "refer" registered by mod-refer
16:46:41.982 sip_endpoint.c .Module "mod-pjsua-pres" registered
16:46:41.982 sip_endpoint.c .Module "mod-pjsua-im" registered
16:46:41.982 sip_endpoint.c .Module "mod-pjsua-options" registered
16:46:41.983 pjsua_core.c .1 SIP worker threads created
16:46:41.983 pjsua_core.c .pjsua version 2.2.1-svn for initialized
16:46:41.983 pjsua_core.c .PJSUA state changed: CREATED --> INIT
16:46:41.984 pjsua_core.c SIP UDP socket reachable at 10.0.6.137:52573
16:46:41.985 udp0x16c25a00 SIP UDP transport started, published address is 10.0.6.137:52573
16:46:41.985 pjsua_acc.c Adding account: id=sip:223281800@sip2sip.info
16:46:41.986 pjsua_acc.c .Account sip:223281800@sip2sip.info added with id 0
16:46:41.986 pjsua_core.c PJSUA state changed: INIT --> STARTING
16:46:41.986 sip_endpoint.c .Module "mod-unsolicited-mwi" registered
16:46:41.986 pjsua_core.c .PJSUA state changed: STARTING --> RUNNING
2014-10-13 16:46:41.987 MyMyGossipExample[240:60b] User agent started...
2014-10-13 16:46:41.991 MyMyGossipExample[240:60b] Codecs:
2014-10-13 16:46:41.994 MyMyGossipExample[240:60b] codecid: speex/16000/1, priority: 130
2014-10-13 16:46:41.997 MyMyGossipExample[240:60b] codecid: speex/8000/1, priority: 129
2014-10-13 16:46:42.001 MyMyGossipExample[240:60b] codecid: speex/32000/1, priority: 128
2014-10-13 16:46:42.005 MyMyGossipExample[240:60b] codecid: iLBC/8000/1, priority: 128
2014-10-13 16:46:42.009 MyMyGossipExample[240:60b] codecid: GSM/8000/1, priority: 128
2014-10-13 16:46:42.012 MyMyGossipExample[240:60b] codecid: PCMU/8000/1, priority: 128
2014-10-13 16:46:42.015 MyMyGossipExample[240:60b] codecid: PCMA/8000/1, priority: 128
16:46:42.020 pjsua_acc.c Acc 0: setting registration..
16:46:42.020 endpoint .Request msg REGISTER/cseq=63250 (tdta0x16c32e00) created.
16:46:42.021 tsx0x16c33e64 ..Transaction created for Request msg REGISTER/cseq=63251 (tdta0x16c32e00)
16:46:42.021 tsx0x16c33e64 .Sending Request msg REGISTER/cseq=63251 (tdta0x16c32e00) in state Null
16:46:42.022 sip_resolve.c ..Starting async DNS SRV query: target=_sip._udp.sip2sip.info, transport=Unspecified, port=0
16:46:42.022 _sip._udp.sip2 ..Starting async DNS SRV query_job: target=_sip._udp.sip2sip.info:5060
16:46:42.022 resolver.c ..Nameserver 8.8.8.8:53 state changed Active --> Probing
16:46:42.023 resolver.c ..Transmitting 40 bytes to NS 0 (8.8.8.8:53): DNS SRV query for _sip._udp.sip2sip.info: Success
16:46:42.023 tsx0x16c33e64 ..State changed from Null to Calling, event=TX_MSG
2014-10-13 16:46:42.024 MyMyGossipExample[240:60b] Gossip: dispatchRegistrationStarted(0, 1)
16:46:42.028 pjsua_acc.c .Acc 0: Registration sent
16:46:42.028 pjsua_acc.c Acc 0: setting online status to 1..
2014-10-13 16:46:42.028 MyMyGossipExample[240:60b] Account connected...
2014-10-13 16:46:42.031 MyMyGossipExample[240:60b] Account Status: 0
16:46:42.038 resolver.c !Received 77 bytes DNS response from 8.8.8.8:53
16:46:42.038 resolver.c Nameserver 8.8.8.8:53 state changed Probing --> Active
16:46:42.038 _sip._udp.sip2 SRV query_job for _sip._udp.sip2sip.info completed, 1 of 1 total entries selected:
16:46:42.038 _sip._udp.sip2 0: SRV 100 100 5060 proxy.sipthor.net (-)
16:46:42.039 _sip._udp.sip2 Starting async DNS A query_job for proxy.sipthor.net
16:46:42.039 resolver.c Transmitting 35 bytes to NS 0 (8.8.8.8:53): DNS A query for proxy.sipthor.net: Success
2014-10-13 16:46:42.034 MyMyGossipExample[240:60b] init done...
16:46:42.054 resolver.c Received 83 bytes DNS response from 8.8.8.8:53
16:46:42.055 resolver.c Nameserver 8.8.8.8:53 state changed Active --> Active
16:46:42.055 _sip._udp.sip2 DNS A for proxy.sipthor.net: 81.23.228.129
16:46:42.055 _sip._udp.sip2 Additional DNS A for proxy.sipthor.net: 81.23.228.150
16:46:42.055 _sip._udp.sip2 Additional DNS A for proxy.sipthor.net: 85.17.186.7
16:46:42.055 _sip._udp.sip2 Server resolution complete, 1 server entry(s) found
16:46:42.055 pjsua_core.c TX 525 bytes Request msg REGISTER/cseq=63251 (tdta0x16c32e00) to UDP 81.23.228.129:5060:
REGISTER sip:sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 10.0.6.137:52573;rport;branch=z9hG4bKPjVm8IDdrcSTR.Tc5ATgFq1Vs8IHR5O-vL
Route: <sip:sip2sip.info;lr>
Max-Forwards: 70
From: <sip:223281800@sip2sip.info>;tag=13id-9V.KXoOs9DpSzmlHlA2-vVgx76R
To: <sip:223281800@sip2sip.info>
Call-ID: f78ltWZBiWuR6M.xXt8GU4MVI07eeGh6
CSeq: 63251 REGISTER
Contact: <sip:223281800@10.0.6.137:52573;ob>
Expires: 300
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Content-Length: 0
--end msg--
16:46:42.183 sip_endpoint.c Processing incoming message: Response msg 401/REGISTER/cseq=63251 (rdata0x16c30214)
16:46:42.183 pjsua_core.c .RX 517 bytes Response msg 401/REGISTER/cseq=63251 (rdata0x16c30214) from UDP 81.23.228.129:5060:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.0.6.137:52573;received=130.149.154.36;rport=52573;branch=z9hG4bKPjVm8IDdrcSTR.Tc5ATgFq1Vs8IHR5O-vL
From: <sip:223281800@sip2sip.info>;tag=13id-9V.KXoOs9DpSzmlHlA2-vVgx76R
To: <sip:223281800@sip2sip.info>;tag=e7d4d6b46afb9bf88242924a8d869ebf.0c7e
Call-ID: f78ltWZBiWuR6M.xXt8GU4MVI07eeGh6
CSeq: 63251 REGISTER
WWW-Authenticate: Digest realm="sip2sip.info", nonce="543be5ef5d3306d61c0d97b8a9fc3938f2ef8c1c"
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:46:42.183 tsx0x16c33e64 .Incoming Response msg 401/REGISTER/cseq=63251 (rdata0x16c30214) in state Calling
16:46:42.183 tsx0x16c33e64 ..State changed from Calling to Completed, event=RX_MSG
16:46:42.183 pjsua_acc.c ....IP address change detected for account 0 (10.0.6.137:52573 --> 130.149.154.36:52573). Updating registration (using method 4)
16:46:42.184 tsx0x16bf3664 ....Transaction created for Request msg REGISTER/cseq=63252 (tdta0x16c32e00)
16:46:42.184 tsx0x16bf3664 ...Sending Request msg REGISTER/cseq=63252 (tdta0x16c32e00) in state Null
16:46:42.184 endpoint ....Request msg REGISTER/cseq=63252 (tdta0x16c32e00): skipping target resolution because address is already set
16:46:42.184 pjsua_core.c ....TX 718 bytes Request msg REGISTER/cseq=63252 (tdta0x16c32e00) to UDP 81.23.228.129:5060:
REGISTER sip:sip2sip.info SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:52573;rport;branch=z9hG4bKPjiGy7Btgf-drXOTbqGGzAha-70sB4w1mA
Route: <sip:sip2sip.info;lr>
Max-Forwards: 70
From: <sip:223281800@sip2sip.info>;tag=13id-9V.KXoOs9DpSzmlHlA2-vVgx76R
To: <sip:223281800@sip2sip.info>
Call-ID: f78ltWZBiWuR6M.xXt8GU4MVI07eeGh6
CSeq: 63252 REGISTER
Contact: <sip:223281800@130.149.154.36:52573;ob>
Expires: 300
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Authorization: Digest username="223281800", realm="sip2sip.info", nonce="543be5ef5d3306d61c0d97b8a9fc3938f2ef8c1c", uri="sip:sip2sip.info", response="03b7503f6e9ce1bd8f242bd4005a5cfb"
Content-Length: 0
--end msg--
16:46:42.186 tsx0x16bf3664 ....State changed from Null to Calling, event=TX_MSG
16:46:42.342 sip_endpoint.c Processing incoming message: Response msg 200/REGISTER/cseq=63252 (rdata0x16c30214)
16:46:42.342 pjsua_core.c .RX 737 bytes Response msg 200/REGISTER/cseq=63252 (rdata0x16c30214) from UDP 81.23.228.129:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 130.149.154.36:52573;received=130.149.154.36;rport=52573;branch=z9hG4bKPjiGy7Btgf-drXOTbqGGzAha-70sB4w1mA
From: <sip:223281800@sip2sip.info>;tag=13id-9V.KXoOs9DpSzmlHlA2-vVgx76R
To: <sip:223281800@sip2sip.info>;tag=e7d4d6b46afb9bf88242924a8d869ebf.6fcd
Call-ID: f78ltWZBiWuR6M.xXt8GU4MVI07eeGh6
CSeq: 63252 REGISTER
Contact: <sip:223281800@130.149.154.36:52573;ob>;expires=300;received="sip:81.23.228.129:5060;target=%73%69%70:%31%33%30.%31%34%39.%31%35%34.%33%36:%35%32%35%37%33", <sip:223281800@130.149.154.36:62604;ob>;expires=116;received="sip:81.23.228.129:5060;target=%73%69%70:%31%33%30.%31%34%39.%31%35%34.%33%36:%36%32%36%30%34"
Server: SIP Thor on OpenSIPS XS 1.9.0
Content-Length: 0
--end msg--
16:46:42.342 tsx0x16bf3664 .Incoming Response msg 200/REGISTER/cseq=63252 (rdata0x16c30214) in state Calling
16:46:42.342 tsx0x16bf3664 ..State changed from Calling to Completed, event=RX_MSG
16:46:42.342 pjsua_acc.c ....SIP outbound status for acc 0 is not active
16:46:42.342 pjsua_acc.c ....sip:223281800@sip2sip.info: registration success, status=200 (OK), will re-register in 300 seconds
16:46:42.342 pjsua_acc.c ....Keep-alive timer started for acc 0, destination:81.23.228.129:5060, interval:15s
2014-10-13 16:46:42.343 MyMyGossipExample[240:3c03] Gossip: dispatchRegistrationState(0)
16:46:47.187 tsx0x16c33e64 Timeout timer event
16:46:47.187 tsx0x16c33e64 .State changed from Completed to Terminated, event=TIMER
16:46:47.190 tsx0x16c33e64 Timeout timer event
16:46:47.190 tsx0x16c33e64 .State changed from Terminated to Destroyed, event=TIMER
16:46:47.190 tsx0x16c33e64 Transaction destroyed!
16:46:47.342 tsx0x16bf3664 Timeout timer event
16:46:47.342 tsx0x16bf3664 .State changed from Completed to Terminated, event=TIMER
16:46:47.343 tsx0x16bf3664 Timeout timer event
16:46:47.343 tsx0x16bf3664 .State changed from Terminated to Destroyed, event=TIMER
16:46:47.343 tdta0x16c32e00 ..Destroying txdata Request msg REGISTER/cseq=63252 (tdta0x16c32e00)
16:46:47.343 tsx0x16bf3664 Transaction destroyed!
16:46:57.344 pjsua_acc.c Sending 2 bytes keep-alive packet for acc 0 to 81.23.228.129:5060
16:46:57.345 tdta0x16c3c000 Destroying txdata raw
16:47:04.874 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=20042 (rdata0x16c30214)
16:47:04.874 pjsua_core.c .RX 1567 bytes Request msg INVITE/cseq=20042 (rdata0x16c30214) from UDP 81.23.228.129:5060:
INVITE sip:223281800@130.149.154.36:52573;ob SIP/2.0
Record-Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.87f16f>
Record-Route: <sip:81.23.228.150;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.3da45dd2>
Record-Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.77f16f>
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bK9b96.0bea7e05.0
Via: SIP/2.0/UDP 81.23.228.150:5060;branch=z9hG4bK9b96.685d5d72.0
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bK9b96.faea7e05.0
Via: SIP/2.0/UDP 130.149.154.36:51155;received=130.149.154.36;rport=51155;branch=z9hG4bKPjLwaOmCVfKgh80DOSNMQja-QcQ7DUKuRb
Max-Forwards: 67
From: sip:chakrit@sip2sip.info;tag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI
To: sip:223281800@sip2sip.info
Contact: <sip:chakrit@130.149.154.36:51155;ob>
Call-ID: 5uYDH25o3.GB.Sn14uH2SmDVwVbAoub2
CSeq: 20042 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
Content-Type: application/sdp
Content-Length: 451
v=0
o=- 3622200423 3622200423 IN IP4 10.0.6.197
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 57650 RTP/AVP 98 97 99 104 3 0 8 96
c=IN IP4 81.23.228.129
b=TIAS:64000
a=rtcp:57651 IN IP4 81.23.228.129
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:97 speex/8000
a=rtpmap:99 speex/32000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
--end msg--
16:47:04.875 pjsua_call.c .Incoming Request msg INVITE/cseq=20042 (rdata0x16c30214)
16:47:04.875 tsx0x16bf2e64 ...Transaction created for Request msg INVITE/cseq=20042 (rdata0x16c30214)
16:47:04.876 tsx0x16bf2e64 ..Incoming Request msg INVITE/cseq=20042 (rdata0x16c30214) in state Null
16:47:04.888 tsx0x16bf2e64 ...State changed from Null to Trying, event=RX_MSG
16:47:04.888 dlg0x16bfd064 ....Transaction tsx0x16bf2e64 state changed to Trying
16:47:04.888 dlg0x16bfd064 ..UAS dialog created
16:47:04.888 dlg0x16bfd064 ..Module mod-invite added as dialog usage, data=0x16be3e14
16:47:04.888 dlg0x16bfd064 ...Session count inc to 2 by mod-invite
16:47:04.888 inv0x16bfd064 ..UAS invite session created for dialog dlg0x16bfd064
16:47:04.888 pjsua_media.c ..Call 0: initializing media..
16:47:04.889 pjsua_media.c ...RTP socket reachable at 10.0.6.137:4000
16:47:04.889 pjsua_media.c ...RTCP socket reachable at 10.0.6.137:4001
16:47:04.889 pjsua_media.c ...Media index 0 selected for audio call 0
16:47:04.890 pjsua_call.c ..Call 0: remote NAT type is 0 (Unknown)
16:47:04.890 endpoint ...Response msg 100/INVITE/cseq=20042 (tdta0x16c46000) created
16:47:04.890 dlg0x16bfd064 ...Initial answer Response msg 100/INVITE/cseq=20042 (tdta0x16c46000)
16:47:04.890 inv0x16bfd064 ...Sending Response msg 100/INVITE/cseq=20042 (tdta0x16c46000)
16:47:04.890 dlg0x16bfd064 ....Sending Response msg 100/INVITE/cseq=20042 (tdta0x16c46000)
16:47:04.891 tsx0x16bf2e64 ....Sending Response msg 100/INVITE/cseq=20042 (tdta0x16c46000) in state Trying
16:47:04.891 sip_resolve.c .....Target '81.23.228.129:5060' type=UDP resolved to '81.23.228.129:5060' type=UDP (UDP transport)
16:47:04.891 pjsua_core.c .....TX 830 bytes Response msg 100/INVITE/cseq=20042 (tdta0x16c46000) to UDP 81.23.228.129:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 81.23.228.129:5060;received=81.23.228.129;branch=z9hG4bK9b96.0bea7e05.0
Via: SIP/2.0/UDP 81.23.228.150:5060;branch=z9hG4bK9b96.685d5d72.0
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bK9b96.faea7e05.0
Via: SIP/2.0/UDP 130.149.154.36:51155;rport=51155;received=130.149.154.36;branch=z9hG4bKPjLwaOmCVfKgh80DOSNMQja-QcQ7DUKuRb
Record-Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.87f16f>
Record-Route: <sip:81.23.228.150;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.3da45dd2>
Record-Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.77f16f>
Call-ID: 5uYDH25o3.GB.Sn14uH2SmDVwVbAoub2
From: <sip:chakrit@sip2sip.info>;tag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI
To: <sip:223281800@sip2sip.info>
CSeq: 20042 INVITE
Content-Length: 0
--end msg--
16:47:04.900 tsx0x16bf2e64 .....State changed from Trying to Proceeding, event=TX_MSG
16:47:04.900 dlg0x16bfd064 ......Transaction tsx0x16bf2e64 state changed to Proceeding
2014-10-13 16:47:04.901 MyMyGossipExample[240:3c03] Gossip: dispatchIncomingCall(0, 0)
2014-10-13 16:47:04.909 MyMyGossipExample[240:60b] Gossip: ringbackWithSoundNamed: /var/mobile/Applications/F0381BCC-EA3E-4E9D-9542-C4484B712D6F/MyMyGossipExample.app/ringtone.wav
16:47:04.911 pjsua_aud.c !Creating playlist with 1 file(s)..
16:47:04.913 wav_playlist.c .WAV playlist 'WAV playlist' created: samp.rate=44100, ch=2, bufsize=4KB
16:47:04.913 resample.c .resample created: high qualiy, small filter, in/out rate=44100/16000
16:47:04.913 resample.c .resample created: high qualiy, small filter, in/out rate=16000/44100
16:47:04.913 pjsua_aud.c .Playlist created, id=0, slot=1
2014-10-13 16:47:05.994 MyMyGossipExample[240:60b] answer call:
16:47:05.998 pjsua_call.c Answering call 0: code=200
16:47:05.998 inv0x16bfd064 ..SDP negotiation done, status=0
16:47:05.998 pjsua_call.c ...Call 0: remote NAT type is 0 (Unknown)
16:47:05.998 pjsua_media.c ...Call 0: updating media..
16:47:05.999 pjsua_aud.c ....Audio channel update..
16:47:05.999 strm0x16c53814 .....VAD temporarily disabled
16:47:05.999 rtp.c .....pjmedia_rtp_session_init: ses=0x16bd6aa4, default_pt=98, ssrc=0x259e7a43
16:47:06.000 rtp.c .....pjmedia_rtp_session_init: ses=0x16c5745c, default_pt=98, ssrc=0x259e7a43
16:47:06.001 stream.c .....Stream strm0x16c53814 created
16:47:06.001 strm0x16c53814 .....Encoder stream started
16:47:06.001 strm0x16c53814 .....Decoder stream started
16:47:06.002 pjsua_media.c ....Audio updated, stream #0: speex (sendrecv)
2014-10-13 16:47:06.002 MyMyGossipExample[240:60b] Gossip: dispatchCallMediaState(0)
16:47:06.005 pjsua_aud.c ...Conf connect: 2 --> 0
16:47:06.006 pjsua_aud.c ....Set sound device: capture=-1, playback=-2
16:47:06.006 pjsua_aud.c .....Opening sound device PCM@16000/1/20ms
16:47:06.006 coreaudio_dev. ......Using RemoteIO audio unit
16:47:06.291 coreaudio_dev. ......core audio stream started
16:47:06.304 conference.c ....Port 2 (sip:chakrit@sip2sip.info) transmitting to port 0 (iPhone IO device)
16:47:06.304 pjsua_aud.c ...Conf connect: 0 --> 2
16:47:06.304 conference.c ....Port 0 (iPhone IO device) transmitting to port 2 (sip:chakrit@sip2sip.info)
16:47:06.304 inv0x16bfd064 ..Sending Response msg 200/INVITE/cseq=20042 (tdta0x16c46000)
16:47:06.304 dlg0x16bfd064 ...Sending Response msg 200/INVITE/cseq=20042 (tdta0x16c46000)
16:47:06.304 tsx0x16bf2e64 ...Sending Response msg 200/INVITE/cseq=20042 (tdta0x16c46000) in state Proceeding
16:47:06.304 pjsua_core.c ....TX 1415 bytes Response msg 200/INVITE/cseq=20042 (tdta0x16c46000) to UDP 81.23.228.129:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 81.23.228.129:5060;received=81.23.228.129;branch=z9hG4bK9b96.0bea7e05.0
Via: SIP/2.0/UDP 81.23.228.150:5060;branch=z9hG4bK9b96.685d5d72.0
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bK9b96.faea7e05.0
Via: SIP/2.0/UDP 130.149.154.36:51155;rport=51155;received=130.149.154.36;branch=z9hG4bKPjLwaOmCVfKgh80DOSNMQja-QcQ7DUKuRb
Record-Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.87f16f>
Record-Route: <sip:81.23.228.150;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.3da45dd2>
Record-Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.77f16f>
Call-ID: 5uYDH25o3.GB.Sn14uH2SmDVwVbAoub2
From: <sip:chakrit@sip2sip.info>;tag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI
To: <sip:223281800@sip2sip.info>;tag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW
CSeq: 20042 INVITE
Contact: <sip:223281800@130.149.154.36:52573;ob>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800;refresher=uac
Require: timer
Content-Type: application/sdp
Content-Length: 269
v=0
o=- 3622200424 3622200425 IN IP4 10.0.6.137
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 4000 RTP/AVP 98 96
c=IN IP4 10.0.6.137
b=TIAS:64000
a=rtcp:4001 IN IP4 10.0.6.137
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
--end msg--
16:47:06.311 tsx0x16bf2e64 ....State changed from Proceeding to Completed, event=TX_MSG
16:47:06.311 dlg0x16bfd064 .....Transaction tsx0x16bf2e64 state changed to Completed
16:47:06.313 coreaudio_dev. !Recorder thread started, (371 frames)
16:47:06.315 os_core_unix.c Info: possibly re-registering existing thread
16:47:06.315 coreaudio_dev. !Player thread started, (372 frames)
16:47:06.316 strm0x16c53814 Jitter buffer is bufferring (prefetch=0), plc invoked
16:47:06.318 strm0x16c53814 Start talksprut..
16:47:06.319 Master/sound Underflow, buf_cnt=0, will generate 1 frame
2014-10-13 16:47:06.311 MyMyGossipExample[240:60b] Gossip: dispatchCallState(0)
16:47:06.331 pjsua_aud.c !.......Conf connect: 1 --> 0
16:47:06.331 conference.c ........Port 1 (WAV playlist) transmitting to port 0 (iPhone IO device)
2014-10-13 16:47:06.331 MyMyGossipExample[240:60b] call answered.
2014-10-13 16:47:06.333 MyMyGossipExample[240:60b] isBegin: YES
16:47:06.341 pjsua_aud.c Conf disconnect: 1 -x- 0
16:47:06.341 conference.c .Port 1 (WAV playlist) stop transmitting to port 0 (iPhone IO device)
16:47:06.341 pjsua_aud.c Destroying player 0..
16:47:06.341 pjsua_call.c Call 0 hanging up: code=0..
16:47:06.343 endpoint ..Request msg BYE/cseq=20621 (tdta0x16c64000) created.
16:47:06.343 inv0x16bfd064 ..Sending Request msg BYE/cseq=20621 (tdta0x16c64000)
16:47:06.343 inv0x16bfd064 ..Delaying BYE request until ACK is received
16:47:06.441 strm0x16c53814 !RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0
16:47:06.442 sip_endpoint.c !Processing incoming message: Request msg ACK/cseq=20042 (rdata0x16c30214)
16:47:06.442 pjsua_core.c .RX 614 bytes Request msg ACK/cseq=20042 (rdata0x16c30214) from UDP 81.23.228.129:5060:
ACK sip:223281800@130.149.154.36:52573;ob SIP/2.0
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bK9b96.faea7e05.2
Via: SIP/2.0/UDP 81.23.228.150:5060;branch=z9hG4bK9b96.685d5d72.3
Via: SIP/2.0/UDP 81.23.228.129:5060;branch=z9hG4bK9b96.faea7e05.2
Via: SIP/2.0/UDP 130.149.154.36:51155;received=130.149.154.36;rport=51155;branch=z9hG4bKPjll9CW6r9xUS7hxP67DoiIHA3mIAzsp0h
Max-Forwards: 67
From: sip:chakrit@sip2sip.info;tag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI
To: sip:223281800@sip2sip.info;tag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW
Call-ID: 5uYDH25o3.GB.Sn14uH2SmDVwVbAoub2
CSeq: 20042 ACK
Content-Length: 0
--end msg--
16:47:06.442 dlg0x16bfd064 .Received Request msg ACK/cseq=20042 (rdata0x16c30214)
16:47:06.443 tsx0x16bf2e64 ..Request to terminate transaction
16:47:06.443 tsx0x16bf2e64 ...State changed from Completed to Terminated, event=USER
16:47:06.443 dlg0x16bfd064 ....Transaction tsx0x16bf2e64 state changed to Terminated
2014-10-13 16:47:06.443 MyMyGossipExample[240:3c03] Gossip: dispatchCallState(0)
16:47:06.446 dlg0x16bfd064 ..Sending pending BYE
16:47:06.446 inv0x16bfd064 ...Sending Request msg BYE/cseq=20621 (tdta0x16c64000)
16:47:06.446 dlg0x16bfd064 ....Sending Request msg BYE/cseq=20621 (tdta0x16c64000)
16:47:06.446 tsx0x16c34864 .....Transaction created for Request msg BYE/cseq=20620 (tdta0x16c64000)
16:47:06.446 tsx0x16c34864 ....Sending Request msg BYE/cseq=20620 (tdta0x16c64000) in state Null
16:47:06.446 sip_resolve.c .....Target '81.23.228.129:0' type=Unspecified resolved to '81.23.228.129:5060' type=UDP (UDP transport)
16:47:06.446 pjsua_core.c .....TX 636 bytes Request msg BYE/cseq=20620 (tdta0x16c64000) to UDP 81.23.228.129:5060:
BYE sip:chakrit@130.149.154.36:51155;ob SIP/2.0
Via: SIP/2.0/UDP 130.149.154.36:52573;rport;branch=z9hG4bKPjW-q-GLNG2X9f97cE5EqxN-OeEm4HBnoC
Max-Forwards: 70
From: <sip:223281800@sip2sip.info>;tag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW
To: <sip:chakrit@sip2sip.info>;tag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI
Call-ID: 5uYDH25o3.GB.Sn14uH2SmDVwVbAoub2
CSeq: 20620 BYE
Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.87f16f>
Route: <sip:81.23.228.150;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.3da45dd2>
Route: <sip:81.23.228.129;lr;ftag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI;did=27.77f16f>
Content-Length: 0
--end msg--
16:47:06.448 tsx0x16c34864 .....State changed from Null to Calling, event=TX_MSG
16:47:06.448 dlg0x16bfd064 ......Transaction tsx0x16c34864 state changed to Calling
16:47:06.448 tsx0x16bf2e64 Timeout timer event
16:47:06.448 tsx0x16bf2e64 .State changed from Terminated to Destroyed, event=TIMER
16:47:06.448 tdta0x16c46000 ..Destroying txdata Response msg 200/INVITE/cseq=20042 (tdta0x16c46000)
16:47:06.448 tsx0x16bf2e64 Transaction destroyed!
16:47:06.452 strm0x16c53814 !Jitter buffer starts returning normal frames (after 7 empty/lost)
16:47:06.515 sip_endpoint.c !Processing incoming message: Response msg 200/BYE/cseq=20620 (rdata0x16c30214)
16:47:06.515 pjsua_core.c .RX 592 bytes Response msg 200/BYE/cseq=20620 (rdata0x16c30214) from UDP 81.23.228.129:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 130.149.154.36:52573;rport=52573;received=130.149.154.36;branch=z9hG4bKPjW-q-GLNG2X9f97cE5EqxN-OeEm4HBnoC
Record-Route: <sip:81.23.228.129;lr;ftag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW>
Record-Route: <sip:81.23.228.150;lr;ftag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW>
Record-Route: <sip:81.23.228.129;lr;ftag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW>
Call-ID: 5uYDH25o3.GB.Sn14uH2SmDVwVbAoub2
From: <sip:223281800@sip2sip.info>;tag=mDb.ynRCE4CghiK1zTavqEFcueJ9KlCW
To: <sip:chakrit@sip2sip.info>;tag=XcABVOdFmdSQfYOSj9xmujmGZmo529jI
CSeq: 20620 BYE
Content-Length: 0
--end msg--
16:47:06.515 tsx0x16c34864 .Incoming Response msg 200/BYE/cseq=20620 (rdata0x16c30214) in state Calling
16:47:06.516 tsx0x16c34864 ..State changed from Calling to Completed, event=RX_MSG
16:47:06.516 dlg0x16bfd064 ...Received Response msg 200/BYE/cseq=20620 (rdata0x16c30214)
16:47:06.516 dlg0x16bfd064 ...Transaction tsx0x16c34864 state changed to Completed
16:47:06.523 strm0x16c53814 !Jitter buffer empty (prefetch=0), plc invoked
2014-10-13 16:47:06.516 MyMyGossipExample[240:3c03] Gossip: dispatchCallState(0)
16:47:06.537 pjsua_media.c !.....Call 0: deinitializing media..
16:47:06.538 strm0x16c53814 .......JB summary:
size=0/eff=0 prefetch=0 level=0
delay (min/max/avg/dev)=40/40/40/0 ms
burst (min/max/avg/dev)=0/0/0/0 frames
lost=0 discard=0 empty=8
16:47:06.538 pjsua_media.c .......Media stream call00:0 is destroyed
16:47:06.544 dlg0x16bfd064 .....Session count dec to 1 by mod-invite
16:47:07.538 pjsua_aud.c Closing sound device after idle for 1 second(s)
16:47:07.547 pjsua_aud.c .Closing iPhone IO device sound playback device and iPhone IO device sound capture device
16:47:07.686 coreaudio_dev. .core audio stream stopped
16:47:11.517 tsx0x16c34864 Timeout timer event
16:47:11.517 tsx0x16c34864 .State changed from Completed to Terminated, event=TIMER
16:47:11.517 dlg0x16bfd064 ..Transaction tsx0x16c34864 state changed to Terminated
16:47:11.517 dlg0x16bfd064 ...Dialog destroyed
16:47:11.521 tsx0x16c34864 Timeout timer event
16:47:11.521 tsx0x16c34864 .State changed from Terminated to Destroyed, event=TIMER
16:47:11.521 tdta0x16c64000 ..Destroying txdata Request msg BYE/cseq=20620 (tdta0x16c64000)
16:47:11.521 tsx0x16c34864 Transaction destroyed!
16:47:12.346 pjsua_acc.c Sending 2 bytes keep-alive packet for acc 0 to 81.23.228.129:5060
16:47:12.347 tdta0x16bf2e00 Destroying txdata raw
16:47:27.348 pjsua_acc.c Sending 2 bytes keep-alive packet for acc 0 to 81.23.228.129:5060
16:47:27.349 tdta0x16c33000 Destroying txdata raw
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment