Call Trace - 183 Session Progress (F-6480)
In the call trace below, the 2020 IMG receives a 183 Session Progress message without SDP from egress or B leg of a call. The 180 Ringing Behavior field is set to 183 Session Progress w/SDP. The 183 Session Progress message is propagated and regenerated on the ingress or A leg of the call as a 183 Session Progress with SDP.
08:32:34.285 CALL(SIP) (00:00017:00) with Via sent-by: 10.129.47.141
08:32:34.285 CALL(SIP) (00:00017:00) Call-id: 1-4192@10.129.47.141
08:32:34.285 CALL(SIP) (00:00017:00) and Msg Size: 534
08:32:34.285 CALL(SIP) (00:00017:00)
---> [10.129.47.141, 5060]
INVITE sip:50885968@10.129.47.177:5060 SIP/2.0\r\n
Via: SIP/2.0/UDP 10.129.47.141:5060;branch=z9hG4bK-4192-
1-0\r\n
From: sipp <sip:sipp@10.129.47.141:5060>;tag=4192SIPpTag001\r\n
To: sut <sip:50885968@10.129.47.177:5060>\r\n
Call-ID: 1-4192@10.129.47.141\r\n
CSeq: 1 INVITE\r\n
Contact: sip:sipp@10.129.47.141:5060\r\n
Max-Forwards: 70\r\n
Subject: Performance Test\r\n
Content-Type: application/sdp\r\n
Content-Length: 135\r\n
\r\n
v=0\r\n
o=user1 53655765 2353687637 IN IP4 10.129.47.141\r\n
s=-\r\n
c=IN IP4 10.129.47.141\r\n
t=0 0\r\n
m=audio 6001 RTP/AVP 0\r\n
a=rtpmap:0 PCMU/8000
08:32:34.285 CALL(SIP) (00:00017:00) SENT 100 Trying to 10.129.47.141:5060
08:32:34.285 CALL(SIP) (00:00017:00)
<--- [10.129.47.141, 5060 <- 10.129.47.177, 5060]
SIP/2.0 100 Trying\r\n
Via: SIP/2.0/UDP 10.129.47.141:5060;branch=z9hG4bK-4192-1-0;received=10.129.47.141\r\n
Call-ID: 1-4192@10.129.47.141\r\n
From: sipp <sip:sipp@10.129.47.141:5060>;tag=4192SIPpTag001\r\n
To: sut <sip:50885968@10.129.47.177:5060>\r\n
CSeq: 1 INVITE\r\n
Content-Length: 0\r\n
\r\n
08:32:34.285 CALL(SIP) (00:00017:00) SENT Route Control to L4
08:32:34.285 CALL(L4) (00:00017:00) RCVD Route Control from SIP
08:32:34.285 CALL(L4) (00:00017:00) Accessing Route Table 2(m)
08:32:34.285 CALL(L4) (00:00017:00) Accessing Resource Table 149
08:32:34.285 CALL(L4) (00:00017:00) Hunting Algorithm is Round Robin
08:32:34.285 CALL(L4) (00:00017:00) SENT Route Control Ack to SIP
08:32:34.285 CALL(SIP) (00:00017:00) RCVD Route Control Ack from L4
08:32:34.285 CALL(SIP) (00:00017:00) Session Group Profile ID is 1
08:32:34.285 CALL(SIP) (00:00017:00) SENT Route Control to L4
08:32:34.285 CALL(L4) (00:00017:00) RCVD Route Control from SIP
08:32:34.285 CALL(L4) (00:00017:00) Accessing IP Bearer Profiles
08:32:34.285 CALL(L4) (00:00017:00) Profile Id 1 (RG 769)
08:32:34.285 CALL(SIP) (00:00017:00) RCVD Route Control Ack from L4
08:32:34.285 CALL(SIP) (00:00017:00) Checking if GW 1024(10.129.47.141:5060) is in blocking mode (0)
08:32:34.285 CALL(SIP) (00:00017:00) m line (audio) codec list: 0
08:32:34.285 CALL(SIP) (00:00017:00) RTP Type: 0, name: PCMU, clk: 8000
08:32:34.285 CALL(SIP) (00:00017:00) CODEC Negotiation Priority LOCAL
08:32:34.285 CALL(SIP) (00:00017:00) SRTP configuration Disabled
08:32:34.285 CALL(SIP) (00:00017:00) SDP Audio Codec Overlap Success
08:32:34.285 CALL(SIP) (00:00017:00) Local Media Capability is Audio Only
08:32:34.285 CALL(SIP) (00:00017:00) SENT iL3-L3 Reserve Resource Request to VPPL
08:32:34.285 CALL(VPP) (00:00017:00) RCVD Reserve Resource [its 22] from L3P
08:32:34.285 CALL(VPP) (00:00017:00) SENT Reserve Resource Request to CM
08:32:34.285 CALL(XCM) (00:00017:00) LTS:3478 Processing RESERVE request for xCM_PACKET_AUDIO_CHANNEL
08:32:34.285 CALL(XCM) (00:00017:00) SENT MEDAUDIO_MODM_CHAN_RESERVE_REQ chanType 1 groupId 0x1
08:32:34.285 CALL(XCM) (00:00017:00) LTS:3478 RCV :0x2f01(MEDAUDIO_MODM_CHAN_RESERVE_RESP) in state:xCM_CHANNEL_RESERVING
08:32:34.285 CALL(XCM) (00:00017:00) Sending message:0x2b17(XCM_CHANNEL_RESERVE_RSP), result=0x0
08:32:34.285 CALL(VPP) (00:00017:00) RCVD Reserve Resp from CM
08:32:34.285 CALL(VPP) (00:00017:00) SENT Reserve ACK (toPvid: x66) to L3P
08:32:34.285 CALL(SIP) (00:00017:00) RCVD Reserve Resource ACK from VPPL
08:32:34.285 CALL(SIP) (00:00017:00) 1: CPC (Default)
08:32:34.285 CALL(SIP) (00:00017:00) Leg 0 associated with hndl(21967), LTS(3478)(span 8208 chan 22)
08:32:34.285 CALL(SIP) (00:00017:00) SENT Setup to L4
08:32:34.295 CALL(L4) (00:00017:00) RCVD Setup Ind from SIP
08:32:34.295 CALL(L4) (00:00017:00)
08:32:34.295 CALL(L4) (00:00017:00) SENT RFS to GCL
08:32:34.295 CALL(GCL) (00:00017:00) RCVD RFS DN=[50885968] ANI=[] GN=[] from L4
08:32:34.295 CALL(GCL) (00:00017:00) DN NOA=[3]
08:32:34.295 CALL(GCL) (00:00017:00) Incoming Channel Group = 0 [SIP1]
08:32:34.295 CALL(L4) (00:00017:00) RCVD RFS response from GCL
08:32:34.295 CALL(GCL) (00:00017:00) SENT Make Call Request to GCL
08:32:34.295 CALL(GCL) (00:00017:01) SENT Route Control to L4
08:32:34.295 CALL(L4) (00:00017:00) RCVD Route Control from GCL
08:32:34.295 CALL(L4) (00:00017:00) Accessing Route Table 5
08:32:34.295 CALL(GCL) (00:00017:01) RCVD Route Control Ack (Mid Stream Router) from L4
08:32:34.295 CALL(GCL) (00:00017:01) Outgoing Channel Group = 1 [SIP2]
08:32:34.295 CALL(GCL) (00:00017:01) SENT Route Control to L4
08:32:34.295 CALL(L4) (00:00017:01) RCVD Route Control from GCL
08:32:34.295 CALL(L4) (00:00017:01) Accessing Resource Table 149
08:32:34.295 CALL(L4) (00:00017:01) Resource Group ID is 1
08:32:34.295 CALL(L4) (00:00017:01) Hunting Algorithm is Round Robin
08:32:34.295 CALL(GCL) (00:00017:01) RCVD CPE of ADDRESS INFO from L4
08:32:34.295 CALL(GCL) (00:00017:01) Leg 1 associated with LTS(3479)(span 8208 chan 23)
08:32:34.295 CALL(L4) (00:00017:01) SENT Outseize Ctrl to SIP
08:32:34.295 CALL(SIP) (00:00017:01) RCVD Outseize Ctrl from L4
08:32:34.295 CALL(SIP) (00:00017:01) SENT Route Control to L4
08:32:34.295 CALL(L4) (00:00017:01) RCVD Route Control from SIP
08:32:34.295 CALL(L4) (00:00017:01) Accessing GatewayId to IP Tables
08:32:34.295 CALL(L4) (00:00017:01) Gateway ID is 1025
08:32:34.295 CALL(SIP) (00:00017:01) RCVD Route Control Ack from L4
08:32:34.295 CALL(SIP) (00:00017:01) Session Group Profile ID is 1
08:32:34.295 CALL(SIP) (00:00017:01) SENT Route Control to L4
08:32:34.295 CALL(L4) (00:00017:01) RCVD Route Control from SIP
08:32:34.295 CALL(L4) (00:00017:01) Accessing IP Bearer Profiles
08:32:34.295 CALL(L4) (00:00017:01) Profile Id 1 (RG 769)
08:32:34.295 CALL(SIP) (00:00017:01) RCVD Route Control Ack from L4
08:32:34.295 CALL(SIP) (00:00017:01) Remote Media Capability is audio Only
08:32:34.295 CALL(SIP) (00:00017:01) Local Media Capability is Audio Only
08:32:34.295 CALL(SIP) (00:00017:01) SENT iL3-L3 Reserve Resource Request to VPPL
08:32:34.295 CALL(VPP) (00:00017:01) RCVD Reserve Resource [its 23] from L3P
08:32:34.295 CALL(VPP) (00:00017:01) SENT Reserve Resource Request to CM
08:32:34.305 CALL(XCM) (00:00017:01) LTS:3479 Processing RESERVE request for xCM_PACKET_AUDIO_CHANNEL
08:32:34.305 CALL(XCM) (00:00017:01) SENT MEDAUDIO_MODM_CHAN_RESERVE_REQ chanType 1 groupId 0x1
08:32:34.305 CALL(XCM) (00:00017:01) LTS:3479 RCV :0x2f01(MEDAUDIO_MODM_CHAN_RESERVE_RESP) in state:xCM_CHANNEL_RESERVING
08:32:34.305 CALL(XCM) (00:00017:01) Sending message:0x2b17(XCM_CHANNEL_RESERVE_RSP), result=0x0
08:32:34.305 CALL(VPP) (00:00017:01) RCVD Reserve Resp from CM
08:32:34.305 CALL(VPP) (00:00017:01) SENT Reserve ACK (toPvid: x66) to L3P
08:32:34.305 CALL(SIP) (00:00017:01) RCVD Reserve Resource ACK from VPPL
08:32:34.305 CALL(SIP) (00:00017:01) REM TP port=6060 transport:0
08:32:34.305 CALL(SIP) (00:00017:01) Remote media capabilities:Audio local media capabilities:Audio
08:32:34.305 CALL(SIP) (00:00017:01) SENT INVITE W/SDP to 10.129.47.141:6060 Cseq:1
08:32:34.305 CALL(SIP) (00:00017:01) with R-URI: 10.129.47.141:6060 UDP
08:32:34.305 CALL(SIP) (00:00017:01) and Call-id: 284e-d97-910201283234-Node0-0-10.129.47.177
08:32:34.305 CALL(SIP) (00:00017:01)
<--- [10.129.47.141, 6060 <- 10.129.47.177, 5060]
INVITE sip:50885968@10.129.47.141:6060 SIP/2.0\r\n
Via: SIP/2.0/UDP 10.129.47.177:5060;rport;branch=z9hG4bK-6795-1349857954-21966-178\r\n
Call-ID: 284e-d97-910201283234-Node0-0-10.129.47.177\r\n
CSeq: 1 INVITE\r\n
Max-Forwards: 70\r\n
To: "sut"<sip:50885968@10.129.47.141:6060>\r\n
From: "unavailable"<sip:unavailable@10.129.47.177>;tag=58e8025a0fa07a00f9bd9fc91ed98963c9cf3bc0\r\n
User-Agent: Dialogic-SIP/2.2.0.27 Node0 0\r\n
Privacy: none\r\n
Contact: <sip:unavailable@10.129.47.177:5060>\r\n
Allow: INVITE, BYE, REGISTER, ACK, OPTIONS, CANCEL, SUBS
CRIBE, NOTIFY, INFO, REFER, UPDATE\r\n
Supported: path, replaces, timer, tdialog\r\n
Session-Expires: 1800\r\n
Expires: 300\r\n
Organization: Dialogic\r\n
Content-Type: application/sdp\r\n
Content-Length: 168\r\n
\r\n
v=0\r\n
o=Dialogic_SDP 33 0 IN IP4 10.129.47.177\r\n
s=Dialogic-SIP\r\n
c=IN IP4 10.129.47.178\r\n
t=0 0\r\n
m=audio 12280 RTP/AVP 0\r\n
a=rtpmap:0 PCMU/8000\r\n
a=silenceSupp:off - - - -\r\n
Â
Relevant section
08:32:34.365 CALL(SIP) (00:00017:01) RCVD 183 Session Progress WO/SDP from 10.129.47.141:6060 udp CSeq:1 Msg Size:414
08:32:34.365 CALL(SIP) (00:00017:01)
---> [10.129.47.141, 6060 -> 10.129.47.177, 5060]
SIP/2.0 183 Session Progress\r\n
Via: SIP/2.0/UDP 10.129.47.177:5060;rport;branch=z9hG4bK-6795-1349857954-21966-178\r\n
From: "unavailable"<sip:unavailable@10.129.47.177>;tag=58e8025a0fa07a00f9bd9fc91ed98963c9cf3bc0\r\n
To: "sut"<sip:50885968@10.129.47.141:6060>;tag=4740SIPpTag011\r\n
Call-ID: 284e-d97-910201283234-Node0-0-10.129.47.177\r\n
CSeq: 1 INVITE\r\n
Contact: <sip:10.129.47.141:6060;transport=UDP>\r\n
Content-Length: 0\r\n
\r\n
08:32:34.365 CALL(SIP) (00:00017:01) SENT Outseize Ack to L4
08:32:34.365 CALL(SIP) (00:00017:01) SENT Progress to L4
08:32:34.365 CALL(SIP) (00:00017:01) RCVD 200 OK INVITE W/SDP from 10.129.47.141:6060 udp CSeq:1 Msg Size:570
08:32:34.365 CALL(SIP) (00:00017:01)
---> [10.129.47.141, 6060 -> 10.129.47.177, 5060]
SIP/2.0 200 OK\r\n
Via: SIP/2.0/UDP 10.129.47.177:5060;rport;branch=z9hG4bK-6795-1349857954-21966-178\r\n
From: "unavailable"<sip:unavailable@10.129.47.177>;tag=58e8025a0fa07a00f9bd9fc91ed98963c9cf3bc0\r\n
To: "sut"<sip:50885968@10.129.47.141:6060>;tag=4740SIPpTag011\r\n
Call-ID: 284e-d97-910201283234-Node0-0-10.129.47.177\r\n
CSeq: 1 INVITE\r\n
Contact: <sip:10.129.47.141:6060;transport=UDP>\r\n
Content-Type: application/sdp\r\n
Content-Length: 135\r\n
\r\n
v=0\r\n
o=user1 53655765 2353687637 IN IP4 10.129.47.141\r\n
s=-\r\n
c=IN IP4 10.129.47.141\r\n
t=0 0\r\n
m=audio 6000 RTP/AVP 0\r\n
a=rtpmap:0 PCMU/8000
08:32:34.365 CALL(SIP) (00:00017:01) Session Refresh is not Needed
08:32:34.365 CALL(SIP) (00:00017:01) SDP Audio Codec Overlap Success
08:32:34.365 CALL(SIP) (00:00017:01) SENT Connect to L4
08:32:34.365 CALL(SIP) (00:00017:01) SENT ACK WO/SDP to 10.129.47.141:6060 Cseq:1
08:32:34.365 CALL(SIP) (00:00017:01) with R-URI: 10.129.47.141:6060 UDP
08:32:34.365 CALL(SIP) (00:00017:01)
<--- [10.129.47.141, 6060 <- 10.129.47.177, 5060]
ACK sip:10.129.47.141:6060 SIP/2.0\r\n
Via: SIP/2.0/UDP 10.129.47.177:5060;rport;branch=z9hG4bK-56f7-1349857954-21966-178\r\n
Call-ID: 284e-d97-910201283234-Node0-0-10.129.47.177\r\n
CSeq: 1 ACK\r\n
Max-Forwards: 70\r\n
To: <sip:50885968@10.129.47.141:6060>;tag=4740SIPpTag011\r\n
From: <sip:unavailable@10.129.47.177>;tag=58e8025a0fa07a00f9bd9fc91ed98963c9cf3bc0\r\n
User-Agent: Dialogic-SIP/2.2.0.27 Node0 0\r\n
Content-Length: 0\r\n
\r\n
08:32:34.365 CALL(SIP) (00:00017:01) SENT CDR Msg Event to L4
08:32:34.365 CALL(SIP) (00:00017:01) Set audio media src IP 10.129.47.178:12280
08:32:34.365 CALL(SIP) (00:00017:01) Set audio media dst IP 10.129.47.141:6000
08:32:34.365 CALL(SIP) (00:00017:01) CODEC Negotiation Priority LOCAL
08:32:34.365 CALL(SIP) (00:00017:01) Set media PLD Size 20
08:32:34.365 CALL(SIP) (00:00017:01) Set media PLD ID 2
08:32:34.365 CALL(SIP) (00:00017:01) RFC 2833 DTMF Relay Disabled,method=0
08:32:34.365 CALL(SIP) (00:00017:01) Set Fax Type to Bypass
08:32:34.365 CALL(SIP) (00:00017:01) Source Port Validation : Enabled
08:32:34.365 CALL(SIP) (00:00017:01) Set media dst IP 10.129.47.141:(rtp:6000)
08:32:34.365 CALL(SIP) (00:00017:01) Set media PLD ID 2
08:32:34.365 CALL(SIP) (00:00017:01) SENT iL3-L3 Outseize Ctrl to VPPL
08:32:34.365 CALL(L4) (00:00017:01) RCVD Outseize ACK from SIP
08:32:34.365 CALL(L4) (00:00017:01) Set Call Answer Timeout : 180 sec
08:32:34.365 CALL(L4) (00:00017:01) RCVD Progress from SIP
08:32:34.365 CALL(L4) (00:00017:01) RCVD Connect from SIP
08:32:34.365 CALL(L4) (00:00017:01) SENT CDR Msg Event to GCL
08:32:34.365 CALL(GCL) (00:00017:01) RCVD CDR Msg Event from L4
08:32:34.365 CALL(GCL) (00:00017:00) SENT Connect w/Pad Response to L4
08:32:34.365 CALL(L4) (00:00017:01) SENT Progress to L4
08:32:34.365 CALL(L4) (00:00017:01) SENT CPE of ANSWER to GCL
08:32:34.365 CALL(L4) (00:00017:00) SENT Progress to SIP
08:32:34.365 CALL(L4) (00:00017:00) SENT Conn 1Way to xCM r_ts=0xd97,l_ts=0xd96
08:32:34.365 CALL(L4) (00:00017:00) SENT Channel Connect Req to xCM
08:32:34.365 CALL(L4) (00:00017:01) SENT Conn 1Way to xCM r_ts=0xd96,l_ts=0xd97
08:32:34.365 CALL(L4) (00:00017:01) SENT Channel Connect Req to xCM
08:32:34.365 CALL(SIP) (00:00017:01) RCVD Host Connect from L4
08:32:34.365 CALL(SIP) (00:00017:00) RCVD Progress from L4
08:32:34.365 CALL(VPP) (00:00017:01) RCVD Outseize [its 23] from L3P
08:32:34.365 CALL(VPP) (00:00017:01) SENT Channel Open Request to CM
08:32:34.365 CALL(SIP) (00:00017:00) Set audio media src IP 10.129.47.178:12272
08:32:34.365 CALL(SIP) (00:00017:00) Set audio media dst IP 10.129.47.141:6001
08:32:34.365 CALL(SIP) (00:00017:00) CODEC Negotiation Priority LOCAL
08:32:34.365 CALL(SIP) (00:00017:00) Set media PLD Size 20
08:32:34.365 CALL(XCM) (00:00017:00) XCM CONNECT request, channel in state xCM_CHANNEL_RESERVED, not ready, Postponing.
08:32:34.365 CALL(SIP) (00:00017:00) Set media PLD ID 2
08:32:34.365 CALL(XCM) (00:00017:01) XCM CONNECT request, channel in state xCM_CHANNEL_RESERVED, not ready, Postponing.
08:32:34.365 CALL(SIP) (00:00017:00) RFC 2833 DTMF Relay Disabled,method=0
08:32:34.365 CALL(SIP) (00:00017:00) Set Fax Type to Bypass
08:32:34.365 CALL(XCM) (00:00017:01) LTS:3479 Processing OPEN request
08:32:34.365 CALL(SIP) (00:00017:00) Source Port Validation : Enabled
08:32:34.365 CALL(XCM) (00:00017:01) SENT MEDAUDIO_MODM_CHAN_OPEN_REQ
08:32:34.365 CALL(SIP) (00:00017:00) Set media dst IP 10.129.47.141:(rtp:6001)
08:32:34.365 CALL(SIP) (00:00017:00) Set media PLD ID 2
08:32:34.365 CALL(AUD) (00:00017:01) RCVD OPEN REQ [ResID x1001056A; CID 1386; TransID 1401760352]
08:32:34.365 CALL(SIP) (00:00017:00) SENT iL3-L3 Outseize Ctrl to VPPL
08:32:34.365 CALL(GCL) (00:00017:01) RCVD CPE of ANSWER from L4
08:32:34.365 CALL(VPP) (00:00017:00) RCVD Outseize [its 22] from L3P
08:32:34.365 CALL(VPP) (00:00017:00) SENT Channel Open Request to CM
08:32:34.365 CALL(GCL) (00:00017:01) SENT Call Answered to GCL
08:32:34.365 CALL(XCM) (00:00017:00) LTS:3478 Processing OPEN request
08:32:34.365 CALL(XCM) (00:00017:00) SENT MEDAUDIO_MODM_CHAN_OPEN_REQ
08:32:34.365 CALL(AUD) (00:00017:00) RCVD OPEN REQ [ResID x10010540; CID 1344; TransID 1401724736]
08:32:34.365 CALL(GCL) (00:00017:00) SENT CPE of ANSWER to L4
08:32:34.365 CALL(L4) (00:00017:00) RCVD CPE of ANSWER from GCL
08:32:34.365 CALL(L4) (00:00017:00) SENT Connect to SIP
08:32:34.365 CALL(SIP) (00:00017:00) RCVD Connect from L4
08:32:34.415 CALL(AUD) (00:00017:00) SENT OPEN RESP [ResID x10010540; CID 1344; TransID 1401724736, SUCCESS]
08:32:34.415 CALL(AUD) (00:00017:01) SENT OPEN RESP [ResID x1001056A; CID 1386; TransID 1401760352, SUCCESS]
08:32:34.415 CALL(XCM) (00:00017:00) LTS:3478 RCV :0x2f05(MEDAUDIO_MODM_CHAN_OPEN_RESP) in state:xCM_CHANNEL_OPENING
08:32:34.415 CALL(XCM) (00:00017:00) Sending message:0x2b19(XCM_CHANNEL_OPEN_RSP), result=0x0
08:32:34.415 CALL(XCM) (00:00017:00) XCM CONNECT, channels not ready, Postponing.
08:32:34.415 CALL(XCM) (00:00017:01) LTS:3479 RCV :0x2f05(MEDAUDIO_MODM_CHAN_OPEN_RESP) in state:xCM_CHANNEL_OPENING
08:32:34.415 CALL(XCM) (00:00017:01) Sending message:0x2b19(XCM_CHANNEL_OPEN_RSP), result=0x0
08:32:34.415 CALL(XCM) (00:00017:01) XCM CONNECT, channels not ready, Postponing.
08:32:34.415 CALL(VPP) (00:00017:00) RCVD Open Resp from CM
08:32:34.415 CALL(VPP) (00:00017:00) SENT Event Register Request to CM
08:32:34.415 CALL(VPP) (00:00017:01) RCVD Open Resp from CM
08:32:34.415 CALL(VPP) (00:00017:01) SENT Event Register Request to CM
08:32:34.415 CALL(VPP) (00:00017:00) RCVD Event Register Resp from CM
08:32:34.415 CALL(VPP) (00:00017:00) SENT Channel Configure Request to CM
08:32:34.415 CALL(VPP) (00:00017:01) RCVD Event Register Resp from CM
08:32:34.415 CALL(VPP) (00:00017:01) SENT Channel Configure Request to CM
08:32:34.415 CALL(XCM) (00:00017:00) LTS:3478 Processing CONFIG request
08:32:34.415 CALL(XCM) (00:00017:00) SENT MEDAUDIO_MODM_CHAN_CONFIG_REQ
08:32:34.415 CALL(XCM) (00:00017:01) LTS:3479 Processing CONFIG request
08:32:34.415 CALL(XCM) (00:00017:01) SENT MEDAUDIO_MODM_CHAN_CONFIG_REQ
08:32:34.415 CALL(AUD) (00:00017:00) RCVD CONFIG REQ [ResID x10010540; CID 1344; TransID 1401540208]
08:32:34.415 CALL(AUD) (00:00017:01) RCVD CONFIG REQ [ResID x1001056A; CID 1386; TransID 945238432]
08:32:34.415 CALL(AUD) (00:00017:00) VoIP Codec is G711Mulaw (PT=0); Payload Size is 20 ms
08:32:34.415 CALL(AUD) (00:00017:01) VoIP Codec is G711Mulaw (PT=0); Payload Size is 20 ms
08:32:34.515 CALL(AUD) (00:00017:01) Silence Suppression has been DISABLED
08:32:34.515 CALL(AUD) (00:00017:01) Echo Cancellation has been ENABLED
08:32:34.515 CALL(AUD) (00:00017:01) RTP Redundancy has been DISABLED
08:32:34.515 CALL(AUD) (00:00017:01) DTMF Relay (RFC2833) has been DISABLED
08:32:34.515 CALL(AUD) (00:00017:01) Media Inactivity Detection is DISABLED
08:32:34.515 CALL(AUD) (00:00017:00) Silence Suppression has been DISABLED
08:32:34.515 CALL(AUD) (00:00017:00) Echo Cancellation has been ENABLED
08:32:34.515 CALL(AUD) (00:00017:00) RTP Redundancy has been DISABLED
08:32:34.515 CALL(AUD) (00:00017:00) DTMF Relay (RFC2833) has been DISABLED
08:32:34.515 CALL(AUD) (00:00017:00) Media Inactivity Detection is DISABLED
08:32:34.555 CALL(AUD) (00:00017:01) SENT CONFIG RESP [ResID x1001056A; CID 1386; TransID 945238432, SUCCESS]
08:32:34.555 CALL(AUD) (00:00017:00) SENT CONFIG RESP [ResID x10010540; CID 1344; TransID 1401540208, SUCCESS]
08:32:34.555 CALL(XCM) (00:00017:01) LTS:3479 RCV :0x2f0d(MEDAUDIO_MODM_CHAN_CONFIG_RESP) in state:xCM_CHANNEL_CONFIGURING
08:32:34.555 CALL(XCM) (00:00017:01) SENT MEDAUDIO_MODM_CHAN_ACTIVATE_REQ
08:32:34.555 CALL(XCM) (00:00017:00) LTS:3478 RCV :0x2f0d(MEDAUDIO_MODM_CHAN_CONFIG_RESP) in state:xCM_CHANNEL_CONFIGURING
08:32:34.555 CALL(XCM) (00:00017:00) SENT MEDAUDIO_MODM_CHAN_ACTIVATE_REQ
08:32:34.555 CALL(AUD) (00:00017:01) RCVD ACTIVATE REQ [ResID x1001056A; CID 1386; TransID 945238432]
08:32:34.555 CALL(AUD) (00:00017:01) Initial MID is DISABLED
08:32:34.555 CALL(AUD) (00:00017:00) RCVD ACTIVATE REQ [ResID x10010540; CID 1344; TransID 1401540208]
08:32:34.555 CALL(AUD) (00:00017:00) Initial MID is DISABLED
08:32:34.595 CALL(AUD) (00:00017:01) SENT ACTIVATE RESP [ResID x1001056A; CID 1386; TransID 945238432, SUCCESS]
08:32:34.595 CALL(AUD) (00:00017:00) SENT ACTIVATE RESP [ResID x10010540; CID 1344; TransID 1401540208, SUCCESS]
08:32:34.595 CALL(XCM) (00:00017:01) LTS:3479 RCV :0x2f09(MEDAUDIO_MODM_CHAN_ACTIVATE_RESP) in state:xCM_CHANNEL_CONFIGURING
08:32:34.595 CALL(XCM) (00:00017:01) Sending message:0x2b1d(XCM_CHANNEL_CONFIG_RSP), result=0x0
08:32:34.595 CALL(XCM) (00:00017:01) XCM CONNECT, channels now ready! Proceeding!
08:32:34.595 CALL(XCM) (00:00017:01) TSI connect audio channel: localGTS(xf47e), remoteGTS(xf454)
08:32:34.595 CALL(XCM) (00:00017:01) Sending message:0x2b28(XCM_CHANNEL_CONNECT_RSP), result=0x0
08:32:34.595 CALL(XCM) (00:00017:00) LTS:3478 RCV :0x2f09(MEDAUDIO_MODM_CHAN_ACTIVATE_RESP) in state:xCM_CHANNEL_CONFIGURING
08:32:34.595 CALL(XCM) (00:00017:00) Sending message:0x2b1d(XCM_CHANNEL_CONFIG_RSP), result=0x0
08:32:34.595 CALL(XCM) (00:00017:00) XCM CONNECT, channels now ready! Proceeding!
08:32:34.595 CALL(L4) (00:00017:01) RVCD Channel Connect Rsp from xCM
08:32:34.595 CALL(XCM) (00:00017:00) TSI connect audio channel: localGTS(xf454), remoteGTS(xf47e)
08:32:34.595 CALL(XCM) (00:00017:00) Sending message:0x2b28(XCM_CHANNEL_CONNECT_RSP), result=0x0
08:32:34.595 CALL(L4) (00:00017:00) RVCD Channel Connect Rsp from xCM
08:32:34.595 CALL(VPP) (00:00017:01) RCVD Channel Cfg Resp from CM
08:32:34.595 CALL(VPP) (00:00017:01) SENT Outseize ACK (toPvid: x66) to L3P
08:32:34.595 CALL(VPP) (00:00017:01) SENT CutThru to SIP
08:32:34.595 CALL(VPP) (00:00017:01) SENT Connect to SIP
08:32:34.595 CALL(SIP) (00:00017:01) RCVD Outseize Ack from VPPL
08:32:34.595 CALL(VPP) (00:00017:00) RCVD Channel Cfg Resp from CM
08:32:34.595 CALL(VPP) (00:00017:00) SENT Outseize ACK (toPvid: x66) to L3P
08:32:34.595 CALL(VPP) (00:00017:00) SENT CutThru to SIP
08:32:34.595 CALL(VPP) (00:00017:00) SENT Connect to SIP
08:32:34.595 CALL(SIP) (00:00017:01) RCVD Cut Thru from VPPL
08:32:34.595 CALL(SIP) (00:00017:01) RCVD Connect from VPPL
08:32:34.595 CALL(SIP) (00:00017:00) RCVD Outseize Ack from VPPL
08:32:34.595 CALL(SIP) (00:00017:00) Unsupported Header Relaying Disabled
Â
Relevant section