TomasBill22
Technical User
Hi all ...
I have Configured a SIP Trunk between Avaya IP Offcce 500v2 Rls 8.1 and Cisco Call Manager Rls.7
I have an issue on call completion and hope to find the solution on this fourm.
first, Here is the information about setup:
IP Office IP Address: 10.10.89.10
Cisco Call Manager IP Address:10.10.240.1
IP Office Extension Range: 33xx
Cisco Call Manager Extension Range: 2xxx
IP Office ARS: 2N"@10.10.240.1"
We follow the following document in the configuration:
After completion, the SIP Trunk is up, and the Cisco Users can call the IP Office Users, but in vise versa, when calling from Avaya Phone, it's displays "incompatible" Message.
the following is the trace I capture it from Moniter when I call extension number 2888 on the cisco call manager:
68644mS RES: Sun 29/9/2013 14:51:51 FreeMem=56419056(1) CMMsg=5 (6) Buff=5200 948 999 7423 5 Links=4950 CPU=3/8/3483/21937/22461/0
68645mS RES2: IP 500 V2 8.1(43) Tasks=52 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=73 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=54 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
71620mS PRN: 3330: Digit Pressed 2
71621mS CMCallEvt: 0.1005.0 -1 BaseEP: NEW CMEndpoint f4e5efbc TOTAL NOW=1 CALL_LIST=0
71621mS CMCallEvt: 0.1005.0 -1 Alaa Sammamah.-1: NEW CMExtnEndpoint f4e5efbc, Name=Alaa Sammamah, Extn=3330, Phys Extn=3330
71622mS CMCallEvt: CREATE CALL:2 (f4e5d87c)
71622mS CMCallEvt: 0.1006.0 -1 BaseEP: NEW CMEndpoint f4e5c3b0 TOTAL NOW=2 CALL_LIST=0
71624mS CMExtnEvt: Alaa Sammamah: CMExtnHandler::SetCurrent( id: 0->1005 )
71624mS CMExtnRx: v=3330, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[3330] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Alaa Sammamah
IE CMIEFastStartInfoData (6) 10 item(s)
71625mS CMCallEvt: 252.1005.0 2 Alaa Sammamah.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
71625mS CMExtnEvt: v=1 State, new=Dialling old=Idle,0,0,Alaa Sammamah
71625mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=3330 dir=out complete=0 ses=0
71625mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
71626mS CMCallEvt: 252.1005.0 2 Alaa Sammamah.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
71628mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIESecurityData (253) 2 item(s)
Timed: 29/09/13 14:51
71629mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
71629mS CMExtnTx: v=3330, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Timed: 29/09/13 14:51
71630mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
71632mS CD: CALL: 252.1005.0 BState=Idle Cut=0 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="" [] (0.0) CalledNum=2 () CallingNum=3330 (Alaa Sammamah) Internal=1 Time=10 AState=Dialling
71633mS H323Evt: SetOperational 2 10.1.68.10:0 to 0
72039mS PRN: 3330: Digit Pressed 8
72039mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
72230mS PRN: 3330: Digit Pressed 8
72230mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
72421mS PRN: 3330: Digit Pressed 8
72421mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
72421mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: CancelTimer CMTCDelayedProcessing
72422mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: LOOKUP CALL ROUTE: type=100 called_party=2888 sub= calling=3330 dir=out complete=0 ses=0
72422mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: ADD TARGET (N): number=2888 type=100 depth=1 nobar=1 setorig=1 ses=0
72422mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: SYS SC: 2888 4 888 sc=type=Dial code=2xxx, num=2N"@10.10.240.1" callinfop->sending_complete=0 secondary_dialtone=
72422mS CMARS: FindActiveARSByGroupID GroupID=17 - Not Found
72423mS CMLRQ: FindActiveLRQByGroupID GroupID=17 - Not Found
72423mS CMTARGET: Group Id: 17 has NOT been found in Line: 5
72423mS CMCallEvt: 0.1007.0 -1 BaseEP: NEW CMEndpoint f4e50898 TOTAL NOW=3 CALL_LIST=1
72425mS CMTARGET: DIAL LINE: 2 GROUP = 17 SUCCESS = f4e50898
72425mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: CancelTimer CMTCDialToneTimeout
72425mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: INITIAL TARGETING SUCCEEDED
72425mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: GetNoAnswerTimer:15
72426mS CMCallEvt: 0.1006.0 2 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
72427mS CMCallEvt: 17.1007.0 2 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
72428mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 17 Call: lid=17 id=1007 in=0
Called[2888@10.10.240.1] Type=Default (100) Reason=CMDRdirect Calling[3330] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Alaa Sammamah
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=3330
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceH323Phone type=88 number=8001 channel=0 rx_gain=32 tx_gain=32 ep_callid=1005 ipaddr=10.1.68.10 apps=0
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Alaa Sammamah
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 14626
user 'Alaa Sammamah' presentation Allowed
IE CMIEFastStartInfoData (6) 10 item(s)
Display [Alaa Sammamah>2888]
Timed: 29/09/13 14:51
Locale: ara
72430mS SIP Tx: TCP 10.1.68.10:5060 -> 10.10.240.1:5060
INVITE sip:2888@10.10.240.1 SIP/2.0
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
To: <sip:2888@10.10.240.1>
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
CSeq: 630221668 INVITE
Contact: "Alaa Sammamah" <sip:3330@10.1.68.10:5060;transport=tcp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 8.1 (43)
Content-Length: 271
v=0
o=UserA 3612928582 3500921764 IN IP4 10.1.68.10
s=Session SDP
c=IN IP4 10.1.68.10
t=0 0
m=audio 49154 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
72431mS CD: CALL: 252.1005.0 BState=Idle Cut=0 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=2888 () CallingNum=3330 (Alaa Sammamah) Internal=0 Time=809 AState=Dialling
72446mS SIP Rx: TCP 10.10.240.1:5060 -> 10.1.68.10:5060
SIP/2.0 100 Trying
Date: Sun, 29 Sep 2013 11:53:50 GMT
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
Allow-Events: presence
Content-Length: 0
To: <sip:2888@10.10.240.1>
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
CSeq: 630221668 INVITE
72449mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 17 Call: lid=17 id=1007 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=2888
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=1007 ipaddr=10.1.68.10 apps=0
72449mS CMCallEvt: 0.1006.0 2 TargetingEP: RequestEnd 17.1007.0 2 SIPTrunk Endpoint
72449mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: CancelTimer CMTCNoAnswerTimeout
72449mS CMCallEvt: 0.1006.0 -1 BaseEP: DELETE CMEndpoint f4e5c3b0 TOTAL NOW=2 CALL_LIST=1
72449mS CMCallEvt: 17.1007.0 2 SIPTrunk Endpoint: StateChange: END=B CMCSOffering->CMCSAccept
72450mS CMCallEvt: 252.1005.0 2 Alaa Sammamah.0: StateChange: END=A CMCSDialling->CMCSDialled
72450mS CMExtnEvt: v=1 State, new=Proceeding old=Dialling,0,0,Alaa Sammamah
72451mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 29/09/13 14:51
72452mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
72452mS CMExtnTx: v=3330, p1=0
CMProceeding
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=2888
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=1007 ipaddr=10.1.68.10 apps=0
Timed: 29/09/13 14:51
72454mS CD: CALL: 252.1005.0 BState=Ringing Cut=3 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=2888@10.10.240.1 () CallingNum=3330 (Alaa Sammamah) Internal=0 Time=832 AState=Dialled
72456mS SIP Rx: TCP 10.10.240.1:5060 -> 10.1.68.10:5060
SIP/2.0 404 Not Found
Reason: Q.850;cause=1
Date: Sun, 29 Sep 2013 11:53:50 GMT
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
Allow-Events: presence
Content-Length: 0
To: <sip:2888@10.10.240.1>;tag=ed8670f9-bccc-48ab-a850-c066054d2648-51165869
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
CSeq: 630221668 INVITE
72460mS SIP Tx: TCP 10.1.68.10:5060 -> 10.10.240.1:5060
ACK sip:2888@10.10.240.1 SIP/2.0
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
To: <sip:2888@10.10.240.1>;tag=ed8670f9-bccc-48ab-a850-c066054d2648-51165869
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
CSeq: 630221668 ACK
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
User-Agent: IP Office 8.1 (43)
Content-Length: 0
72461mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 17 Call: lid=17 id=1007 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=2888
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=1007 ipaddr=10.1.68.10 apps=0
Cause=1, Unallocated (unassigned) number
72461mS CMCallEvt: 17.1007.0 2 SIPTrunk Endpoint: StateChange: END=B CMCSAccept->CMCSCompleted
72462mS CMLOGGING: CALL:2013/09/2914:51,00:00:00,000,3330,O,2888@10.10.240.1,2888,AlaaSammamah,,,0,,""n/a,0
72463mS CD: CALL: 252.1005.0 BState=Disconnecting Cut=1 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=2888@10.10.240.1 () CallingNum=3330 (Alaa Sammamah) Internal=0 Time=840 AState=Dialled
72463mS CD: CALL: 252.1005.0 Deleted
72464mS CMExtnEvt: Alaa Sammamah: CALL LOST (CMCauseUnallocatedNumber)
72464mS CMExtnEvt: Alaa Sammamah: Extn(3330) Calling Party Number(3330) Type(CMNTypeInternal)
72464mS CMCallEvt: 252.1005.0 -1 Alaa Sammamah.0: StateChange: END=X CMCSDialled->CMCSCompletedTone
72467mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 29/09/13 14:51
72467mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
72467mS CMExtnEvt: v=1 State, new=CMESCompleted old=Proceeding,0,0,Alaa Sammamah
72468mS CMCallEvt: 17.1007.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
72468mS CMCallEvt: END CALL:2 (f4e5d87c)
72469mS CMCallEvt: 17.1007.0 -1 BaseEP: DELETE CMEndpoint f4e50898 TOTAL NOW=1 CALL_LIST=0
72473mS CMMap: PCG::AddToneGenerator g B3[6] for cp[125]b0r1 append pcp[127]b0r1 (total 1)
72473mS CMMap: a=2.1 b=0.0 IP::ReserveCodec pcp[127]b0r1 allocated CMRTVocoder resource busy 1, total 42, codec type 4
72473mS CMMap: a=21.8 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 7, total 8
72474mS CMMap: a=21.8 b=1.255 T
72474mS CMMap: a=21.8 b=2.1 M22
72474mS CMMap: PlatformConnectionAudioSAP::ConnectVoice (connect) pcp[127]b0r1 echo_cancellation set to 0
72474mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[127]b0r1 Configure 2.1
72474mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[127]b0r1 ConnectIndication 2.1
72474mS CMMap: a=0.0 b=0.0 pcp[125]b0r1 RTPB3
72475mS H323Evt: SetOperational 2 10.1.68.10:49152 to 1
73605mS H323Evt: RTP(50r): 10.1.68.10/49152 10.1.68.20/51520 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=1972 SENT=51 (avg size=160) RECV=50 (avg size=160)
73647mS RES: Sun 29/9/2013 14:51:56 FreeMem=56383524(1) CMMsg=5 (6) Buff=5200 940 999 7423 5 Links=4815 CPU=14/29/3483/19347/22461/0
73647mS RES2: IP 500 V2 8.1(43) Tasks=52 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=78 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=54 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
75471mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
75472mS CMExtnRx: v=3330, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
75472mS CMCallEvt: 252.1005.0 -1 Alaa Sammamah.0: StateChange: END=X CMCSCompletedTone->CMCSCompleted
75473mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 29/09/13 14:51
75473mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=CMESCompleted,0,0,Alaa Sammamah
75474mS CMExtnEvt: Alaa Sammamah: CALL LOST (CMCauseForceClear)
75474mS CMExtnEvt: Alaa Sammamah: Extn(3330) Calling Party Number(3330) Type(CMNTypeInternal)
75475mS CMExtnEvt: Alaa Sammamah: CMExtnHandler::SetCurrent( id: 1005->0 )
75475mS CMCallEvt: 252.1005.0 -1 Alaa Sammamah.-1: StateChange: END=X CMCSCompleted->CMCSDelete
75476mS CMTARGET: 252.1005.0 -1 BaseEP: ~CMTargetHandler f4e562a4 ep f4e5efbc
75476mS CMCallEvt: 252.1005.0 -1 BaseEP: DELETE CMEndpoint f4e5efbc TOTAL NOW=0 CALL_LIST=0
75478mS CMMap: a=0.0 b=0.0 pcp[125]b0r1 RTPB0
75478mS H323Evt: SetOperational 2 10.1.68.10:49152 to 0
75478mS CMMap: a=21.8 b=2.1 M02
75478mS CMMap: a=21.8 b=0.0 T0
75478mS CMMap: a=21.8 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 6, total 8
75479mS H323Evt: RTP(END): 10.1.68.10/49152 10.1.68.20/51520 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=3846 SENT=145 RECV=143 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
75480mS CMMap: a=2.1 b=0.0 IP::FreeCodec pcp[127]b0r1 freed CMRTVocoder resource busy 1, total 42
********** Warning: Logging to Screen Stopped **********
I think this is the problem:
Cause=1, Unallocated (unassigned) number
The number 2888 is not configured in the Cisco call Manager correctly.
That is why I received a 404 Not found.
Is this analysis true, if this mean i need to configure some kind of URI on the Cisco side.
Can I found a suggestion on How to do this on the cisco call manager ?
Regards,
I have Configured a SIP Trunk between Avaya IP Offcce 500v2 Rls 8.1 and Cisco Call Manager Rls.7
I have an issue on call completion and hope to find the solution on this fourm.
first, Here is the information about setup:
IP Office IP Address: 10.10.89.10
Cisco Call Manager IP Address:10.10.240.1
IP Office Extension Range: 33xx
Cisco Call Manager Extension Range: 2xxx
IP Office ARS: 2N"@10.10.240.1"
We follow the following document in the configuration:
After completion, the SIP Trunk is up, and the Cisco Users can call the IP Office Users, but in vise versa, when calling from Avaya Phone, it's displays "incompatible" Message.
the following is the trace I capture it from Moniter when I call extension number 2888 on the cisco call manager:
68644mS RES: Sun 29/9/2013 14:51:51 FreeMem=56419056(1) CMMsg=5 (6) Buff=5200 948 999 7423 5 Links=4950 CPU=3/8/3483/21937/22461/0
68645mS RES2: IP 500 V2 8.1(43) Tasks=52 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=73 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=54 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
71620mS PRN: 3330: Digit Pressed 2
71621mS CMCallEvt: 0.1005.0 -1 BaseEP: NEW CMEndpoint f4e5efbc TOTAL NOW=1 CALL_LIST=0
71621mS CMCallEvt: 0.1005.0 -1 Alaa Sammamah.-1: NEW CMExtnEndpoint f4e5efbc, Name=Alaa Sammamah, Extn=3330, Phys Extn=3330
71622mS CMCallEvt: CREATE CALL:2 (f4e5d87c)
71622mS CMCallEvt: 0.1006.0 -1 BaseEP: NEW CMEndpoint f4e5c3b0 TOTAL NOW=2 CALL_LIST=0
71624mS CMExtnEvt: Alaa Sammamah: CMExtnHandler::SetCurrent( id: 0->1005 )
71624mS CMExtnRx: v=3330, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[3330] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Alaa Sammamah
IE CMIEFastStartInfoData (6) 10 item(s)
71625mS CMCallEvt: 252.1005.0 2 Alaa Sammamah.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
71625mS CMExtnEvt: v=1 State, new=Dialling old=Idle,0,0,Alaa Sammamah
71625mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=3330 dir=out complete=0 ses=0
71625mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
71626mS CMCallEvt: 252.1005.0 2 Alaa Sammamah.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
71628mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIESecurityData (253) 2 item(s)
Timed: 29/09/13 14:51
71629mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
71629mS CMExtnTx: v=3330, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Timed: 29/09/13 14:51
71630mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
71632mS CD: CALL: 252.1005.0 BState=Idle Cut=0 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="" [] (0.0) CalledNum=2 () CallingNum=3330 (Alaa Sammamah) Internal=1 Time=10 AState=Dialling
71633mS H323Evt: SetOperational 2 10.1.68.10:0 to 0
72039mS PRN: 3330: Digit Pressed 8
72039mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
72230mS PRN: 3330: Digit Pressed 8
72230mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
72421mS PRN: 3330: Digit Pressed 8
72421mS CMExtnRx: v=3330, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
72421mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: CancelTimer CMTCDelayedProcessing
72422mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: LOOKUP CALL ROUTE: type=100 called_party=2888 sub= calling=3330 dir=out complete=0 ses=0
72422mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: ADD TARGET (N): number=2888 type=100 depth=1 nobar=1 setorig=1 ses=0
72422mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: SYS SC: 2888 4 888 sc=type=Dial code=2xxx, num=2N"@10.10.240.1" callinfop->sending_complete=0 secondary_dialtone=
72422mS CMARS: FindActiveARSByGroupID GroupID=17 - Not Found
72423mS CMLRQ: FindActiveLRQByGroupID GroupID=17 - Not Found
72423mS CMTARGET: Group Id: 17 has NOT been found in Line: 5
72423mS CMCallEvt: 0.1007.0 -1 BaseEP: NEW CMEndpoint f4e50898 TOTAL NOW=3 CALL_LIST=1
72425mS CMTARGET: DIAL LINE: 2 GROUP = 17 SUCCESS = f4e50898
72425mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: CancelTimer CMTCDialToneTimeout
72425mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: INITIAL TARGETING SUCCEEDED
72425mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: GetNoAnswerTimer:15
72426mS CMCallEvt: 0.1006.0 2 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
72427mS CMCallEvt: 17.1007.0 2 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
72428mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 17 Call: lid=17 id=1007 in=0
Called[2888@10.10.240.1] Type=Default (100) Reason=CMDRdirect Calling[3330] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Alaa Sammamah
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=3330
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceH323Phone type=88 number=8001 channel=0 rx_gain=32 tx_gain=32 ep_callid=1005 ipaddr=10.1.68.10 apps=0
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Alaa Sammamah
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 14626
user 'Alaa Sammamah' presentation Allowed
IE CMIEFastStartInfoData (6) 10 item(s)
Display [Alaa Sammamah>2888]
Timed: 29/09/13 14:51
Locale: ara
72430mS SIP Tx: TCP 10.1.68.10:5060 -> 10.10.240.1:5060
INVITE sip:2888@10.10.240.1 SIP/2.0
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
To: <sip:2888@10.10.240.1>
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
CSeq: 630221668 INVITE
Contact: "Alaa Sammamah" <sip:3330@10.1.68.10:5060;transport=tcp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 8.1 (43)
Content-Length: 271
v=0
o=UserA 3612928582 3500921764 IN IP4 10.1.68.10
s=Session SDP
c=IN IP4 10.1.68.10
t=0 0
m=audio 49154 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
72431mS CD: CALL: 252.1005.0 BState=Idle Cut=0 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=2888 () CallingNum=3330 (Alaa Sammamah) Internal=0 Time=809 AState=Dialling
72446mS SIP Rx: TCP 10.10.240.1:5060 -> 10.1.68.10:5060
SIP/2.0 100 Trying
Date: Sun, 29 Sep 2013 11:53:50 GMT
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
Allow-Events: presence
Content-Length: 0
To: <sip:2888@10.10.240.1>
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
CSeq: 630221668 INVITE
72449mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 17 Call: lid=17 id=1007 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=2888
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=1007 ipaddr=10.1.68.10 apps=0
72449mS CMCallEvt: 0.1006.0 2 TargetingEP: RequestEnd 17.1007.0 2 SIPTrunk Endpoint
72449mS CMTARGET: 252.1005.0 2 Alaa Sammamah.0: CancelTimer CMTCNoAnswerTimeout
72449mS CMCallEvt: 0.1006.0 -1 BaseEP: DELETE CMEndpoint f4e5c3b0 TOTAL NOW=2 CALL_LIST=1
72449mS CMCallEvt: 17.1007.0 2 SIPTrunk Endpoint: StateChange: END=B CMCSOffering->CMCSAccept
72450mS CMCallEvt: 252.1005.0 2 Alaa Sammamah.0: StateChange: END=A CMCSDialling->CMCSDialled
72450mS CMExtnEvt: v=1 State, new=Proceeding old=Dialling,0,0,Alaa Sammamah
72451mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 29/09/13 14:51
72452mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
72452mS CMExtnTx: v=3330, p1=0
CMProceeding
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=2888
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=1007 ipaddr=10.1.68.10 apps=0
Timed: 29/09/13 14:51
72454mS CD: CALL: 252.1005.0 BState=Ringing Cut=3 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=2888@10.10.240.1 () CallingNum=3330 (Alaa Sammamah) Internal=0 Time=832 AState=Dialled
72456mS SIP Rx: TCP 10.10.240.1:5060 -> 10.1.68.10:5060
SIP/2.0 404 Not Found
Reason: Q.850;cause=1
Date: Sun, 29 Sep 2013 11:53:50 GMT
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
Allow-Events: presence
Content-Length: 0
To: <sip:2888@10.10.240.1>;tag=ed8670f9-bccc-48ab-a850-c066054d2648-51165869
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
CSeq: 630221668 INVITE
72460mS SIP Tx: TCP 10.1.68.10:5060 -> 10.10.240.1:5060
ACK sip:2888@10.10.240.1 SIP/2.0
Via: SIP/2.0/TCP 10.1.68.10:5060;rport;branch=z9hG4bK74b94ee30671bba6942063bffcc56c0c
From: "Alaa Sammamah" <sip:3330@avaya.com>;tag=fee68729789c201c
To: <sip:2888@10.10.240.1>;tag=ed8670f9-bccc-48ab-a850-c066054d2648-51165869
Call-ID: 41e907b1e3423a20dfa5accb231c2fe4
CSeq: 630221668 ACK
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
User-Agent: IP Office 8.1 (43)
Content-Length: 0
72461mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 17 Call: lid=17 id=1007 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=2888
IE CMIEDeviceDetail (231) LOCALE=ara HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=17 channel=1 rx_gain=32 tx_gain=32 ep_callid=1007 ipaddr=10.1.68.10 apps=0
Cause=1, Unallocated (unassigned) number
72461mS CMCallEvt: 17.1007.0 2 SIPTrunk Endpoint: StateChange: END=B CMCSAccept->CMCSCompleted
72462mS CMLOGGING: CALL:2013/09/2914:51,00:00:00,000,3330,O,2888@10.10.240.1,2888,AlaaSammamah,,,0,,""n/a,0
72463mS CD: CALL: 252.1005.0 BState=Disconnecting Cut=1 Music=0.0 Aend="Alaa Sammamah(3330)" (0.0) Bend="Line 17" [Line 17] (0.0) CalledNum=2888@10.10.240.1 () CallingNum=3330 (Alaa Sammamah) Internal=0 Time=840 AState=Dialled
72463mS CD: CALL: 252.1005.0 Deleted
72464mS CMExtnEvt: Alaa Sammamah: CALL LOST (CMCauseUnallocatedNumber)
72464mS CMExtnEvt: Alaa Sammamah: Extn(3330) Calling Party Number(3330) Type(CMNTypeInternal)
72464mS CMCallEvt: 252.1005.0 -1 Alaa Sammamah.0: StateChange: END=X CMCSDialled->CMCSCompletedTone
72467mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 29/09/13 14:51
72467mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
72467mS CMExtnEvt: v=1 State, new=CMESCompleted old=Proceeding,0,0,Alaa Sammamah
72468mS CMCallEvt: 17.1007.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
72468mS CMCallEvt: END CALL:2 (f4e5d87c)
72469mS CMCallEvt: 17.1007.0 -1 BaseEP: DELETE CMEndpoint f4e50898 TOTAL NOW=1 CALL_LIST=0
72473mS CMMap: PCG::AddToneGenerator g B3[6] for cp[125]b0r1 append pcp[127]b0r1 (total 1)
72473mS CMMap: a=2.1 b=0.0 IP::ReserveCodec pcp[127]b0r1 allocated CMRTVocoder resource busy 1, total 42, codec type 4
72473mS CMMap: a=21.8 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 7, total 8
72474mS CMMap: a=21.8 b=1.255 T
72474mS CMMap: a=21.8 b=2.1 M22
72474mS CMMap: PlatformConnectionAudioSAP::ConnectVoice (connect) pcp[127]b0r1 echo_cancellation set to 0
72474mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[127]b0r1 Configure 2.1
72474mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[127]b0r1 ConnectIndication 2.1
72474mS CMMap: a=0.0 b=0.0 pcp[125]b0r1 RTPB3
72475mS H323Evt: SetOperational 2 10.1.68.10:49152 to 1
73605mS H323Evt: RTP(50r): 10.1.68.10/49152 10.1.68.20/51520 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=1972 SENT=51 (avg size=160) RECV=50 (avg size=160)
73647mS RES: Sun 29/9/2013 14:51:56 FreeMem=56383524(1) CMMsg=5 (6) Buff=5200 940 999 7423 5 Links=4815 CPU=14/29/3483/19347/22461/0
73647mS RES2: IP 500 V2 8.1(43) Tasks=52 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=78 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=54 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
75471mS CMExtnTx: v=3330, p1=8001
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
75472mS CMExtnRx: v=3330, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
75472mS CMCallEvt: 252.1005.0 -1 Alaa Sammamah.0: StateChange: END=X CMCSCompletedTone->CMCSCompleted
75473mS CMExtnTx: v=3330, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=252 id=1005 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 29/09/13 14:51
75473mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=CMESCompleted,0,0,Alaa Sammamah
75474mS CMExtnEvt: Alaa Sammamah: CALL LOST (CMCauseForceClear)
75474mS CMExtnEvt: Alaa Sammamah: Extn(3330) Calling Party Number(3330) Type(CMNTypeInternal)
75475mS CMExtnEvt: Alaa Sammamah: CMExtnHandler::SetCurrent( id: 1005->0 )
75475mS CMCallEvt: 252.1005.0 -1 Alaa Sammamah.-1: StateChange: END=X CMCSCompleted->CMCSDelete
75476mS CMTARGET: 252.1005.0 -1 BaseEP: ~CMTargetHandler f4e562a4 ep f4e5efbc
75476mS CMCallEvt: 252.1005.0 -1 BaseEP: DELETE CMEndpoint f4e5efbc TOTAL NOW=0 CALL_LIST=0
75478mS CMMap: a=0.0 b=0.0 pcp[125]b0r1 RTPB0
75478mS H323Evt: SetOperational 2 10.1.68.10:49152 to 0
75478mS CMMap: a=21.8 b=2.1 M02
75478mS CMMap: a=21.8 b=0.0 T0
75478mS CMMap: a=21.8 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 6, total 8
75479mS H323Evt: RTP(END): 10.1.68.10/49152 10.1.68.20/51520 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=3846 SENT=145 RECV=143 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
75480mS CMMap: a=2.1 b=0.0 IP::FreeCodec pcp[127]b0r1 freed CMRTVocoder resource busy 1, total 42
********** Warning: Logging to Screen Stopped **********
I think this is the problem:
Cause=1, Unallocated (unassigned) number
The number 2888 is not configured in the Cisco call Manager correctly.
That is why I received a 404 Not found.
Is this analysis true, if this mean i need to configure some kind of URI on the Cisco side.
Can I found a suggestion on How to do this on the cisco call manager ?
Regards,