Incoming Caller ID from PSTN not show on Avaya phone

[Binhphamngoc]

Dear all

I've problem about caller id display on avaya Phone.
when make call from pstn to Avaya IP office 500 v2, this call is routed to reception ip phone. on LCD phone only display external@172.17.150.10 without number of caller.
please see attached file.
Please help me this case
thanks so much

 

[tac84]

Hi @Binhphamngoc
I can't see any files attached, however are you sure your PSTN provider has caller id enabled on the line? have you tested this with another device to troubleshoot?

Thanks, Tim
Adelaide, Australia

 

[janni78]

You should start by tracing with System Monitor to see that CLI is actually sent from the provider.

"Trying is the first step to failure..." - Homer

 

[Binhphamngoc]

 

[Binhphamngoc]

I'm sure Cli is enabled on pstn line. i'll trace log call and send you later
thanks

 

[Binhphamngoc]

dear all

This is the log call from outside pstn to extension 1112.
From: <sip:external@172.17.150.10>;tag=e21ae409d1905aa3
To: <sip:1112@172.17.150.10;transport=tcp;avaya-sc-enabled>


21:30:58 208302mS CMCallEvt: 0000000000000000 0.1002.0 -1 BaseEP: NEW CMEndpoint f17c3854 TOTAL NOW=1 CALL_LIST=0
21:30:58 208601mS PRN: SysSetServiceDateVersion set 21, 1611783058
21:30:58 208601mS PRN: 1 service set date 1611783058 and version 21
21:30:58 208601mS PRN: 27/01/2021 21:30:58
21:30:58 208602mS CMCallEvt: CREATE CALL:1 (f17c293c)
21:30:58 208602mS CMCallEvt: 0000000000000000 0.1003.0 -1 BaseEP: NEW CMEndpoint f17c0ddc TOTAL NOW=2 CALL_LIST=0
21:30:58 208604mS CMLineRx: v=1
CMSetup
Line: type=AnalogueLine 1 Call: lid=1 id=2 in=1
Called[] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[] Type=Unknown Plan=Unknown Pres=NAInterworking (2)
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
BChan: slot=1 chan=1
IE CMIEDeviceDetail (231) ac11960a000003ea LOCALE=eng HW=15 VER=11 class=CMDeviceAlogTrunk type=0 number=1 channel=0 features=0x0 rx_gain=32 tx_gain=32
ep_callid=1002 ipaddr=172.17.150.10 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
21:30:58 208604mS CMCallEvt: ac11960a000003ea 1.2.1 1 Alog Trunk:1: StateChange: END=A CMCSIdle->CMCSDialInitiated
21:30:58 208604mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: LOOKUP CALL ROUTE: GID=0 type=0 called_party= sub= calling= calling_sub= dir=in complete=1 ses=0
21:30:58 208605mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: SET BESTMATCH: length 100 vs -1 match=* dest=1112
21:30:58 208605mS CMCallEvt: Priority hike: call 1 priority 0->1
21:30:58 208605mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: LOOKUP ICR: DDI= CGPN= (Destination 1112 ) => CDPN=1112
21:30:58 208606mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: ADD TARGET (N): number=1112 type=0 depth=1 nobar=1 setorig=1 ses=0
21:30:58 208606mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: SET USER: 1112 orig=1
21:30:58 208606mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: ADD USER: 1112 depth=1 disallow_cw=0 dnd=0 real_call=1 group_call=0 type(CMNTypeUnknown) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0) r_lic=T
21:30:58 208606mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f52ee06c) resource busy 1, total 42
21:30:58 208607mS CMCallEvt: 0000000000000000 0.1004.0 -1 BaseEP: NEW CMEndpoint f4bc0f18 TOTAL NOW=3 CALL_LIST=1
21:30:58 208607mS CMCallEvt: 0000000000000000 0.1004.0 -1 1112.-1: NEW CMExtnEndpoint f4bc0f18, Name=1112, Extn=1112, Phys Extn=1112
21:30:58 208609mS CMTARGET: ac11960a000003ec 282.1004.0 1 1112.0: ADD PRIMARY
21:30:58 208610mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: INITIAL TARGETING SUCCEEDED
21:30:58 208610mS CMTARGET: ac11960a000003ea 1.2.1 1 Alog Trunk:1: GetNoAnswerTimer:25
21:30:58 208610mS CMCallEvt: ac11960a000003ea 1.2.1 1 Alog Trunk:1: StateChange: END=A CMCSDialInitiated->CMCSDialled
21:30:58 208610mS CMLineTx: v=1
CMProceeding
Line: type=AnalogueLine 1 Call: lid=1 id=2 in=1
21:30:58 208611mS CMCallEvt: 0000000000000000 0.1003.0 1 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
21:30:58 208611mS CMCallEvt: ac11960a000003ec 282.1004.0 1 1112.0: StateChange: END=T CMCSIdle->CMCSOffering
21:30:58 208613mS CMExtnEvt: 1112: CMExtnHandler::SetCurrent( id: 0->1004 )
21:30:58 208613mS CMExtnTx: v=1112, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=282 id=1004 in=0
Called[1112] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[] Type=Unknown Plan=Unknown Pres=NAInterworking (2)
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECalledPartyName (224)(Type=CMNameInternalUser) name=1112
IE CMIECalledPartyKName (225)(Type=CMNameDefault) name=NTTuyet-TPHCM
IE CMIERespondingPartyNumber (230)(P:2 S:100 T:0 N:0 R:4) number=
IE CMIEDeviceDetail (231) ac11960a000003ea LOCALE=eng HW=15 VER=11 class=CMDeviceAlogTrunk type=0 number=1 channel=0 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1002 ipaddr=172.17.150.10 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7)
}
Display [??>1112]
Timed: 27/01/21 21:30
Locale: zhi
21:30:58 208617mS SIP Tx: TCP 172.17.150.10:5060 -> 172.17.130.202:62530
INVITE sip:1112@172.17.130.202;transport=tcp;avaya-sc-enabled SIP/2.0
Via: SIP/2.0/TCP 172.17.150.10:5060;rport;branch=z9hG4bK1d94d9d6101aed9b13fe857d28e295a4
From: <sip:external@172.17.150.10>;tag=e21ae409d1905aa3
To: <sip:1112@172.17.150.10;transport=tcp;avaya-sc-enabled>
Call-ID: 1172b2e7f4b615f40116213f779319b5
CSeq: 1732913336 INVITE
Contact: <sip:external@172.17.150.10: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.4.4.0 build 6
Content-Type: application/sdp
Content-Length: 301

v=0
o=UserA 1417561386 1798830313 IN IP4 172.17.150.10
s=Session SDP
c=IN IP4 172.17.150.10
t=0 0
m=audio 46750 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
21:30:58 208637mS SIP Rx: TCP 172.17.130.202:62530 -> 172.17.150.10:5060
SIP/2.0 100 Trying
From: <sip:external@172.17.150.10>;tag=e21ae409d1905aa3
To: <sip:1112@172.17.150.10;transport=tcp;avaya-sc-enabled>
Call-ID: 1172b2e7f4b615f40116213f779319b5
CSeq: 1732913336 INVITE
Via: SIP/2.0/TCP 172.17.150.10:5060;branch=z9hG4bK1d94d9d6101aed9b13fe857d28e295a4
User-Agent: Avaya J129 IP Phone 4.0.6.1.6 c81feaaef136
Content-Length: 0

21:30:58 208639mS CMExtnRx: v=1112, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=282 id=1004 in=0
21:30:58 208640mS CMCallEvt: ac11960a000003ec 282.1004.0 1 1112.0: StateChange: END=T CMCSOffering->CMCSAccept
21:30:58 208640mS CMCallEvt: 0000000000000000 0.1003.0 1 TargetingEP: StateChange: END=B CMCSOffering->CMCSAccept
21:30:58 208761mS SIP Rx: TCP 172.17.130.202:62530 -> 172.17.150.10:5060
SIP/2.0 180 Ringing
From: <sip:external@172.17.150.10>;tag=e21ae409d1905aa3
To: <sip:1112@172.17.150.10;transport=tcp;avaya-sc-enabled>;tag=6011792150ca65b76uk4g2m1i165n1yu5b274p_T1112
Call-ID: 1172b2e7f4b615f40116213f779319b5
CSeq: 1732913336 INVITE
Via: SIP/2.0/TCP 172.17.150.10:5060;branch=z9hG4bK1d94d9d6101aed9b13fe857d28e295a4
Allow: INVITE,ACK,BYE,CANCEL,SUBSCRIBE,NOTIFY,MESSAGE,REFER,INFO,PRACK,PUBLISH,UPDATE
User-Agent: Avaya J129 IP Phone 4.0.6.1.6 c81feaaef136
Contact: <sip:1112@172.17.130.202:62530;transport=tcp>
Accept-Language: en
Content-Length: 0

21:30:58 208763mS CMExtnRx: v=1112, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=282 id=1004 in=0
21:30:58 208764mS CMCallEvt: ac11960a000003ec 282.1004.0 1 1112.0: StateChange: END=T CMCSAccept->CMCSRinging
21:30:58 208764mS CMExtnEvt: v=0 State, new=Ringing old=Idle,0,0,1112
21:30:58 208764mS CMCallEvt: 0000000000000000 0.1003.0 1 TargetingEP: StateChange: END=B CMCSAccept->CMCSRinging
21:30:58 208765mS CMCallEvt: ac11960a000003ea 1.2.1 1 Alog Trunk:1: StateChange: END=A CMCSDialled->CMCSRingBack
21:30:58 208765mS CMLineTx: v=1
CMAlerting
Line: type=AnalogueLine 1 Call: lid=1 id=2 in=1
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=1112
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=NTTuyet-TPHCM
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1112
IE CMIEDeviceDetail (231) ac11960a000003ec LOCALE=eng HW=15 VER=11 class=CMDeviceSIPPhone type=174 number=56 channel=0 features=0x20110000 rx_gain=32 tx_gain=32
ep_callid=1004 ipaddr=172.17.150.10 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=1 avgsid=
21:30:58 208767mS CMMap: a=1.1 b=0.0 R1

 

[janni78]

So guess this is analog lines?

The Calling part is empty so you need to verify that CLI is sent

21:30:58 208613mS CMExtnTx: v=1112, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=282 id=1004 in=0
Called[1112] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[] Type=Unknown Plan=Unknown Pres=NAInterworking (2)
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw

"Trying is the first step to failure..." - Homer

 

[Binhphamngoc]

Hi Janni78
This is analog line, I don't know why it show type=sipline from log call ?

Thanks

 

[janni78]

That's the part to the phone, the line part also has Calling as blank

21:30:58 208604mS CMLineRx: v=1
CMSetup
Line: type=AnalogueLine 1 Call: lid=1 id=2 in=1
Called[] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[] Type=Unknown Plan=Unknown Pres=NAInterworking (2)
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
BChan: slot=1 chan=1

You need to verify with the provider that they send CLI, also there's an option on the trunk you can try

Long CLI Line Default = Off
The CLI signal on some analog lines can become degraded and is not then correctly detected. If you are sure that CLI is being provided but not detected, selecting this option may resolve the problem.


"Trying is the first step to failure..." - Homer

 

[sizbut]

No. There's a SIP line involved here as well. The trace shows the call being passed from the analog line to a SIP line for some reason. So please tell the full story of where the call is being made from, going to, and all the stages in between.

I strongly suspect that "External" is the IP Office SIP response to not being given any caller ID by the analog line. Its a little better than "Don't know" or "No Clue". The only puzzle is why the IP part isn't being removed as usual.

Stuck in a never ending cycle of file copying.

 

[janni78]

The SIPLine 260 is part of the CMExtnTx event, also you can't create a line with a number higher than 249 (on IP500) and if I remember correctly IP DECT has 250.

"Trying is the first step to failure..." - Homer