[cisco-voip] SIP IPhone Debug

Tue Jun 16 13:44:12 EDT 2009

All,

I have been trying to get an iphone attached to the CUCM 6.1 cluster I have
in production. I have attached the debug from the phone for review.

I can make and place calls fine but the iphone is unable to recieve any
audio. The iphone is sending audio and the far end can hear the audio fine.

Any help is welcomed.

Dustin
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://puck.nether.net/pipermail/cisco-voip/attachments/20090616/01ef3cee/attachment.html>
-------------- next part --------------
13:16:44.356 sip_endpoint.c Module "mod-pjsua-log" registered
13:16:44.357 sip_endpoint.c Module "mod-tsx-layer" registered
13:16:44.357 sip_endpoint.c Module "mod-stateful-util" registered
13:16:44.359 sip_endpoint.c Module "mod-ua" registered
13:16:44.359 sip_endpoint.c Module "mod-100rel" registered
13:16:44.359 sip_endpoint.c Module "mod-pjsua" registered 13:16:44.360 sip_endpoint.c Module "mod-invite" registered
13:16:45.014 pasound.c PortAudio sound library initialized, status=0
13:16:45.015 pasound.c PortAudio host api count=1
13:16:45.015 pasound.c Sound device count=2
13:16:45.017 pjlib select() I/O Queue created (0x818014)
13:16:45.018 sip_endpoint.c Module "mod-evsub" registered
13:16:45.019 sip_endpoint.c Module "mod-presence" registered
13:16:45.019 sip_endpoint.c Module "mod-refer" registered
13:16:45.019 sip_endpoint.c Module "mod-pjsua-pres" registered 13:16:45.020 sip_endpoint.c Module "mod-pjsua-im" registered 13:16:45.020 sip_endpoint.c Module "mod-pjsua-options" registered
13:16:45.021 pjsua_core.c 1 SIP worker threads created
13:16:45.021 pjsua_core.c pjsua version 2.0.3 for iPhoneOS initialized
13:16:45.022 pjsua_media.c pjsua_set_snd_dev(): attempting to open devices @8000 Hz
13:16:47.095 sound_port.c Echo canceller is now disabled in the sound port
13:16:47.096 conference.c Port 2 (local-keytone) transmitting to port 0 (iphonemic)
13:16:47.096 sock_common.c ==========================
13:16:47.097 sock_common.c searching for vpn ...
13:16:47.097 sock_common.c done, searching for vpn
13:16:47.097 sock_common.c host ip: 10.10.1.109
13:16:47.098 sock_common.c Using ip: 10.10.1.109
13:16:47.098 sock_common.c ==========================
13:16:47.098 pjsua_core.c SIP UDP socket reachable at 10.10.1.109:5060
13:16:47.098 sip_transport_ Success setting SO_RCVBUF(5242880)
13:16:47.099 sip_transport_ Success setting SO_SNDBUF(5242880)
13:16:47.099 udp0x846200 SIP UDP transport started, published address is 10.10.1.109:5060 13:16:47.100 pjsua_acc.c Account added with id 0 13:16:47.100 sock_common.c ==========================
13:16:47.101 sock_common.c searching for vpn ...
13:16:47.101 sock_common.c done, searching for vpn
13:16:47.102 sock_common.c host ip: 10.10.1.109
13:16:47.102 sock_common.c Using ip: 10.10.1.109
13:16:47.102 sock_common.c ==========================
13:16:47.102 pjsua_media.c RTP socket reachable at 10.10.1.109:4000
13:16:47.102 pjsua_media.c RTCP socket reachable at 10.10.1.109:4001
13:16:47.103 sock_common.c ==========================
13:16:47.104 sock_common.c searching for vpn ...
13:16:47.104 sock_common.c done, searching for vpn
13:16:47.104 sock_common.c host ip: 10.10.1.109
13:16:47.105 sock_common.c Using ip: 10.10.1.109
13:16:47.105 sock_common.c ==========================
13:16:47.105 pjsua_media.c RTP socket reachable at 10.10.1.109:4002
13:16:47.105 pjsua_media.c RTCP socket reachable at 10.10.1.109:4003
13:16:47.106 sock_common.c ==========================
13:16:47.107 sock_common.c searching for vpn ...
13:16:47.107 sock_common.c done, searching for vpn
13:16:47.107 sock_common.c host ip: 10.10.1.109
13:16:47.107 sock_common.c Using ip: 10.10.1.109
13:16:47.108 sock_common.c ==========================
13:16:47.108 pjsua_media.c RTP socket reachable at 10.10.1.109:4004
13:16:47.108 pjsua_media.c RTCP socket reachable at 10.10.1.109:4005
13:16:47.109 sock_common.c ========================== 13:16:47.110 sock_common.c searching for vpn ...
13:16:47.110 sock_common.c done, searching for vpn 13:16:47.110 sock_common.c host ip: 10.10.1.109 13:16:47.110 sock_common.c Using ip: 10.10.1.109 13:16:47.110 sock_common.c ==========================
13:16:47.111 pjsua_media.c RTP socket reachable at 10.10.1.109:4006
13:16:47.111 pjsua_media.c RTCP socket reachable at 10.10.1.109:4007
13:16:47.112 sip_endpoint.c Module "My-Notify-Module" registered
13:16:47.112 pjsua_mynotify Register Notify Module successfully
13:16:47.113 pjsua_acc.c Account sip:6911 at 172.31.1.20 added with id 1
13:16:47.118 pjsua_core.c TX 414 bytes Request msg REGISTER/cseq=34588
(tdta0x853000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjtcgmp1irmz6mw5d9l72rambwoxrc4hrp
Max-Forwards: 70
From: ;tag=0aylz9ef1glarkac7nqxspn6wyd-byxy
To:
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
CSeq: 34588 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 120
Content-Length: 0

--end msg--
13:16:47.121 pjsua_acc.c Registration sent
13:16:47.353 pjsua_core.c RX 350 bytes Response msg 100/REGISTER/
cseq=34588 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:16:49 GMT
From: ;tag=0aylz9ef1glarkac7nqxspn6wyd-byxy
Content-Length: 0
To:
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjtcgmp1irmz6mw5d9l72rambwoxrc4hrp;received=172.16.14.34
CSeq: 34588 REGISTER

--end msg--
13:16:47.354 pjsua_core.c RX 473 bytes Response msg 401/REGISTER/
cseq=34588 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 401 Unauthorized
Date: Tue, 16 Jun 2009 17:16:49 GMT
From: ;tag=0aylz9ef1glarkac7nqxspn6wyd-byxy
WWW-Authenticate: Digest realm="ccmsipline", nonce="CDNVtJGYIQTFdrK8M4w99VqZQl3rI5jH", algorithm=MD5
Content-Length: 0
To: ;tag=1863319205
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjtcgmp1irmz6mw5d9l72rambwoxrc4hrp;received=172.16.14.34
CSeq: 34588 REGISTER

--end msg--
13:16:47.355 pjsua_core.c TX 602 bytes Request msg REGISTER/cseq=34589
(tdta0x853000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjdtq.i3jkjo11jp61qglg1qex0lyonux5
Max-Forwards: 70
From: ;tag=0aylz9ef1glarkac7nqxspn6wyd-byxy
To:
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
CSeq: 34589 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 120
Authorization: Digest username="earimont", realm="ccmsipline", nonce="CDNVtJGYIQTFdrK8M4w99VqZQl3rI5jH", uri="sip:172.31.1.20", response="20e6806bf9fa35b848a48b2bdb859fdb", algorithm=MD5
Content-Length: 0

--end msg--
13:16:47.573 pjsua_core.c RX 365 bytes Response msg 100/REGISTER/
cseq=34589 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:16:50 GMT
From: ;tag=0aylz9ef1glarkac7nqxspn6wyd-byxy
Content-Length: 0
To: ;tag=1863319205
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjdtq.i3jkjo11jp61qglg1qex0lyonux5;received=172.16.14.34
CSeq: 34589 REGISTER

--end msg--
13:16:47.573 pjsua_core.c RX 458 bytes Response msg 200/REGISTER/
cseq=34589 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:16:50 GMT
From: ;tag=0aylz9ef1glarkac7nqxspn6wyd-byxy
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=1863319205
Contact: ;x-cisco-newreg
Expires: 120
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjdtq.i3jkjo11jp61qglg1qex0lyonux5;received=172.16.14.34
CSeq: 34589 REGISTER

--end msg--
13:16:47.574 pjsua_acc.c IP address change detected for account 1 (10.10.1.109:5060 --> 172.16.14.34:5060). Updating registration..
13:16:47.575 pjsua_core.c TX 412 bytes Request msg REGISTER/cseq=34590
(tdta0x87c000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjjw6ecd7h9qmwfdj3a.f5dppbjuhiljnv
Max-Forwards: 70
From: ;tag=ogg2j.0cnl7jyc2avpnaawjjydssfopc
To:
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
CSeq: 34590 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 0
Content-Length: 0

--end msg--
13:16:47.577 pjsua_acc.c Unregistration sent
13:16:47.785 pjsua_core.c RX 350 bytes Response msg 100/REGISTER/ cseq=34590 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:16:50 GMT
From: ;tag=ogg2j.0cnl7jyc2avpnaawjjydssfopc
Content-Length: 0
To:
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjjw6ecd7h9qmwfdj3a.f5dppbjuhiljnv;received=172.16.14.34
CSeq: 34590 REGISTER

--end msg--
13:16:47.786 pjsua_core.c RX 403 bytes Response msg 200/REGISTER/ cseq=34590 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:16:50 GMT
From: ;tag=ogg2j.0cnl7jyc2avpnaawjjydssfopc
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=1996959787
Expires: 0
Call-ID: zmoij8hpcf4exmda9xla65yqgyw56bt8
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjjw6ecd7h9qmwfdj3a.f5dppbjuhiljnv;received=172.16.14.34
CSeq: 34590 REGISTER

--end msg--
13:16:47.787 pjsua_core.c TX 428 bytes Request msg REGISTER/cseq=9023
(tdta0x87e000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjfxxd5lo8h8oyq8y-.9pyctrjt6bvomyv
Max-Forwards: 70
From: ;tag=yzpkeybop3ebz4fharhmbqdangblol5a
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
CSeq: 9023 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 120
Content-Length: 0

--end msg--
13:16:47.792 pjsua_acc.c Registration sent 13:16:48.010 pjsua_core.c RX 349 bytes Response msg 100/REGISTER/
cseq=9023 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:16:50 GMT
From: ;tag=yzpkeybop3ebz4fharhmbqdangblol5a
Content-Length: 0
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjfxxd5lo8h8oyq8y-. 
9pyctrjt6bvomyv;received=172.16.14.34
CSeq: 9023 REGISTER

--end msg--
13:16:48.217 pjsua_core.c RX 472 bytes Response msg 401/REGISTER/
cseq=9023 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 401 Unauthorized
Date: Tue, 16 Jun 2009 17:16:50 GMT
From: ;tag=yzpkeybop3ebz4fharhmbqdangblol5a
WWW-Authenticate: Digest realm="ccmsipline", nonce="VFSZ5xyD/ BAzcjsMtsByUkcbf3XrSeXG", algorithm=MD5
Content-Length: 0
To: ;tag=1312206834
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjfxxd5lo8h8oyq8y-. 
9pyctrjt6bvomyv;received=172.16.14.34
CSeq: 9023 REGISTER

--end msg--
13:16:48.218 pjsua_core.c TX 616 bytes Request msg REGISTER/cseq=9024
(tdta0x87e000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjg28lnldt8gw4tioqei2.u3cyudeclzv5
Max-Forwards: 70
From: ;tag=yzpkeybop3ebz4fharhmbqdangblol5a
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
CSeq: 9024 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 120
Authorization: Digest username="earimont", realm="ccmsipline", nonce="VFSZ5xyD/BAzcjsMtsByUkcbf3XrSeXG", uri="sip:172.31.1.20", response="442e9d8d502ec03c6ab5f6b073f29d6a", algorithm=MD5
Content-Length: 0

--end msg--
13:16:48.459 pjsua_core.c RX 364 bytes Response msg 100/REGISTER/
cseq=9024 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:16:51 GMT
From: ;tag=yzpkeybop3ebz4fharhmbqdangblol5a
Content-Length: 0
To: ;tag=1312206834
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjg28lnldt8gw4tioqei2.u3cyudeclzv5;received=172.16.14.34
CSeq: 9024 REGISTER

--end msg--
13:16:48.460 pjsua_core.c RX 472 bytes Response msg 200/REGISTER/
cseq=9024 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:16:51 GMT
From: ;tag=yzpkeybop3ebz4fharhmbqdangblol5a
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=1312206834
Contact: ;x-cisco-newreg
Expires: 120
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjg28lnldt8gw4tioqei2.u3cyudeclzv5;received=172.16.14.34
CSeq: 9024 REGISTER

--end msg--
13:16:48.461 pjsua_acc.c sip:6911 at 172.31.1.20: registration success, status=200 (OK), will re-register in 120 seconds
13:16:48.461 pjsua_acc.c Keep-alive timer started for acc 1, destination:172.31.1.20:5060, interval:15s
13:16:48.478 pjsua_core.c RX 531 bytes Request msg NOTIFY/cseq=101
(rdata0x847864) from UDP 172.31.1.20:5060:
NOTIFY sip:6911 at 172.16.14.34:5060;transport=UDP SIP/2.0
Date: Tue, 16 Jun 2009 17:16:51 GMT
From: ;tag=2111420432
Event: message-summary
Content-Length: 22
User-Agent: Cisco-CUCM6.1
To:
Contact:
Content-Type: application/simple-message-summary
Call-ID: 79e9c900-a371d383-47b0-14011fac at 172.31.1.20
Subscription-State: active
Via: SIP/2.0/UDP 172.31.1.20:5060;branch=z9hG4bK448e3f8dfcb5
CSeq: 101 NOTIFY
Max-Forwards: 70

Messages-Waiting: no

--end msg--
13:16:48.809 pjsua_core.c TX 267 bytes Response msg 200/NOTIFY/
cseq=101 (tdta0x881a00) to UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
172.31.1.20:5060;received=172.31.1.20;branch=z9hG4bK448e3f8dfcb5
Call-ID: 79e9c900-a371d383-47b0-14011fac at 172.31.1.20
From: ;tag=2111420432
To:
CSeq: 101 NOTIFY
Content-Length: 0

--end msg--
13:16:48.960 pjsua_core.c RX 531 bytes Request msg NOTIFY/cseq=101
(rdata0x847864) from UDP 172.31.1.20:5060:
NOTIFY sip:6911 at 172.16.14.34:5060;transport=UDP SIP/2.0
Date: Tue, 16 Jun 2009 17:16:51 GMT
From: ;tag=2111420432
Event: message-summary
Content-Length: 22
User-Agent: Cisco-CUCM6.1
To:
Contact:
Content-Type: application/simple-message-summary
Call-ID: 79e9c900-a371d383-47b0-14011fac at 172.31.1.20
Subscription-State: active
Via: SIP/2.0/UDP 172.31.1.20:5060;branch=z9hG4bK448e3f8dfcb5
CSeq: 101 NOTIFY
Max-Forwards: 70

Messages-Waiting: no

--end msg--
13:16:48.991 pjsua_core.c TX 267 bytes Response msg 200/NOTIFY/
cseq=101 (tdta0x881a00) to UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
172.31.1.20:5060;received=172.31.1.20;branch=z9hG4bK448e3f8dfcb5
Call-ID: 79e9c900-a371d383-47b0-14011fac at 172.31.1.20
From: ;tag=2111420432
To:
CSeq: 101 NOTIFY
Content-Length: 0

--end msg--
13:16:53.175 pjsua_call.c Making call with acc #1 to sip:5667 at 172.31.1.20
13:16:53.371 pjsua_media.c Media index 0 selected for call 0
13:16:53.372 pjsua_core.c TX 855 bytes Request msg INVITE/cseq=13958
(tdta0x87c000) to UDP 172.31.1.20:5060:
INVITE sip:5667 at 172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-veoyve
Max-Forwards: 70
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
To:
Contact:
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
CSeq: 13958 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
User-Agent: SipPhone v2.0.3/iPhoneOS
Content-Type: application/sdp
Content-Length: 263

v=0
o=- 3454161413 3454161413 IN IP4 10.10.1.109 s=pjmedia c=IN IP4 10.10.1.109 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 3 8 101 a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:16:53.376 pjsua_app.c Call 0 state changed to CALLING
13:16:53.933 pjsua_core.c TX 855 bytes Request msg INVITE/cseq=13958
(tdta0x87c000) to UDP 172.31.1.20:5060:
INVITE sip:5667 at 172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-veoyve
Max-Forwards: 70
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
To:
Contact:
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
CSeq: 13958 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
User-Agent: SipPhone v2.0.3/iPhoneOS
Content-Type: application/sdp
Content-Length: 263

v=0
o=- 3454161413 3454161413 IN IP4 10.10.1.109 s=pjmedia c=IN IP4 10.10.1.109 t=0 0 a=X-nat:0 m=audio 4000 RTP/AVP 0 3 8 101 a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:16:54.388 pjsua_core.c RX 372 bytes Response msg 100/INVITE/
cseq=13958 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:16:56 GMT
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
Allow-Events: presence
Content-Length: 0
To:
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-
veoyve;received=172.16.14.34
CSeq: 13958 INVITE

--end msg--
13:16:54.389 pjsua_core.c RX 568 bytes Response msg 183/INVITE/
cseq=13958 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 183 Session Progress
Date: Tue, 16 Jun 2009 17:16:56 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
Allow-Events: presence
Content-Length: 0
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Contact:
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-
veoyve;received=172.16.14.34
CSeq: 13958 INVITE

--end msg--
13:16:54.389 pjsua_app.c Call 0 state changed to EARLY (183 Session
Progress)
13:17:05.313 pjsua_core.c RX 652 bytes Response msg 180/INVITE/
cseq=13958 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 180 Ringing
Date: Tue, 16 Jun 2009 17:16:56 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
Allow-Events: presence
Remote-Party-ID: "Dustin Fowler" ;party=called;screen=yes;privacy=off
Content-Length: 0
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Contact:
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-
veoyve;received=172.16.14.34
CSeq: 13958 INVITE

--end msg--
13:17:05.314 conference.c Port 1 (ringback) transmitting to port 0
(iphonemic)
13:17:05.314 pjsua_app.c Call 0 state changed to EARLY (180 Ringing)
13:17:12.199 pjsua_core.c RX 917 bytes Response msg 200/INVITE/
cseq=13958 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:16:56 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
Allow-Events: presence, kpml
Supported: replaces
Remote-Party-ID: "Dustin Fowler" ;party=called;screen=yes;privacy=off
Content-Length: 210
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Contact:
Content-Type: application/sdp
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-
veoyve;received=172.16.14.34
CSeq: 13958 INVITE

v=0
o=CiscoSystemsCCM-SIP 2000 1 IN IP4 172.31.1.20 s=SIP Call c=IN IP4 172.31.1.20 t=0 0 m=audio 30240 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=ptime:20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:17:12.200 pjsua_app.c Call 0 state changed to CONNECTING
13:17:12.216 strm0x88c4b4 Encoder stream started
13:17:12.216 strm0x88c4b4 Decoder stream started
13:17:12.216 pjsua_media.c Media updates, stream #0: PCMU (sendrecv)
13:17:12.217 conference.c Port 1 (ringback) stop transmitting to port 0 (iphonemic)
13:17:12.217 conference.c Port 3 (sip:5667 at 172.31.1.20) transmitting to port 0 (iphonemic)
13:17:12.217 conference.c Port 0 (iphonemic) transmitting to port 3
(sip:5667 at 172.31.1.20)
13:17:12.217 pjsua_app.c Media for call 0 is active
13:17:12.218 pjsua_core.c TX 374 bytes Request msg ACK/cseq=13958
(tdta0x88fe00) to UDP 172.31.1.20:5060:
ACK sip:5667 at 172.31.1.20:5060 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjwprdqxs13qhf.nenc4nwhzke73pek-gn
Max-Forwards: 70
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
CSeq: 13958 ACK
Content-Length: 0

--end msg--
13:17:12.256 pjsua_app.c Call 0 state changed to CONFIRMED
13:17:12.257 pjsua_core.c RX 917 bytes Response msg 200/INVITE/
cseq=13958 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:16:56 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
Allow-Events: presence, kpml
Supported: replaces
Remote-Party-ID: "Dustin Fowler" ;party=called;screen=yes;privacy=off
Content-Length: 210
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Contact:
Content-Type: application/sdp
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrxcodmtkkzbqieo3kvt6zewjh-
veoyve;received=172.16.14.34
CSeq: 13958 INVITE

v=0
o=CiscoSystemsCCM-SIP 2000 1 IN IP4 172.31.1.20 s=SIP Call c=IN IP4 172.31.1.20 t=0 0 m=audio 30240 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=ptime:20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:17:12.259 pjsua_core.c TX 374 bytes Request msg ACK/cseq=13958
(tdta0x88fe00) to UDP 172.31.1.20:5060:
ACK sip:5667 at 172.31.1.20:5060 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjwprdqxs13qhf.nenc4nwhzke73pek-gn
Max-Forwards: 70
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
CSeq: 13958 ACK
Content-Length: 0

--end msg--
13:17:44.665 pjsua_core.c TX 412 bytes Request msg BYE/cseq=13959
(tdta0x87c000) to UDP 172.31.1.20:5060:
BYE sip:5667 at 172.31.1.20:5060 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjagurlsv0gbx0npb30lshm9h7u0jelnla
Max-Forwards: 70
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
CSeq: 13959 BYE
User-Agent: SipPhone v2.0.3/iPhoneOS
Content-Length: 0

--end msg--
13:17:44.987 pjsua_core.c RX 391 bytes Response msg 200/BYE/cseq=13959
(rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:17:47 GMT
From: ;tag=sjidfwlnvul9bgksgkkuz871s87rwxit
Content-Length: 0
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556704
Call-ID: krjwnidpvwlufr0rh3oamosaoofcbd-a
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjagurlsv0gbx0npb30lshm9h7u0jelnla;received=172.16.14.34
CSeq: 13959 BYE

--end msg--
13:17:45.990 pjsua_app.c Call 0 is DISCONNECTED [reason=200 (Normal call clearing)]
13:17:45.993 pjsua_media.c Media session for call 0 is destroyed
13:18:08.136 pjsua_call.c Making call with acc #1 to sip:99543302928 at 172.31.1.20
13:18:08.137 pjsua_media.c Media index 0 selected for call 1
13:18:08.138 pjsua_core.c TX 869 bytes Request msg INVITE/cseq=18078
(tdta0x858400) to UDP 172.31.1.20:5060:
INVITE sip:99543302928 at 172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjx9umewqwplyl4uqxjpnvxzza.pkbrokr
Max-Forwards: 70
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
To:
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
CSeq: 18078 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
User-Agent: SipPhone v2.0.3/iPhoneOS
Content-Type: application/sdp
Content-Length: 263

v=0
o=- 3454161488 3454161488 IN IP4 10.10.1.109 s=pjmedia c=IN IP4 10.10.1.109 t=0 0 a=X-nat:0 m=audio 4002 RTP/AVP 0 3 8 101 a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:18:08.154 pjsua_app.c Call 1 state changed to CALLING
13:18:08.654 pjsua_core.c TX 869 bytes Request msg INVITE/cseq=18078
(tdta0x858400) to UDP 172.31.1.20:5060:
INVITE sip:99543302928 at 172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjx9umewqwplyl4uqxjpnvxzza.pkbrokr
Max-Forwards: 70
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
To:
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
CSeq: 18078 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
User-Agent: SipPhone v2.0.3/iPhoneOS
Content-Type: application/sdp
Content-Length: 263

v=0
o=- 3454161488 3454161488 IN IP4 10.10.1.109 s=pjmedia c=IN IP4 10.10.1.109 t=0 0 a=X-nat:0 m=audio 4002 RTP/AVP 0 3 8 101 a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=sendrecv
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:18:09.035 pjsua_core.c RX 379 bytes Response msg 100/INVITE/
cseq=18078 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:18:11 GMT
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Allow-Events: presence
Content-Length: 0
To:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjx9umewqwplyl4uqxjpnvxzza.pkbrokr;received=172.16.14.34
CSeq: 18078 INVITE

--end msg--
13:18:09.123 pjsua_core.c RX 582 bytes Response msg 183/INVITE/
cseq=18078 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 183 Session Progress
Date: Tue, 16 Jun 2009 17:18:11 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Allow-Events: presence
Content-Length: 0
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjx9umewqwplyl4uqxjpnvxzza.pkbrokr;received=172.16.14.34
CSeq: 18078 INVITE

--end msg--
13:18:09.123 pjsua_app.c Call 1 state changed to EARLY (183 Session
Progress)
13:18:10.684 pjsua_call.c Media is not established yet!
13:18:10.684 pjsua_app.c Unable to send DTMF: Invalid operation [status=70013] 13:18:15.700 pjsua_core.c RX 915 bytes Response msg 183/INVITE/
cseq=18078 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 183 Session Progress
Date: Tue, 16 Jun 2009 17:18:11 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Allow-Events: presence, kpml
Remote-Party-ID: ;party=called;screen=yes;privacy=off
Content-Length: 210
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Contact:
Content-Type: application/sdp
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjx9umewqwplyl4uqxjpnvxzza.pkbrokr;received=172.16.14.34
CSeq: 18078 INVITE

v=0
o=CiscoSystemsCCM-SIP 2000 1 IN IP4 172.31.1.20 s=SIP Call c=IN IP4 172.31.1.20 t=0 0 m=audio 30250 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=ptime:20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:18:15.703 pjsua_app.c Call 1 state changed to EARLY (183 Session
Progress)
13:18:15.705 strm0x88c0b4 Encoder stream started
13:18:15.706 strm0x88c0b4 Decoder stream started
13:18:15.706 pjsua_media.c Media updates, stream #0: PCMU (sendrecv)
13:18:15.707 conference.c Port 3 (sip:99543302928 at 172.31.1.20) transmitting to port 0 (iphonemic)
13:18:15.707 conference.c Port 0 (iphonemic) transmitting to port 3
(sip:99543302928 at 172.31.1.20)
13:18:15.708 pjsua_app.c Media for call 1 is active
13:18:16.465 pjsua_core.c RX 564 bytes Request msg UPDATE/cseq=101
(rdata0x847864) from UDP 172.31.1.20:5060:
UPDATE sip:6911 at 172.16.14.34:5060;transport=UDP SIP/2.0
Date: Tue, 16 Jun 2009 17:18:11 GMT
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Remote-Party-ID: ;party=called;screen=yes;privacy=off
Content-Length: 0
User-Agent: Cisco-CUCM6.1
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP 172.31.1.20:5060;branch=z9hG4bK448f6021714f
CSeq: 101 UPDATE
Max-Forwards: 70

--end msg--
13:18:16.466 pjsua_core.c TX 529 bytes Response msg 200/UPDATE/
cseq=101 (tdta0x871000) to UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
172.31.1.20:5060;received=172.31.1.20;branch=z9hG4bK448f6021714f
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
CSeq: 101 UPDATE
Contact:
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Length: 0

--end msg--
13:18:16.989 pjsua_core.c RX 564 bytes Request msg UPDATE/cseq=101
(rdata0x847864) from UDP 172.31.1.20:5060:
UPDATE sip:6911 at 172.16.14.34:5060;transport=UDP SIP/2.0
Date: Tue, 16 Jun 2009 17:18:11 GMT
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Remote-Party-ID: ;party=called;screen=yes;privacy=off
Content-Length: 0
User-Agent: Cisco-CUCM6.1
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP 172.31.1.20:5060;branch=z9hG4bK448f6021714f
CSeq: 101 UPDATE
Max-Forwards: 70

--end msg--
13:18:16.989 pjsua_core.c TX 529 bytes Response msg 200/UPDATE/
cseq=101 (tdta0x871000) to UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
172.31.1.20:5060;received=172.31.1.20;branch=z9hG4bK448f6021714f
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
CSeq: 101 UPDATE
Contact:
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Length: 0

--end msg--
13:18:18.657 pjsua_core.c RX 563 bytes Request msg UPDATE/cseq=102
(rdata0x847864) from UDP 172.31.1.20:5060:
UPDATE sip:6911 at 172.16.14.34:5060;transport=UDP SIP/2.0
Date: Tue, 16 Jun 2009 17:18:11 GMT
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Remote-Party-ID: ;party=called;screen=yes;privacy=off
Content-Length: 0
User-Agent: Cisco-CUCM6.1
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP 172.31.1.20:5060;branch=z9hG4bK4490af860da
CSeq: 102 UPDATE
Max-Forwards: 70

--end msg--
13:18:18.659 pjsua_core.c TX 528 bytes Response msg 200/UPDATE/
cseq=102 (tdta0x87c000) to UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
172.31.1.20:5060;received=172.31.1.20;branch=z9hG4bK4490af860da
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
CSeq: 102 UPDATE
Contact:
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Length: 0

--end msg--
13:18:19.182 pjsua_core.c RX 563 bytes Request msg UPDATE/cseq=102
(rdata0x847864) from UDP 172.31.1.20:5060:
UPDATE sip:6911 at 172.16.14.34:5060;transport=UDP SIP/2.0
Date: Tue, 16 Jun 2009 17:18:11 GMT
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Remote-Party-ID: ;party=called;screen=yes;privacy=off
Content-Length: 0
User-Agent: Cisco-CUCM6.1
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Contact:
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP 172.31.1.20:5060;branch=z9hG4bK4490af860da
CSeq: 102 UPDATE
Max-Forwards: 70

--end msg--
13:18:19.182 pjsua_core.c TX 528 bytes Response msg 200/UPDATE/
cseq=102 (tdta0x87c000) to UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
172.31.1.20:5060;received=172.31.1.20;branch=z9hG4bK4490af860da
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
From: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
To: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
CSeq: 102 UPDATE
Contact:
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, norefersub
Content-Length: 0

--end msg--
13:18:25.266 pjsua_core.c RX 922 bytes Response msg 200/INVITE/
cseq=18078 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:18:11 GMT
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, PUBLISH
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Allow-Events: presence, kpml
Supported: replaces
Remote-Party-ID: ;party=called;screen=yes;privacy=off
Content-Length: 210
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Contact:
Content-Type: application/sdp
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjx9umewqwplyl4uqxjpnvxzza.pkbrokr;received=172.16.14.34
CSeq: 18078 INVITE

v=0
o=CiscoSystemsCCM-SIP 2000 1 IN IP4 172.31.1.20 s=SIP Call c=IN IP4 172.31.1.20 t=0 0 m=audio 30250 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=ptime:20
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

--end msg--
13:18:25.267 pjsua_app.c Call 1 state changed to CONNECTING
13:18:25.267 inv0x80fc64 SDP negotiation done, message body is ignored
13:18:25.267 pjsua_core.c TX 388 bytes Request msg ACK/cseq=18078
(tdta0x88f800) to UDP 172.31.1.20:5060:
ACK sip:99543302928 at 172.31.1.20:5060 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjwi.nr-6fvqnhhzemf2pktz4t2jk8zsif
Max-Forwards: 70
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
CSeq: 18078 ACK
Content-Length: 0

--end msg--
13:18:25.298 pjsua_app.c Call 1 state changed to CONFIRMED
13:18:36.327 pjsua_core.c TX 426 bytes Request msg BYE/cseq=18079
(tdta0x858400) to UDP 172.31.1.20:5060:
BYE sip:99543302928 at 172.31.1.20:5060 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPjrncsabdglhxvfg04.dtd7uuk2dhu7ovg
Max-Forwards: 70
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
CSeq: 18079 BYE
User-Agent: SipPhone v2.0.3/iPhoneOS
Content-Length: 0

--end msg--
13:18:36.557 pjsua_core.c RX 398 bytes Response msg 200/BYE/cseq=18079
(rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:18:39 GMT
From: ;tag=dqndxln3jtwvgecn47u2mwgy-gw47rq7
Content-Length: 0
To: ;tag=33c7a6cc-2eba-4721-9ad8-dff3fdb609f9-24556708
Call-ID: ohttko690qjnunsiw2ngqpd0adjlzqil
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPjrncsabdglhxvfg04.dtd7uuk2dhu7ovg;received=172.16.14.34
CSeq: 18079 BYE

--end msg--
13:18:37.561 pjsua_app.c Call 1 is DISCONNECTED [reason=200 (Normal call clearing)]
13:18:37.563 pjsua_media.c Media session for call 1 is destroyed
13:18:43.465 pjsua_core.c TX 428 bytes Request msg REGISTER/cseq=9025
(tdta0x858400) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP 10.10.1.109:5060;rport;branch=z9hG4bKPjixghgmysstr0-
munodqrogbxcrlhr8iw
Max-Forwards: 70
From: ;tag=fm-7niv8--c6ajjpuxfmaldft4sqhk-y
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
CSeq: 9025 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 120
Content-Length: 0

--end msg--
13:18:43.967 pjsua_core.c TX 428 bytes Request msg REGISTER/cseq=9025
(tdta0x858400) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP 10.10.1.109:5060;rport;branch=z9hG4bKPjixghgmysstr0-
munodqrogbxcrlhr8iw
Max-Forwards: 70
From: ;tag=fm-7niv8--c6ajjpuxfmaldft4sqhk-y
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
CSeq: 9025 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 120
Content-Length: 0

--end msg--
13:18:44.483 pjsua_core.c RX 349 bytes Response msg 100/REGISTER/
cseq=9025 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:18:47 GMT
From: ;tag=fm-7niv8--c6ajjpuxfmaldft4sqhk-y
Content-Length: 0
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP 10.10.1.109:5060;rport;branch=z9hG4bKPjixghgmysstr0-
munodqrogbxcrlhr8iw;received=172.16.14.34
CSeq: 9025 REGISTER

--end msg--
13:18:44.484 pjsua_core.c RX 457 bytes Response msg 200/REGISTER/
cseq=9025 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:18:47 GMT
From: ;tag=fm-7niv8--c6ajjpuxfmaldft4sqhk-y
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=1450658152
Contact:
Expires: 120
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP 10.10.1.109:5060;rport;branch=z9hG4bKPjixghgmysstr0-
munodqrogbxcrlhr8iw;received=172.16.14.34
CSeq: 9025 REGISTER

--end msg--
13:18:44.485 pjsua_acc.c sip:6911 at 172.31.1.20: registration success, status=200 (OK), will re-register in 120 seconds
13:18:44.485 pjsua_acc.c Keep-alive timer started for acc 1, destination:172.31.1.20:5060, interval:15s
13:18:44.507 pjsua_core.c RX 457 bytes Response msg 200/REGISTER/
cseq=9025 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:18:47 GMT
From: ;tag=fm-7niv8--c6ajjpuxfmaldft4sqhk-y
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=1450658152
Contact:
Expires: 120
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP 10.10.1.109:5060;rport;branch=z9hG4bKPjixghgmysstr0-
munodqrogbxcrlhr8iw;received=172.16.14.34
CSeq: 9025 REGISTER

--end msg--
13:18:49.162 pjsua_core.c TX 426 bytes Request msg REGISTER/cseq=9026
(tdta0x853000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPj4fgyjzhgomaf6tegve5jtnpdi7ki5cqz
Max-Forwards: 70
From: ;tag=0snkd3uxpu0zpcifd80rfcnff1ur2rnp
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
CSeq: 9026 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 0
Content-Length: 0

--end msg--
13:18:49.168 pjsua_acc.c Unregistration sent
13:18:49.169 pjsua_acc.c Account id 1 deleted
13:18:49.178 conference.c Port 2 (local-keytone) stop transmitting to port 0 (iphonemic)
13:18:49.179 sip_endpoint.c Module "My-Notify-Module" unregistered
13:18:49.183 pjsua_core.c Shutting down...
13:18:49.669 pjsua_core.c TX 426 bytes Request msg REGISTER/cseq=9026
(tdta0x853000) to UDP 172.31.1.20:5060:
REGISTER sip:172.31.1.20 SIP/2.0
Via: SIP/2.0/UDP
10.10.1.109:5060;rport;branch=z9hG4bKPj4fgyjzhgomaf6tegve5jtnpdi7ki5cqz
Max-Forwards: 70
From: ;tag=0snkd3uxpu0zpcifd80rfcnff1ur2rnp
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
CSeq: 9026 REGISTER
User-Agent: SipPhone v2.0.3/iPhoneOS
Contact:
Expires: 0
Content-Length: 0

--end msg--
13:18:50.088 pjsua_core.c RX 349 bytes Response msg 100/REGISTER/
cseq=9026 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 100 Trying
Date: Tue, 16 Jun 2009 17:18:52 GMT
From: ;tag=0snkd3uxpu0zpcifd80rfcnff1ur2rnp
Content-Length: 0
To:
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPj4fgyjzhgomaf6tegve5jtnpdi7ki5cqz;received=172.16.14.34
CSeq: 9026 REGISTER

--end msg--
13:18:50.106 pjsua_core.c RX 401 bytes Response msg 200/REGISTER/
cseq=9026 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:18:52 GMT
From: ;tag=0snkd3uxpu0zpcifd80rfcnff1ur2rnp
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=444835025
Expires: 0
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPj4fgyjzhgomaf6tegve5jtnpdi7ki5cqz;received=172.16.14.34
CSeq: 9026 REGISTER

--end msg--
13:18:50.124 pjsua_core.c RX 401 bytes Response msg 200/REGISTER/
cseq=9026 (rdata0x847864) from UDP 172.31.1.20:5060:
SIP/2.0 200 OK
Date: Tue, 16 Jun 2009 17:18:52 GMT
From: ;tag=0snkd3uxpu0zpcifd80rfcnff1ur2rnp
Supported: X-cisco-sis-2.0.0
Content-Length: 0
To: ;tag=444835025
Expires: 0
Call-ID: ukjqrbqsporv5jvw1nz1j8adovddqwjf
Via: SIP/2.0/UDP
10.10.1.109: 
5060;rport;branch=z9hG4bKPj4fgyjzhgomaf6tegve5jtnpdi7ki5cqz;received=172.16.14.34
CSeq: 9026 REGISTER

--end msg--
13:18:50.193 pjsua_media.c Closing (null) sound playback device and
(null) sound capture device
13:18:50.769 pasound.c PortAudio sound library shutting down..
13:18:50.986 sip_endpoint.c Module "mod-pjsua-options" unregistered
13:18:50.987 sip_endpoint.c Module "mod-pjsua-im" unregistered
13:18:50.987 sip_endpoint.c Module "mod-pjsua-pres" unregistered
13:18:50.987 sip_endpoint.c Module "mod-pjsua" unregistered
13:18:50.987 sip_endpoint.c Module "mod-stateful-util" unregistered
13:18:50.987 sip_endpoint.c Module "mod-refer" unregistered
13:18:50.988 sip_endpoint.c Module "mod-presence" unregistered
13:18:50.988 sip_endpoint.c Module "mod-evsub" unregistered
13:18:50.988 sip_endpoint.c Module "mod-invite" unregistered
13:18:50.988 sip_endpoint.c Module "mod-100rel" unregistered
13:18:50.989 sip_endpoint.c Module "mod-ua" unregistered
13:18:50.989 sip_transactio Stopping transaction layer module
13:18:50.991 sip_transactio Transaction layer module destroyed
13:18:50.991 sip_endpoint.c Module "mod-tsx-layer" unregistered
13:18:50.991 sip_endpoint.c Module "mod-msg-print" unregistered
13:18:50.991 sip_endpoint.c Module "mod-pjsua-log" unregistered
13:18:50.994 sip_endpoint.c Endpoint 0x816664 destroyed
13:18:50.994 dlg0x80fc00 Pool is not released by application, releasing now
13:18:50.995 pjsua_core.c PJSUA destroyed...