AT&T is rejecting calls from us to one of their toll free numbers. We are sending the billing number so I do not get an unrecognized number error. Our carrier, Telepacific says they can see AT&T rejecting the call and asked if I could change the type from National to Unknown. I have tried every combination of s and si prefixes as well as no prefix and can see the number being sent is correct but it shows a type of National no matter which prefix I use. Can this be changed somewhere by using a prefix or no user code?
Trace with the i prefix:
14:30:56 842672441mS CMExtnRx: v=217, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=261 id=3675 in=0
Called[918774627356] Type=Default (100) Reason=CMDRdirect SndComp Calling[217] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Craig Ness
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=217
14:30:56 842672442mS CMCallEvt: 261.3675.0 659 Craig Ness.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
14:30:56 842672442mS CMExtnEvt: v=0 State, new=Dialling old=Idle,0,0,Craig Ness
14:30:56 842672442mS CMTARGET: 261.3675.0 659 Craig Ness.0: LOOKUP CALL ROUTE: type=100 called_party=918774627356 sub= calling=217 dir=out complete=1 ses=0
14:30:56 842672442mS CMTARGET: 261.3675.0 659 Craig Ness.0: ADD TARGET (N): number=918774627356 type=100 depth=1 nobar=1 setorig=1 ses=0
14:30:56 842672443mS CMTARGET: 261.3675.0 659 Craig Ness.0: USER SC: 918774627356 2 18774627356 sc=type=Dial code=9N, num=N
14:30:56 842672443mS CMARS: FindActiveARSByGroupID GroupID=57 - Found
14:30:56 842672443mS CMARS: MakeCallTarget - Called Number: 18774627356
14:30:56 842672443mS CMCallEvt: 0.3677.0 -1 BaseEP: NEW CMEndpoint f4cb2550 TOTAL NOW=3 CALL_LIST=1
14:30:56 842672444mS CMTARGET: 261.3675.0 659 Craig Ness.0: INITIAL TARGETING SUCCEEDED
14:30:56 842672444mS CMTARGET: 261.3675.0 659 Craig Ness.0: GetNoAnswerTimer:19
14:30:56 842672444mS CMCallEvt: 261.3675.0 659 Craig Ness.0: StateChange: END=A CMCSDialInitiated->CMCSDialled
14:30:56 842672445mS CMExtnEvt: v=0 State, new=Proceeding old=Dialling,0,0,Craig Ness
14:30:56 842672446mS CMExtnTx: v=217, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=261 id=3675 in=0
Timed: 17/10/14 14:30
14:30:56 842672447mS CMCallEvt: 0.3676.0 659 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
14:30:56 842672447mS CMCallEvt: 0.3677.0 659 ARS for Craig: StateChange: END=T CMCSIdle->CMCSOffering
14:30:56 842672448mS CMCallEvt: 0.3676.0 659 TargetingEP: RequestEnd 0.3677.0 659 ARS for Craig
14:30:56 842672448mS CMTARGET: 261.3675.0 659 Craig Ness.0: CancelTimer CMTCNoAnswerTimeout
14:30:56 842672449mS CMCallEvt: 0.3677.0 659 ARS for Craig: StateChange: END=B CMCSOffering->CMCSOverlapRecv
14:30:56 842672449mS CMARS: FORM: Craig - Received Number: 18774627356
14:30:56 842672449mS CMARS: FOUND A SHORT CODE - short_code: 1N; - Tel: 1Nsi9259411244 - Called_Party: 18774627356 - Line Group Id: 0
14:30:56 842672450mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
14:30:56 842672450mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
14:30:56 842672450mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f55b3898) resource busy 1, total 10
14:30:56 842672450mS CMCallEvt: 0.3678.0 -1 BaseEP: NEW CMEndpoint f4d02450 TOTAL NOW=4 CALL_LIST=1
14:30:56 842672451mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:30:56 842672451mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:30:56 842672452mS CMARS: FOUND LINE - Line Id: 9 - using line group id: 0 - Called Number: 18774627356 - Calling Number: 9259411244
14:30:56 842672452mS CMARS: SEND Setup TO LINE
14:30:56 842672452mS CMCallEvt: 0.3678.0 659 Q931 Trunk:9 CHAN=8: StateChange: END=child CMCSIdle->CMCSOffering
14:30:56 842672453mS PRN: Setting configured voice gain for ch 8.
14:30:56 842672453mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=3678 in=0
Called[18774627356] Type=National (2) Reason=CMDRdirect Calling[9259411244] Type=National Plan=ISDN
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=8
Locale: enu
14:30:56 842672453mS CMCallEvt: 0.3676.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
14:30:56 842672453mS CMCallEvt: 0.3676.0 -1 BaseEP: DELETE CMEndpoint f4d34ee8 TOTAL NOW=3 CALL_LIST=1
14:30:56 842672455mS ISDNL3Evt: v=9 stacknum=9 State, new=Initiated, old=NullState id=3678
14:30:56 842672457mS CD: CALL: 261.3675.0 BState=Idle Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="" [Line 9] (0.0) CalledNum=918774627356 () CallingNum=217 (Craig Ness) Internal=1 Time=23 AState=Dialled
14:30:56 842672470mS ISDNL3Evt: v=9 stacknum=9 State, new=Proceeding, old=Initiated id=3678
14:30:56 842672471mS CMLineRx: v=9
CMProceeding
Line: type=Q931Line 9 Call: lid=0 id=3678 in=0
BChan: slot=0 chan=8
14:30:56 842672472mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
14:30:56 842672472mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
14:30:56 842672472mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.3677.0 659 ARS for Craig - Call State: CMCSOverlapRecv
14:30:56 842672472mS CMCallEvt: 0.3677.0 -1 ARS for Craig: StateChange: END=X CMCSOverlapRecv->CMCSDelete
14:30:56 842672473mS CMCallEvt: 0.3678.0 659 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSOffering->CMCSAccept
14:30:56 842672473mS CMCallEvt: 0.3677.0 -1 BaseEP: DELETE CMEndpoint f4cb2550 TOTAL NOW=2 CALL_LIST=1
14:30:56 842672474mS CD: CALL: 261.3675.0 BState=Ringing Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="Line 9" [Line 9] (5.9) CalledNum=18774627356 () CallingNum=217 (Craig Ness) Internal=0 Time=40 AState=Dialled
14:30:58 842674037mS CMLineRx: v=9
CMProgress
Line: type=Q931Line 9 Call: lid=0 id=3678 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDInbandPattern (8)
Trace with no i prefix:
14:43:35 843430860mS CMExtnRx: v=217, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=261 id=3688 in=0
Called[918774627356] Type=Default (100) Reason=CMDRdirect SndComp Calling[217] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Craig Ness
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=217
14:43:35 843430860mS CMCallEvt: 261.3688.0 662 Craig Ness.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
14:43:35 843430860mS CMExtnEvt: v=0 State, new=Dialling old=Idle,0,0,Craig Ness
14:43:35 843430861mS CMTARGET: 261.3688.0 662 Craig Ness.0: LOOKUP CALL ROUTE: type=100 called_party=918774627356 sub= calling=217 dir=out complete=1 ses=0
14:43:35 843430861mS CMTARGET: 261.3688.0 662 Craig Ness.0: ADD TARGET (N): number=918774627356 type=100 depth=1 nobar=1 setorig=1 ses=0
14:43:35 843430861mS CMTARGET: 261.3688.0 662 Craig Ness.0: USER SC: 918774627356 2 18774627356 sc=type=Dial code=9N, num=N
14:43:35 843430862mS CMARS: FindActiveARSByGroupID GroupID=57 - Found
14:43:35 843430862mS CMARS: MakeCallTarget - Called Number: 18774627356
14:43:35 843430862mS CMCallEvt: 0.3690.0 -1 BaseEP: NEW CMEndpoint f4cb2550 TOTAL NOW=3 CALL_LIST=1
14:43:35 843430862mS CMTARGET: 261.3688.0 662 Craig Ness.0: INITIAL TARGETING SUCCEEDED
14:43:35 843430863mS CMTARGET: 261.3688.0 662 Craig Ness.0: GetNoAnswerTimer:19
14:43:35 843430863mS CMCallEvt: 261.3688.0 662 Craig Ness.0: StateChange: END=A CMCSDialInitiated->CMCSDialled
14:43:35 843430863mS CMExtnEvt: v=0 State, new=Proceeding old=Dialling,0,0,Craig Ness
14:43:35 843430865mS CMExtnTx: v=217, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=261 id=3688 in=0
Timed: 17/10/14 14:43
14:43:35 843430865mS CMCallEvt: 0.3689.0 662 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
14:43:35 843430866mS CMCallEvt: 0.3690.0 662 ARS for Craig: StateChange: END=T CMCSIdle->CMCSOffering
14:43:35 843430866mS CMCallEvt: 0.3689.0 662 TargetingEP: RequestEnd 0.3690.0 662 ARS for Craig
14:43:35 843430866mS CMTARGET: 261.3688.0 662 Craig Ness.0: CancelTimer CMTCNoAnswerTimeout
14:43:35 843430867mS CMCallEvt: 0.3690.0 662 ARS for Craig: StateChange: END=B CMCSOffering->CMCSOverlapRecv
14:43:35 843430868mS CMARS: FORM: Craig - Received Number: 18774627356
14:43:35 843430868mS CMARS: FOUND A SHORT CODE - short_code: 1N; - Tel: 1Ns9259411244 - Called_Party: 18774627356 - Line Group Id: 0
14:43:35 843430868mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
14:43:35 843430868mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
14:43:35 843430868mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f55b3898) resource busy 1, total 10
14:43:35 843430869mS CMCallEvt: 0.3691.0 -1 BaseEP: NEW CMEndpoint f4d02450 TOTAL NOW=4 CALL_LIST=1
14:43:35 843430869mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:43:35 843430869mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:43:35 843430870mS CMARS: FOUND LINE - Line Id: 9 - using line group id: 0 - Called Number: 18774627356 - Calling Number: 9259411244
14:43:35 843430870mS CMARS: SEND Setup TO LINE
14:43:35 843430871mS CMCallEvt: 0.3691.0 662 Q931 Trunk:9 CHAN=8: StateChange: END=child CMCSIdle->CMCSOffering
14:43:35 843430871mS PRN: Setting configured voice gain for ch 8.
14:43:35 843430871mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=3691 in=0
Called[18774627356] Type=National (2) Reason=CMDRdirect Calling[9259411244] Type=National Plan=ISDN
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=8
Locale: enu
14:43:35 843430871mS CMCallEvt: 0.3689.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
14:43:35 843430872mS CMCallEvt: 0.3689.0 -1 BaseEP: DELETE CMEndpoint f4d34ee8 TOTAL NOW=3 CALL_LIST=1
14:43:35 843430874mS CD: CALL: 261.3688.0 BState=Idle Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="" [Line 9] (0.0) CalledNum=918774627356 () CallingNum=217 (Craig Ness) Internal=1 Time=21 AState=Dialled
14:43:35 843430875mS ISDNL3Evt: v=9 stacknum=9 State, new=Initiated, old=NullState id=3691
14:43:35 843430890mS ISDNL3Evt: v=9 stacknum=9 State, new=Proceeding, old=Initiated id=3691
14:43:35 843430890mS CMLineRx: v=9
CMProceeding
Line: type=Q931Line 9 Call: lid=0 id=3691 in=0
BChan: slot=0 chan=8
14:43:35 843430891mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
14:43:35 843430891mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
14:43:35 843430891mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.3690.0 662 ARS for Craig - Call State: CMCSOverlapRecv
14:43:35 843430891mS CMCallEvt: 0.3690.0 -1 ARS for Craig: StateChange: END=X CMCSOverlapRecv->CMCSDelete
14:43:35 843430892mS CMCallEvt: 0.3691.0 662 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSOffering->CMCSAccept
14:43:35 843430892mS CMCallEvt: 0.3690.0 -1 BaseEP: DELETE CMEndpoint f4cb2550 TOTAL NOW=2 CALL_LIST=1
14:43:35 843430893mS CD: CALL: 261.3688.0 BState=Ringing Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="Line 9" [Line 9] (5.9) CalledNum=18774627356 () CallingNum=217 (Craig Ness) Internal=0 Time=40 AState=Dialled
14:43:36 843431127mS RES: Fri 17/10/2014 14:43:35 FreeMem=53572984 52552176(3) CachedMem=1020808 CMMsg=9(10) Buff=5200 1362 1000 7365 4 Links=2414 BTree=14163 CPU=09.03% CPUStats=24/31/4502/11803/14521/0/0 MCR=0 MCW=0
14:43:36 843431127mS RES2: IP 500 V2 9.0.4.0 build 965 Tasks=55 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=76 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=22(TLS=1) TAPI=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
14:43:36 843431127mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
14:43:36 843431448mS PRN: Optimizing BTree Lists Completed...Started:843430297
14:43:37 843432292mS CMLineRx: v=9
CMProgress
Line: type=Q931Line 9 Call: lid=0 id=3691 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDInbandPattern (8)
14:43:37 843432292mS CMCallEvt: 0.3691.0 662 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSAccept->CMCSRinging
14:43:37 843432293mS CMCallEvt: 261.3688.0 662 Craig Ness.0: StateChange: END=A CMCSDialled->CMCSRingBack
14:43:37 843432294mS CMExtnEvt: v=0 State, new=Alerting old=Proceeding,0,0,Craig Ness
14:43:37 843432296mS CMExtnTx: v=217, p1=0
Both show National as the type.
Trace with the i prefix:
14:30:56 842672441mS CMExtnRx: v=217, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=261 id=3675 in=0
Called[918774627356] Type=Default (100) Reason=CMDRdirect SndComp Calling[217] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Craig Ness
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=217
14:30:56 842672442mS CMCallEvt: 261.3675.0 659 Craig Ness.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
14:30:56 842672442mS CMExtnEvt: v=0 State, new=Dialling old=Idle,0,0,Craig Ness
14:30:56 842672442mS CMTARGET: 261.3675.0 659 Craig Ness.0: LOOKUP CALL ROUTE: type=100 called_party=918774627356 sub= calling=217 dir=out complete=1 ses=0
14:30:56 842672442mS CMTARGET: 261.3675.0 659 Craig Ness.0: ADD TARGET (N): number=918774627356 type=100 depth=1 nobar=1 setorig=1 ses=0
14:30:56 842672443mS CMTARGET: 261.3675.0 659 Craig Ness.0: USER SC: 918774627356 2 18774627356 sc=type=Dial code=9N, num=N
14:30:56 842672443mS CMARS: FindActiveARSByGroupID GroupID=57 - Found
14:30:56 842672443mS CMARS: MakeCallTarget - Called Number: 18774627356
14:30:56 842672443mS CMCallEvt: 0.3677.0 -1 BaseEP: NEW CMEndpoint f4cb2550 TOTAL NOW=3 CALL_LIST=1
14:30:56 842672444mS CMTARGET: 261.3675.0 659 Craig Ness.0: INITIAL TARGETING SUCCEEDED
14:30:56 842672444mS CMTARGET: 261.3675.0 659 Craig Ness.0: GetNoAnswerTimer:19
14:30:56 842672444mS CMCallEvt: 261.3675.0 659 Craig Ness.0: StateChange: END=A CMCSDialInitiated->CMCSDialled
14:30:56 842672445mS CMExtnEvt: v=0 State, new=Proceeding old=Dialling,0,0,Craig Ness
14:30:56 842672446mS CMExtnTx: v=217, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=261 id=3675 in=0
Timed: 17/10/14 14:30
14:30:56 842672447mS CMCallEvt: 0.3676.0 659 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
14:30:56 842672447mS CMCallEvt: 0.3677.0 659 ARS for Craig: StateChange: END=T CMCSIdle->CMCSOffering
14:30:56 842672448mS CMCallEvt: 0.3676.0 659 TargetingEP: RequestEnd 0.3677.0 659 ARS for Craig
14:30:56 842672448mS CMTARGET: 261.3675.0 659 Craig Ness.0: CancelTimer CMTCNoAnswerTimeout
14:30:56 842672449mS CMCallEvt: 0.3677.0 659 ARS for Craig: StateChange: END=B CMCSOffering->CMCSOverlapRecv
14:30:56 842672449mS CMARS: FORM: Craig - Received Number: 18774627356
14:30:56 842672449mS CMARS: FOUND A SHORT CODE - short_code: 1N; - Tel: 1Nsi9259411244 - Called_Party: 18774627356 - Line Group Id: 0
14:30:56 842672450mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
14:30:56 842672450mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
14:30:56 842672450mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f55b3898) resource busy 1, total 10
14:30:56 842672450mS CMCallEvt: 0.3678.0 -1 BaseEP: NEW CMEndpoint f4d02450 TOTAL NOW=4 CALL_LIST=1
14:30:56 842672451mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:30:56 842672451mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:30:56 842672452mS CMARS: FOUND LINE - Line Id: 9 - using line group id: 0 - Called Number: 18774627356 - Calling Number: 9259411244
14:30:56 842672452mS CMARS: SEND Setup TO LINE
14:30:56 842672452mS CMCallEvt: 0.3678.0 659 Q931 Trunk:9 CHAN=8: StateChange: END=child CMCSIdle->CMCSOffering
14:30:56 842672453mS PRN: Setting configured voice gain for ch 8.
14:30:56 842672453mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=3678 in=0
Called[18774627356] Type=National (2) Reason=CMDRdirect Calling[9259411244] Type=National Plan=ISDN
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=8
Locale: enu
14:30:56 842672453mS CMCallEvt: 0.3676.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
14:30:56 842672453mS CMCallEvt: 0.3676.0 -1 BaseEP: DELETE CMEndpoint f4d34ee8 TOTAL NOW=3 CALL_LIST=1
14:30:56 842672455mS ISDNL3Evt: v=9 stacknum=9 State, new=Initiated, old=NullState id=3678
14:30:56 842672457mS CD: CALL: 261.3675.0 BState=Idle Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="" [Line 9] (0.0) CalledNum=918774627356 () CallingNum=217 (Craig Ness) Internal=1 Time=23 AState=Dialled
14:30:56 842672470mS ISDNL3Evt: v=9 stacknum=9 State, new=Proceeding, old=Initiated id=3678
14:30:56 842672471mS CMLineRx: v=9
CMProceeding
Line: type=Q931Line 9 Call: lid=0 id=3678 in=0
BChan: slot=0 chan=8
14:30:56 842672472mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
14:30:56 842672472mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
14:30:56 842672472mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.3677.0 659 ARS for Craig - Call State: CMCSOverlapRecv
14:30:56 842672472mS CMCallEvt: 0.3677.0 -1 ARS for Craig: StateChange: END=X CMCSOverlapRecv->CMCSDelete
14:30:56 842672473mS CMCallEvt: 0.3678.0 659 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSOffering->CMCSAccept
14:30:56 842672473mS CMCallEvt: 0.3677.0 -1 BaseEP: DELETE CMEndpoint f4cb2550 TOTAL NOW=2 CALL_LIST=1
14:30:56 842672474mS CD: CALL: 261.3675.0 BState=Ringing Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="Line 9" [Line 9] (5.9) CalledNum=18774627356 () CallingNum=217 (Craig Ness) Internal=0 Time=40 AState=Dialled
14:30:58 842674037mS CMLineRx: v=9
CMProgress
Line: type=Q931Line 9 Call: lid=0 id=3678 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDInbandPattern (8)
Trace with no i prefix:
14:43:35 843430860mS CMExtnRx: v=217, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=261 id=3688 in=0
Called[918774627356] Type=Default (100) Reason=CMDRdirect SndComp Calling[217] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Craig Ness
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=217
14:43:35 843430860mS CMCallEvt: 261.3688.0 662 Craig Ness.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
14:43:35 843430860mS CMExtnEvt: v=0 State, new=Dialling old=Idle,0,0,Craig Ness
14:43:35 843430861mS CMTARGET: 261.3688.0 662 Craig Ness.0: LOOKUP CALL ROUTE: type=100 called_party=918774627356 sub= calling=217 dir=out complete=1 ses=0
14:43:35 843430861mS CMTARGET: 261.3688.0 662 Craig Ness.0: ADD TARGET (N): number=918774627356 type=100 depth=1 nobar=1 setorig=1 ses=0
14:43:35 843430861mS CMTARGET: 261.3688.0 662 Craig Ness.0: USER SC: 918774627356 2 18774627356 sc=type=Dial code=9N, num=N
14:43:35 843430862mS CMARS: FindActiveARSByGroupID GroupID=57 - Found
14:43:35 843430862mS CMARS: MakeCallTarget - Called Number: 18774627356
14:43:35 843430862mS CMCallEvt: 0.3690.0 -1 BaseEP: NEW CMEndpoint f4cb2550 TOTAL NOW=3 CALL_LIST=1
14:43:35 843430862mS CMTARGET: 261.3688.0 662 Craig Ness.0: INITIAL TARGETING SUCCEEDED
14:43:35 843430863mS CMTARGET: 261.3688.0 662 Craig Ness.0: GetNoAnswerTimer:19
14:43:35 843430863mS CMCallEvt: 261.3688.0 662 Craig Ness.0: StateChange: END=A CMCSDialInitiated->CMCSDialled
14:43:35 843430863mS CMExtnEvt: v=0 State, new=Proceeding old=Dialling,0,0,Craig Ness
14:43:35 843430865mS CMExtnTx: v=217, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=261 id=3688 in=0
Timed: 17/10/14 14:43
14:43:35 843430865mS CMCallEvt: 0.3689.0 662 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
14:43:35 843430866mS CMCallEvt: 0.3690.0 662 ARS for Craig: StateChange: END=T CMCSIdle->CMCSOffering
14:43:35 843430866mS CMCallEvt: 0.3689.0 662 TargetingEP: RequestEnd 0.3690.0 662 ARS for Craig
14:43:35 843430866mS CMTARGET: 261.3688.0 662 Craig Ness.0: CancelTimer CMTCNoAnswerTimeout
14:43:35 843430867mS CMCallEvt: 0.3690.0 662 ARS for Craig: StateChange: END=B CMCSOffering->CMCSOverlapRecv
14:43:35 843430868mS CMARS: FORM: Craig - Received Number: 18774627356
14:43:35 843430868mS CMARS: FOUND A SHORT CODE - short_code: 1N; - Tel: 1Ns9259411244 - Called_Party: 18774627356 - Line Group Id: 0
14:43:35 843430868mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
14:43:35 843430868mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
14:43:35 843430868mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f55b3898) resource busy 1, total 10
14:43:35 843430869mS CMCallEvt: 0.3691.0 -1 BaseEP: NEW CMEndpoint f4d02450 TOTAL NOW=4 CALL_LIST=1
14:43:35 843430869mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:43:35 843430869mS CMTARGET: ISDN BChannel 8: in-service check = 1
14:43:35 843430870mS CMARS: FOUND LINE - Line Id: 9 - using line group id: 0 - Called Number: 18774627356 - Calling Number: 9259411244
14:43:35 843430870mS CMARS: SEND Setup TO LINE
14:43:35 843430871mS CMCallEvt: 0.3691.0 662 Q931 Trunk:9 CHAN=8: StateChange: END=child CMCSIdle->CMCSOffering
14:43:35 843430871mS PRN: Setting configured voice gain for ch 8.
14:43:35 843430871mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=3691 in=0
Called[18774627356] Type=National (2) Reason=CMDRdirect Calling[9259411244] Type=National Plan=ISDN
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=8
Locale: enu
14:43:35 843430871mS CMCallEvt: 0.3689.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
14:43:35 843430872mS CMCallEvt: 0.3689.0 -1 BaseEP: DELETE CMEndpoint f4d34ee8 TOTAL NOW=3 CALL_LIST=1
14:43:35 843430874mS CD: CALL: 261.3688.0 BState=Idle Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="" [Line 9] (0.0) CalledNum=918774627356 () CallingNum=217 (Craig Ness) Internal=1 Time=21 AState=Dialled
14:43:35 843430875mS ISDNL3Evt: v=9 stacknum=9 State, new=Initiated, old=NullState id=3691
14:43:35 843430890mS ISDNL3Evt: v=9 stacknum=9 State, new=Proceeding, old=Initiated id=3691
14:43:35 843430890mS CMLineRx: v=9
CMProceeding
Line: type=Q931Line 9 Call: lid=0 id=3691 in=0
BChan: slot=0 chan=8
14:43:35 843430891mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
14:43:35 843430891mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
14:43:35 843430891mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.3690.0 662 ARS for Craig - Call State: CMCSOverlapRecv
14:43:35 843430891mS CMCallEvt: 0.3690.0 -1 ARS for Craig: StateChange: END=X CMCSOverlapRecv->CMCSDelete
14:43:35 843430892mS CMCallEvt: 0.3691.0 662 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSOffering->CMCSAccept
14:43:35 843430892mS CMCallEvt: 0.3690.0 -1 BaseEP: DELETE CMEndpoint f4cb2550 TOTAL NOW=2 CALL_LIST=1
14:43:35 843430893mS CD: CALL: 261.3688.0 BState=Ringing Cut=3 Music=0.0 Aend="Craig Ness(217)" (0.0) Bend="Line 9" [Line 9] (5.9) CalledNum=18774627356 () CallingNum=217 (Craig Ness) Internal=0 Time=40 AState=Dialled
14:43:36 843431127mS RES: Fri 17/10/2014 14:43:35 FreeMem=53572984 52552176(3) CachedMem=1020808 CMMsg=9(10) Buff=5200 1362 1000 7365 4 Links=2414 BTree=14163 CPU=09.03% CPUStats=24/31/4502/11803/14521/0/0 MCR=0 MCW=0
14:43:36 843431127mS RES2: IP 500 V2 9.0.4.0 build 965 Tasks=55 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=76 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=22(TLS=1) TAPI=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
14:43:36 843431127mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
14:43:36 843431448mS PRN: Optimizing BTree Lists Completed...Started:843430297
14:43:37 843432292mS CMLineRx: v=9
CMProgress
Line: type=Q931Line 9 Call: lid=0 id=3691 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDInbandPattern (8)
14:43:37 843432292mS CMCallEvt: 0.3691.0 662 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSAccept->CMCSRinging
14:43:37 843432293mS CMCallEvt: 261.3688.0 662 Craig Ness.0: StateChange: END=A CMCSDialled->CMCSRingBack
14:43:37 843432294mS CMExtnEvt: v=0 State, new=Alerting old=Proceeding,0,0,Craig Ness
14:43:37 843432296mS CMExtnTx: v=217, p1=0
Both show National as the type.