- Cisco Community
- Technology and Support
- Service Providers
- Voice over IP
- Cisco 2811 SIP-to-SIP GW T.38 does not work!
- Subscribe to RSS Feed
- Mark Topic as New
- Mark Topic as Read
- Float this Topic for Current User
- Bookmark
- Subscribe
- Mute
- Printer Friendly Page
Cisco 2811 SIP-to-SIP GW T.38 does not work!
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
09-19-2012 05:25 AM
Hello!
Diagram is something like this: Softswitch(MERA) -->>-- Cisco2811 -->>-- Softswitch(MERA) It's needed to limit traffic if one of SSWs is hacked. But it is not a subject. We just need such "construction".
Previously there was Cisco 1760 instead of 2811, result was the same. So I exclude platform and IOS.
1. Voice calls are sent and received fine in diagram above.
2. Fax are passed good between two Softswitches if I exclude Cisco2811.
3. Faxes are stopped immediately when I re-route voice traffic through Cisco2811 (in the same conditions on both Softswitches as in above paragraph 2. That is, Faxes are passed between Softswitches directly, I don't change anything on Softswitches, and I just re-route Voice from both Softswitches on C2811 - Faxes stop immediately).
4. Relevant configuraion:
voice service voip
allow-connections sip to sip
!
!
voice class uri Centrex sip
host ^10\.0\.99\.111$
!
voice class uri RTU1 sip
host ^10\.0\.99\.121$
!
voice class uri RTU2 sip
host ^10\.0\.99\.221$
!
!
voice class codec 1
codec preference 1 g711alaw bytes 80
codec preference 2 clear-channel
!
!
voice translation-rule 112
rule 1 /^000112\(.*\)$/ /\1/
!
voice translation-rule 999
rule 1 /^999\(.*\)$/ /000\1/
!
voice translation-rule 999112
rule 1 /^\(.*\)$/ /999112\1/
!
voice translation-profile 112
translate called 112
!
voice translation-profile 999
translate called 999
!
voice translation-profile 999112
translate called 999112
!
!
interface FastEthernet0/0.18
encapsulation dot1Q 18
ip address 10.0.99.29 255.255.255.0
no snmp trap link-status
!
!
dial-peer voice 999112 voip
translation-profile incoming 999112
voice-class codec 1
session protocol sipv2
incoming uri from Centrex
dtmf-relay rtp-nte
fax-relay ecm disable
fax rate 9600
fax nsf 000000
fax protocol t38 ls-redundancy 3 hs-redundancy 0 fallback pass-through g711alaw
no vad
!
dial-peer voice 999 voip
translation-profile outgoing 999
destination-pattern 999.+
voice-class codec 1
session protocol sipv2
session target ipv4:10.0.99.99
session transport udp
dtmf-relay rtp-nte
fax-relay ecm disable
fax rate 9600
fax nsf 000000
fax protocol t38 ls-redundancy 3 hs-redundancy 0 fallback pass-through g711alaw
no vad
!
dial-peer voice 112 voip
translation-profile outgoing 112
destination-pattern 000112.+
voice-class codec 1
session protocol sipv2
session target ipv4:10.0.99.100
session transport udp
dtmf-relay rtp-nte
fax-relay ecm disable
fax rate 9600
fax nsf 000000
fax protocol t38 ls-redundancy 3 hs-redundancy 0 fallback pass-through g711alaw
no vad
!
dial-peer voice 901 voip
voice-class codec 1
session protocol sipv2
incoming uri from RTU1
dtmf-relay rtp-nte
fax-relay ecm disable
fax rate 9600
fax nsf 000000
fax protocol t38 ls-redundancy 3 hs-redundancy 0 fallback pass-through g711alaw
no vad
!
dial-peer voice 902 voip
voice-class codec 1
session protocol sipv2
incoming uri from RTU2
dtmf-relay rtp-nte
fax-relay ecm disable
fax rate 9600
fax nsf 000000
fax protocol t38 ls-redundancy 3 hs-redundancy 0 fallback pass-through g711alaw
no vad
!
5. TSHARK from left-side Softswitch:
16:10:51.680764 10.0.99.221 -> 10.0.99.29 SIP/SDP Request: INVITE sip:0001124957887603@10.0.99.29;user=phone, with session description
16:10:51.721616 10.0.99.29 -> 10.0.99.221 SIP Status: 100 Trying
16:10:55.413288 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 183 Session Progress, with session description
16:10:55.418718 10.0.99.29 -> 10.0.99.221 SIP Status: 180 Ringing
16:10:59.090481 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:10:59.091451 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:04.296532 10.0.99.29 -> 10.0.99.221 SIP Status: 488 Not Acceptable Media
16:11:04.296708 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:04.793058 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:11:04.793262 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:05.793043 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:11:05.793261 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:07.793042 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:11:07.793300 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:11.793077 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:11:11.793264 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:15.793316 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:11:15.793541 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:19.793289 10.0.99.29 -> 10.0.99.221 SIP/SDP Status: 200 OK, with session description
16:11:19.793538 10.0.99.221 -> 10.0.99.29 SIP Request: ACK sip:0001124957887603@10.0.99.29:5060
16:11:23.794963 10.0.99.29 -> 10.0.99.221 SIP Request: BYE sip:4991589848@10.0.99.221:5061;user=phone
16:11:23.795650 10.0.99.221 -> 10.0.99.29 SIP Status: 200 OK
6. TSHARK from right-side Softswitch:
16:10:12.071247 10.0.99.111 -> 10.0.99.29 SIP/SDP Request: INVITE sip:4957815696@10.0.99.29;user=phone, with session description
16:10:12.113708 10.0.99.29 -> 10.0.99.111 SIP Status: 100 Trying
16:10:12.843352 10.0.99.29 -> 10.0.99.111 SIP/SDP Status: 183 Session Progress, with session description
16:10:16.328955 10.0.99.29 -> 10.0.99.111 SIP/SDP Status: 200 OK, with session description
16:10:16.329808 10.0.99.111 -> 10.0.99.29 SIP Request: ACK sip:4957815696@10.0.99.29:5060
16:10:51.721600 10.0.99.29 -> 10.0.99.100 SIP/SDP Request: INVITE sip:4957887603@10.0.99.100:5060, with session description
16:10:51.723145 10.0.99.100 -> 10.0.99.29 SIP Status: 100 Trying
16:10:55.384493 10.0.99.100 -> 10.0.99.29 SIP/SDP Status: 183 Progress, with session description
16:10:55.392178 10.0.99.100 -> 10.0.99.29 SIP Status: 180 Ringing
16:10:59.069771 10.0.99.100 -> 10.0.99.29 SIP/SDP Status: 200 OK, with session description
16:10:59.088587 10.0.99.29 -> 10.0.99.100 SIP Request: ACK sip:4957887603@10.0.99.100:5060
7. Debug output for "debug ccsip all" and "debug voice dialpeer all"
Router#
*Sep 19 12:27:55.107: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportSetAgeingTimer: Aging timer initiated for holder=0x4654DA30,addr=10.0.99.111
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:0001124957887603@10.0.99.29;user=phone SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 INVITE
Contact: <sip:4991589848@10.0.99.221:5061;user=phone>
Content-Type: application/sdp
Allow: ACK, BYE, CANCEL, INFO, INVITE, OPTIONS, REFER, REGISTER, UPDATE
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Cisco-Guid: 237931618-38998498-2747662362-1690784024
Category: 10
Content-Length: 313
v=0
o=- 1348056651 1348056651 IN IP4 10.0.99.221
s=-
c=IN IP4 10.0.99.221
t=0 0
m=audio 17294 RTP/AVP 8 0 18 4 96
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=fmtp:4 annexa=yes
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-15
a=sendrecv
*Sep 19 12:27:55.267: //-1/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:27:55.267: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:27:55.271: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetGtdBody: No valid GTD body found.
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/SIP/Info/sipSPIUaddCcbToUASReqTable: ****Adding to UAS Request table.
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x4627A3B8 key=0e3a1c30025311e2a3c6001a64c75118@10.0.99.2210001124957887603
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on carrier id
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on Incoming called number: 0001124957887603
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on destination pattern: 4991589848
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/SIP/Info/ccsipUpdateIncomingCallParams: ccCallInfo: Calling name , number 4991589848, Calling oct3 0x00, oct_3a 0x80, Called number 0001124957887603
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpAssociateIncomingPeerCore:
Calling Number=4991589848, Called Number=0001124957887603, Voice-Interface=0x0,
Timeout=TRUE, Peer Encap Type=ENCAP_VOIP, Peer Search Type=PEER_TYPE_VOICE,
Peer Info Type=DIALPEER_INFO_SPEECH
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpAssociateIncomingPeerCore:
Match Rule=DP_MATCH_REQUEST_URI; URI=sip:0001124957887603@10.0.99.29;user=phone
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchPeertype:
Is Incoming=TRUE, Number Expansion=FALSE
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchCore:
Dial String=, Expanded String=, Calling Number=
Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchCore:
Result=-1
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchPeertype:exit@5392
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpAssociateIncomingPeerCore:
Match Rule=DP_MATCH_TO_URI; URI=sip:0001124957887603@10.0.99.29;user=phone
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchPeertype:
Is Incoming=TRUE, Number Expansion=FALSE
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchCore:
Dial String=, Expanded String=, Calling Number=
Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchCore:
Result=-1
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchPeertype:exit@5392
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpAssociateIncomingPeerCore:
Match Rule=DP_MATCH_FROM_URI; URI=sip:4991589848@10.0.99.221:5061;user=phone
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchPeertype:
Is Incoming=TRUE, Number Expansion=FALSE
*Sep 19 12:27:55.271: //-1/0E2E8C62A3C6/DPM/dpMatchCore:
Dial String=, Expanded String=, Calling Number=
Timeout=TRUE, Is Incoming=TRUE, Peer Info Type=DIALPEER_INFO_SPEECH
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/DPM/MatchNextPeer:
Result=Success(0); Incoming Dial-peer=902 Is Matched
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/DPM/dpMatchPeertype:exit@5392
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/DPM/dpAssociateIncomingPeerCore:
Result=Success(0) after DP_MATCH_FROM_URI; Incoming Dial-peer=902
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/DPM/dpAssociateIncomingPeerSPI:exit@5926
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/SIP/Info/sipSPIGetCallConfig: Peer tag 902 matched for incoming call
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/SIP/Info/sipSPIGetCallConfig: Using Voice Class Codec, tag = 1
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/SIP/Info/sipSPICopyPeerDataToCCB:
From CLI: Modem NSE payload = 100, Passthrough = 0, Modem relay = 0, Gw-Xid = 1
SPRT latency 200, SPRT Retries = 12, Dict Size = 1024
String Len = 32, Compress dir = 3
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/SIP/Info/sipSPIContinueNewMsgInvite: Calling name , number 4991589848, Calling oct3 0x00, oct_3a 0x80, ext_priv 0x00, Called number 0001124957887603, oct3 0x00
*Sep 19 12:27:55.275: //-1/0E2E8C62A3C6/SIP/Info/sipSPIContinueNewMsgInvite: Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoAudioNegotiation: Codec (g711alaw) Negotiation Successful on Static Payload for m-line 1
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoPtimeNegotiation: No ptime present or multiple ptime attributes that can't be handled
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoDTMFRelayNegotiation: m-line index 1
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(96) could not be reserved.
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoDTMFRelayNegotiation: Requested DTMF-RELAY payload (96) is reserved by another application.
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoDTMFRelayNegotiation: Requested DTMF-RELAY option(s) not found in Preferred DTMF-RELAY option list!
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIStreamTypeAndDtmfRelay: DTMF Relay mode: Inband Voice
*Sep 19 12:27:55.275: //-1/xxxxxxxxxxxx/SIP/Info/sip_sdp_get_modem_relay_cap_params: NSE payload from X-cap = 0
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIGetSDPDirectionAttribute: No direction attribute present or multiple direction attributes that can't be handled for m-line:1 and num-a-lines:0
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1
payload_type=8, codec_bytes=80, codec=g711alaw, dtmf_relay=inband-voice
stream_type=voice-only (0), dest_ip_address=10.0.99.221, dest_port=17294
*Sep 19 12:27:55.275: //19/0E2E8C62A3C6/SIP/Media/sipSPIUpdCallWithSdpInfo:
Preferred Codec : g711alaw, bytes :80
Preferred DTMF relay : rtp-nte
Preferred NTE payload : 101
Early Media : No
Delayed Media : No
Bridge Done : No
New Media : No
DSP DNLD Reqd : No
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_report_media_to_peer:
callId 19 peer 0 flags 0x201
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
CallID 19, sdp 0x45A61FCC channels 0x4627BC80
SIP: (19) Attribute ptime, level 1 instance 1 not found.
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 8 mline 1
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711alaw
*Sep 19 12:27:55.279: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation done: stream->negotiated_ptime=0,stream->negotiated_codec_bytes=80, coverted ptime=10 stream->mline_index=1, media_ndx=1
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 6 ptype 8 time 10, bytes 80 as channel 0 mline 1 ss 0 10.0.99.221:17294
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 0 mline 1
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711ulaw
SIP: (19) Attribute ptime, level 1 instance 1 not found.
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=0, media_ndx=1
*Sep 19 12:27:55.279: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g711ulaw ptime :0, codecbytes: 0
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 160
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 5 ptype 0 time 0, bytes 160 as channel 1 mline 1 ss 0 10.0.99.221:17294
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 18 mline 1
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPISelectCodecVersion: Codec (g729r8) is not in preferred list
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SI
Router#P/Info/sipSPI_ipip_copy_sdp_to_channelInfo: An exact codec match not configured, using interoperable codec g729r8 pre-ietf
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g729r8 pre-ietf
SIP: (19) Attribute ptime, level 1 instance 1 not found.
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=0, media_ndx=1
*Sep 19 12:27:55.279: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g729r8 pre-ietf ptime :0, codecbytes: 0
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 20
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 0 ptype 18 time 0, bytes 20 as channel 2 mline 1 ss 0 10.0.99.221:17294
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 4 mline 1
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPISelectCodecVersion: Codec (g723ar63) is not in preferred list
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: An exact codec match not configured, using interoperable codec g729r8 pre-ietf
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g729r8 pre-ietf
SIP: (19) Attribute ptime, level 1 instance 1 not found.
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=0, media_ndx=1
*Sep 19 12:27:55.279: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g729r8 pre-ietf ptime :0, codecbytes: 0
*Sep 19 12:27:55.279: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 20
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 0 ptype 4 time 0, bytes 20 as channel 3 mline 1 ss 0 10.0.99.221:17294
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 96 mline 1
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_report_media_to_peer:
Report initial call media
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/copy_channels:
callId 19 size 296 ptr 0x46646D94)
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_report_media_to_peer:
CCSIP: Unable to report channel ind
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Media/sipSPIUpdCallWithSdpInfo:
Stream type : voice-only
Media line : 1
State : STREAM_ADDING (2)
Callid : -1
Negotiated Codec : g711alaw, bytes :80
Negotiated DTMF relay : inband-voice
Negotiated NTE payload : 0
Negotiated CN payload : 0
Media Srce Addr/Port : 10.0.99.29:0
Media Dest Addr/Port : 10.0.99.221:17294
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIHandleInviteMedia:
Negotiated Codec : g711alaw, bytes :80
Preferred Codec : g711alaw, bytes :80
Preferred DTMF relay 1 : 6
Preferred DTMF relay 2 : 0
Negotiated DTMF relay : 0
Preferred and Negotiated NTE payloads: 101 0
Preferred and Negotiated NSE payloads: 100 0
Preferred and Negotiated Modem Relay: 0 0
Preferred and Negotiated Modem Relay GwXid: 1 0
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIDoQoSNegotiation: SDP body with media description
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active
*Sep 19 12:27:55.283: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 19570 for stream 1
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIUpdateSrcSdpFixedPart: Reserving rtp port for stream 1, src_port=19570
*Sep 19 12:27:55.283: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 19570
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIAddBillingInfoToCcb: sipCallId for billing records = 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_store_channel_info: Store channelInfo in CallInfo
*Sep 19 12:27:55.283: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateRawMsg: No GTD passed.
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIContinueNewMsgInvite: ccsip_api_call_setup_ind returned: SIP_SUCCESS
*Sep 19 12:27:55.283: //19/0E2E8C62A3C6/SIP/Info/sipSPIUaddCcbToUASRespTable: ****Adding to UAS Response table.
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x4627A3B8 key=0e3a1c30025311e2a3c6001a64c75118@10.0.99.221114FC0-1F24
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 13 to table
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654E450, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:27:55.287: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654E450, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_RECD_INVITE, SUBSTATE_NONE)
*Sep 19 12:27:55.287: //19/0E2E8C62A3C6/SIP/Info/sipSPIProcessContactInfo: Previous Hop 10.0.99.221:5061
*Sep 19 12:27:55.287: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_PROCEEDING
*Sep 19 12:27:55.291: //-1/0E2E8C62A3C6/DPM/dpMatchPeersCore:
Calling Number=, Called Number=0001124957887603, Peer Info Type=DIALPEER_INFO_SPEECH
*Sep 19 12:27:55.291: //-1/0E2E8C62A3C6/DPM/dpMatchPeersCore:
Match Rule=DP_MATCH_DEST; Called Number=0001124957887603
*Sep 19 12:27:55.291: //-1/0E2E8C62A3C6/DPM/dpMatchCore:
Dial String=0001124957887603, Expanded String=0001124957887603, Calling Number=
Timeout=TRUE, Is Incoming=FALSE, Peer Info Type=DIALPEER_INFO_SPEECH
*Sep 19 12:27:55.291: //-1/0E2E8C62A3C6/DPM/MatchNextPeer:
Result=Success(0); Outgoing Dial-peer=112 Is Matched
*Sep 19 12:27:55.291: //-1/0E2E8C62A3C6/DPM/dpMatchPeersCore:
Result=Success(0) after DP_MATCH_DEST
*Sep 19 12:27:55.291: //-1/0E2E8C62A3C6/DPM/dpMatchPeersMoreArg:
Result=SUCCESS(0)
List of Matched Outgoing Dial-peer(s):
1: Dial-peer Tag=112
*Sep 19 12:27:55.291: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
*Sep 19 12:27:55.291: //20/000000000000/SIP/Info/ccsip_call_setup_request:
This a IPIP call: Chan 0, codec 6 channel 17294, ip A0063DD:17294 params 0x465F9EF4 caps 0x44ED30C8
*Sep 19 12:27:55.291: //20/000000000000/SIP/Info/ccsip_call_setup_request:
This a IPIP call: Chan 1, codec 5 channel 17294, ip A0063DD:17294 params 0x465F9EF4 caps 0x44ED30C8
*Sep 19 12:27:55.291: //20/000000000000/SIP/Info/ccsip_call_setup_request:
This a IPIP call: Chan 2, codec 0 channel 17294, ip A0063DD:17294 params 0x465F9EF4 caps 0x44ED30C8
*Sep 19 12:27:55.291: //20/000000000000/SIP/Info/ccsip_call_setup_request:
This a IPIP call: Chan 3, codec 0 channel 17294, ip A0063DD:17294 params 0x465F9EF4 caps 0x44ED30C8
*Sep 19 12:27:55.291: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_SETUP
*Sep 19 12:27:55.291: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler:
*Sep 19 12:27:55.291: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler: switch(ev.ev_id: 137)
*Sep 19 12:27:55.291: //19/0E2E8C62A3C6/SIP/Info/ccsip_event_handler:
ccsip_event_handler: peer ID 20 chans 0x44EE3BB0 event 137 flags 0x10020038 0x601 data 0x44EE3BB0
*Sep 19 12:27:55.291: //19/0E2E8C62A3C6/SIP/Info/ccsip_event_handler:
ccsip_event_handler: CC_EV_H245_SET_MODE: peer ID 20 chans 0x44EE3BB0 event 137 flags 0x10020038 0x601 data 0x44EE3BB0
*Sep 19 12:27:55.295: //19/0E2E8C62A3C6/SIP/Info/ccsip_event_handler:
ccsip_event_handler: CC_EV_H245_SET_MODE: peer ID 20 chans 0x44EE3BB0 event 137 flags 0x10020038 0x601 data 0x44EE3BB0, type = 3
*Sep 19 12:27:55.295: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler: CC_R_SUCCESS_WITH_CONFIRMED
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 14 to table
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/act_idle_continue_call_setup:
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIGetCallConfig: preferred_codec set[0] type :No Codec bytes: 0
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIGetCallConfig: Using Voice Class Codec, tag = 1
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPICopyPeerDataToCCB:
From CLI: Modem NSE payload = 100, Passthrough = 0, Modem relay = 0, Gw-Xid = 1
SPRT latency 200, SPRT Retries = 12, Dict Size = 1024
String Len = 32, Compress dir = 3
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPI_ipip_copy_channelInfo_to_sdp:
callid 20, channels 0x44E96BE0 caps 0x44ED30C8
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPI_ipip_copy_channelInfo_to_sdp:
pref dtmf 96
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIValidateGtd: No rawMsg from CCAPI
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x4627C64C key=45D1BE07-18C11E2-80158018-61678721@10.0.99.29
*Sep 19 12:27:55.295: //20/000000000000/SIP/Info/sipSPIUsetBillingProfile: sipCallId for billing records = 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
*Sep 19 12:27:55.295: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:27:55.295: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 16926 for stream 1
*Sep 19 12:27:55.299: //20/000000000000/SIP/Media/sipSPIAddSDPMediaPayload: Preferred method of dtmf relay is: 6, with payload: 101
*Sep 19 12:27:55.299: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:27:55.299: //20/000000000000/SIP/Info/sip_generate_sdp_xcaps
Router#_list: Modem Relay and T38 disabled. X-cap not needed
*Sep 19 12:27:55.299: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.0.99.100,Port 5060, Transport 1, SentBy Port 5060
*Sep 19 12:27:55.299: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:27:55.299: //20/000000000000/SIP/Event/sipSPICreateRpid: Received Octet3A=0x80 -> Setting ;screen=no ;privacy=off
*Sep 19 12:27:55.299: //20/000000000000/SIP/Transport/sipSPISendInvite: Sending Invite to the transport layer
*Sep 19 12:27:55.299: //20/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch Transport is FALSE
*Sep 19 12:27:55.299: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x4654D520, addr=10.0.99.100, port=5060, sentBy_port=0, is_req=1, transport=1, switch=0, callBack=0x41086470
*Sep 19 12:27:55.299: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:27:55.299: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:27:55.299: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x4654D520
*Sep 19 12:27:55.299: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654D520, addr=10.0.99.100, port=5060, connId=3 for UDP
*Sep 19 12:27:55.299: //20/000000000000/SIP/Info/sentInviteRequest: Sent Invite in state STATE_IDLE
*Sep 19 12:27:55.303: //-1/xxxxxxxxxxxx/SIP/Info/sentInviteRequest: Transaction active. Facilities will be queued.
*Sep 19 12:27:55.303: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_SENT_INVITE, SUBSTATE_NONE)
*Sep 19 12:27:55.303: //20/000000000000/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions
*Sep 19 12:27:55.303: //20/000000000000/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice+dtmf (callid 20) to the VOIP RTP library
*Sep 19 12:27:55.303: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:27:55.303: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1
*Sep 19 12:27:55.303: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info
laddr = 10.0.99.29, lport = 16926, raddr = 0.0.0.0, rport=0, do_rtcp=FALSE
src_callid = 20, dest_callid = -1, stream type = voice+dtmf, stream direction = RECVONLY
media_ip_addr = 0.0.0.0
*Sep 19 12:27:55.303: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: No rtp session, creating a new one
*Sep 19 12:27:55.303: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:27:55 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow-Events: telephone-event
Content-Length: 0
*Sep 19 12:27:55.307: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:4957887603@10.0.99.100:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1C14C0
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>
Date: Wed, 19 Sep 2012 12:27:55 GMT
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
Supported: 100rel,timer,replaces
Min-SE: 1800
Cisco-Guid: 237931618-38998498-2747662362-1690784024
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
CSeq: 101 INVITE
Max-Forwards: 70
Remote-Party-ID: <sip:4991589848@10.0.99.29>;party=calling;screen=no;privacy=off
Timestamp: 1348057675
Contact: <sip:4991589848@10.0.99.29:5060>
Expires: 180
Allow-Events: telephone-event
Content-Type: application/sdp
Content-Length: 241
v=0
o=CiscoSystemsSIP-GW-UserAgent 3284 8564 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 16926 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:10
*Sep 19 12:27:55.307: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:27:55.307: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:27:55.311: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1C14C0
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 101 INVITE
Contact: <sip:4957887603@10.0.99.100:5060>
Server: MERA MVTS3G v.4.4.0-15
Timestamp: 1348057675
Content-Length: 0
*Sep 19 12:27:55.311: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_SENT_INVITE, SUBSTATE_NONE) to (STATE_RECD_PROCEEDING, SUBSTATE_PROCEEDING_PROCEEDING)
Router#
*Sep 19 12:27:58.971: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:27:58.971: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:27:58.971: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 183 Progress
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1C14C0
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 101 INVITE
Contact: <sip:4957887603@10.0.99.100:5060>
Content-Type: application/sdp
Server: MERA MVTS3G v.4.4.0-15
Content-Length: 239
v=0
o=- 1348056655 1348056655 IN IP4 10.0.99.111
s=-
c=IN IP4 10.0.99.111
t=0 0
m=audio 21550 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=sendrecv
a=silenceSupp:off - - - -
*Sep 19 12:27:58.971: //20/000000000000/SIP/Info/HandleSIP1xxSessionProgress: Content-Disposition NOT received in 18x response - using default Content-Disposition values
*Sep 19 12:27:58.971: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetGtdBody: No valid GTD body found.
*Sep 19 12:27:58.971: //20/000000000000/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1
*Sep 19 12:27:58.971: //20/000000000000/SIP/Info/sipSPIDoAudioNegotiation: Codec (g711alaw) Negotiation Successful on Static Payload for m-line 1
*Sep 19 12:27:58.971: //20/000000000000/SIP/Info/sipSPIDoPtimeNegotiation: One ptime attribute found - value:10
*Sep 19 12:27:58.975: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g711alaw ptime :10, codecbytes: 80
*Sep 19 12:27:58.975: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPIDoDTMFRelayNegotiation: m-line index 1
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) could not be reserved.
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPIDoDTMFRelayNegotiation: Payload type (101) is reserved for requested dtmf relay mode.
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPIDoDTMFRelayNegotiation: Case of partial named event(NE) match in fmtp list of events.
*Sep 19 12:27:58.975: //-1/xxxxxxxxxxxx/SIP/Info/sip_sdp_get_modem_relay_cap_params: NSE payload from X-cap = 0
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPIGetSDPDirectionAttribute: No direction attribute present or multiple direction attributes that can't be handled for m-line:1 and num-a-lines:0
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1
payload_type=8, codec_bytes=80, codec=g711alaw, dtmf_relay=rtp-nte
stream_type=voice+dtmf (1), dest_ip_address=10.0.99.111, dest_port=21550
*Sep 19 12:27:58.975: //20/000000000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
Preferred Codec : g711alaw, bytes :80
Preferred DTMF relay : rtp-nte
Preferred NTE payload : 101
Early Media : No
Delayed Media : No
Bridge Done : No
New Media : No
DSP DNLD Reqd : No
*Sep 19 12:27:58.975: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_report_media_to_peer:
callId 20 peer 19 flags 0x7
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
CallID 20, sdp 0x45C92F44 channels 0x4627DF14
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 8 mline 1
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711alaw
*Sep 19 12:27:58.975: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation done: stream->negotiated_ptime=10,stream->negotiated_codec_bytes=80, coverted ptime=10 stream->mline_index=1, media_ndx=1
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 6 ptype 8 time 10, bytes 80 as channel 0 mline 1 ss 1 10.0.99.111:21550
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 101 mline 1
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/sipSPI_ipip_report_media_to_peer:
Report initial call media
*Sep 19 12:27:58.975: //20/000000000000/SIP/Info/copy_channels:
callId 20 size 80 ptr 0x46655B7C)
*Sep 19 12:27:58.975: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler:
*Sep 19 12:27:58.975: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler: switch(ev.ev_id: 131)
*Sep 19 12:27:58.975: //19/0E2E8C62A3C6/SIP/Info/ccsip_event_handler:
ccsip_event_handler: peer ID 20 chans 0x46655B7C event 131 flags 0x10020038 0x403 data 0x46655B7C
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_event_handler:
ccsip_event_handler: CC_EV_H245_OPEN_CHANNEL_IND: peer ID 20 chans 0x46655B7C event 131 flags 0x10020038 0x403 data 0x46655B7C
*Sep 19 12:27:58.979: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_NEW_MEDIA
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_event_handler:
ccsip_event_handler: set event->type = SIPSPI_EV_CC_NEW_MEDIA!: peer ID 20 chans 0x46655B7C event 131 flags 0x10020038 0x403 data 0x46655B7C
*Sep 19 12:27:58.979: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler: CC_R_SUCCESS_WITH_CONFIRMED
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_get_rtcp_session_parameters: CURRENT VALUES: stream_callid=-1, current_seq_num=0x1A8
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_get_rtcp_session_parameters: NEW VALUES: stream_callid=-1, current_seq_num=0x0
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_caps_ind: Load DSP with negotiated codec: g711alaw, Bytes=80
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_caps_ind: Set forking flag to 0x0
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sipSPISetDTMFRelayMode: Set DSP for dtmf-relay = CC_CAP_DTMF_RELAY_INBAND_VOICE_AND_OOB
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sip_set_modem_caps: Preferred (or the one that came from DSM) modem relay=1161273728, from CLI config=0
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sip_set_modem_caps: Disabling Modem Relay...
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sip_generate_sdp_xcaps_list: Modem Relay and T38 disabled. X-cap not needed
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sip_set_modem_caps: Negotiation already Done. Set negotiated Modem caps and generate SDP Xcap list
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sip_set_modem_caps: Modem Relay & Passthru both disabled
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sip_set_modem_caps: nse payload = 0, ptru mode = 0, ptru-codec=0, redundancy=0, xid=0, relay=0, sprt-retry=12, latecncy=200, compres-dir=3, dict=1024, strnlen=32
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Media/sipSPISetStreamInfo: 0 Active Streams
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Error/sipSPISetStreamInfo: Number of active streams is zero (0)!
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Media/sipSPISetStreamInfo:
caps.stream_count=0,caps.stream[0].stream_type=0xFFFF, caps.stream_list.xmitFunc=
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Media/sipSPISetStreamInfo: ??unknown??, caps.stream_list.context=
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Media/sipSPISetStreamInfo: 0x0 (gccb)
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_caps_ind: Load DSP with codec : g711alaw, Bytes=80
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/ccsip_caps_ind: ccsip_caps_ind: ccb->flags_ipip = 0x403
*Sep 19 12:27:58.979: //20/000000000000/SIP/Info/ccsip_caps_ack: Set forking flag to 0x0
*Sep 19 12:27:58.979: //20/000000000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
Stream type : voice+dtmf
Media line : 1
State : STREAM_ADDING (2)
Callid : 20
Negotiated Codec : g711alaw, bytes :80
Negotiated DTMF relay : rtp-nte
Negotiated NTE payload : 101
Negotiated CN payload : 0
Media Srce Addr/Port : 10.0.99.29:16926
Media Dest Addr/Port : 10.0.99.111:21550
*Sep 19 12:27:58.979: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateRawMsg: No GTD passed.
*Sep 19 12:27:58.979: //20/000000000000/SIP/Info/HandleSIP1xxSessionProgress: ccsip_api_call_cut_progress returned: SIP_SUCCESS
*Sep 19 12:27:58.979: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_RECD_PROCEEDING, SUBSTATE_PROCEEDING_PROCEEDING) to (STATE_RECD_PROCEEDING, SUBSTATE_NONE)
*Sep 19 12:27:58.979: //20/000000000000/SIP/Info/HandleSIP1xxSessionProgress: Transaction Complete. Lock on Facilities released.
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_handle_channel_info:
CCSIP:callID 19 ft: 1, inc 8, 10.0.99.111:21550, codec 6
*Sep 19 12:27:58.979: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_channelInfo_to_sdp:
callid 19, channels 0x46655B7C caps 0x44E8F284
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_channelInfo_to_sdp:
pref dtmf 101
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_channelInfo_to_sdp:
nego mline 1 dtmf 101 ss 1 ret 0
*Sep 19 12:27:58.983: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPI_ipip_copy_channelInfo_to_sdp:
retreive codec 6 ptype 8 time 10 bytes 80
*Sep 19 12:27:58.983: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 19570
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Negotiated method of dtmf relayand pyld: 6 101
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPIProcessMediaChanges: sipSPIProcessMediaChanges
*Sep 19 12:27:58.983: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_PROGRESS
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/ccsip_bridge: confID = 10, srcCallID = 19, dstCallID = 20
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Inf
Router#o/sipSPIUupdateCcCallIds: Old src/dest ccCallids: -1/-1, new src/dest ccCallids: 19/20
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Info/sipSPIUupdateCcCallIds: Old streamcallid=-1, new streamcallid=19
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice+dtmf (callid 19) to the VOIP RTP library
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1
*Sep 19 12:27:58.983: //19/0E2E8C62A3C6/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info
laddr = 10.0.99.29, lport = 19570, raddr = 10.0.99.221, rport=17294, do_rtcp=TRUE
src_callid = 19, dest_callid = 20, stream type = voice+dtmf, stream direction = SENDRECV
media_ip_addr = 10.0.99.221
*Sep 19 12:27:58.987: //19/0E2E8C62A3C6/SIP/Media/sipSPIUpdateRtcpSession: No rtp session, creating a new one
*Sep 19 12:27:58.987: //19/0E2E8C62A3C6/SIP/Info/sipSPIUpdateRtcpSession: Process Media changes is still pending.
*Sep 19 12:27:58.987: //19/0E2E8C62A3C6/SIP/Media/sipSPIGetNewLocalMediaDirection:
New Remote Media Direction = SENDRECV
Present Local Media Direction = SENDRECV
New Local Media Direction = SENDRECV
retVal = 0
*Sep 19 12:27:58.987: //20/000000000000/SIP/Info/ccsip_bridge: confID = 10, srcCallID = 20, dstCallID = 19
*Sep 19 12:27:58.987: //20/000000000000/SIP/Info/sipSPIUupdateCcCallIds: Old src/dest ccCallids: -1/-1, new src/dest ccCallids: 20/19
*Sep 19 12:27:58.987: //20/000000000000/SIP/Info/sipSPIUupdateCcCallIds: Old streamcallid=20, new streamcallid=20
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice+dtmf (callid 20) to the VOIP RTP library
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info
laddr = 10.0.99.29, lport = 16926, raddr = 10.0.99.111, rport=21550, do_rtcp=TRUE
src_callid = 20, dest_callid = 19, stream type = voice+dtmf, stream direction = SENDRECV
media_ip_addr = 10.0.99.111
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: RTP session already created - update
*Sep 19 12:27:58.987: //20/000000000000/SIP/Media/sipSPIGetNewLocalMediaDirection:
New Remote Media Direction = SENDRECV
Present Local Media Direction = SENDRECV
New Local Media Direction = SENDRECV
retVal = 0
*Sep 19 12:27:58.991: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Info/sipSPIValidateGtd: No rawMsg from CCAPI
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Info/sipSPISendInviteResponse183: Session Type is Media/Qos/Security/RTR SDP body is attached
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 183 Response to the Transport Layer
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DFD0, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x41086D90
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:27:58.991: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DFD0, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:27:58.991: //19/0E2E8C62A3C6/SIP/Info/sentInviteResponse18x: Sent a 18x Response
*Sep 19 12:27:58.991: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:27:58.991: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1C14C0
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 101 INVITE
Contact: <sip:4957887603@10.0.99.100:5060>
Server: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:27:58.995: //20/000000000000/SIP/Info/ccsip_api_call_alert: SDP Body either absent or ignored in 180 RINGING:- will wait for 200 OK to do negotiation.
*Sep 19 12:27:58.995: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateRawMsg: No GTD passed.
*Sep 19 12:27:58.995: //20/000000000000/SIP/Info/HandleSIP1xxRinging: ccsip_api_call_alert returned: SIP_SUCCESS
*Sep 19 12:27:58.995: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_RECD_PROCEEDING, SUBSTATE_NONE) to (STATE_RECD_PROCEEDING, SUBSTATE_NONE)
*Sep 19 12:27:58.995: //20/000000000000/SIP/Info/HandleSIP1xxRinging: Transaction Complete. Lock on Facilities released.
*Sep 19 12:27:58.995: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:27:55 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Disposition: session;handling=required
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:27:58.999: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_ALERTING
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/Info/sipSPIValidateGtd: No rawMsg from CCAPI
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 180 Response to the Transport Layer
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DFD0, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x41086D90
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:27:58.999: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DFD0, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/Info/sentInviteResponse18x: Sent a 18x Response
*Sep 19 12:27:58.999: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_RECD_INVITE, SUBSTATE_NONE) to (STATE_SENT_ALERTING, SUBSTATE_NONE)
*Sep 19 12:27:59.003: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:27:55 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Length: 0
Router#
*Sep 19 12:28:02.655: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:28:02.655: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:02.655: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1C14C0
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 101 INVITE
Contact: <sip:4957887603@10.0.99.100:5060>
Content-Type: application/sdp
Allow: ACK, BYE, CANCEL, INFO, INVITE, OPTIONS, REFER, REGISTER, SUBSCRIBE, UPDATE
Server: MERA MVTS3G v.4.4.0-15
X-mera-expires: 86460
Content-Length: 239
v=0
o=- 1348056655 1348056655 IN IP4 10.0.99.111
s=-
c=IN IP4 10.0.99.111
t=0 0
m=audio 21550 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=sendrecv
a=silenceSupp:off - - - -
*Sep 19 12:28:02.659: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetGtdBody: No valid GTD body found.
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIhandle200OKInvite: Transaction active. Facilities will be queued.
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIhandle200OKInvite: *** This ccb is the parent
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIDoAudioNegotiation: Codec (g711alaw) Negotiation Successful on Static Payload for m-line 1
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIDoPtimeNegotiation: One ptime attribute found - value:10
*Sep 19 12:28:02.659: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g711alaw ptime :10, codecbytes: 80
*Sep 19 12:28:02.659: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIDoDTMFRelayNegotiation: m-line index 1
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIDoDTMFRelayNegotiation: Case of partial named event(NE) match in fmtp list of events.
*Sep 19 12:28:02.659: //-1/xxxxxxxxxxxx/SIP/Info/sip_sdp_get_modem_relay_cap_params: NSE payload from X-cap = 0
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sip_do_nse_negotiation: Remote NSE payload = local one = 0, Use it
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIGetSDPDirectionAttribute: No direction attribute present or multiple direction attributes that can't be handled for m-line:1 and num-a-lines:0
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1
payload_type=8, codec_bytes=80, codec=g711alaw, dtmf_relay=rtp-nte
stream_type=voice+dtmf (1), dest_ip_address=10.0.99.111, dest_port=21550
*Sep 19 12:28:02.659: //20/000000000000/SIP/Media/sipSPICompareStreams: stream 1 dest_port: old=21550 new=21550
*Sep 19 12:28:02.659: //20/000000000000/SIP/Media/sipSPIGetNewLocalMediaDirection:
New Remote Media Direction = SENDRECV
Present Local Media Direction = SENDRECV
New Local Media Direction = SENDRECV
retVal = 0
*Sep 19 12:28:02.659: //20/000000000000/SIP/Media/sipSPICompareStreams: Flags set for stream 1: RTP_CHANGE=No CAPS_CHANGE=No
*Sep 19 12:28:02.659: //20/000000000000/SIP/Media/sipSPICompareSDP: Flags set for call: NEW_MEDIA=No DSPDNLD_REQD=No IPIP_MEDIA=No
*Sep 19 12:28:02.659: //20/000000000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
Preferred Codec : g711alaw, bytes :80
Preferred DTMF relay : rtp-nte
Preferred NTE payload : 101
Early Media : No
Delayed Media : No
Bridge Done : Yes
New Media : No
DSP DNLD Reqd : No
*Sep 19 12:28:02.659: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPI_ipip_report_media_to_peer:
callId 20 peer 19 flags 0x407
*Sep 19 12:28:02.659: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
CallID 20, sdp 0x45CB1F40 channels 0x4627DF14
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 8 mline 1
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711alaw
*Sep 19 12:28:02.663: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :80, ptime: 10
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation done: stream->negotiated_ptime=10,stream->negotiated_codec_bytes=80, coverted ptime=10 stream->mline_index=1, media_ndx=1
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 6 ptype 8 time 10, bytes 80 as channel 0 mline 1 ss 1 10.0.99.111:21550
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 101 mline 1
*Sep 19 12:28:02.663: //20/000000000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
Stream type : voice+dtmf
Media line : 1
State : STREAM_ACTIVE (5)
Callid : 20
Negotiated Codec : g711alaw, bytes :80
Negotiated DTMF relay : rtp-nte
Negotiated NTE payload : 101
Negotiated CN payload : 0
Media Srce Addr/Port : 10.0.99.29:16926
Media Dest Addr/Port : 10.0.99.111:21550
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPIProcessMediaChanges: sipSPIProcessMediaChanges
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPIhandle200OKInvite: ccsip_api_call_connect_media returned: SIP_SUCCESS
*Sep 19 12:28:02.663: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_RECD_PROCEEDING, SUBSTATE_NONE) to (STATE_RECD_PROCEEDING, SUBSTATE_NONE)
*Sep 19 12:28:02.663: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateRawMsg: No GTD passed.
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPICreateAndStartRtpTimer:
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPICreateAndStartRtpTimer: Media Inactivity Timer is disabled.
*Sep 19 12:28:02.663: //20/000000000000/SIP/Info/sipSPIhandle200OKInvite: ccsip_api_call_connected returned: SIP_SUCCESS
*Sep 19 12:28:02.663: //20/000000000000/SIP/Transport/sipSPISendAck: Sending ACK to the transport layer
*Sep 19 12:28:02.663: //20/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch Transport is FALSE
*Sep 19 12:28:02.663: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x4654D880, addr=10.0.99.100, port=5060, sentBy_port=0, is_req=1, transport=1, switch=0, callBack=0x41087AE4
*Sep 19 12:28:02.663: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:02.663: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:02.663: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x4654D880
*Sep 19 12:28:02.663: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654D880, addr=10.0.99.100, port=5060, connId=3 for UDP
*Sep 19 12:28:02.663: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_RECD_PROCEEDING, SUBSTATE_NONE) to (STATE_ACTIVE, SUBSTATE_NONE)
*Sep 19 12:28:02.667: //20/000000000000/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x4627C64C
State of The Call : STATE_ACTIVE
TCP Sockets Used : NO
Calling Number : 4991589848
Called Number : 4957887603
Source IP Address (Sig ): 10.0.99.29
Destn SIP Req Addr:Port : 10.0.99.100:5060
Destn SIP Resp Addr:Port : 10.0.99.100:5060
Destination Name : 10.0.99.100
*Sep 19 12:28:02.667: //20/000000000000/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : g711alaw
Negotiated Codec Bytes : 80
Negotiated Dtmf-relay : 6
Dtmf-relay Payload : 101
Source IP Address (Media): 10.0.99.29
Source IP Port (Media): 16926
Destn IP Address (Media): 10.0.99.111
Destn IP Port (Media): 21550
Orig Destn IP Address:Port (Media): 0.0.0.0:0
*Sep 19 12:28:02.667: //20/000000000000/SIP/Info/sipSPICallActive: Transaction Complete. Lock on Facilities released.
*Sep 19 12:28:02.667: //20/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Sep 19 12:28:02.667: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_CONNECT
*Sep 19 12:28:02.667: //19/0E2E8C62A3C6/SIP/Info/sipSPIValidateGtd: No rawMsg from CCAPI
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DC70, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x41087080
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:02.671: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DC70, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/Info/sentInviteResponse200: Sent 200Ok for Invite in state STATE_SENT_ALERTING
*Sep 19 12:28:02.671: //-1/xxxxxxxxxxxx/SIP/Info/sentInviteResponse200: Transaction active. Facilities will be queued.
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_SENT_ALERTING, SUBSTATE_NONE) to (STATE_SENT_SUCCESS, SUBSTATE_NONE)
*Sep 19 12:28:02.671: //19/0E2E8C62A3C6/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Sep 19 12:28:02.671: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:4957887603@10.0.99.100:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1D505
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
Date: Wed, 19 Sep 2012 12:27:55 GMT
Router#
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
Max-Forwards: 70
CSeq: 101 ACK
Content-Length: 0
*Sep 19 12:28:02.675: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:27:55 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:02.675: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:02.675: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:02.675: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:02.679: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:02.679: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:02.679: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:02.679: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Info/act_sentsucc_new_message_request: Transaction Complete. Lock on Facilities released.
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_SENT_SUCCESS, SUBSTATE_NONE) to (STATE_ACTIVE, SUBSTATE_NONE)
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x4627A3B8
State of The Call : STATE_ACTIVE
TCP Sockets Used : NO
Calling Number : 4991589848
Called Number : 0001124957887603
Source IP Address (Sig ): 10.0.99.29
Destn SIP Req Addr:Port : 10.0.99.221:5061
Destn SIP Resp Addr:Port : 10.0.99.221:5061
Destination Name : 10.0.99.221
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : g711alaw
Negotiated Codec Bytes : 80
Negotiated Dtmf-relay : 6
Dtmf-relay Payload : 101
Source IP Address (Media): 10.0.99.29
Source IP Port (Media): 19570
Destn IP Address (Media): 10.0.99.221
Destn IP Port (Media): 17294
Orig Destn IP Address:Port (Media): 0.0.0.0:0
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Info/sipSPICreateAndStartRtpTimer:
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Info/sipSPICreateAndStartRtpTimer: Media Inactivity Timer is disabled.
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Info/sipSPIProcessHoldTimerForCall: Media IP Addr 10.0.99.221, RTCP Type 3
*Sep 19 12:28:02.679: //19/0E2E8C62A3C6/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
Router#
*Sep 19 12:28:07.859: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:28:07.859: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:07.859: //20/000000000000/SIP/Info/ccsip_new_msg_preprocessor: ****Found CCB in UAC table
*Sep 19 12:28:07.859: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:4991589848@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.100:5060;rport;branch=z9hG4bK-3561377568-3792786178-436251047-22870608361
Via: SIP/2.0/UDP 10.0.99.100:5061;rport=5061;branch=z9hG4bK-3561377568-3792786178-436251047-2287060836;received=10.0.99.100
From: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
To: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 102 INVITE
Contact: <sip:4957887603@10.0.99.100:5060>
Content-Type: application/sdp
Allow: ACK, BYE, CANCEL, INFO, INVITE, OPTIONS, REFER, REGISTER, SUBSCRIBE, UPDATE
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 193
v=0
o=- 1348056664 1348056664 IN IP4 10.0.99.111
s=-
c=IN IP4 10.0.99.111
t=0 0
m=image 21550 udptl t38
a=T38FaxRateManagement:transferredTCF
a=T38FaxUdpEC:t38UDPRedundancy
a=sendrecv
*Sep 19 12:28:07.863: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.100,Port 5060, Transport 1, SentBy Port 5060
*Sep 19 12:28:07.863: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:07.863: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.100,Port 5060, Transport 1, SentBy Port 5060
*Sep 19 12:28:07.863: //20/000000000000/SIP/Info/sact_active_new_message_request: Case of Mid-Call INVITE/UPDATE in ACTIVE STATE
*Sep 19 12:28:07.863: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetGtdBody: No valid GTD body found.
*Sep 19 12:28:07.863: //20/000000000000/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1
*Sep 19 12:28:07.863: //20/000000000000/SIP/Info/sipSPIDoFaxMediaNegotiation: T.38 negotiated
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPICompareStreams: stream 1 dest_port: old=21550 new=21550
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPIGetNewLocalMediaDirection:
New Remote Media Direction = SENDRECV
Present Local Media Direction = SENDRECV
New Local Media Direction = SENDRECV
retVal = 0
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPICompareMediaType: Media type switching from 0 to 11 for stream 1
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPICompareStreams: negotiated codec changed from g711alaw to T38Fax
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPICompareStreams: negotiated dtmf relay changed from rtp-nte to inband-voice
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPICompareStreams: Flags set for stream 1: RTP_CHANGE=Yes CAPS_CHANGE=Yes
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPICompareSDP: Flags set for call: NEW_MEDIA=Yes DSPDNLD_REQD=Yes IPIP_MEDIA=Yes
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
Preferred Codec : g711alaw, bytes :80
Preferred DTMF relay : rtp-nte
Preferred NTE payload : 101
Early Media : No
Delayed Media : No
Bridge Done : Yes
New Media : Yes
DSP DNLD Reqd : Yes
*Sep 19 12:28:07.863: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:28:07.863: //20/000000000000/SIP/Info/sipSPI_ipip_report_media_to_peer:
callId 20 peer 19 flags 0x4D0F
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
CallID 20, sdp 0x45516EBC channels 0x4627DF14
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Finished storing fax attrs 1 type 1 prot 0, rmgmt 1 maxbuff 0 max dgram 0
SIP: Attribute ptime, level 1 instance 1 not found.
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Call 20 setting xmit func to udp
*Sep 19 12:28:07.867: //19/0E2E8C62A3C6/SIP/Info/ccsip_remote_codec_download_done:
callId 19 context 0x46647940
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Call 20 set InfoType to FAX
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 0 mline 1
*Sep 19 12:28:07.867: //-1/xxxxxxxxxxxx/SIP/Error/convert_codec_bytes_to_ptime: Unexpected VoIPCodec Type :T38Fax
*Sep 19 12:28:07.867: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: T38Fax codecbytes :20, ptime: 0
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation done: stream->negotiated_ptime=0,stream->negotiated_codec_bytes=20, coverted ptime=0 stream->mline_index=1, media_ndx=1
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 17 ptype 0 time 0, bytes 20 as channel 0 mline 1 ss 0 10.0.99.111:21550
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPI_ipip_report_media_to_peer:
Report reINVITE media
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/copy_channels:
callId 20 size 80 ptr 0x44ECA9CC)
*Sep 19 12:28:07.867: //19/0E2E8C62A3C6/SIP/Info/ccsip_modify_media_ind: codec=0x10000 modem_redundancy=1175993460 callID 19 peer callID 20
*Sep 19 12:28:07.867: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_MEDIA_CHANGED
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIUpdCallWithSdpInfo:
Stream type : voice+dtmf
Media line : 1
State : STREAM_CHANGING (4)
Callid : -1
Negotiated Codec : T38Fax, bytes :20
Negotiated DTMF relay : inband-voice
Negotiated NTE payload : 0
Negotiated CN payload : 0
Media Srce Addr/Port : 10.0.99.29:16926
Media Dest Addr/Port : 10.0.99.111:21550
*Sep 19 12:28:07.867: //20/000000000000/SIP/Info/sipSPIProcessMediaChanges: sipSPIProcessMediaChanges
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIDeleteStream: Deleting stream 1 from the VOIP RTP library
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice+dtmf (callid 20) to the VOIP RTP library
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 10.0.99.29
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info
laddr = 10.0.99.29, lport = 16926, raddr = 10.0.99.111, rport=21550, do_rtcp=FALSE
src_callid = 20, dest_callid = 19, stream type = voice+dtmf, stream direction = SENDRECV
media_ip_addr = 10.0.99.111
*Sep 19 12:28:07.867: //20/000000000000/SIP/Media/sipSPIUpdateRtcpSession: No rtp session, creating a new one
*Sep 19 12:28:07.871: //20/000000000000/SIP/Media/sipSPIGetNewLocalMediaDirection:
New Remote Media Direction = SENDRECV
Present Local Media Direction = SENDRECV
New Local Media Direction = SENDRECV
retVal = 0
*Sep 19 12:28:07.871: //20/000000000000/SIP/Info/sipSPIProcessMediaChanges: DSPDNLD Reqd is true. Call DoCapsInd
*Sep 19 12:28:07.871: //20/000000000000/SIP/Info/sipSPIIncomingCallSDP: SDP already there use old SDP and update media if needed
*Sep 19 12:28:07.871: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1
*Sep 19 12:28:07.871: //20/000000000000/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 16926
*Sep 19 12:28:07.871: //20/000000000000/SIP/Info/sipSPI_ipip_build_t38_sdp:
*Sep 19 12:28:07.871: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_MEDIA_EVENT
*Sep 19 12:28:07.871: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_MIDCALL_LOCAL_RESP_PENDING, SUBSTATE_NONE)
*Sep 19 12:28:07.871: //20/000000000000/SIP/Info/sipSPIHandleIncomingMidCallInvite: ccsip_api_request_offer returned: SIP_SUCCESS
*Sep 19 12:28:07.871: //20/000000000000/SIP/Event/sipSPICreateRpid: Received Octet3A=0x80 -> Setting ;screen=no ;privacy=off
*Sep 19 12:28:07.871: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x4654E3C0, addr=10.0.99.100, port=5060, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:07.871: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:07.871: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:07.871: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654E3C0, addr=10.0.99.100, port=5060, connId=0 for UDP
*Sep 19 12:28:07.871: //20/000000000000/SIP/Info/sipSPIProcessContactInfo: Previous Hop 10.0.99.100:5060
*Sep 19 12:28:07.871: //19/0E2E8C62A3C6/SIP/Info/act_active_media_changed: New codec = 17
*Sep 19 12:28:07.875: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendErrorResponse: Sending ERROR Response to the transport layer
*Sep 19 12:28:07.875: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DC70, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:07.875: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:07.875: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:07.875: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DC70, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:07.875: //20/000000000000/SIP/Info/act_handle_app_media_event: Received media sip event SIP_RESPONSE_ANSWER
*Sep 19 12:28:07.875: //20/000000000000/SIP/Event/sipSPICreateRpid: Received Octet3A=0x80 -> Setting ;screen=no ;privacy=off
*Sep 19 12:28:07.875: //20/000000000000/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:07.875: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x4654D0A0, addr=10.0.99.100, port=5060, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x410Router#
*Sep 19 12:28:07.875: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:07.875: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:07.875: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654D0A0, addr=10.0.99.100, port=5060, connId=0 for UDP
*Sep 19 12:28:07.875: //20/000000000000/SIP/Info/sentResponseStartConnectTimer: Sent Response, start ConnectTimer
*Sep 19 12:28:07.875: //20/000000000000/SIP/Info/sipSPIProcessHoldTimerForCall: Media IP Addr 10.0.99.111, RTCP Type 3
*Sep 19 12:28:07.875: //20/000000000000/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:07.879: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.0.99.100:5060;rport;branch=z9hG4bK-3561377568-3792786178-436251047-22870608361,SIP/2.0/UDP 10.0.99.100:5061;rport=5061;branch=z9hG4bK-3561377568-3792786178-436251047-2287060836;received=10.0.99.100
From: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
To: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
Date: Wed, 19 Sep 2012 12:28:07 GMT
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 102 INVITE
Allow-Events: telephone-event
Remote-Party-ID: <sip:4991589848@10.0.99.29>;party=called;screen=no;privacy=off
Content-Length: 0
*Sep 19 12:28:07.879: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 488 Not Acceptable Media
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Warning: 304 10.0.99.29 "Media Type(s) Unavailable"
CSeq: 1 INVITE
Content-Length: 0
*Sep 19 12:28:07.879: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.100:5060;rport;branch=z9hG4bK-3561377568-3792786178-436251047-22870608361,SIP/2.0/UDP 10.0.99.100:5061;rport=5061;branch=z9hG4bK-3561377568-3792786178-436251047-2287060836;received=10.0.99.100
From: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
To: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
Date: Wed, 19 Sep 2012 12:28:07 GMT
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Remote-Party-ID: <sip:4991589848@10.0.99.29>;party=called;screen=no;privacy=off
Contact: <sip:4991589848@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 151
v=0
o=CiscoSystemsSIP-GW-UserAgent 3284 8565 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=image 16926 udptl t38
c=IN IP4 10.0.99.29
*Sep 19 12:28:07.883: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:07.883: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:28:07.883: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:07.883: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:07.887: //20/000000000000/SIP/Info/ccsip_new_msg_preprocessor: ****Found CCB in UAC table
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:4991589848@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.100:5060;rport;branch=z9hG4bK-1223512608-3792786178-436251047-22870608361
Via: SIP/2.0/UDP 10.0.99.100:5061;rport=5061;branch=z9hG4bK-1223512608-3792786178-436251047-2287060836;received=10.0.99.100
From: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
To: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 102 ACK
Contact: <sip:4957887603@10.0.99.100:5060>
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.100,Port 5060, Transport 1, SentBy Port 5060
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:07.887: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.100,Port 5060, Transport 1, SentBy Port 5060
*Sep 19 12:28:07.887: //20/000000000000/SIP/Info/sipSPIProcessIncomingAckForMidCall: Processing MidCall ACK
*Sep 19 12:28:07.887: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_MIDCALL_LOCAL_RESP_PENDING, SUBSTATE_NONE) to (STATE_ACTIVE, SUBSTATE_NONE)
*Sep 19 12:28:07.891: //20/000000000000/SIP/Info/sipSPICreateAndStartRtpTimer:
*Sep 19 12:28:07.891: //20/000000000000/SIP/Info/sipSPICreateAndStartRtpTimer: Media Inactivity Timer is disabled.
*Sep 19 12:28:08.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:08.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DD90, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:08.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:08.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:08.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DD90, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:08.375: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:28:07 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:08.403: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:08.407: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:08.407: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:08.407: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:08.407: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:08.407: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:08.407: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:28:09.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:09.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654CDD0, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:09.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:09.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:09.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654CDD0, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:09.375: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:28:08 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Serv
Router#er: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:09.379: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:09.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:09.379: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:09.379: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:09.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:09.379: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:09.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
Router#
*Sep 19 12:28:11.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:11.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654CEF0, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:11.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:11.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:11.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654CEF0, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:11.375: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:28:09 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:11.379: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:11.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:11.379: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:11.379: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
Router#
*Sep 19 12:28:11.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:11.379: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:11.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
Router#
*Sep 19 12:28:15.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:15.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DD90, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:15.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:15.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:15.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DD90, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:15.375: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:28:11 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:15.379: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:15.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:15.379: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:15.379: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
Router#
*Sep 19 12:28:15.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:15.379: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:15.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
Router#
*Sep 19 12:28:19.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:19.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654CDD0, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:19.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:19.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:19.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654CDD0, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:19.375: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:28:15 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:19.379: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:19.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:19.379: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:19.379: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
Router#
*Sep 19 12:28:19.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:19.379: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:19.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:28:20.147: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportSetAgeingTimer: Aging timer initiated for holder=0x4654D2E0,addr=10.0.99.100
Router#
*Sep 19 12:28:23.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer
*Sep 19 12:28:23.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654CEF0, addr=10.0.99.221, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x00000000
*Sep 19 12:28:23.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:23.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:23.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654CEF0, addr=10.0.99.221, port=5061, connId=0 for UDP
*Sep 19 12:28:23.375: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-3628481038-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Date: Wed, 19 Sep 2012 12:28:19 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 1 INVITE
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO, UPDATE, REGISTER
Allow-Events: telephone-event
Contact: <sip:0001124957887603@10.0.99.29:5060>
Content-Type: application/sdp
Content-Length: 268
v=0
o=CiscoSystemsSIP-GW-UserAgent 4191 6681 IN IP4 10.0.99.29
s=SIP Call
c=IN IP4 10.0.99.29
t=0 0
m=audio 19570 RTP/AVP 8 101
c=IN IP4 10.0.99.29
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:10
a=silenceSupp:off - - - -
*Sep 19 12:28:23.379: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:23.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:23.379: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x4627A3B8
*Sep 19 12:28:23.379: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:0001124957887603@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.221:5061;rport;branch=z9hG4bK-2684396818-3792786178-436258467-408012644
From: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
To: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 1 ACK
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Content-Length: 0
Router#
*Sep 19 12:28:23.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:23.379: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:23.379: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.221,Port 5061, Transport 1, SentBy Port 5061
Router#
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Error/act_active_wait_ack: Out of retries
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Info/ccsip_set_cc_cause_for_spi_err: Categorized cause:102, category:129
*Sep 19 12:28:27.375: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_set_release_source_for_peer: ownCallId[19], src[6]
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Info/sipSPIInitiateDisconnect: Initiate call disconnect(127) for incoming call
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPISendBye: Sending BYE to the transport layer
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch Transport is FALSE
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DD90, addr=10.0.99.221, port=5061, sentBy_port=0, is_req=1, transport=1, switch=0, callBack=0x410872CC
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x4654DD90
*Sep 19 12:28:27.375: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DD90, addr=10.0.99.221, port=5061, connId=4 for UDP
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/Info/sentByeDisconnecting: Sent Bye Request, starting DisconnectTimer
*Sep 19 12:28:27.375: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)
*Sep 19 12:28:27.379: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
BYE sip:4991589848@10.0.99.221:5061;user=phone SIP/2.0
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1E2659
From: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
To: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
Date: Wed, 19 Sep 2012 12:28:23 GMT
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1348057707
CSeq: 101 BYE
Content-Length: 0
*Sep 19 12:28:27.379: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_DISCONNECT
*Sep 19 12:28:27.379: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_DISCONNECT
*Sep 19 12:28:27.379: //20/000000000000/SIP/Info/sipSPIValidateGtd: No rawMsg from CCAPI
*Sep 19 12:28:27.379: //20/000000000000/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:27.379: //20/000000000000/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:27.383: //20/000000000000/SIP/Transport/sipSPISendBye: Sending BYE to the transport layer
*Sep 19 12:28:27.383: //20/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch Transport is FALSE
*Sep 19 12:28:27.383: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DD90, addr=10.0.99.100, port=5060, sentBy_port=0, is_req=1, transport=1, switch=0, callBack=0x410872CC
*Sep 19 12:28:27.383: //20/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:27.383: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:27.383: //20/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x4654DD90
*Sep 19 12:28:27.383: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DD90, addr=10.0.99.100, port=5060, connId=3 for UDP
*Sep 19 12:28:27.383: //20/000000000000/SIP/Info/sentByeDisconnecting: Sent Bye Request, starting DisconnectTimer
*Sep 19 12:28:27.383: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)
*Sep 19 12:28:27.383: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.221:5061
*Sep 19 12:28:27.383: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
BYE sip:4957887603@10.0.99.100:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1F1C07
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
Date: Wed, 19 Sep 2012 12:28:07 GMT
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1348057707
CSeq: 102 BYE
Content-Length: 0
*Sep 19 12:28:27.383: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIFindCcbUASRespTable: *****CCB found in UAS Response table. ccb=0x4627A3B8
*Sep 19 12:28:27.387: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1E2659
From: <sip:0001124957887603@10.0.99.29;user=phone>;tag=114FC0-1F24
To: <sip:4991589848@10.0.99.221:5061;user=phone>;tag=4095425038-3792786178-436258467-408012644
Call-ID: 0e3a1c30025311e2a3c6001a64c75118@10.0.99.221
CSeq: 101 BYE
Contact: <sip:4991589848@10.0.99.221:5061;user=phone>
Server: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIIcpifUpdate: CallState: 3 Playout: 0 DiscTime:116664 ConnTime 114193
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/State/sipSPIChangeState: 0x4627A3B8 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x4627A3B8
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 4991589848
Called Number : 0001124957887603
Source IP Address (Sig ): 10.0.99.29
Destn SIP Req Addr:Port : 10.0.99.221:5061
Destn SIP Resp Addr:Port : 10.0.99.221:5061
Destination Name : 10.0.99.221
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : g711alaw
Negotiated Codec Bytes : 80
Negotiated Dtmf-relay : 6
Dtmf-relay Payload : 101
Source IP Address (Media): 10.0.99.29
Source IP Port (Media): 19570
Destn IP Address (Media): 10.0.99.221
Destn IP Port (Media): 17294
Orig Destn IP Address:Port (Media): 0.0.0.0:0
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 127
Disconnect Cause (SIP) : 200
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 13
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIUdeleteCcbFromUASReqTable: ****Deleting from UAS Request table.
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x4627A3B8 key=0e3a1c30025311e2a3c6001a64c75118@10.0.99.2210001124957887603
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIUdeleteCcbFromUASRespTable: ****Deleting from UAS Response table.
*Sep 19 12:28:27.387: //19/0E2E8C62A3C6/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x4627A3B8 key=0e3a1c30025311e2a3c6001a64c75118@10.0.99.221114FC0-1F24
*Sep 19 12:28:27.391: //19/0E2E8C62A3C6/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Sep 19 12:28:27.391: //19/0E2E8C62A3C6/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 4627A3B8
*Sep 19 12:28:27.395: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.100:5060
*Sep 19 12:28:27.395: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:27.395: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK1F1C07
From: <sip:4991589848@10.0.99.29>;tag=114FE0-26C0
To: <sip:4957887603@10.0.99.100>;tag=2318849048-3792786178-436251047-2287060836
Call-ID: 45D1BE07-18C11E2-80158018-61678721@10.0.99.29
CSeq: 102 BYE
Contact: <sip:4957887603@10.0.99.100:5060>
Server: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:27.395: //20/000000000000/SIP/Info/sipSPIIcpifUpdate: CallState: 3 Playout: 0 DiscTime:116665 ConnTime 114192
*Sep 19 12:28:27.395: //20/000000000000/SIP/State/sipSPIChangeState: 0x4627C64C : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)
*Sep 19 12:28:27.395: //20/000000000000/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x4627C64C
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 4991589848
Called Number : 4957887603
Source IP Address (Sig ): 10.0.99.29
Destn SIP Req Addr:Port : 10.0.99.100:5060
Destn SIP Resp Addr:Port : 10.0.99.100:5060
Destination Name : 10.0.99.100
*Sep 19 12:28:27.395: //20/000000000000/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : T38Fax
Negotiated Codec Bytes : 20
Negotiated Dtmf-relay : 0
Dtmf-relay Payload : 0
Source IP Address (Media): 10.0.99.29
Source IP Port (Media): 16926
Destn IP Address (Media): 10.0.99.111
Destn IP Port (Media): 21550
Orig Destn IP Address:Port (Media): 0.0.0.0:0
*Sep 19 12:28:27.395: //20/000000000000/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 127
Disconnect Cause (SIP) : 200
*Sep 19 12:28:27.395: //20/000000000000/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 14
Router#
*Sep 19 12:28:27.399: //20/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Sep 19 12:28:27.399: //20/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x4627C64C key=45D1BE07-18C11E2-80158018-61678721@10.0.99.29
*Sep 19 12:28:27.399: //20/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Sep 19 12:28:27.399: //20/0E2E8C62A3C6/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 4627C64C
Router#
*Sep 19 12:28:48.411: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.111:5061
*Sep 19 12:28:48.411: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:48.415: //17/012C5B20A7A9/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x46275E90
*Sep 19 12:28:48.415: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
BYE sip:4957815696@10.0.99.29:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.111:5061;rport;branch=z9hG4bK-3327884088-3792786178-436251047-2287060836
From: <sip:4996540000@10.0.99.111:5061;user=phone>;tag=513356033-3792786178-436251047-2287060836
To: <sip:4957815696@10.0.99.29;user=phone>;tag=10B508-12FA
Call-ID: 01319946025311e2a7a9001a64c75188@10.0.99.111
CSeq: 2 BYE
Max-Forwards: 70
User-Agent: MERA MVTS3G v.4.4.0-15
Reason: MVTSLocal;cause=10;text="BYE received"
Content-Length: 0
*Sep 19 12:28:48.415: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.111,Port 5061, Transport 1, SentBy Port 5060
*Sep 19 12:28:48.415: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Sep 19 12:28:48.415: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.0.99.111,Port 5061, Transport 1, SentBy Port 5061
*Sep 19 12:28:48.415: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_set_release_source_for_peer: ownCallId[17], src[2]
*Sep 19 12:28:48.415: //17/012C5B20A7A9/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:48.415: //17/012C5B20A7A9/SIP/Info/sipSPIInitiateDisconnect: Initiate call disconnect(16) for incoming call
*Sep 19 12:28:48.415: //17/012C5B20A7A9/SIP/State/sipSPIChangeState: 0x46275E90 : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)
*Sep 19 12:28:48.419: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_DISCONNECT
*Sep 19 12:28:48.419: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_DISCONNECT
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Transport/sipSPISendByeResponse: Sending BYE Response to the transport layer
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Transport/sipSPITransportSendMessage: msg=0x4654DD00, addr=10.0.99.111, port=5061, sentBy_port=5061, is_req=0, transport=1, switch=0, callBack=0x41087578
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:48.419: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654DD00, addr=10.0.99.111, port=5061, connId=0 for UDP
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Info/sentByeResponse: Sent 200ok to the BYE, tearing down the call
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Info/sipSPIIcpifUpdate: CallState: 4 Playout: 0 DiscTime:118768 ConnTime 109917
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/State/sipSPIChangeState: 0x46275E90 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x46275E90
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 4996540000
Called Number : 4957815696
Source IP Address (Sig ): 10.0.99.29
Destn SIP Req Addr:Port : 10.0.99.111:5061
Destn SIP Resp Addr:Port : 10.0.99.111:5061
Destination Name : 10.0.99.111
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : g711alaw
Negotiated Codec Bytes : 80
Negotiated Dtmf-relay : 6
Dtmf-relay Payload : 101
Source IP Address (Media): 10.0.99.29
Source IP Port (Media): 18178
Destn IP Address (Media): 10.0.99.111
Destn IP Port (Media): 21538
Orig Destn IP Address:Port (Media): 0.0.0.0:0
*Sep 19 12:28:48.419: //17/012C5B20A7A9/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 16
Disconnect Cause (SIP) : 200
*Sep 19 12:28:48.423: //17/012C5B20A7A9/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 11
*Sep 19 12:28:48.423: //18/000000000000/SIP/Info/sipSPIValidateGtd: No rawMsg from CCAPI
*Sep 19 12:28:48.423: //18/000000000000/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:48.423: //18/000000000000/SIP/Info/sipSPIStopHoldTimer: Stopping hold timer
*Sep 19 12:28:48.423: //18/000000000000/SIP/Transport/sipSPISendBye: Sending BYE to the transport layer
*Sep 19 12:28:48.423: //18/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Global configuration, Switch Transport is FALSE
*Sep 19 12:28:48.423: //18/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x4654E2A0, addr=10.0.99.99, port=5060, sentBy_port=0, is_req=1, transport=1, switch=0, callBack=0x410872CC
*Sep 19 12:28:48.423: //18/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Sep 19 12:28:48.423: //18/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Sep 19 12:28:48.423: //18/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x4654E2A0
*Sep 19 12:28:48.423: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4654E2A0, addr=10.0.99.99, port=5060, connId=1 for UDP
*Sep 19 12:28:48.423: //18/000000000000/SIP/Info/sentByeDisconnecting: Sent Bye Request, starting DisconnectTimer
*Sep 19 12:28:48.423: //18/000000000000/SIP/State/sipSPIChangeState: 0x46278124 : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE)
*Sep 19 12:28:48.423: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.111:5061;rport;branch=z9hG4bK-3327884088-3792786178-436251047-2287060836
From: <sip:4996540000@10.0.99.111:5061;user=phone>;tag=513356033-3792786178-436251047-2287060836
To: <sip:4957815696@10.0.99.29;user=phone>;tag=10B508-12FA
Date: Wed, 19 Sep 2012 12:28:48 GMT
Call-ID: 01319946025311e2a7a9001a64c75188@10.0.99.111
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0
CSeq: 2 BYE
*Sep 19 12:28:48.427: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
BYE sip:0001124957815696@10.0.99.99:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK20206B
From: <sip:4996540000@10.0.99.29>;tag=10B528-2661
To: <sip:0001124957815696@10.0.99.99>;tag=1689190644-3792785922-436270253-3629041508
Date: Wed, 19 Sep 2012 12:27:15 GMT
Call-ID: 2E36A5D4-18C11E2-80138018-61678721@10.0.99.29
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
Timestamp: 1348057728
CSeq: 102 BYE
Content-Length: 0
*Sep 19 12:28:48.427: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 10.0.99.99:5060
*Sep 19 12:28:48.427: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x00000000
*Sep 19 12:28:48.427: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.99.29:5060;branch=z9hG4bK20206B
From: <sip:4996540000@10.0.99.29>;tag=10B528-2661
To: <sip:0001124957815696@10.0.99.99>;tag=1689190644-3792785922-436270253-3629041508
Call-ID: 2E36A5D4-18C11E2-80138018-61678721@10.0.99.29
CSeq: 102 BYE
Contact: <sip:0001124957815696@10.0.99.99:5060>
Server: MERA MVTS3G v.4.4.0-15
Content-Length: 0
*Sep 19 12:28:48.431: //18/000000000000/SIP/Info/sipSPIIcpifUpdate: CallState: 4 Playout: 0 DiscTime:118769 ConnTime 109916
*Sep 19 12:28:48.431: //18/000000000000/SIP/State/sipSPIChangeState: 0x46278124 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE)
*Sep 19 12:28:48.431: //18/000000000000/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x46278124
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 4996540000
Called Number : 0001124957815696
Source IP Address (Sig ): 10.0.99.29
Destn SIP Req Addr:Port : 10.0.99.99:5060
Destn SIP Resp Addr:Port : 10.0.99.99:5060
Destination Name : 10.0.99.99
*Sep 19 12:28:48.431: //18/000000000000/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : g711alaw
Negotiated Codec Bytes : 80
Negotiated Dtmf-relay : 6
Dtmf-relay Payload : 101
Source IP Address (Media): 10.0.99.29
Source IP Port (Media): 17106
Destn IP Address (Media): 10.0.99.121
Destn IP Port (Media): 18600
Orig Destn IP Address:Port (Media): 0.0.0.0:0
*Sep 19 12:28:48.431: //18/000000000000/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 16
Disconnect Cause (SIP) : 200
*Sep 19 12:28:48.431: //18/000000000000/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 12
Router#
*Sep 19 12:28:48.431: //18/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Sep 19 12:28:48.431: //18/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x46278124 key=2E36A5D4-18C11E2-80138018-61678721@10.0.99.29
*Sep 19 12:28:48.431: //18/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Sep 19 12:28:48.431: //18/012C5B20A7A9/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 46278124
In my previos discussion Danielle Giordany tried to help, but he disappeared.
May somebody help me in my situation? I give all needed additional information.
Kind regards,
Ellad Yatsko
- Labels:
-
Voice over IP
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
09-19-2012 10:15 AM
Hi Ellad.
Why don't try to use the 2811 as a SIP signalling proxy only?
In this way the media (RTP or T.38) will be handled only from the two MERA SoftSwitch.
To do this you must enable CUBE on your 2811 and use these special commands:
voice service voip
media flow-around
allow-connections sip to sip
signaling forward unconditional
sip
rel1xx disable
header-passing
midcall-signaling passthru
pass-thru headers unsupp
pass-thru content unsupp
pass-thru content sdp
I don't remember if we have already try this solution.
Regards.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
09-19-2012 09:41 PM
Hello Danielle!
I'm glad to see you! :-) Sure! I'll try it, but... It would be better if all traffic is handled by transit Cisco. On other hand we encounter error during FAX re-invite. That is during the signalling session, in't it? Or do I imagine the process incorrectly?
By the way, I tried this but some commands are not available. Cisco "swears". :-)
Kind regards,
Ellad Yatsko
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
10-03-2012 12:31 PM
Hi, im having a similar issue with T.38, what was the exact version of code that you upgraded to?
Thanks in advance,
Tom.....
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
10-03-2012 10:53 PM
Hello Tom!
We didn't try it with 2811, we got result on initial 1760 (see the similar topic for 1760). We upgraded on "voice" T-version. But I think "adventerprice" would be appropriate too. The only thing that memory requirements should be met.
Kind regards,
Ellad
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
09-20-2012 06:07 AM
Problem was resolved by upgrading IOS on T(est)-version.
In mainstream version SIP-to-SIP switchover in T.38 mode doesn't work.
Special thanks and glory to JTR!
Kind regards,
Ellad
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
09-23-2012 07:10 AM
The letter T in IOS filename does not means Test.
Whatever it means, it only designantes the new versions being release.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
09-23-2012 09:32 PM
The letter T in IOS filename does not means Test.
Whatver it means, it only designantes the new versions being release.
Hello Paolo!
It doesn't matter as you understand. Most importantly it works! :-) But it would be considerably more useful if you decrypt it for all who reads this topic. :-) Though... Nevermind! :-)
Kind regards,
Ellad
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
10-04-2012 04:51 AM
It used to to indicate Technology.
Discover and save your favorite ideas. Come back to expert answers, step-by-step guides, recent topics, and more.
New here? Get started with these tips. How to use Community New member guide