Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

  • Congratulations Chris Miller on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

Avaya Communicator Audio 2

Status
Not open for further replies.

rsv23

Systems Engineer
Feb 13, 2019
243
PH
did any one of you experience this? Avaya communicator to avaya communicator calling, they can't hear each other?

But Avaya communicator to ip phones works and also, Avaya communicator to other softphone (jitsi) works.

Any config that is missed?

 
Both avaya communicator connected via VPN.
 
There's an instance that the audio is one way. The caller can hear us but we can't hear them.
 
Sorry Derfloh, but how and where can found the SDP?

Thanks
 
is this the correct logs:

================= GLOBAL RTP RELAY STATISTICS =================

Total received IP frames : 13724013
Total received UDP frames : 10863372
Total received loopback UDP frames : 0
Total found relay sessions : 8905860
Total remapped tos byte for voip media : 634655
Total remotely forwarded frames : 0
Total locally forwarded frames : 0
Total remotely forwarded recorded frames : 0
Total locally forwarded recorded frames : 0
Total not ready for fast path frames : 2564
Total forwarded fast path frames : 8903145
Total dropped filtered frames : 0
Total dropped source unresolved frames : 0
Total dropped dest unresolved frames : 0
Total dropped ok frames : 0
Total dropped recorded ok frames : 0
Total dropped l2 header unresolved : 0
Total dropped fast path frames : 0
Total detected RFC2833 frames : 892
Total keep alive initial forwarded frames : 0
Total keep alive initial dropped frames : 0
Total keep alive periodic forwarded frames : 0
Total keep alive periodic dropped frames : 0
Total unmatched late bound streams : 0
Total number of late bind. resolved streams: 0
Total number of open sessions : 0
Total number of open recording sessions : 0
Total number of active streams : 0
 
See below logs


1539694969mS SIP Call Tx: phone
SIP/2.0 180 Ringing
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK4_146b44f8-1aa483ff72ff7902_I1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 INVITE
Contact: "Jane ACW" <sip:1030@10.10.12.5:5060;transport=tcp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
P-Asserted-Identity: "Jane ACW" <sip:1030@10.10.12.5:5060>
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Content-Length: 0

1539695839mS PRN: Monitor Status IP 500 V2 11.0.0.0.0 build 849
1539695840mS PRN: LAW=A PRI=0, BRI=2, ALOG=4, VCOMP=42, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=5 VMAIL=1(VER=3 TYP=1) 1-X=0 CALLS=1(TOT=1298)
1539697216mS SIP Call Rx: phone
SIP/2.0 200 OK
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 INVITE
Via: sip/2.0/tcp 10.10.12.5:5060;rport;branch=z9hG4bK75ab461998333b1baefeab52848d6402
Contact: <sip:1030@10.212.134.202:56827;transport=tcp>
Allow: INVITE,CANCEL,BYE,ACK,SUBSCRIBE,NOTIFY,MESSAGE,INFO,PUBLISH,REFER,UPDATE,PRACK
Accept-Language: en
P-Conference: OutdialPrompt=false, FeedbackPrompts=false
Content-Type: application/sdp
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.19; Windows NT 6.2, 64-bit)
Supported: replaces
Content-Length: 326

v=0
o=sip:1030@10.212.134.202 1 10 IN IP4 10.212.134.202
s=sip:1030@10.212.134.202
c=IN IP4 10.212.134.202
b=TIAS:64000
t=0 0
a=activetalker
m=audio 5004 RTP/AVP 8 0 18 101
b=TIAS:64000
a=rtpmap:8 PCMA/8000/1
a=rtpmap:0 PCMU/8000/1
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000/1
1539697218mS SIP Call Tx: phone
ACK sip:1030@10.212.134.202:56827;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.10.12.5:5060;rport;branch=z9hG4bK126a5dc6183975715e49cd274a088bd5
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: "Jane ACW" <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 11.0.0.0.0 build 849
Content-Length: 0

1539697219mS CMExtnRx: v=1030, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
Called[Robel ACW] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
IE CMIEFastStartInfoData (6) 6 item(s)
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 2 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 6 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 3 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
CMFastStartElement lc_num = 2 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
1539697220mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessInboundMsg, set incoming_leg to false
1539697220mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessInboundMsg, was_connected set
1539697221mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=T CMCSRinging->CMCSConnReq
1539697221mS CMCallEvt: 0000000000000000 0.7454.0 1298 TargetingEP: RequestEnd 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0
1539697221mS CMCallEvt: 0000000000000000 0.7454.0 -1 BaseEP: DELETE CMEndpoint f16d3f40 TOTAL NOW=2 CALL_LIST=1
1539697221mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: SetLocalTone CMLocalToneNone->CMLocalToneCutThru
1539697222mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange to CMLocalTonePending SSOperationInProgress 0 MEDIA_FLAG_ACC_ENTRY 0
1539697223mS CMExtnEvt: v=0 State, new=Connected old=Ringing,0,0,Jane ACW
1539697223mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSRingBack->CMCSOGConnReq
1539697224mS CMExtnEvt: v=0 State, new=Connected old=Alerting,0,0,Robel ACW
1539697224mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneNone play_tapi_moh 0
1539697225mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneNone)->CMLocalToneDirectMedia, other side's media handler is not changed (lcmh) renego 0
1539697225mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: LCMH PlayLocalTone CMLocalToneCutThru (current CMLocalToneDirectMedia, prev CMLocalToneNone) parent state CMCSConnReq action 1 reneg 0 voip_neg->proc_inb 1
1539697226mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: LCMH Tone CMLocalToneDirectMedia(CMLocalToneNone)->CMLocalToneDirectMedia, other side's media handler is not changed (lcmh) renego 0
1539697227mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 2->2
1539697227mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 6->6
1539697227mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: Create session id 1 active 1
1539697228mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: SetLocalState LCFSInitialize -> LCMediaConnected
1539697229mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697230mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneRingBack play_tapi_moh 0
1539697231mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: CheckEmptyReInviteProcedureOnMHChanged empty_invite_outgoing = <EINotStarted>
1539697231mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneNone)->CMLocalToneDirectMedia, other side's media handler is changed (lcmh) renego 0
1539697231mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneCutThru (current CMLocalToneDirectMedia, prev CMLocalToneNone) parent state CMCSOGConnReq action 1 reneg 0 voip_neg->proc_inb 0
1539697232mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697232mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: PlayPendingLocalTone lcmh_media_handler_changed is still true...
1539697232mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneCutThru (current CMLocalToneDirectMedia, prev CMLocalToneDirectMedia) parent state CMCSOGConnReq action 1 reneg 0 voip_neg->proc_inb 0
1539697233mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: PlayPendingLocalTone lcmh_media_handler_changed is still true...
1539697233mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: RearrangeFSProposal 2->2
1539697235mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: IsRenegoFSCompatible: choose a common cap 8
1539697235mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: Create session id 1 active 1
1539697236mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: UnsetLcmhChanged other_mh f1664ff8 lcmh 1
1539697236mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: SetLocalState LCFSResponse -> LCMediaConnected
1539697237mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697237mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697239mS CMExtnTx: v=1031, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
Called[Robel ACW] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
CMFastStartElement lc_num = 1 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
IE CMIEFastStartInfoData (6) 6 item(s)
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 2 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 6 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 3 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
CMFastStartElement lc_num = 2 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Jane ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Jane ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1030
IE CMIEDeviceDetail (231) 0a0a0c0500001d1f LOCALE=aru HW=15 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110000 rx_gain=32 tx_gain=32
ep_callid=7455 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x10 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
ConnectedName.Invoke.CodePageISO8859-1
invokeId 15104
user 'Jane ACW' presentation Allowed
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7) {
lc_num = 1 AUDIO_G711_ALAW64K
lc_num = 2 AUDIO_G711_ULAW64K
lc_num = 3 AUDIO_G729_A
lc_num = 4 AUDIO_G729
lc_num = 5 AUDIO_G729_WB
lc_num = 6 AUDIO_G729_AWB
lc_num = 7 AUDIO_G7231
}
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7) {
lc_num = 1 AUDIO_G711_ALAW64K
lc_num = 2 AUDIO_G711_ULAW64K
lc_num = 3 AUDIO_G729_A
lc_num = 4 AUDIO_G729
lc_num = 5 AUDIO_G729_WB
lc_num = 6 AUDIO_G729_AWB
lc_num = 7 AUDIO_G7231
}
}
Timed: 13/04/20 13:42
1539697241mS SIP Call Tx: phone
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK4_146b44f8-1aa483ff72ff7902_I1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 INVITE
Contact: "Jane ACW" <sip:1030@10.10.12.5:5060;transport=tcp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
P-Asserted-Identity: "Jane ACW" <sip:1030@10.10.12.5:5060>
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Content-Type: application/sdp
Content-Length: 207

v=0
o=UserA 1624881862 3409257323 IN IP4 10.212.134.202
s=Session SDP
c=IN IP4 10.212.134.202
t=0 0
m=audio 5004 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
1539697242mS CMExtnRx: v=1031, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
1539697242mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSOGConnReq->CMCSConnected
1539697243mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=B CMCSConnReq->CMCSConnected
1539697245mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697246mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697246mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 2->2
1539697247mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessOutboundFastStart LCMediaConnected --- caps_fs 0 caps_sec 0
1539697247mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: OnRenegotiate to stack in local LCRIdle, remote LCRIdle, pause is 0 (fs f166e970, size 2), renego 1 mh_ch 0 relay 0 resp 0 stream_ch 0 sec_ch 0 dtmf_ch 0 t38_shuff 0
1539697248mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: IsRenegoFSCompatible: choose a common cap 8
1539697249mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessOutboundFastStart, respond 0 responded 0 forward 0 other_waits_for_response 0
1539697249mS CMExtnTx: v=1030, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
Timed: 13/04/20 13:42
1539697250mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697251mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: CMVoipNegotiator::processOutboundFastStart, out1
1539697251mS CMExtnTx: v=1030, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1031
IE CMIEDeviceDetail (231) 0a0a0c0500001d1d LOCALE=aru HW=15 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110020 rx_gain=32 tx_gain=32
ep_callid=7453 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
Timed: 13/04/20 13:42
1539697251mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: ProcessOutboundMsg, was_connected set
1539697762mS SIP Call Rx: phone
ACK sip:1030@10.10.12.5:5060;transport=tcp SIP/2.0
From: sip:1031@10.10.12.5;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 ACK
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK189f7080_146b513c45a6042572ff8d50_A1031
Content-Length: 0
Max-Forwards: 70
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.30; Windows NT 6.2, 64-bit)
Supported: eventlist, 100rel, replaces, vnd.avaya.ipo

1539698065mS DTM: 13/04/2020 13:42:28 (Mon 13 Apr 2020) [10.10.12.5 (Unified Dubai)]
1539705753mS SIP Call Rx: phone
BYE sip:1030@10.10.12.5:5060;transport=tcp SIP/2.0
From: sip:1031@10.10.12.5;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 5 BYE
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK1e9fad70_146b707c43bb834572ffa4a2_B1031
Content-Length: 0
Max-Forwards: 70
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.30; Windows NT 6.2, 64-bit)
Supported: eventlist, 100rel, replaces, vnd.avaya.ipo

1539705755mS SIP Call Tx: phone
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK1e9fad70_146b707c43bb834572ffa4a2_B1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 5 BYE
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Content-Length: 0
 
Hi defloh, please see below full logs:


********** Warning: Logging to Screen Started **********
1539694622mS SIP Call Rx: phone
INVITE sip:1030@10.10.12.5 SIP/2.0
From: sip:1031@10.10.12.5;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
To: sip:1030@10.10.12.5
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 INVITE
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK4_146b44f8-1aa483ff72ff7902_I1031
Content-Length: 449
Max-Forwards: 70
Contact: <sip:1031@10.212.134.201:58941;transport=tcp>
Accept-Language: en
Allow: INVITE,CANCEL,BYE,ACK,SUBSCRIBE,NOTIFY,MESSAGE,INFO,PUBLISH,REFER,UPDATE,PRACK
P-Conference: OutdialPrompt=false, FeedbackPrompts=false
Content-Type: application/sdp
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.30; Windows NT 6.2, 64-bit)
Supported: eventlist, 100rel, replaces, vnd.avaya.ipo

v=0
o=sip:1031@10.212.134.201 1 5 IN IP4 10.212.134.201
s=sip:1031@10.212.134.201
c=IN IP4 10.212.134.201
b=TIAS:64000
t=0 0
a=activetalker
m=audio 5010 RTP/AVP 103 9 18 8 0 110 101 13 121
b=TIAS:64000
a=rtpmap:103 ISAC/16000/1
a=rtpmap:9 G722/8000/1
a=rtpmap:18 G729/8000/1
a=rtpmap:8 PCMA/8000/1
a=rtpmap:0 PCMU/8000/1
a=rtpmap:110 G726-32/8000/1
a=rtpmap:101 telephone-event/8000/1
a=rtpmap:13 CN/8000/1
a=rtpmap:121 CN/16000/1
1539694623mS CMCallEvt: 0000000000000000 0.7453.0 -1 BaseEP: NEW CMEndpoint f4f7b1bc TOTAL NOW=1 CALL_LIST=0
1539694623mS CMCallEvt: 0000000000000000 0.7453.0 -1 Robel ACW.-1: NEW CMExtnEndpoint f4f7b1bc, Name=Robel ACW, Extn=1031, Phys Extn=1031
1539694624mS CH : CHand::AllocateIPConnectionPoint cp[927]b0r0[TOTAL CP:110]
1539694625mS CMCallEvt: CREATE CALL:1298 (f1692774)
1539694625mS CMCallEvt: 0000000000000000 0.7454.0 -1 BaseEP: NEW CMEndpoint f16d3f40 TOTAL NOW=2 CALL_LIST=0
1539694627mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: SetLocalTone CMLocalToneNone->CMLocalToneCutThru
1539694627mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneUnCut active=CMLocalToneNone play_tapi_moh 0
1539694628mS CMExtnEvt: Robel ACW: CMExtnHandler::SetCurrent( id: 0->7453 )
1539694629mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneUnCut active=CMLocalToneNone play_tapi_moh 0
1539694629mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneNone)->CMLocalToneUnCut, other side's media handler is not changed (not lcmh) renego 0
1539694629mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneUnCut (current CMLocalToneUnCut, prev CMLocalToneNone) parent state CMCSIdle action 1 reneg 0 voip_neg->proc_inb 0
1539694632mS SIP Call Tx: phone
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK4_146b44f8-1aa483ff72ff7902_I1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>
Content-Length: 0

1539694635mS CMExtnRx: v=1031, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
Called[1030] Type=Default (100) Reason=CMDRdirect SndComp Calling[1031] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1031
IE CMIEFastStartInfoData (6) 6 item(s)
CMFastStartElement lc_num = 1 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5010 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5011 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 2 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5010 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5011 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 3 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 4 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 5 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 6 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
1539694635mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: ProcessInboundMsg, set incoming_leg to true
1539694636mS CH : CP::SetMediaCallback cp[927]b0r0 to f5f18ec4
1539694636mS CH : CP::SetOutboundDTMFCallback cp[927]b0r0 to 0
1539694636mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: InitDtmf
1539694636mS MH : <InitDtmf> dtmf: oob 0 rfc2833 1 txp 101 rxp 101 misc 0 (hidden oob 0 hidden rfc2833 0 prio oob 0 prio rfc2833 0)
1539694636mS CH : CP::SetOutboundDTMFCallback cp[927]b0r0 to 0
1539694636mS CH : CP::SetInboundDTMFCallback cp[927]b0r0 to f5f2811c
1539694637mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
1539694637mS CMExtnEvt: v=0 State, new=Dialling old=Idle,0,0,Robel ACW
1539694637mS CMCallEvt: 0000000000000000 0.7455.0 -1 BaseEP: NEW CMEndpoint f165c264 TOTAL NOW=3 CALL_LIST=1
1539694638mS CMCallEvt: 0000000000000000 0.7455.0 -1 Jane ACW.-1: NEW CMExtnEndpoint f165c264, Name=Jane ACW, Extn=1030, Phys Extn=1030
1539694638mS CH : CHand::AllocateIPConnectionPoint cp[928]b0r0[TOTAL CP:111]
1539694640mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSDialInitiated->CMCSDialled
1539694641mS CMExtnEvt: v=0 State, new=Proceeding old=Dialling,0,0,Robel ACW
1539694641mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneNone active=CMLocalToneUnCut play_tapi_moh 0
1539694641mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneUnCut(CMLocalToneUnCut)->CMLocalToneNone, other side's media handler is not changed (not lcmh) renego 0
1539694642mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneNone (current CMLocalToneNone, prev CMLocalToneUnCut) parent state CMCSDialled action 1 reneg 0 voip_neg->proc_inb 1
1539694642mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneUnCut)->CMLocalToneNone, other side's media handler is not changed (not lcmh) renego 0
1539694643mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: RearrangeFSProposal 6->6
1539694643mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: SetLocalState LCIdle -> LCFSResponse
1539694644mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: CMVoipNegotiator::processOutboundFastStart, out1
1539694644mS CMExtnTx: v=1031, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
Timed: 13/04/20 13:42
1539694644mS CMCallEvt: 0000000000000000 0.7454.0 1298 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
1539694645mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=T CMCSIdle->CMCSOffering
1539694646mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessOutboundMsg, set incoming_leg to false
1539694646mS CH : CP::SetMediaCallback cp[928]b0r0 to f5efcc1c
1539694646mS CH : CP::SetOutboundDTMFCallback cp[928]b0r0 to 0
1539694646mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: InitDtmf
1539694646mS MH : <InitDtmf> dtmf: oob 0 rfc2833 1 txp 101 rxp 101 misc 0 (hidden oob 0 hidden rfc2833 0 prio oob 0 prio rfc2833 0)
1539694646mS CH : CP::SetOutboundDTMFCallback cp[928]b0r0 to 0
1539694647mS CH : CP::SetInboundDTMFCallback cp[928]b0r0 to f5f1ba98
1539694647mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: InitOtherLcmh other_mh_lcmh 1 is lcmh 1
1539694648mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 6->6
1539694648mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: SetLocalState LCIdle -> LCFSInitialize
1539694649mS CMExtnEvt: Jane ACW: CMExtnHandler::SetCurrent( id: 0->7455 )
1539694649mS CMExtnTx: v=1030, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
Called[1030] Type=Default (100) Reason=CMDRdirect SndComp Calling[1031] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1031
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Robel ACW
IE CMIEDeviceDetail (231) 0a0a0c0500001d1d LOCALE=aru HW=15 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110020 rx_gain=32 tx_gain=32
ep_callid=7453 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIECalledPartyName (224)(Type=CMNameInternalUser) name=Jane ACW
IE CMIECalledPartyKName (225)(Type=CMNameDefault) name=Jane ACW
IE CMIECallingPartyName (110)(Type=CMNameInternalUser) name=Robel ACW
IE CMIECallingPartyKName (226)(Type=CMNameDefault) name=Robel ACW
IE CMIEDIDNumber (245)(P:100 S:100 T:100 N:100 R:4) number=1030
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESimultTargeting (199) targeting flags 8 CALLED_SIM
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 15102
user 'Robel ACW' presentation Allowed
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIEFastStartInfoData (6) 6 item(s)
CMFastStartElement lc_num = 3 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5010 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5011 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5010 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.201 port 5011 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 5 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 6 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
CMFastStartElement lc_num = 2 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7) {
lc_num = 1 AUDIO_G711_ALAW64K
lc_num = 2 AUDIO_G711_ULAW64K
lc_num = 3 AUDIO_G729_A
lc_num = 4 AUDIO_G729
lc_num = 5 AUDIO_G729_WB
lc_num = 6 AUDIO_G729_AWB
lc_num = 7 AUDIO_G7231
}
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7) {
lc_num = 1 AUDIO_G711_ALAW64K
lc_num = 2 AUDIO_G711_ULAW64K
lc_num = 3 AUDIO_G729_A
lc_num = 4 AUDIO_G729
lc_num = 5 AUDIO_G729_WB
lc_num = 6 AUDIO_G729_AWB
lc_num = 7 AUDIO_G7231
}
}
Display [Robel ACW>Jane ACW]
Timed: 13/04/20 13:42
Locale: aru
1539694652mS SIP Call Tx: phone
INVITE sip:1030@10.212.134.202;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.10.12.5:5060;rport;branch=z9hG4bK75ab461998333b1baefeab52848d6402
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: <sip:1030@10.10.12.5;transport=tcp>
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 INVITE
Contact: "Robel ACW" <sip:1031@10.10.12.5:5060;transport=tcp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: 100rel
User-Agent: IP Office 11.0.0.0.0 build 849
P-Asserted-Identity: "Robel ACW" <sip:1031@10.10.12.5:5060>
Content-Type: application/sdp
Content-Length: 278

v=0
o=UserA 1719845045 1401463299 IN IP4 10.212.134.201
s=Session SDP
c=IN IP4 10.212.134.201
t=0 0
m=audio 5010 RTP/AVP 8 0 18 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
1539694806mS SIP Call Rx: phone
SIP/2.0 100 Trying
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: <sip:1030@10.10.12.5;transport=tcp>
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 INVITE
Via: sip/2.0/tcp 10.10.12.5:5060;rport;branch=z9hG4bK75ab461998333b1baefeab52848d6402
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.19; Windows NT 6.2, 64-bit)
Content-Length: 0

1539694806mS CMExtnRx: v=1030, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
1539694807mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=T CMCSOffering->CMCSAccept
1539694807mS CMCallEvt: 0000000000000000 0.7454.0 1298 TargetingEP: StateChange: END=B CMCSOffering->CMCSAccept
1539694963mS SIP Call Rx: phone
SIP/2.0 180 Ringing
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 INVITE
Via: sip/2.0/tcp 10.10.12.5:5060;rport;branch=z9hG4bK75ab461998333b1baefeab52848d6402
Contact: <sip:1030@10.212.134.202:56827;transport=tcp>
Allow: INVITE,CANCEL,BYE,ACK,SUBSCRIBE,NOTIFY,MESSAGE,INFO,PUBLISH,REFER,UPDATE,PRACK
Allow-Events: hold, talk
Accept-Language: en
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.19; Windows NT 6.2, 64-bit)
Content-Length: 0

1539694964mS CMExtnRx: v=1030, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
1539694964mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=T CMCSAccept->CMCSRinging
1539694964mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneRingBack active=CMLocalToneNone play_tapi_moh 0
1539694965mS CMExtnEvt: v=0 State, new=Ringing old=Idle,0,0,Jane ACW
1539694965mS CMCallEvt: 0000000000000000 0.7454.0 1298 TargetingEP: StateChange: END=B CMCSAccept->CMCSRinging
1539694966mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSDialled->CMCSRingBack
1539694966mS CMExtnEvt: v=0 State, new=Alerting old=Proceeding,0,0,Robel ACW
1539694967mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: CMVoipNegotiator::processOutboundFastStart, out1
1539694968mS CMExtnTx: v=1031, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Jane ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Jane ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1030
IE CMIEDeviceDetail (231) 0a0a0c0500001d1f LOCALE=aru HW=15 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110000 rx_gain=32 tx_gain=32
ep_callid=7455 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
AlertingName.Invoke.CodePageISO8859-1
invokeId 15103
user 'Jane ACW' presentation Allowed
Timed: 13/04/20 13:42
1539694969mS SIP Call Tx: phone
SIP/2.0 180 Ringing
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK4_146b44f8-1aa483ff72ff7902_I1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 INVITE
Contact: "Jane ACW" <sip:1030@10.10.12.5:5060;transport=tcp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
P-Asserted-Identity: "Jane ACW" <sip:1030@10.10.12.5:5060>
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Content-Length: 0

1539695839mS PRN: Monitor Status IP 500 V2 11.0.0.0.0 build 849
1539695840mS PRN: LAW=A PRI=0, BRI=2, ALOG=4, VCOMP=42, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=5 VMAIL=1(VER=3 TYP=1) 1-X=0 CALLS=1(TOT=1298)
1539697216mS SIP Call Rx: phone
SIP/2.0 200 OK
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 INVITE
Via: sip/2.0/tcp 10.10.12.5:5060;rport;branch=z9hG4bK75ab461998333b1baefeab52848d6402
Contact: <sip:1030@10.212.134.202:56827;transport=tcp>
Allow: INVITE,CANCEL,BYE,ACK,SUBSCRIBE,NOTIFY,MESSAGE,INFO,PUBLISH,REFER,UPDATE,PRACK
Accept-Language: en
P-Conference: OutdialPrompt=false, FeedbackPrompts=false
Content-Type: application/sdp
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.19; Windows NT 6.2, 64-bit)
Supported: replaces
Content-Length: 326

v=0
o=sip:1030@10.212.134.202 1 10 IN IP4 10.212.134.202
s=sip:1030@10.212.134.202
c=IN IP4 10.212.134.202
b=TIAS:64000
t=0 0
a=activetalker
m=audio 5004 RTP/AVP 8 0 18 101
b=TIAS:64000
a=rtpmap:8 PCMA/8000/1
a=rtpmap:0 PCMU/8000/1
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000/1
1539697218mS SIP Call Tx: phone
ACK sip:1030@10.212.134.202:56827;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.10.12.5:5060;rport;branch=z9hG4bK126a5dc6183975715e49cd274a088bd5
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: "Jane ACW" <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455951 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 11.0.0.0.0 build 849
Content-Length: 0

1539697219mS CMExtnRx: v=1030, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
Called[Robel ACW] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
IE CMIEFastStartInfoData (6) 6 item(s)
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 2 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 6 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 3 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
CMFastStartElement lc_num = 2 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
1539697220mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessInboundMsg, set incoming_leg to false
1539697220mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessInboundMsg, was_connected set
1539697221mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=T CMCSRinging->CMCSConnReq
1539697221mS CMCallEvt: 0000000000000000 0.7454.0 1298 TargetingEP: RequestEnd 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0
1539697221mS CMCallEvt: 0000000000000000 0.7454.0 -1 BaseEP: DELETE CMEndpoint f16d3f40 TOTAL NOW=2 CALL_LIST=1
1539697221mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: SetLocalTone CMLocalToneNone->CMLocalToneCutThru
1539697222mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange to CMLocalTonePending SSOperationInProgress 0 MEDIA_FLAG_ACC_ENTRY 0
1539697223mS CMExtnEvt: v=0 State, new=Connected old=Ringing,0,0,Jane ACW
1539697223mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSRingBack->CMCSOGConnReq
1539697224mS CMExtnEvt: v=0 State, new=Connected old=Alerting,0,0,Robel ACW
1539697224mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneNone play_tapi_moh 0
1539697225mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneNone)->CMLocalToneDirectMedia, other side's media handler is not changed (lcmh) renego 0
1539697225mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: LCMH PlayLocalTone CMLocalToneCutThru (current CMLocalToneDirectMedia, prev CMLocalToneNone) parent state CMCSConnReq action 1 reneg 0 voip_neg->proc_inb 1
1539697226mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: LCMH Tone CMLocalToneDirectMedia(CMLocalToneNone)->CMLocalToneDirectMedia, other side's media handler is not changed (lcmh) renego 0
1539697227mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 2->2
1539697227mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 6->6
1539697227mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: Create session id 1 active 1
1539697228mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: SetLocalState LCFSInitialize -> LCMediaConnected
1539697229mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697230mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneRingBack play_tapi_moh 0
1539697231mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: CheckEmptyReInviteProcedureOnMHChanged empty_invite_outgoing = <EINotStarted>
1539697231mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneNone)->CMLocalToneDirectMedia, other side's media handler is changed (lcmh) renego 0
1539697231mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneCutThru (current CMLocalToneDirectMedia, prev CMLocalToneNone) parent state CMCSOGConnReq action 1 reneg 0 voip_neg->proc_inb 0
1539697232mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697232mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: PlayPendingLocalTone lcmh_media_handler_changed is still true...
1539697232mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneCutThru (current CMLocalToneDirectMedia, prev CMLocalToneDirectMedia) parent state CMCSOGConnReq action 1 reneg 0 voip_neg->proc_inb 0
1539697233mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: PlayPendingLocalTone lcmh_media_handler_changed is still true...
1539697233mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: RearrangeFSProposal 2->2
1539697235mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: IsRenegoFSCompatible: choose a common cap 8
1539697235mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: Create session id 1 active 1
1539697236mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: UnsetLcmhChanged other_mh f1664ff8 lcmh 1
1539697236mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: SetLocalState LCFSResponse -> LCMediaConnected
1539697237mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697237mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697239mS CMExtnTx: v=1031, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
Called[Robel ACW] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
CMFastStartElement lc_num = 1 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
IE CMIEFastStartInfoData (6) 6 item(s)
CMFastStartElement lc_num = 1 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 4 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ALAW64K
num_frames = 20
}
}
mplex_para = CMH2250LCPara = {
session_id = 1
media_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5004 }
media_ctrl_channel = CMTransportAddress = unicast = { addr 10.212.134.202 port 5005 }
media_guaranteed_delivery = false
media_ctrl_guaranteed_delivery = false
silence_suppression = false
}
}
}
CMFastStartElement lc_num = 2 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 6 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G711_ULAW64K
num_frames = 20
}
}
}
}
CMFastStartElement lc_num = 3 = {
rx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
CMFastStartElement lc_num = 2 = {
tx_lc_para = CMLogicalChannelPara = {
data_type = CMLCDataType = {
media_cap = CMSimpleAudioCapability = {
data_type = AUDIO_G729_A
num_frames = 2
}
}
}
}
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Jane ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Jane ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1030
IE CMIEDeviceDetail (231) 0a0a0c0500001d1f LOCALE=aru HW=15 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110000 rx_gain=32 tx_gain=32
ep_callid=7455 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x10 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
ConnectedName.Invoke.CodePageISO8859-1
invokeId 15104
user 'Jane ACW' presentation Allowed
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7) {
lc_num = 1 AUDIO_G711_ALAW64K
lc_num = 2 AUDIO_G711_ULAW64K
lc_num = 3 AUDIO_G729_A
lc_num = 4 AUDIO_G729
lc_num = 5 AUDIO_G729_WB
lc_num = 6 AUDIO_G729_AWB
lc_num = 7 AUDIO_G7231
}
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7) {
lc_num = 1 AUDIO_G711_ALAW64K
lc_num = 2 AUDIO_G711_ULAW64K
lc_num = 3 AUDIO_G729_A
lc_num = 4 AUDIO_G729
lc_num = 5 AUDIO_G729_WB
lc_num = 6 AUDIO_G729_AWB
lc_num = 7 AUDIO_G7231
}
}
Timed: 13/04/20 13:42
1539697241mS SIP Call Tx: phone
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK4_146b44f8-1aa483ff72ff7902_I1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 INVITE
Contact: "Jane ACW" <sip:1030@10.10.12.5:5060;transport=tcp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
P-Asserted-Identity: "Jane ACW" <sip:1030@10.10.12.5:5060>
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Content-Type: application/sdp
Content-Length: 207

v=0
o=UserA 1624881862 3409257323 IN IP4 10.212.134.202
s=Session SDP
c=IN IP4 10.212.134.202
t=0 0
m=audio 5004 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
1539697242mS CMExtnRx: v=1031, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
1539697242mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSOGConnReq->CMCSConnected
1539697243mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: StateChange: END=B CMCSConnReq->CMCSConnected
1539697245mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697246mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697246mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: RearrangeFSProposal 2->2
1539697247mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessOutboundFastStart LCMediaConnected --- caps_fs 0 caps_sec 0
1539697247mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: OnRenegotiate to stack in local LCRIdle, remote LCRIdle, pause is 0 (fs f166e970, size 2), renego 1 mh_ch 0 relay 0 resp 0 stream_ch 0 sec_ch 0 dtmf_ch 0 t38_shuff 0
1539697248mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: IsRenegoFSCompatible: choose a common cap 8
1539697249mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: ProcessOutboundFastStart, respond 0 responded 0 forward 0 other_waits_for_response 0
1539697249mS CMExtnTx: v=1030, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
Timed: 13/04/20 13:42
1539697250mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneCutThru active=CMLocalToneCutThru play_tapi_moh 0
1539697251mS VOIP: (Out) 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: CMVoipNegotiator::processOutboundFastStart, out1
1539697251mS CMExtnTx: v=1030, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1031
IE CMIEDeviceDetail (231) 0a0a0c0500001d1d LOCALE=aru HW=15 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110020 rx_gain=32 tx_gain=32
ep_callid=7453 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
Timed: 13/04/20 13:42
1539697251mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: ProcessOutboundMsg, was_connected set
1539697762mS SIP Call Rx: phone
ACK sip:1030@10.10.12.5:5060;transport=tcp SIP/2.0
From: sip:1031@10.10.12.5;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 4 ACK
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK189f7080_146b513c45a6042572ff8d50_A1031
Content-Length: 0
Max-Forwards: 70
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.30; Windows NT 6.2, 64-bit)
Supported: eventlist, 100rel, replaces, vnd.avaya.ipo

1539698065mS DTM: 13/04/2020 13:42:28 (Mon 13 Apr 2020) [10.10.12.5 (Unified Dubai)]
1539705753mS SIP Call Rx: phone
BYE sip:1030@10.10.12.5:5060;transport=tcp SIP/2.0
From: sip:1031@10.10.12.5;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 5 BYE
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK1e9fad70_146b707c43bb834572ffa4a2_B1031
Content-Length: 0
Max-Forwards: 70
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.30; Windows NT 6.2, 64-bit)
Supported: eventlist, 100rel, replaces, vnd.avaya.ipo

1539705755mS SIP Call Tx: phone
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.212.134.201:58941;branch=z9hG4bK1e9fad70_146b707c43bb834572ffa4a2_B1031
From: <sip:1031@10.10.12.5>;tag=-5e00a75e94340072ff79fe_F103110.212.134.201
Call-ID: 4_146b44f8-11bce3ff72ff78fc_I@10.212.134.201
CSeq: 5 BYE
Supported: 100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:1030@10.10.12.5>;tag=2d12f5b6cb0b3472
Content-Length: 0

1539705756mS CMExtnRx: v=1031, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
Cause=16, Normal call clearing
1539705757mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: StateChange: END=A CMCSConnected->CMCSCompleted
1539705757mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: SetLocalTone CMLocalToneCutThru->CMLocalToneNone
1539705757mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: AudioConnectionChange current=CMLocalToneCutThru new=CMLocalToneNone active=CMLocalToneCutThru play_tapi_moh 0
1539705758mS MH : 0a0a0c0500001d1f 10192.7455.0 1298 Jane ACW.0: PlayLocalTone other end is completed, skip any action
1539705758mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: AudioConnectionChange current=CMLocalToneNone new=CMLocalToneNone active=CMLocalToneCutThru play_tapi_moh 0
1539705759mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: CheckEmptyReInviteProcedureOnMHChanged empty_invite_outgoing = <EINotStarted>
1539705760mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneDirectMedia(CMLocalToneDirectMedia)->CMLocalToneNone, other side's media handler is changed (not lcmh) renego 0
1539705760mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH PlayLocalTone CMLocalToneNone (current CMLocalToneNone, prev CMLocalToneDirectMedia) parent state CMCSCompleted action 1 reneg 0 voip_neg->proc_inb 1
1539705761mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=Connected,0,0,Robel ACW
1539705762mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: PlayPendingLocalTone lcmh_media_handler_changed is still true...
1539705763mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: LCMH Tone CMLocalToneNone(CMLocalToneDirectMedia)->CMLocalToneNone, other side's media handler is changed (not lcmh) renego 0
1539705763mS MH : 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: UnsetLcmhChanged other_mh 0 lcmh 0
1539705764mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: OnRenegotiate to stack in local LCRIdle, remote LCRIdle, pause is 1 (fs 0, size 0), renego 1 mh_ch 0 relay 0 resp 0 stream_ch 0 sec_ch 0 dtmf_ch 0 t38_shuff 0
1539705764mS CH : CHand::JoinGroup, cp[927]b0r1 (current group: g null), group g null
1539705765mS CMExtnTx: v=1031, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=10205 id=7453 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
CMFastStartElement lc_num = 1 = {
tx_lc_para = CMLogicalChannelPara = {
}
}
CMFastStartElement lc_num = 4 = {
rx_lc_para = CMLogicalChannelPara = {
}
}
Timed: 13/04/20 13:42
1539705765mS VOIP: (In) 0a0a0c0500001d1d 10205.7453.0 1298 Robel ACW.0: SetRenegotiateState local LCRIdle -> LCRPaused
1539705765mS CH : CHand::JoinGroup, cp[927]b0r1 (current group: g null), group g null
1539705766mS CH : CHand::JoinGroup, cp[927]b0r1 (current group: g null), group g null
1539705767mS CMExtnEvt: Robel ACW: CALL LOST (CMCauseNormal)
1539705767mS CMExtnEvt: Robel ACW: Extn(1031) Calling Party Number(1031) Type(CMNTypeInternal)
1539705767mS CMExtnEvt: Robel ACW: CMExtnHandler::SetCurrent( id: 7453->0 )
1539705767mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 -1 Robel ACW.0: SetLocalTone CMLocalToneNone->CMLocalToneNone
1539705767mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 -1 Robel ACW.-1: StateChange: END=X CMCSCompleted->CMCSDelete
1539705768mS CMExtnCutEvt: 0a0a0c0500001d1d 10205.7453.0 -1 Robel ACW.-1: SetLocalTone CMLocalToneNone->CMLocalToneNone
1539705768mS CMExtnEvt: Jane ACW: CALL LOST (CMCauseNormal)
1539705769mS CMExtnEvt: Jane ACW: Extn(1030) Calling Party Number(1031) Type(CMNTypeInternal)
1539705769mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 -1 Jane ACW.0: StateChange: END=X CMCSConnected->CMCSCompleted
1539705769mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 -1 Jane ACW.0: SetLocalTone CMLocalToneCutThru->CMLocalToneNone
1539705769mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=Connected,0,0,Jane ACW
1539705770mS CMExtnTx: v=1030, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=10192 id=7455 in=0
Called[1030] Type=Default (100) Reason=CMDRdirect Calling[1031] Type=Internal Plan=Default
Cause=16, Normal call clearing
Timed: 13/04/20 13:42
1539705771mS SIP Call Tx: phone
BYE sip:1030@10.212.134.202:56827;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.10.12.5:5060;rport;branch=z9hG4bKf23f1051395d59d43859cafb22191586
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: "Jane ACW" <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455952 BYE
Contact: "Robel ACW" <sip:1031@10.10.12.5:5060;transport=tcp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: 100rel
User-Agent: IP Office 11.0.0.0.0 build 849
Reason: Q.850;cause=16;text="Normal call clearing"
Content-Length: 0

1539705772mS CMExtnEvt: Jane ACW: CMExtnHandler::SetCurrent( id: 7455->0 )
1539705772mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 -1 Jane ACW.0: SetLocalTone CMLocalToneNone->CMLocalToneNone
1539705772mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 -1 Jane ACW.-1: StateChange: END=X CMCSCompleted->CMCSDelete
1539705773mS CMExtnCutEvt: 0a0a0c0500001d1f 10192.7455.0 -1 Jane ACW.-1: SetLocalTone CMLocalToneNone->CMLocalToneNone
1539705773mS CMCallEvt: 0a0a0c0500001d1f 10192.7455.0 -1 BaseEP: DELETE CMEndpoint f165c264 TOTAL NOW=1 CALL_LIST=0
1539705774mS CMCallEvt: END CALL:1298 (f1692774)
1539705775mS CMCallEvt: 0a0a0c0500001d1d 10205.7453.0 -1 BaseEP: DELETE CMEndpoint f4f7b1bc TOTAL NOW=0 CALL_LIST=0
1539705777mS CH : CHand::FreeConnectionPoint cp[928]b0r0[TOTAL CP:110]
1539705777mS CH : CHand::FreeConnectionPoint cp[927]b0r1[TOTAL CP:109]
1539705932mS SIP Call Rx: phone
SIP/2.0 200 OK
From: "Robel ACW" <sip:1031@10.10.12.5>;tag=7ac64bf39d60f160
To: "Jane ACW" <sip:1030@10.10.12.5;transport=tcp>;tag=59e43b425e943402-3444013c_T103010.212.134.202
Call-ID: ec0af3384705068942f2390fd252e3ee
CSeq: 1688455952 BYE
Via: sip/2.0/tcp 10.10.12.5:5060;rport;branch=z9hG4bKf23f1051395d59d43859cafb22191586
User-Agent: Avaya Flare Engine/2.0.0 (Engine GA-2.0.0.19; Windows NT 6.2, 64-bit)
Content-Length: 0


********** Warning: Logging to Screen Stopped **********
 
hi derfloh, did you find anything?
 
yes these IP address 10.212.134.201 and 10.212.134.202 are VPN addresses of the 2 computers where the avaya communicator are installed.

The Avaya communicator is setup using H.323 extension with power user license assigned on both extensions.

Avaya communicator calling to external number(Mobile phones, landline numbers) is okay, no problem at all. audio can be heard on both party.

But if avaya communicator to avaya communicator calling internally (extension to extension), no audio on both party.
 
OK, in the VPN gateway you have to enable client to client traffic.

IPO asks the clients to send their media packages directly to each other. They "only" ask IPO to establish the connection but to exchange media directly with each other.

But as long as IP connections between VPN clients are restricted you will have no audio.

IP Office remote service
Fixed price SIP trunk configuration
CLI based call blocking
SCN fallback over PSTN
 
It is allowed as there is policy both the ways to voice subnet

We are using fortinet firewall

all -> voice subnet

and voice subnet -> all
 
And also, the direct media path is disabled.
 
Direct media is enabled for the H.323 extension but this doesn't affect the on demand created temporary Communicator extension.

In your case additionally to the routing between voice and "any" you need to allow routing between VPN clients. Don't know how to set this up in the firewall.

You can try to ping between the two VPN clients to test.

IP Office remote service
Fixed price SIP trunk configuration
CLI based call blocking
SCN fallback over PSTN
 
@ derfloh, many thanks for your help, I really appreciate. Our softphone to softphone calling audio issue when on VPN resolved.



 
Status
Not open for further replies.

Part and Inventory Search

Sponsor

Back
Top