Hi, Im trying to help a friend downsize his IPO from having a T1 to just four analog trunks. However, he can no longer make outside calls and gets a busy after 10 digits. We reprogrammed the analog lines to group 0 incoming and outgoing. Below is the capture of him trying an 800 call. I have to admit Im new at this, but it looks to me like he's trying to select route 7. However, I only have one route built in LCR and that is to line 0. Does anyone have a suggestion?
Thanks,
Joe
********** Warning: TEXT Logging to File STOPPED on 19/7/2012 14:49:20 **********
292742mS PRN: Monitor Started IP=192.168.101.106 IP 406 DS 3.1(56) Primrose
292743mS PRN: LAW=U PRI=0, BRI=0, ALOG=4, ADSL=0 VCOMP=8, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=0 TYP=3) CALLS=0(TOT=6)
303463mS CMExtnRx: v=2607, p1=1
CMSetup
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
303463mS CMExtnEvt: v=1 State, new=DialReq old=Idle,0,0,
303464mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party= sub= calling=2607 in=0 complete=0
303464mS CMTARGET: ADD TARGET:7 number= type=100 depth=1 nobar=1 setorig=1
303464mS CMTARGET: LOOKUP CALL ROUTE:7 returned 0
303464mS CMCallEvt: Astate
303465mS CD: CALL: 0.1013.0 State=0 Cut=0 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="" [] (0.0) CalledNum= () CallingNum=2607 () Internal=1 Time=1 Astate=7
303465mS CMExtnEvt: v=1 State, new=Dialling old=DialReq,0,0,
303465mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 19/07/12 16:13
303465mS CMExtnTx: v=2607, p1=1
CMSetupAck
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
BChan: slot=1 chan=3
Timed: 19/07/12 16:13
303466mS CMCallEvt: Astate
303466mS CD: CALL: 0.1013.0 State=0 Cut=0 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="" [] (0.0) CalledNum= () CallingNum=2607 () Internal=1 Time=3 Astate=9
303466mS CMMap: a=1.3 b=0.0 D1
303727mS RES: Thu 19/7/2012 16:13:21 FreeMem=48631964(38) CMMsg=5 (6) Buff=100 595 497 566 5 Links=9575 Elements=0
304622mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[9] Type=Default (100) Reason=CMDRdirect
304622mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 19/07/12 16:13
304623mS CMMap: a=1.3 b=0.0 D0
304623mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9 sub= calling=2607 in=0 complete=0
304623mS CMTARGET: ADD TARGET:7 number=9 type=100 depth=1 nobar=1 setorig=1
304623mS CMTARGET: SYS SC:7 9 1 sc=type=Dial code=9, num=N
304624mS CMTARGET: LCR PARTIAL:7 len=1
304624mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
305470mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
305470mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91 sub= calling=2607 in=0 complete=0
305470mS CMTARGET: ADD TARGET:7 number=91 type=100 depth=1 nobar=1 setorig=1
305471mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
305796mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[8] Type=Default (100) Reason=CMDRdirect
305796mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918 sub= calling=2607 in=0 complete=0
305796mS CMTARGET: ADD TARGET:7 number=918 type=100 depth=1 nobar=1 setorig=1
305796mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306054mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
306054mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9180 sub= calling=2607 in=0 complete=0
306054mS CMTARGET: ADD TARGET:7 number=9180 type=100 depth=1 nobar=1 setorig=1
306055mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306230mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
306230mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91800 sub= calling=2607 in=0 complete=0
306230mS CMTARGET: ADD TARGET:7 number=91800 type=100 depth=1 nobar=1 setorig=1
306231mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306458mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[7] Type=Default (100) Reason=CMDRdirect
306458mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007 sub= calling=2607 in=0 complete=0
306458mS CMTARGET: ADD TARGET:7 number=918007 type=100 depth=1 nobar=1 setorig=1
306459mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306647mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[5] Type=Default (100) Reason=CMDRdirect
306647mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9180075 sub= calling=2607 in=0 complete=0
306647mS CMTARGET: ADD TARGET:7 number=9180075 type=100 depth=1 nobar=1 setorig=1
306648mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306822mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[6] Type=Default (100) Reason=CMDRdirect
306822mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91800756 sub= calling=2607 in=0 complete=0
306822mS CMTARGET: ADD TARGET:7 number=91800756 type=100 depth=1 nobar=1 setorig=1
306822mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307052mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
307052mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007561 sub= calling=2607 in=0 complete=0
307052mS CMTARGET: ADD TARGET:7 number=918007561 type=100 depth=1 nobar=1 setorig=1
307052mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307474mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
307474mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9180075610 sub= calling=2607 in=0 complete=0
307474mS CMTARGET: ADD TARGET:7 number=9180075610 type=100 depth=1 nobar=1 setorig=1
307474mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307648mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
307648mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91800756100 sub= calling=2607 in=0 complete=0
307648mS CMTARGET: ADD TARGET:7 number=91800756100 type=100 depth=1 nobar=1 setorig=1
307649mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307823mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
307824mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007561000 sub= calling=2607 in=0 complete=0
307824mS CMTARGET: ADD TARGET:7 number=918007561000 type=100 depth=1 nobar=1 setorig=1
307824mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
313825mS PRN: CMCall::Forced Sending Complete
313825mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007561000 sub= calling=2607 in=0 complete=1
313825mS CMTARGET: ADD TARGET:7 number=918007561000 type=100 depth=1 nobar=1 setorig=1
313825mS CMTARGET: SYS SC:7 918007561000 7 7561000 sc=type=Dial code=[9]1800N;, num=1800N
313826mS CMTARGET: LCR MATCH:7 (current LCR=Main Trunk) nsc=type=Dial3K1 code=1N;, num=1NS608521E lcr=18007561000 cpn=18007561000 dtmf=
313826mS CMTARGET: DIAL LINE:7 GROUP=0 SUCCESS=1
313826mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 1
313826mS CMCallEvt: Astate
313827mS CD: CALL: 0.1013.0 State=0 Cut=1 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="Line 1" [Line 1] (0.0) CalledNum=18007561000 () CallingNum=6085212607 () Internal=0 Time=10363 Astate=7
313827mS CMExtnTx: v=2607, p1=1
CMSetupAck
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
Called[18007561000] Type=Default (100) Reason=CMDRdirect
BChan: slot=1 chan=3
Display [18007561000]
Timed: 19/07/12 16:13
313828mS CMCallEvt: Astate
313828mS CD: CALL: 0.1013.0 State=0 Cut=1 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="Line 1" [Line 1] (0.0) CalledNum=18007561000 () CallingNum=6085212607 () Internal=0 Time=10365 Astate=8
318841mS CMTARGET: LCR TIMEOUT:7
318842mS CMTARGET: LCR NOT MATCHED:7 (cpn=18007561000)
318842mS CMTARGET: ADD TARGET:7 number=918007561000 type=100 depth=1 nobar=1 setorig=0
318842mS CMTARGET: SYS SC:7 918007561000 7 7561000 sc=type=Dial code=[9]1800N;, num=1800N
318843mS CMTARGET: LCR NOT MATCHED:7 (cpn=18007561000)
318843mS CMTARGET: DIAL LINE:7 GROUP=0 SUCCESS=0
318843mS CMTARGET: SELECT:7 1 0 TGHG=00000000 TGUSER=00000000 INCL=00000000 EXCL=00000000
318843mS CMTARGET: SELECT:7 NO TARGETS, TRY VOICEMAIL
318844mS PRN: CALL: 0.1013.0 Deleted leaving 0 CMCall objects
318844mS CMCallEvt: Astate
318844mS CMCallEvt: BState
318844mS CMLOGGING: CALL:2012/07/1916:13,00:00:00,000,2607,O,18007561000,918007561000,BowersM,,,1,18007561000,""
318845mS CD: CALL: 0.1013.0 State=0 Cut=0 Music=0.1 Aend="BowersM(2607)" (1.3) Bend="" [] (0.0) CalledNum=18007561000 () CallingNum=6085212607 () Internal=1 Time=15382 Astate=0
318845mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
UUI type=User2User [TB1\r\n] [0x54 0x42 0x31 0x0d 0x0a ]
Cause=17, User busy
Timed: 19/07/12 16:13
318846mS CMExtnEvt: v=1 State, new=DialReq old=Dialling,0,0,
318846mS CD: CALL: 0.1013.0 Deleted
319226mS RES: Thu 19/7/2012 16:13:36 FreeMem=48634252(38) CMMsg=5 (6) Buff=98 595 497 566 5 Links=9574 Elements=0
325796mS CMExtnRx: v=2607, p1=1
CMRelease
Line: type=NoLine 0 Call: lid=0 id=1013 in=0
325796mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=DialReq,0,0,
325796mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
UUI type=User2User [TB0\r\n] [0x54 0x42 0x30 0x0d 0x0a ]
Timed: 19/07/12 16:13
325797mS CMExtnTx: v=2607, p1=1
CMReleaseComp
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 19/07/12 16:13
327797mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,
337727mS RES: Thu 19/7/2012 16:13:55 FreeMem=48633012(38) CMMsg=5 (6) Buff=100 595 497 566 5 Links=9579 Elements=0
341068mS PRN: LVMailFlashMan::FiveMinuteActions: Free: 395.8 MBytes ( 77% )
341068mS PRN: 13 Hours 44 Minutes Approx. Remaining
341068mS PRN: FMML Size: 504
Thanks,
Joe
********** Warning: TEXT Logging to File STOPPED on 19/7/2012 14:49:20 **********
292742mS PRN: Monitor Started IP=192.168.101.106 IP 406 DS 3.1(56) Primrose
292743mS PRN: LAW=U PRI=0, BRI=0, ALOG=4, ADSL=0 VCOMP=8, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=0 TYP=3) CALLS=0(TOT=6)
303463mS CMExtnRx: v=2607, p1=1
CMSetup
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
303463mS CMExtnEvt: v=1 State, new=DialReq old=Idle,0,0,
303464mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party= sub= calling=2607 in=0 complete=0
303464mS CMTARGET: ADD TARGET:7 number= type=100 depth=1 nobar=1 setorig=1
303464mS CMTARGET: LOOKUP CALL ROUTE:7 returned 0
303464mS CMCallEvt: Astate
303465mS CD: CALL: 0.1013.0 State=0 Cut=0 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="" [] (0.0) CalledNum= () CallingNum=2607 () Internal=1 Time=1 Astate=7
303465mS CMExtnEvt: v=1 State, new=Dialling old=DialReq,0,0,
303465mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 19/07/12 16:13
303465mS CMExtnTx: v=2607, p1=1
CMSetupAck
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
BChan: slot=1 chan=3
Timed: 19/07/12 16:13
303466mS CMCallEvt: Astate
303466mS CD: CALL: 0.1013.0 State=0 Cut=0 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="" [] (0.0) CalledNum= () CallingNum=2607 () Internal=1 Time=3 Astate=9
303466mS CMMap: a=1.3 b=0.0 D1
303727mS RES: Thu 19/7/2012 16:13:21 FreeMem=48631964(38) CMMsg=5 (6) Buff=100 595 497 566 5 Links=9575 Elements=0
304622mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[9] Type=Default (100) Reason=CMDRdirect
304622mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 19/07/12 16:13
304623mS CMMap: a=1.3 b=0.0 D0
304623mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9 sub= calling=2607 in=0 complete=0
304623mS CMTARGET: ADD TARGET:7 number=9 type=100 depth=1 nobar=1 setorig=1
304623mS CMTARGET: SYS SC:7 9 1 sc=type=Dial code=9, num=N
304624mS CMTARGET: LCR PARTIAL:7 len=1
304624mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
305470mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
305470mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91 sub= calling=2607 in=0 complete=0
305470mS CMTARGET: ADD TARGET:7 number=91 type=100 depth=1 nobar=1 setorig=1
305471mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
305796mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[8] Type=Default (100) Reason=CMDRdirect
305796mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918 sub= calling=2607 in=0 complete=0
305796mS CMTARGET: ADD TARGET:7 number=918 type=100 depth=1 nobar=1 setorig=1
305796mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306054mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
306054mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9180 sub= calling=2607 in=0 complete=0
306054mS CMTARGET: ADD TARGET:7 number=9180 type=100 depth=1 nobar=1 setorig=1
306055mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306230mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
306230mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91800 sub= calling=2607 in=0 complete=0
306230mS CMTARGET: ADD TARGET:7 number=91800 type=100 depth=1 nobar=1 setorig=1
306231mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306458mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[7] Type=Default (100) Reason=CMDRdirect
306458mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007 sub= calling=2607 in=0 complete=0
306458mS CMTARGET: ADD TARGET:7 number=918007 type=100 depth=1 nobar=1 setorig=1
306459mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306647mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[5] Type=Default (100) Reason=CMDRdirect
306647mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9180075 sub= calling=2607 in=0 complete=0
306647mS CMTARGET: ADD TARGET:7 number=9180075 type=100 depth=1 nobar=1 setorig=1
306648mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
306822mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[6] Type=Default (100) Reason=CMDRdirect
306822mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91800756 sub= calling=2607 in=0 complete=0
306822mS CMTARGET: ADD TARGET:7 number=91800756 type=100 depth=1 nobar=1 setorig=1
306822mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307052mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
307052mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007561 sub= calling=2607 in=0 complete=0
307052mS CMTARGET: ADD TARGET:7 number=918007561 type=100 depth=1 nobar=1 setorig=1
307052mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307474mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
307474mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=9180075610 sub= calling=2607 in=0 complete=0
307474mS CMTARGET: ADD TARGET:7 number=9180075610 type=100 depth=1 nobar=1 setorig=1
307474mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307648mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
307648mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=91800756100 sub= calling=2607 in=0 complete=0
307648mS CMTARGET: ADD TARGET:7 number=91800756100 type=100 depth=1 nobar=1 setorig=1
307649mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
307823mS CMExtnRx: v=2607, p1=1
CMInformation
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
307824mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007561000 sub= calling=2607 in=0 complete=0
307824mS CMTARGET: ADD TARGET:7 number=918007561000 type=100 depth=1 nobar=1 setorig=1
307824mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 0
313825mS PRN: CMCall::Forced Sending Complete
313825mS CMTARGET: LOOKUP CALL ROUTE:7 type=100 called_party=918007561000 sub= calling=2607 in=0 complete=1
313825mS CMTARGET: ADD TARGET:7 number=918007561000 type=100 depth=1 nobar=1 setorig=1
313825mS CMTARGET: SYS SC:7 918007561000 7 7561000 sc=type=Dial code=[9]1800N;, num=1800N
313826mS CMTARGET: LCR MATCH:7 (current LCR=Main Trunk) nsc=type=Dial3K1 code=1N;, num=1NS608521E lcr=18007561000 cpn=18007561000 dtmf=
313826mS CMTARGET: DIAL LINE:7 GROUP=0 SUCCESS=1
313826mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:7 returned 1
313826mS CMCallEvt: Astate
313827mS CD: CALL: 0.1013.0 State=0 Cut=1 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="Line 1" [Line 1] (0.0) CalledNum=18007561000 () CallingNum=6085212607 () Internal=0 Time=10363 Astate=7
313827mS CMExtnTx: v=2607, p1=1
CMSetupAck
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
Called[18007561000] Type=Default (100) Reason=CMDRdirect
BChan: slot=1 chan=3
Display [18007561000]
Timed: 19/07/12 16:13
313828mS CMCallEvt: Astate
313828mS CD: CALL: 0.1013.0 State=0 Cut=1 Music=0.0 Aend="BowersM(2607)" (1.3) Bend="Line 1" [Line 1] (0.0) CalledNum=18007561000 () CallingNum=6085212607 () Internal=0 Time=10365 Astate=8
318841mS CMTARGET: LCR TIMEOUT:7
318842mS CMTARGET: LCR NOT MATCHED:7 (cpn=18007561000)
318842mS CMTARGET: ADD TARGET:7 number=918007561000 type=100 depth=1 nobar=1 setorig=0
318842mS CMTARGET: SYS SC:7 918007561000 7 7561000 sc=type=Dial code=[9]1800N;, num=1800N
318843mS CMTARGET: LCR NOT MATCHED:7 (cpn=18007561000)
318843mS CMTARGET: DIAL LINE:7 GROUP=0 SUCCESS=0
318843mS CMTARGET: SELECT:7 1 0 TGHG=00000000 TGUSER=00000000 INCL=00000000 EXCL=00000000
318843mS CMTARGET: SELECT:7 NO TARGETS, TRY VOICEMAIL
318844mS PRN: CALL: 0.1013.0 Deleted leaving 0 CMCall objects
318844mS CMCallEvt: Astate
318844mS CMCallEvt: BState
318844mS CMLOGGING: CALL:2012/07/1916:13,00:00:00,000,2607,O,18007561000,918007561000,BowersM,,,1,18007561000,""
318845mS CD: CALL: 0.1013.0 State=0 Cut=0 Music=0.1 Aend="BowersM(2607)" (1.3) Bend="" [] (0.0) CalledNum=18007561000 () CallingNum=6085212607 () Internal=1 Time=15382 Astate=0
318845mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
UUI type=User2User [TB1\r\n] [0x54 0x42 0x31 0x0d 0x0a ]
Cause=17, User busy
Timed: 19/07/12 16:13
318846mS CMExtnEvt: v=1 State, new=DialReq old=Dialling,0,0,
318846mS CD: CALL: 0.1013.0 Deleted
319226mS RES: Thu 19/7/2012 16:13:36 FreeMem=48634252(38) CMMsg=5 (6) Buff=98 595 497 566 5 Links=9574 Elements=0
325796mS CMExtnRx: v=2607, p1=1
CMRelease
Line: type=NoLine 0 Call: lid=0 id=1013 in=0
325796mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=DialReq,0,0,
325796mS CMExtnTx: v=2607, p1=1
CMInbandTone
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
UUI type=User2User [TB0\r\n] [0x54 0x42 0x30 0x0d 0x0a ]
Timed: 19/07/12 16:13
325797mS CMExtnTx: v=2607, p1=1
CMReleaseComp
Line: type=DigitalExtn 3 Call: lid=0 id=1013 in=0
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 19/07/12 16:13
327797mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,
337727mS RES: Thu 19/7/2012 16:13:55 FreeMem=48633012(38) CMMsg=5 (6) Buff=100 595 497 566 5 Links=9579 Elements=0
341068mS PRN: LVMailFlashMan::FiveMinuteActions: Free: 395.8 MBytes ( 77% )
341068mS PRN: 13 Hours 44 Minutes Approx. Remaining
341068mS PRN: FMML Size: 504