waiting for line across wan

[SAToronto]

I have just rolled out our IPO server solution in a centralized model with 8 expansion V2s
All inbound and outbound calls are going through our own SBCs connected to the IPO server
When users across the wan go to make a call they are getting waiting for line for about 5 seconds and then I see the line get seized
Can anyone suggest how I can fix this??

TIA

Wayne

 

[amriddle01]

Monitor traces is always a good start. What have you tried so far? Or did you reach straight for the panic button?

 

[joe2938]

hit the # sign after digits, does it then route, if so how is your ars programmed?

 

[Westi]

the users in the other location and some shortcode(s) is most likely overlapping so the system waits if you dial more than just the extension numbers

Joe W.

FHandw, ACSS (SME)


"This is the end of the world, make sure to buy your T-shirt before it is too late"
Original expression of my daughter

 

[SAToronto]

Hi Guys
It seems this is really only happening at 1 site
as soon as the user hits 9 for an outside line it goes waiting for line @ ARS(SipX)

My ARS on the IPO server where ALL calls go through

N:
Dial
N"@ip of telco sbc"

There is no ARS on the local v2

Personally I don't think I need ARS as my IPO server is connected to my Avaya SBC, however our support vendor set it this way

Any thoughts?????

 

[janni78]

ARS have nothing to do with if you have an SBC or not, what you don't need is the "@ip of telco sbc" on your shortcode.

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

 

[SAToronto]

I removed the "@10.254.11.4" in the ARS however the calls still sit at waiting for line. The user picks up the handset and dials the number, however they hear dial tone after dialling for 9-15 seconds before they hear a ring

 

[janni78]

As amriddle01 said to begin with, do a monitor trace. That way you'll see what's happening and why, now we can guess at best.

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

 

[SAToronto]

ok..here are some logs


********** Warning: Logging to Screen Started **********
10:06:34 362381236mS H323Evt: Recv: RegistrationRequest 10.10.100.20; Extn(4315), time since last RRQ-KA 55008, Endpoints registered: 7; Endpoints in registration: 0
10:06:43 362391194mS H323Evt: Recv: RegistrationRequest 10.10.100.24; Extn(4313), time since last RRQ-KA 55009, Endpoints registered: 7; Endpoints in registration: 0
10:06:43 362391655mS H323Evt: Recv: RegistrationRequest 10.10.100.21; Extn(4319), time since last RRQ-KA 55010, Endpoints registered: 7; Endpoints in registration: 0
10:06:48 362395678mS H323Evt: Recv: RegistrationRequest 10.10.100.23; Extn(4321), time since last RRQ-KA 55010, Endpoints registered: 7; Endpoints in registration: 0
10:06:49 362396937mS H323Evt: Recv: RegistrationRequest 10.10.100.25; Extn(4312), time since last RRQ-KA 55011, Endpoints registered: 7; Endpoints in registration: 0
10:06:56 362403513mS CMExtnEvt: Paul Truong: No user activity
10:06:59 362406170mS CMCallEvt: 0000000000000000 0.2155.0 -1 BaseEP: NEW CMEndpoint f16b0db4 TOTAL NOW=3 CALL_LIST=1
10:06:59 362406170mS CMCallEvt: 0000000000000000 0.2155.0 -1 user.-1: NEW CMExtnEndpoint f16b0db4, Name=user, Extn=4317, Phys Extn=4317
10:06:59 362406170mS CMCallEvt: CREATE CALL:396 (f173862c)
10:06:59 362406171mS CMCallEvt: 0000000000000000 0.2156.0 -1 BaseEP: NEW CMEndpoint f1751958 TOTAL NOW=4 CALL_LIST=1
10:06:59 362406172mS CMExtnEvt: user: CMExtnHandler::SetCurrent( id: 0->2155 )
10:06:59 362406172mS CMExtnRx: v=4317, p1=0
CMSetup
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[4317] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=user
IE CMIECallingPartyKName (226)(Type=CMNameDefault) name=user
10:06:59 362406173mS CMCallEvt: 0a0a640a0000086b 0.2155.0 396 user.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
10:06:59 362406173mS CMExtnEvt: v=3 State, new=Dialling old=Idle,0,0,user
10:06:59 362406173mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: LOOKUP CALL ROUTE: GID=0 type=100 called_party= sub= calling=4317 calling_sub= dir=out complete=0 ses=0
10:06:59 362406173mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
10:06:59 362406174mS CMCallEvt: 0a0a640a0000086b 0.2155.0 396 user.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
10:06:59 362406174mS CMExtnTx: v=4317, p1=0
CMSetupAck
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
BChan: slot=20 chan=3
Timed: 20/07/16 10:06
10:06:59 362406175mS CD: CALL: 0.2155.0 BState=Idle Cut=1 Music=3.0 Aend="user(4317)" (20.3) Bend="" [] (0.0) CalledNum= () CallingNum=4317 (user) Internal=1 Time=5 AState=DialInitiated
10:06:59 362406175mS CMMap: a=20.3 b=0.0 D1
10:06:59 362406641mS RES: Wed 20/7/2016 10:07:00 FreeMem=53626544 Heap=53253580(3) Cache=372964 MemObjs=14760(15586) CMMsg=6(8) ASN=0 Buff=5200 704 1000 7443 5 Links=59232(60241) BTree=2718(7989) CPU=06.66% CPUStats=07.24%/5/10/2548/18348/21926/00.37%/1
/02.91% MCR=0 MCW=0
10:06:59 362406641mS RES2: (SE-E) IP 500 V2 9.1.6.0 build 153 Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=71 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=0 TCP=38(TLS=6) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:06:59 362406641mS RES4: XML MemObjs=63 PoolMem=4748404(2) FreePoolMem=4733100(0)
10:06:59 362406641mS RES5: CLog MemObjs=729 FreePoolMem(Objs)=3692(71) TotalMem=175650
10:07:00 362407669mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 9
10:07:00 362407669mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
10:07:00 362407670mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: Setting Hard Timer 7000
10:07:00 362407670mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: LOOKUP CALL ROUTE: GID=0 type=100 called_party=9 sub= calling=4317 calling_sub= dir=out complete=0 ses=0
10:07:00 362407670mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: ADD TARGET (N): number=9 type=100 depth=1 nobar=1 setorig=1 ses=0
10:07:00 362407671mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: SYS SC: 9 2 sc=type=Dial code=9N, num=. callinfop->sending_complete=0 secondary_dialtone=
10:07:00 362407671mS CMARS: FindActiveARSByGroupID GroupID=99999 - Not Found
10:07:00 362407671mS CMLRQ: FindActiveLRQByGroupID GroupID=99999 - Not Found
10:07:00 362407672mS CMMap: a=6.17 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f565c1e0) resource busy 2, total 32
10:07:00 362407672mS CMCallEvt: 0000000000000000 0.2157.0 -1 BaseEP: NEW CMEndpoint f1754014 TOTAL NOW=5 CALL_LIST=2
10:07:00 362407674mS CMTARGET: DIAL LINE: 396 GROUP = 99999 SUCCESS = f1754014
10:07:00 362407674mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: CancelTimer CMTCDelayedProcessing
10:07:00 362407674mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: INITIAL TARGETING SUCCEEDED
10:07:00 362407674mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: GetNoAnswerTimer:15
10:07:00 362407675mS CMCallEvt: 0000000000000000 0.2156.0 396 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:07:00 362407676mS CMCallEvt: 0a0a640a0000086d 0.2157.0 396 H323TrunkEP: StateChange: END=T CMCSIdle->CMCSOffering
10:07:00 362407677mS CMLineTx: v=17
CMSetup
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Calling[4317] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=20 chan=3
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageUtf8String
invokeId 15065
user 'user' presentation Allowed
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIECallSignalChannelData (8) unknown
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=user
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 3 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 1)
IE CMIECallingPartyKName (226)(Type=CMNameDefault) name=user
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
Timed: 20/07/16 10:07
Locale: enu
10:07:00 362407678mS CD: CALL: 0.2155.0 BState=Idle Cut=0 Music=0.0 Aend="user(4317)" (20.3) Bend="Line 17" [Line 17] (0.0) CalledNum=9 () CallingNum=4317 (user) Internal=0 Time=1508 AState=Dialling
10:07:00 362407679mS CMMap: a=20.3 b=0.0 D0
10:07:00 362407680mS H323Evt: v=0 stacknum=17 State, new=NullState, old=NullState id=-1
10:07:00 362407682mS H323Evt: v=0 stacknum=17 State, new=Initiated, old=NullState id=2157
10:07:00 362407733mS H323Evt: v=0 stacknum=17 State, new=OverlapSend, old=Initiated id=2157
10:07:00 362407733mS CMLineRx: v=17
CMSetupAck
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 3 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 1)
10:07:00 362407734mS CMCallEvt: 0000000000000000 0.2156.0 396 TargetingEP: RequestEnd 0a0a640a0000086d 0.2157.0 396 H323TrunkEP
10:07:00 362407734mS CMTARGET: 0a0a640a0000086b 0.2155.0 396 user.0: CancelTimer CMTCNoAnswerTimeout
10:07:00 362407734mS CMCallEvt: 0000000000000000 0.2156.0 -1 BaseEP: DELETE CMEndpoint f1751958 TOTAL NOW=4 CALL_LIST=2
10:07:00 362407734mS CMCallEvt: 0a0a640a0000086d 0.2157.0 396 H323TrunkEP: StateChange: END=B CMCSOffering->CMCSOverlapRecv
10:07:00 362407735mS CMExtnTx: v=4317, p1=0
CMFacility
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Timed: 20/07/16 10:07
10:07:00 362407735mS CD: CALL: 0.2155.0 BState=Idle Cut=2 Music=0.0 Aend="user(4317)" (20.3) Bend="Line 17" [Line 17] (267.1) CalledNum=9 () CallingNum=4317 (user) Internal=0 Time=1565 AState=Dialling
10:07:00 362407776mS CMLineRx: v=17
CMProgress
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDOrigNotISDN (3)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 3 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 1)
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
10:07:00 362407776mS CMCallEvt: 0a0a640a0000086d 0.2157.0 396 H323TrunkEP: StateChange: END=B CMCSOverlapRecv->CMCSAccept
10:07:00 362407777mS CMCallEvt: 0a0a640a0000086b 0.2155.0 396 user.0: StateChange: END=A CMCSDialling->CMCSRingBack
10:07:00 362407777mS CMExtnEvt: v=3 State, new=Alerting old=Dialling,0,0,user
10:07:00 362407778mS CMMap: IP::SetCodec pcp[686]b0r0 0 -> f565c1e0
10:07:00 362407780mS CMExtnTx: v=4317, p1=0
CMProgress
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDOrigNotISDN (3)
Timed: 20/07/16 10:07
10:07:00 362407780mS CD: CALL: 0.2155.0 BState=Ringing Cut=3 Music=0.0 Aend="user(4317)" (20.3) Bend="Line 17" [Line 17] (267.1) CalledNum=9 () CallingNum=4317 (user) Internal=0 Time=1610 AState=Ringing
10:07:00 362407781mS H323Evt: SESS 12f SetOperational local 10.10.100.10:0 remote 0.0.0.0:0 to 0
10:07:00 362407781mS H323Evt: SESS 12f SetRemUDP 0 -> 43076, remote IP 0.0.0.0 -> 10.15.5.136
10:07:00 362407782mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
10:07:00 362407782mS CMMap: PCGS CPReserveCodec for the other end (pcp[686]b0r1) true
10:07:00 362407782mS CMMap: PCG::MapBChan pcp[110]b1r0 cp_b f55a7c48 other_cp_b f565c048 type CGTypeSimple
10:07:00 362407782mS CMMap: a=6.17 b=20.3 M12
10:07:00 362407782mS CMMap: PlatformConnectionAudioSAP::Bind pcp[686]b0r1 to 6.17
10:07:00 362407782mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[686]b0r1 Configure 6.17
10:07:00 362407782mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Open got rtpRelay ID: 2
10:07:00 362407783mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Configure success
10:07:00 362407783mS CMMap: PlatformConnectionAudioSAP::ConnectVoice local IP addr 10.10.100.10:49154, Remote IP addr 10.15.5.136:43076
10:07:00 362407783mS CMMap: PlatformConnectionAudioSAP::ConnectVoice DSP IP addr 1.1.1.4:32768, telogyHost IP addr 1.1.1.1:42
10:07:00 362407783mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Start success
10:07:00 362407783mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[686]b0r1 ConnectIndication 6.17
10:07:00 362407783mS H323Evt: SESS 12f SetOperational local 10.10.100.10:49154 remote 10.15.5.136:43076 to 1

********** SysMonitor v9.1.6.0 build 153 [connected to 10.10.100.10 (EDMv2 (Server Edition(E)))] **********
10:07:01 362408947mS PRN: Monitor Status S-Edition Expansion (V2) 9.1.6.0 build 153
10:07:01 362408948mS PRN: LAW=U PRI=0, BRI=0, ALOG=8, VCOMP=32, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=3 TYP=2) 1-X=0 CALLS=2(TOT=396)
10:07:02 362409133mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 7
10:07:02 362409133mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[7] Type=Default (100) Reason=CMDRdirect Keypad[7]
10:07:02 362409134mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[7] Type=Default (100) Reason=CMDRdirect Keypad[7]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:02 362409136mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409136mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409136mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:02 362409136mS CMMap: a=20.3 b=6.17 M12
10:07:02 362409382mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 8
10:07:02 362409382mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
10:07:02 362409383mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:02 362409386mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409386mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409386mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:02 362409386mS CMMap: a=20.3 b=6.17 M12
10:07:02 362409595mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 0
10:07:02 362409595mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
10:07:02 362409596mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:02 362409599mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409599mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409599mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:02 362409599mS CMMap: a=20.3 b=6.17 M12
10:07:02 362409882mS CMExtnTx: v=4332, p1=8005
CMFacility
Line: type=IPLine 250 Call: lid=256 id=7 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
10:07:02 362409882mS CMExtnRx: v=4332, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=256 id=2152 in=0
10:07:02 362409883mS CMCallEvt: 0a0a640a00000868 256.2152.0 395 Paul Truong.0: StateChange: END=A CMCSConnected->CMCSCompleted
10:07:02 362409883mS CMExtnEvt: v=7 State, new=PortRecoverDelay old=Connected,0,0,Paul Truong
10:07:02 362409885mS CMExtnTx: v=4332, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=256 id=2152 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 20/07/16 10:07
10:07:02 362409885mS CMLOGGING: CALL:2016/07/2010:05,00:01:02,003,4332,O,4316,4316,PaulTruong,,,1,,"",0,n/a
10:07:02 362409885mS CD: CALL: 256.2152.0 BState=Connected Cut=2 Music=0.0 Aend="Paul Truong(4332)" (0.0) Bend="Jeffrey Campbel(4316)" [Jeffrey Campbel(4316)] (20.11) CalledNum=4316 (Jeffrey Campbel) CallingNum=4332 (Paul Truong) Internal=1 Time=67288 A
State=Idle
10:07:02 362409886mS CD: CALL: 256.2152.0 Deleted
10:07:02 362409886mS CMExtnEvt: Paul Truong: CALL LOST (CMCauseNormal)
10:07:02 362409886mS CMExtnEvt: Paul Truong: Extn(4332) Calling Party Number(4332) Type(CMNTypeInternal)
10:07:02 362409886mS CMExtnEvt: Paul Truong: CMExtnHandler::SetCurrent( id: 2152->0 )
10:07:02 362409887mS CMCallEvt: 0a0a640a00000868 256.2152.0 -1 Paul Truong.-1: StateChange: END=X CMCSCompleted->CMCSDelete
10:07:02 362409887mS CMExtnEvt: Jeffrey Campbel: CALL LOST (CMCauseNormal)
10:07:02 362409887mS CMExtnEvt: Jeffrey Campbel: Extn(4316) Calling Party Number(4332) Type(CMNTypeInternal)
10:07:02 362409888mS CMCallEvt: 0a0a640a0000086a 0.2154.0 -1 Jeffrey Campbel.0: StateChange: END=X CMCSConnected->CMCSCompleted
10:07:02 362409888mS CMExtnEvt: v=3 State, new=PortRecoverDelay old=Connected,0,0,Jeffrey Campbel
10:07:02 362409888mS CMExtnTx: v=4316, p1=0
CMReleaseComp
Line: type=DigitalExtn 4 Call: lid=0 id=2154 in=0
Called[4316] Type=Default (100) Reason=CMDRdirect Calling[4332] Type=Internal Plan=Default
Cause=16, Normal call clearing
Timed: 20/07/16 10:07
10:07:02 362409888mS CMExtnEvt: Jeffrey Campbel: CMExtnHandler::SetCurrent( id: 2154->0 )
10:07:02 362409889mS CMCallEvt: 0a0a640a0000086a 0.2154.0 -1 Jeffrey Campbel.-1: StateChange: END=X CMCSCompleted->CMCSDelete
10:07:02 362409889mS CMCallEvt: 0a0a640a0000086a 0.2154.0 -1 BaseEP: DELETE CMEndpoint f16b2cc0 TOTAL NOW=3 CALL_LIST=1
10:07:02 362409889mS CMCallEvt: END CALL:395 (f1732260)
10:07:02 362409890mS CMCallEvt: 0a0a640a00000868 256.2152.0 -1 BaseEP: DELETE CMEndpoint f17479a4 TOTAL NOW=2 CALL_LIST=1
10:07:02 362409895mS CMMap: PCG::UnmapBChan pcp[104]b1r0 cp_b f55aeee4 other_cp_b f565f224
10:07:02 362409895mS CMMap: a=6.1 b=20.11 M02
10:07:02 362409895mS CMMap: PlatformConnectionAudioSAP:isconnectRtpFilter rtpRelay ID: 1 Close success
10:07:02 362409895mS H323Evt: SESS 12e SetOperational local 10.10.100.10:49152 remote 10.10.100.26:50142 to 0
10:07:02 362409895mS CMMap: PCG::UnmapBChan pcp[684]b0r1 cp_b 0 other_cp_b 0
10:07:02 362409896mS H323Evt: SESS 12e: RTP(END): 10.10.100.10/49152 10.10.100.26/50142 CODEC=Ulaw64K(5) PKTSZ=160 RFC2833=off AGE=67286 SENT=3311 RECV=3318 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
10:07:02 362409896mS CMMap: a=6.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder(f567c22c) resource busy 2, total 32
10:07:02 362409899mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 6
10:07:02 362409900mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
10:07:02 362409901mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:02 362409903mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409903mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:02 362409904mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:02 362409904mS CMMap: a=20.3 b=6.17 M12
10:07:03 362410120mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 5
10:07:03 362410120mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[5] Type=Default (100) Reason=CMDRdirect Keypad[5]
10:07:03 362410121mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[5] Type=Default (100) Reason=CMDRdirect Keypad[5]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:03 362410124mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410124mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410124mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:03 362410124mS CMMap: a=20.3 b=6.17 M12
10:07:03 362410294mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 5
10:07:03 362410294mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[5] Type=Default (100) Reason=CMDRdirect Keypad[5]
10:07:03 362410295mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[5] Type=Default (100) Reason=CMDRdirect Keypad[5]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:03 362410297mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410297mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410297mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:03 362410297mS CMMap: a=20.3 b=6.17 M12
10:07:03 362410426mS PRN: Optimizing BTree Lists Completed...Started:362410425 Duration:0 Size:123 Attempted:123
10:07:03 362410545mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 1
10:07:03 362410545mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[1] Type=Default (100) Reason=CMDRdirect Keypad[1]
10:07:03 362410546mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[1] Type=Default (100) Reason=CMDRdirect Keypad[1]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:03 362410549mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410549mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410549mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:03 362410549mS CMMap: a=20.3 b=6.17 M12
10:07:03 362410720mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 2
10:07:03 362410720mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
10:07:03 362410721mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:03 362410724mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410724mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410724mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:03 362410724mS CMMap: a=20.3 b=6.17 M12
10:07:03 362410995mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 0
10:07:03 362410995mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
10:07:03 362410996mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:03 362410999mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410999mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:03 362410999mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:03 362410999mS CMMap: a=20.3 b=6.17 M12
10:07:04 362411232mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,4317: Digit Key Pressed 7
10:07:04 362411233mS CMExtnRx: v=4317, p1=0
CMInformation
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[7] Type=Default (100) Reason=CMDRdirect Keypad[7]
10:07:04 362411234mS CMLineTx: v=17
CMInformation
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[7] Type=Default (100) Reason=CMDRdirect Keypad[7]
BChan: slot=20 chan=3
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=user
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=user
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=4317
IE CMIEDeviceDetail (231) 0a0a640a0000086b LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=27 number=3 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=2155 ipaddr=10.10.100.10 apps=0 loc=0 em_loc=1 features2=0x0 is_spcall=0
10:07:04 362411235mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:04 362411235mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:04 362411235mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:04 362411235mS CMMap: a=20.3 b=6.17 M12
10:07:04 362411642mS RES: Wed 20/7/2016 10:07:04 FreeMem=53647292 Heap=53253580(3) Cache=393712 MemObjs=14725(15586) CMMsg=6(8) ASN=0 Buff=5200 704 1000 7443 5 Links=59221(60241) BTree=2715(7989) CPU=08.05% CPUStats=10.86%/2/11/2548/17577/21926/00.39%/1
/02.97% MCR=0 MCW=0
10:07:04 362411642mS RES2: (SE-E) IP 500 V2 9.1.6.0 build 153 Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=70 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=0 TCP=38(TLS=6) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:07:04 362411642mS RES4: XML MemObjs=63 PoolMem=4748404(2) FreePoolMem=4733100(0)
10:07:04 362411643mS RES5: CLog MemObjs=729 FreePoolMem(Objs)=3692(71) TotalMem=175650
10:07:04 362411887mS CMExtnEvt: Paul Truong: Recover Timer reason=CMTRWrapUp
10:07:04 362411887mS CMExtnEvt: v=7 State, new=Idle old=PortRecoverDelay,0,0,Paul Truong
10:07:04 362411887mS CMExtnTx: v=4332, p1=0
CMVoiceMailStatus
Line: type=IPLine 250 Call: lid=0 id=-1 in=0
Called[Paul Truong Msgs=0 Old=1 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Paul Truong Msgs=0]
Timed: 20/07/16 10:07
10:07:04 362411889mS CMExtnEvt: Jeffrey Campbel: Recover Timer reason=CMTRWrapUp
10:07:04 362411889mS CMExtnEvt: v=3 State, new=Idle old=PortRecoverDelay,0,0,Jeffrey Campbel
10:07:04 362411889mS CMExtnTx: v=4316, p1=0
CMVoiceMailStatus
Line: type=DigitalExtn 4 Call: lid=0 id=-1 in=0
Called[Jeffrey Campbel Msgs=0 Old=1 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Jeffrey Campbel Msgs=0]
Timed: 20/07/16 10:07
10:07:07 362414289mS H323Evt: Recv: RegistrationRequest 10.10.100.22; Extn(4316), time since last RRQ-KA 55012, Endpoints registered: 7; Endpoints in registration: 0
10:07:10 362418796mS H323Evt: Recv: RegistrationRequest 10.10.100.26; Extn(4332), time since last RRQ-KA 55016, Endpoints registered: 7; Endpoints in registration: 0
10:07:11 362419461mS CMLineRx: v=17
CMProgress
Line: type=IPLine 17 Call: lid=0 id=2157 in=0
Called[user] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 12 (misc oob 1 misc rfc2833 0 prio oob 0 prio rfc2833 1)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=97806551207
IE CMIEDeviceDetail (231) 0a0f05880001f0ca LOCALE=enu HW=11 VER=9 class=CMDeviceSIPTrunk type=0 number=9 channel=14 features=0x1 rx_gain=32 tx_gain=32 ep_callid=127178 ipaddr=10.15.5.136 apps=0 loc=999 em_loc=999 features2=0x0 is_spcall=1
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
10:07:11 362419462mS CMCallEvt: 0a0f05880001f0ca 0.2157.0 396 H323TrunkEP: StateChange: END=B CMCSAccept->CMCSRinging
10:07:11 362419465mS CMExtnTx: v=4317, p1=0
CMProgress
Line: type=DigitalExtn 2 Call: lid=0 id=2155 in=0
Called[user] Type=Default (100) Reason=CMDRdirect
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=97806551207
IE CMIEDeviceDetail (231) 0a0f05880001f0ca LOCALE=enu HW=11 VER=9 class=CMDeviceSIPTrunk type=0 number=9 channel=14 features=0x1 rx_gain=32 tx_gain=32 ep_callid=127178 ipaddr=10.15.5.136 apps=0 loc=999 em_loc=999 features2=0x0 is_spcall=1
Timed: 20/07/16 10:07
10:07:11 362419465mS CD: CALL: 0.2155.0 BState=Ringing Cut=3 Music=0.0 Aend="user(4317)" (20.3) Bend="Line 17" [Line 17] (267.1) CalledNum=97806551207 () CallingNum=4317 (user) Internal=0 Time=13295 AState=Ringing
10:07:11 362419466mS H323Evt: SESS 12f SetRfc2833: (1) rx payload 101 tx payload 101
10:07:11 362419466mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:11 362419466mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[686]b0r1 Configure 6.17
10:07:11 362419467mS CMMap: a=20.3 b=0.0 PCGS CPReserveCodec (pcp[686]b0r1) true
10:07:11 362419467mS CMMap: PCG::MapBChan pcp[686]b0r1 cp_b f565c048 other_cp_b f55a7c48 type CGTypeSimple
10:07:11 362419467mS CMMap: a=20.3 b=6.17 M12
10:07:11 362419645mS RES: Wed 20/7/2016 10:07:12 FreeMem=53646460 Heap=53253580(3) Cache=392880 MemObjs=14730(15586) CMMsg=6(8) ASN=0 Buff=5200 704 1000 7443 5 Links=59226(60241) BTree=2715(7989) CPU=08.16% CPUStats=09.12%/4/12/2548/17907/21926/00.46%/0
/02.93% MCR=0 MCW=0
10:07:11 362419645mS RES2: (SE-E) IP 500 V2 9.1.6.0 build 153 Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=67 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=0 TCP=38(TLS=6) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:07:11 362419646mS RES4: XML MemObjs=63 PoolMem=4748404(2) FreePoolMem=4733100(0)
10:07:11 362419646mS RES5: CLog MemObjs=729 FreePoolMem(Objs)=3692(71) TotalMem=175650

********** Warning: Logging to Screen Stopped **********

 

[janni78]

Thanks for informing us on what you were doing in the log example.

What are your dial timer/count under System -> Telephony.



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

 

[SAToronto]

hi Janni
it was set to 7 / 0
I dropped it to 4 /0 which made a little difference...8 seconds now

 

[amriddle01]

This is due to your shortcodes, you need to make the system dial the instant it gets a valid number and the same in the system at the other end of the SCN, you are relying on 2 sets of timers to elapse and that's causing the delay, you need to work out how to make an exact match, for example in the UK most national numbers are 11 digits and begin 0 so the following codes give an instant dial (in ARS):

0xxxxxxxxxx
Dial
.

And to catch the odd 10 digit number

0N;
Dial
.

That way 99% of calls are instant once you hit the 11th digit, except 10 digit numbers which are quite rare and they have to wait for the dial delay timer to elapse