Skip to end of metadata
Go to start of metadata

You are viewing an old version of this page. View the current version.

Compare with Current View Page History

Version 1 Current »

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

08:32:34.595 CALL(SIP) (00:00017:00) SENT 183 Session Progress W/SDP to 10.129.47.141:5060 UDP
08:32:34.595 CALL(SIP) (00:00017:00)
                        <--- [10.129.47.141, 5060 <- 10.129.47.177, 5060]
                       SIP/2.0 183 Session Progress\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>;tag=e999eea9c63cb956897429d824080c904f75739f\r\n
                       Contact: <sip:50885968@10.129.47.177:5060>\r\n
                       CSeq: 1 INVITE\r\n
                       Allow: OPTIONS, CANCEL, UPDATE\r\n
                       Privacy: none\r\n
                       Server: Dialogic-SIP/2.2.0.27 Node0 0\r\n
                       Content-Type: application/sdp\r\n
                       Content-Length: 180\r\n
                       \r\n
                       v=0\r\n
                       o=Dialogic_SDP 32 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 12272 RTP/AVP 0\r\n
                       a=rtpmap:0 PCMU/8000\r\n
                       a=silenceSupp:off - - - -\r\n
                       a=ptime:20\r\n
08:32:34.595 CALL(SIP) (00:00017:00) RCVD Connect from L4
08:32:34.595 CALL(SIP) (00:00017:00) Unsupported Header Relaying Disabled
08:32:34.595 CALL(SIP) (00:00017:00) Session Refresh is not Needed
08:32:34.595 CALL(SIP) (00:00017:00) SENT 200 OK INVITE W/SDP to 10.129.47.141:5060 UDP
08:32:34.595 CALL(SIP) (00:00017:00)
                        <--- [10.129.47.141, 5060 <- 10.129.47.177, 5060]
                       SIP/2.0 200 OK\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>;tag=e999eea9c63cb956897429d824080c904f75739f\r\n
                       Contact: <sip:50885968@10.129.47.177:5060>\r\n
                       CSeq: 1 INVITE\r\n
                       Server: Dialogic-SIP/2.2.0.27 Node0 0\r\n
                       Allow: INVITE, BYE, REGISTER, ACK, OPTIONS, CANCEL, SUBS
                       CRIBE, NOTIFY, INFO, REFER, UPDATE\r\n
                       Supported: path, replaces, timer, tdialog\r\n
                       Accept: application/sdp, application/dtmf-relay, text/pl
                       ain\r\n
                       Content-Type: application/sdp\r\n
                       Content-Length: 180\r\n
                       \r\n
                       v=0\r\n
                       o=Dialogic_SDP 32 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 12272 RTP/AVP 0\r\n
                       a=rtpmap:0 PCMU/8000\r\n
                       a=silenceSupp:off - - - -\r\n
                       a=ptime:20\r\n
                        
08:32:34.595 CALL(SIP) (00:00017:00) RCVD Cut Thru from VPPL
08:32:34.595 CALL(SIP) (00:00017:00) RCVD Connect from VPPL
08:32:34.605 CALL(SIP) (00:00017:00) RCVD ACK from 10.129.47.141:5060 udp CSeq:1 Msg Size:403
08:32:34.605 CALL(SIP) (00:00017:00)      with Via sent-by: 10.129.47.141 udp
08:32:34.605 CALL(SIP) (00:00017:00)
                        ---> [10.129.47.141, 5060]
                       ACK 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-5\r\n
                       From: sipp <sip:sipp@10.129.47.141:5060>;tag=4192SIPpTag001\r\n
                       To: sut <sip:50885968@10.129.47.177:5060>;tag=e999eea9c63cb956897429d824080c904f75739f\r\n
                       Call-ID: 1-4192@10.129.47.141\r\n
                       CSeq: 1 ACK\r\n
                       Contact: sip:sipp@10.129.47.141:5060\r\n
                       Max-Forwards: 70\r\n
                       Subject: Performance Test\r\n
                       Content-Length: 0\r\n
                       \r\n
                        
08:32:54.605 CALL(SIP) (00:00017:00) RCVD BYE from 10.129.47.141:5060 udp CSeq:2 Msg Size:403
08:32:54.605 CALL(SIP) (00:00017:00)      with Via sent-by: 10.129.47.141 UDP
08:32:54.605 CALL(SIP) (00:00017:00)
                        ---> [10.129.47.141, 5060]
                       BYE 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-7\r\n
                       From: sipp <sip:sipp@10.129.47.141:5060>;tag=4192SIPpTag
                       001\r\n
                       To: sut <sip:50885968@10.129.47.177:5060>;tag=e999eea9c6
                       3cb956897429d824080c904f75739f\r\n
                       Call-ID: 1-4192@10.129.47.141\r\n
                       CSeq: 2 BYE\r\n
                       Contact: sip:sipp@10.129.47.141:5060\r\n
                       Max-Forwards: 70\r\n
                       Subject: Performance Test\r\n
                       Content-Length: 0\r\n
                       \r\n
                        
08:32:54.605 CALL(SIP) (00:00017:00) SENT iL3-L3 Clear Req to VPPL
08:32:54.605 CALL(VPP) (00:00017:00) RCVD Clear Request [its 22] from L3P
08:32:54.605 CALL(VPP) (00:00017:00) SENT Channel Close Request to CM
08:32:54.605 CALL(XCM) (00:00017:00) LTS:3478 Processing CLOSE request
08:32:54.605 CALL(XCM) (00:00017:00) SENT MEDAUDIO_MODM_CHAN_CLOSE_REQ
08:32:54.605 CALL(AUD) (00:00017:00) RCVD CLOSE REQ [ResID x10010540; CID 1344; TransID 945231968]
08:32:54.625 CALL(AUD) (00:00017:00) RTCP STATS: TxPackets=1003; RxPackets=0; lostPackets=0
08:32:54.625 CALL(AUD) (00:00017:00) SENT CLOSE RESP [ResID x10010540; CID 1344; TransID 945231968, SUCCESS]
08:32:54.625 CALL(XCM) (00:00017:00) LTS:3478 RCV :0x2f07(MEDAUDIO_MODM_CHAN_CLOSE_RESP) in state:xCM_CHANNEL_CLOSING
08:32:54.625 CALL(XCM) (00:00017:00) Sending message:0x2b1a(XCM_CHANNEL_CLOSE_RSP), result=0x0
08:32:54.625 CALL(VPP) (00:00017:00) RCVD Close Resp from CM
08:32:54.625 CALL(VPP) (00:00017:00) SENT Event DeRegister Request to CM
08:32:54.625 CALL(VPP) (00:00017:00) RCVD Event DeRegister Resp from CM
08:32:54.625 CALL(VPP) (00:00017:00) SENT ClearReq no data to SIP
08:32:54.625 CALL(SIP) (00:00017:00) RCVD Clear Req from VPPL
08:32:54.625 CALL(SIP) (00:00017:00) SENT iL3-L3 Unreserve Resource Request to VPPL
08:32:54.625 CALL(VPP) (00:00017:00) RCVD UnReserve Resource [its 22] from L3P
08:32:54.625 CALL(VPP) (00:00017:00) SENT UnReserve Resource Request to CM
08:32:54.625 CALL(XCM) (00:00017:00) LTS:3478 Processing UNRESERVE request
08:32:54.625 CALL(XCM) (00:00017:00) SENT MEDAUDIO_MODM_CHAN_UNRESERVE_REQ
08:32:54.625 CALL(XCM) (00:00017:00) Sending message:0x2b18(XCM_CHANNEL_UNRESERVE_RSP), result=0x0
08:32:54.625 CALL(AUD) (00:00017:00) RCVD UNRESERVE REQ [ResID x10010540; CID 1344; TransID 1401455504]
08:32:54.625 CALL(AUD) (00:00017:00) SENT UNRESERVE RESP [ResID x10010540; CID 1344; TransID 1401455504, SUCCESS]
08:32:54.625 CALL(VPP) (00:00017:00) RCVD UnReserve Resp from CM
08:32:54.625 CALL(VPP) (00:00017:00) SENT Unreserve ACK (toPvid: x66) to L3P
08:32:54.625 CALL(SIP) (00:00017:00) RCVD Unreserve Resource ACK from VPPL
08:32:54.625 CALL(SIP) (00:00017:00) SENT Clear Request to L4
08:32:54.625 CALL(SIP) (00:00017:00) Unsupported Header Relaying Disabled
08:32:54.625 CALL(SIP) (00:00017:00) SENT 200 OK BYE to 10.129.47.141:5060 UDP
08:32:54.625 CALL(SIP) (00:00017:00)
                        <--- [10.129.47.141, 5060 <- 10.129.47.177, 5060]
                       SIP/2.0 200 OK\r\n
                       Via: SIP/2.0/UDP 10.129.47.141:5060;branch=z9hG4bK-4192-
                       1-7;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>;tag=e999eea9c63cb956897429d824080c904f75739f\r\n
                       CSeq: 2 BYE\r\n
                       Server: Dialogic-SIP/2.2.0.27 Node0 0\r\n
                       Content-Length: 0\r\n
                       \r\n
                        
08:32:54.625 CALL(L4)  (00:00017:00) RCVD Clear request  from SIP
08:32:54.625 CALL(L4)  (00:00017:00) SENT Disconnect to xCM r_ts=0xd97,l_ts=0xd96
08:32:54.625 CALL(L4)  (00:00017:00) SENT Channel Disconnect Req to xCM
08:32:54.625 CALL(L4)  (00:00017:01) SENT Disconnect to xCM r_ts=0xd96,l_ts=0xd97
08:32:54.625 CALL(L4)  (00:00017:01) SENT Channel Disconnect Req to xCM
08:32:54.625 CALL(L4)  (00:00017:00) SENT Channel Release w/data to GCL
08:32:54.625 CALL(GCL) (00:00017:00) RCVD Channel Released w/data, cause=16 from L4
08:32:54.625 CALL(GCL) (00:00017:00) Call Duration(sec): 20
08:32:54.625 CALL(GCL) (00:00017:00) SENT Clear Call Request to GCL
08:32:54.625 CALL(GCL) (00:00017:01) SENT Clear Response, cause=16 to L4
08:32:54.625 CALL(L4)  (00:00017:01) RCVD Clear, cause=16 from GCL
08:32:54.625 CALL(L4)  (00:00017:01) SENT Clear Request, cause=16 to SIP
08:32:54.625 CALL(XCM) (00:00017:01) LTS:3479 Processing DISCONNECT request
08:32:54.625 CALL(XCM) (00:00017:01) TSI disconnect audio channel: localGTS(xf47e), remoteGTS(xf454)
08:32:54.625 CALL(L4)  (00:00017:00) RVCD Channel Disconnect Rsp  from xCM
08:32:54.625 CALL(XCM) (00:00017:01) Sending message:0x2b29(XCM_CHANNEL_DISCONNECT_RSP), result=0x0
08:32:54.625 CALL(L4)  (00:00017:01) RVCD Channel Disconnect Rsp  from xCM
08:32:54.625 CALL(SIP) (00:00017:01) RCVD Clear Request from L4
08:32:54.625 CALL(SIP) (00:00017:01) Unsupported Header Relaying Disabled
08:32:54.625 CALL(SIP) (00:00017:01) Reason Hdr: "Normal call clearing"
08:32:54.625 CALL(SIP) (00:00017:01) SENT BYE to 10.129.47.141:6060 Cseq:2
08:32:54.625 CALL(SIP) (00:00017:01)      with R-URI: 10.129.47.141:6060 UDP
08:32:54.625 CALL(SIP) (00:00017:01)
                        <--- [10.129.47.141, 6060 <- 10.129.47.177, 5060]
                       BYE sip:10.129.47.141:6060 SIP/2.0\r\n
                       Via: SIP/2.0/UDP 10.129.47.177:5060;rport;branch=z9hG4bK-63eb-1349857974-21966-178\r\n
                       Call-ID: 284e-d97-910201283234-Node0-0-10.129.47.177\r\n
                         
                       CSeq: 2 BYE\r\n
                       Max-Forwards: 70\r\n
                       To: "sut"<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
                       Reason: SIP ;cause=16 ;text="Normal call clearing"\r\n
                       Privacy: none\r\n
                       Content-Length: 0\r\n
                       \r\n
                        
08:32:54.645 CALL(SIP) (00:00017:01) RCVD 200 OK BYE from 10.129.47.141:6060 udp CSeq:2 Msg Size:384
08:32:54.645 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-63eb-1349857974-21966-178\r\n
                       From: <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: 2 BYE\r\n
                       Contact: <sip:10.129.47.141:6060;transport=UDP>\r\n
                       Content-Length: 0\r\n
                       \r\n
                        
08:32:54.645 CALL(SIP) (00:00017:01) SENT iL3-L3 Clear Req to VPPL
08:32:54.645 CALL(VPP) (00:00017:01) RCVD Clear Request [its 23] from L3P
08:32:54.645 CALL(VPP) (00:00017:01) SENT Channel Close Request to CM
08:32:54.645 CALL(XCM) (00:00017:01) LTS:3479 Processing CLOSE request
08:32:54.645 CALL(XCM) (00:00017:01) SENT MEDAUDIO_MODM_CHAN_CLOSE_REQ
08:32:54.645 CALL(AUD) (00:00017:01) RCVD CLOSE REQ [ResID x1001056A; CID 1386; TransID 1245893968]
08:32:54.675 CALL(AUD) (00:00017:01) RTCP STATS: TxPackets=1006; RxPackets=0; lostPackets=0
08:32:54.675 CALL(AUD) (00:00017:01) SENT CLOSE RESP [ResID x1001056A; CID 1386; TransID 1245893968, SUCCESS]
08:32:54.675 CALL(XCM) (00:00017:01) LTS:3479 RCV :0x2f07(MEDAUDIO_MODM_CHAN_CLOSE_RESP) in state:xCM_CHANNEL_CLOSING
08:32:54.675 CALL(XCM) (00:00017:01) Sending message:0x2b1a(XCM_CHANNEL_CLOSE_RSP), result=0x0
08:32:54.675 CALL(VPP) (00:00017:01) RCVD Close Resp from CM
08:32:54.675 CALL(VPP) (00:00017:01) SENT Event DeRegister Request to CM
08:32:54.675 CALL(VPP) (00:00017:01) RCVD Event DeRegister Resp from CM
08:32:54.675 CALL(VPP) (00:00017:01) SENT ClearReq no data to SIP
08:32:54.675 CALL(SIP) (00:00017:01) RCVD Clear Req from VPPL
08:32:54.675 CALL(SIP) (00:00017:01) SENT iL3-L3 Unreserve Resource Request to VPPL
08:32:54.675 CALL(VPP) (00:00017:01) RCVD UnReserve Resource [its 23] from L3P
08:32:54.675 CALL(VPP) (00:00017:01) SENT UnReserve Resource Request to CM
08:32:54.675 CALL(XCM) (00:00017:01) LTS:3479 Processing UNRESERVE request
08:32:54.675 CALL(XCM) (00:00017:01) SENT MEDAUDIO_MODM_CHAN_UNRESERVE_REQ
08:32:54.675 CALL(XCM) (00:00017:01) Sending message:0x2b18(XCM_CHANNEL_UNRESERVE_RSP), result=0x0
08:32:54.675 CALL(AUD) (00:00017:01) RCVD UNRESERVE REQ [ResID x1001056A; CID 1386; TransID 1401465216]
08:32:54.675 CALL(AUD) (00:00017:01) SENT UNRESERVE RESP [ResID x1001056A; CID 1386; TransID 1401465216, SUCCESS]
08:32:54.675 CALL(VPP) (00:00017:01) RCVD UnReserve Resp from CM
08:32:54.675 CALL(VPP) (00:00017:01) SENT Unreserve ACK (toPvid: x66) to L3P
08:32:54.675 CALL(SIP) (00:00017:01) RCVD Unreserve Resource ACK from VPPL
08:32:54.675 CALL(SIP) (00:00017:01) SENT Clear Request to L4
08:32:54.675 CALL(L4)  (00:00017:01) RCVD Clear request  from SIP
08:32:54.675 CALL(L4)  (00:00017:01) SENT Channel Release w/data to GCL
08:32:54.675 CALL(GCL) (00:00017:01) RCVD Channel Released w/data, cause=16 from L4
08:32:54.675 CALL(GCL) (00:00017:01) Call Duration(sec): 20
  • No labels