Call already disconnected on E1 Digital.

[diegosaletti]

Good afternoon fellow.

See if you can help me:

I have a IPO500v2 8.0.46 working with an E1-R2, 30 channels.
Incoming calls work normally, but when making outgoing calls to occupy the channel E1 connection is already disconnected, the signal is correct.

Could you help me with this?

thank you in advance for your help.

 

[holdmusic34]

Checked outgoing channels?
og group ID?
ARS?

What does monitor say?

 

[diegosaletti]

good day holdmusic34

I checked the channels, groups, and all is ok.
follows the trace made ​​by the monitor.



********** SysMonitor v10.0 (46) **********

********** contact made with 172.16.67.200 at 11:31:14 11/1/2013 **********

********** System (172.16.67.200) has been up and running for 18hrs, 34mins and 10secs(66850500mS) **********

********** Warning: TEXT File Logging selected **********


********** Warning: TEXT Logging to File STOPPED on 11/1/2013 11:31:14 **********
66850500mS PRN: Monitor Started IP=172.16.67.77 IP 500 V2 8.0(46) C BR RJ 01
(IP Office: Supports Unicode, System Locale is ptb)
66850500mS PRN: LAW=A PRI=1, BRI=0, ALOG=4, ADSL=0 VCOMP=32, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=5 VMAIL=1(VER=2 TYP=3) CALLS=0(TOT=13)
66850941mS RES: Fri 11/1/2013 11:31:01 FreeMem=55393568(1) CMMsg=6 (8) Buff=5200 955 1000 7462 5 Links=25301
66850942mS RES2: IP 500 V2 8.0(46) Tasks=65 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=77 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=0 TCP=43 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034

********** Warning: Logging to Screen Stopped **********
66963258mS CMCallEvt: 0.1033.0 -1 RML6813.-1: NEW CMExtnEndpoint f4f7a4f4, Name=RML6813, Extn=6813, Phys Extn=6813
66963259mS CMCallEvt: CREATE CALL:14 (f4f78fac)
66963259mS CMCallEvt: 0.1034.0 -1 BaseEP: NEW CMEndpoint f4f77aac TOTAL NOW=2 CALL_LIST=0
66963261mS CMExtnEvt: RML6813: CMExtnHandler::SetCurrent( id: 0->1033 )
66963262mS CMExtnRx: v=6813, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[6813] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=RML6813
IE CMIEFastStartInfoData (6) 10 item(s)
66963262mS CMCallEvt: 263.1033.0 14 RML6813.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
66963262mS CMExtnEvt: v=3 State, new=Dialling old=Idle,0,0,RML6813
66963263mS CMTARGET: 263.1033.0 14 RML6813.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=6813 dir=out complete=0 ses=0
66963263mS CMTARGET: 263.1033.0 14 RML6813.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
66963264mS CMCallEvt: 263.1033.0 14 RML6813.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
66963266mS CMExtnTx: v=6813, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIESecurityData (253) 2 item(s)
Timed: 11/01/13 11:32
66963267mS CMExtnTx: v=6813, p1=8012
CMFacility
Line: type=IPLine 250 Call: lid=263 id=3 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
66963267mS CMExtnTx: v=6813, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Timed: 11/01/13 11:32
66963269mS CD: CALL: 263.1033.0 BState=Idle Cut=1 Music=3.0 Aend="RML6813(6813)" (0.0) Bend="" [] (0.0) CalledNum= () CallingNum=6813 (RML6813) Internal=1 Time=10 AState=DialInitiated
66963270mS CMMap: PCG::AddToneGenerator g D1[1] for cp[170]b0r1 append pcp[171]b0r1 (total 1)
66963271mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[171]b0r1 Configure 0.0
66963271mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[171]b0r1 ConnectIndication 0.0
66963271mS CMMap: a=0.0 b=0.0 pcp[170]b0r1 RTPD1
66963278mS H323Evt: Removing inactive H323 socket from 172.16.64.200:41682
66963441mS RES: Fri 11/1/2013 11:32:54 FreeMem=55307136(1) CMMsg=6 (8) Buff=5200 953 999 7463 5 Links=24398
66963442mS RES2: IP 500 V2 8.0(46) Tasks=65 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=86 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=44 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034

********** Warning: Logging to Screen Started **********
66964261mS H323Evt: RTP(50t): 172.16.67.200/49152 172.16.67.201/49532 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=991 SENT=50 (avg size=160) RECV=38 (avg size=160)
66964664mS SIP Tx: UDP 172.16.67.200:5060 -> 172.17.160.17:5060
OPTIONS sip:Unknown@172.17.160.17 SIP/2.0
Via: SIP/2.0/UDP 172.16.67.200:5060;rport;branch=z9hG4bK5188a8b9f9f9c1553cbddfe522bcede6
From: <sip:Unknown@172.17.160.17>;tag=936b53012b9ae9cb
To: <sip:Unknown@172.17.160.17>
Call-ID: 7b334d7fb565f75d5dd619fcb9658ade@172.16.67.200
CSeq: 1920986738 OPTIONS
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
Supported: timer
Content-Length: 0

66965117mS PRN: 6813: Digit Pressed 9
66965118mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
66965120mS CMMap: a=0.0 b=0.0 pcp[170]b0r1 RTPD0
66965918mS PRN: SCNTFTP:rocess (3) DATA seq=6295 repeated len 317 dest 172.16.60.200
66966118mS CMTARGET: 263.1033.0 14 RML6813.0: TimerExpired cause=CMTCDelayedProcessing
66966118mS CMTARGET: 263.1033.0 14 RML6813.0: LOOKUP CALL ROUTE: type=100 called_party=9 sub= calling=6813 dir=out complete=0 ses=0
66966119mS CMTARGET: 263.1033.0 14 RML6813.0: ADD TARGET (N): number=9 type=100 depth=1 nobar=1 setorig=1 ses=0
66966120mS CMTARGET: 263.1033.0 14 RML6813.0: SYS SC: 9 2 sc=type=Dial code=9N, num=N callinfop->sending_complete=0 secondary_dialtone=
66966120mS CMARS: FindActiveARSByGroupID GroupID=51 - Found
66966120mS CMARS: MakeCallTarget - Called Number:
66966121mS CMCallEvt: 0.1035.0 -1 BaseEP: NEW CMEndpoint f4f6b1f8 TOTAL NOW=3 CALL_LIST=1
66966122mS CMTARGET: 263.1033.0 14 RML6813.0: CancelTimer CMTCDialToneTimeout
66966122mS CMTARGET: 263.1033.0 14 RML6813.0: INITIAL TARGETING SUCCEEDED
66966122mS CMTARGET: 263.1033.0 14 RML6813.0: GetNoAnswerTimer:15
66966122mS CMCallEvt: 0.1034.0 14 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
66966123mS CMCallEvt: 0.1035.0 14 ARS for ALL: StateChange: END=T CMCSIdle->CMCSOffering
66966124mS CMCallEvt: 0.1034.0 14 TargetingEP: RequestEnd 0.1035.0 14 ARS for ALL
66966124mS CMTARGET: 263.1033.0 14 RML6813.0: CancelTimer CMTCNoAnswerTimeout
66966125mS CMCallEvt: 0.1035.0 14 ARS for ALL: StateChange: END=B CMCSOffering->CMCSOverlapRecv
66966126mS CMExtnTx: v=6813, p1=0
CMProgress
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
Display [TRANSFERABLE_SEC_DIAL_TONE]
Timed: 11/01/13 11:32
66966126mS CMARS: FORM: ALL - Received Number:
66966126mS CMARS: CMARSTargetingPending
66966126mS CMCallEvt: 0.1034.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
66966127mS CMCallEvt: 0.1034.0 -1 BaseEP: DELETE CMEndpoint f4f77aac TOTAL NOW=2 CALL_LIST=1
66966127mS CD: CALL: 263.1033.0 BState=Idle Cut=2 Music=3.0 Aend="RML6813(6813)" (0.0) Bend="" [] (0.0) CalledNum=9 () CallingNum=6813 (RML6813) Internal=1 Time=2868 AState=Dialling
66966128mS CMMap: PCG::AddToneGenerator g D1[1] for cp[170]b0r1 append pcp[172]b0r1 (total 1)
66966128mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[172]b0r1 Configure 0.0
66966128mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[172]b0r1 ConnectIndication 0.0
66966129mS CMMap: a=0.0 b=0.0 pcp[170]b0r1 RTPD1
66967517mS PRN: 6813: Digit Pressed 9
66967518mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
66967519mS CMARS: FORM: ALL - Received Number: 9
66967519mS CMARS: CMARSTargetingPending
66967520mS CMMap: a=0.0 b=0.0 pcp[170]b0r1 RTPD0
66967884mS PRN: 6813: Digit Pressed 9
66967885mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
66967885mS CMARS: FORM: ALL - Received Number: 99
66967885mS CMARS: CMARSTargetingPending
66968305mS PRN: 6813: Digit Pressed 6
66968306mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
66968306mS CMARS: FORM: ALL - Received Number: 996
66968306mS CMARS: CMARSTargetingPending
66968442mS RES: Fri 11/1/2013 11:32:59 FreeMem=55302372(1) CMMsg=6 (8) Buff=5200 955 1000 7463 5 Links=24403
66968442mS RES2: IP 500 V2 8.0(46) Tasks=65 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=83 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=44 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
66968736mS PRN: 6813: Digit Pressed 2
66968736mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
66968737mS CMARS: FORM: ALL - Received Number: 9962
66968737mS CMARS: CMARSTargetingPending
66969686mS PRN: 6813: Digit Pressed 8
66969687mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
66969687mS CMARS: FORM: ALL - Received Number: 99628
66969687mS CMARS: CMARSTargetingPending
66970105mS PRN: 6813: Digit Pressed 6
66970106mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
66970106mS CMARS: FORM: ALL - Received Number: 996286
66970107mS CMARS: CMARSTargetingPending
66970156mS H323Evt: Recv: RegistrationRequest 172.16.67.202; Endpoints registered: 4; Endpoints in registration: 0
66970556mS PRN: 6813: Digit Pressed 0
66970556mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
66970557mS CMARS: FORM: ALL - Received Number: 9962860
66970557mS CMARS: CMARSTargetingPending
66970785mS H323Evt: Recv: RegistrationRequest 172.16.67.201; Endpoints registered: 4; Endpoints in registration: 0
66970945mS PRN: 6813: Digit Pressed 6
66970946mS CMExtnRx: v=6813, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
66970946mS CMARS: FORM: ALL - Received Number: 99628606
66970946mS CMARS: FOUND A SHORT CODE - short_code: 9XXXXXXX - Tel: 9N - Called_Party: 99628606 - Line Group Id: 0
66970947mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
66970947mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
66970948mS CMTARGET: Problem with Line Id: 9 - check_DNS 1 OperationalTest: 0, IP address: 172.17.160.17
66970948mS CMMap: a=2.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 32
66970948mS R2Line: line: 5.1: State= Idle ep none CanMakeCall: Yes
66970949mS CMCallEvt: 0.1036.0 -1 BaseEP: NEW CMEndpoint f4f68344 TOTAL NOW=3 CALL_LIST=1
66970953mS CMARS: FOUND LINE - Line Id: 5 - using line group id: 0 - Called Number: 99628606 - Calling Number: 6813
66970953mS CMARS: SEND Setup TO LINE
66970953mS CMCallEvt: 0.1036.0 14 R2 Trunk:5 CHAN=1: StateChange: END=child CMCSIdle->CMCSOffering
66970954mS CMLineTx: v=5
CMSetup
Line: type=R2Line 5 Call: lid=0 id=1036 in=0
Called[99628606] Type=Default (100) Reason=CMDRdirect Calling[6813] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=RML6813
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=RML6813
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=6813
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=8 class=CMDeviceH323Phone type=87 number=8012 channel=0 rx_gain=32 tx_gain=32 ep_callid=1033 ipaddr=172.16.67.200 apps=0
IE CMIEMohSourceId (247) MOH Source = 255
Locale: ptb
66970954mS R2Line: line: 5.1: State: Idle CMMessage: CMSetup
66970954mS R2Line: line: 5.1: State Change Idle -> Initiated
66970954mS R2Line: line: 5.1: Sending LL Message Seize
66970955mS CMLineRx: v=5
CMSetupAck
Line: type=R2Line 5 Call: lid=0 id=1036 in=0
BChan: slot=3 chan=2
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=8 class=CMDeviceR2Trunk type=0 number=5 channel=1 rx_gain=32 tx_gain=32 ep_callid=1036 ipaddr=172.16.67.200 apps=0
66970955mS CMARS: LINE ep Received: CMSetupAck - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
66970955mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
66970955mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.1035.0 14 ARS for ALL - Call State: CMCSOverlapRecv
66970955mS CMCallEvt: 0.1035.0 -1 ARS for ALL: StateChange: END=X CMCSOverlapRecv->CMCSDelete
66970957mS CMCallEvt: 0.1036.0 14 R2 Trunk:5 CHAN=1: StateChange: END=B CMCSOffering->CMCSOverlapRecv
66970958mS CMCallEvt: 0.1035.0 -1 BaseEP: DELETE CMEndpoint f4f6b1f8 TOTAL NOW=2 CALL_LIST=1
66970959mS CD: CALL: 263.1033.0 BState=Idle Cut=2 Music=0.0 Aend="RML6813(6813)" (0.0) Bend="Line 5" [Line 5] (3.2) CalledNum=99628606 () CallingNum=6813 (RML6813) Internal=0 Time=7700 AState=Dialling
66970962mS CMMap: PCG::MapBChan pcp[170]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
66970962mS CMMap: PCGS CPReserveCodec for the other end (pcp[170]b0r1) true
66970963mS CMMap: PCG::MapBChan pcp[94]b1r0 cp_b f591da58 other_cp_b f596bb74 type CGTypeSimple
66970963mS CMMap: a=2.1 b=3.2 M1
66970963mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[170]b0r1 Configure 2.1
66970963mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[170]b0r1 ConnectIndication 2.1
66970964mS R2DSP: PRIU DSP 2: channel 1 (timeslot 2), set gains tx 10, rx 10
66970965mS R2DSP: PRIU DSP 2: channel 1 (timeslot 2), set log-law, system A-Law, line A-Law
66970965mS R2Channel R2_BRA_5.1: State Change Idle -> Seized
66970965mS R2Channel R2_BRA_5.1: EventTx: Seize State: Seized
66970965mS PRN: R2 CAS: R2_BRA_5.1:: Transmit: 1001 -> 0001
66970965mS R2DSP: PRIU DSP 2: channel 1 (timeslot 2), speech path off
66971165mS PRN: R2Channel R2_BRA_5.1:: Seize Timeout
66971165mS R2Channel R2_BRA_5.1: State Change Seized -> ClearForward
66971165mS R2Channel R2_BRA_5.1: EventTx: Clear Forward State: ClearForward
66971165mS PRN: R2 CAS: R2_BRA_5.1:: Transmit: 0001 -> 1001
66971166mS R2Line: line: 5.1: State= Initiated RxMessage: Reorder
66971291mS PRN: R2 CAS: R2_BRA_5.1:: Receive: 1001 -> 1101
66971291mS R2Channel R2_BRA_5.1: EventRx: Clear Forward State: ClearForward
66971491mS PRN: R2 CAS: R2_BRA_5.1:: Receive: 1101 -> 1001
66971491mS R2Channel R2_BRA_5.1: EventRx: Idle State: ClearForward
66971665mS R2Channel R2_BRA_5.1: EventTx: Idle State: ClearForward
66971665mS R2Channel R2_BRA_5.1: State Change ClearForward -> Idle
66971665mS R2Channel R2_BRA_5.1: EventTx: Idle State: Idle
66971666mS R2Line: line: 5.1: State= Initiated RxMessage: Idle
66971666mS R2Line: line: 5.1: State Change Initiated -> Idle
66971667mS CMLineRx: v=5
CMReleaseComp
Line: type=R2Line 5 Call: lid=0 id=1036 in=0
Cause=16, Normal call clearing
66971667mS CMCallEvt: 0.1036.0 14 R2 Trunk:5 CHAN=1: StateChange: END=B CMCSOverlapRecv->CMCSCompleted
66971668mS CMExtnTx: v=6813, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 11/01/13 11:33
66971668mS CMExtnTx: v=6813, p1=8012
CMFacility
Line: type=IPLine 250 Call: lid=263 id=3 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
66971670mS CMLOGGING: CALL:2013/01/1111:32,00:00:00,000,6813,O,99628606,999628606,RML6813,,,0,,""n/a,0
66971671mS CD: CALL: 263.1033.0 BState=Disconnecting Cut=0 Music=0.0 Aend="RML6813(6813)" (0.0) Bend="Line 5" [Line 5] (3.2) CalledNum=99628606 () CallingNum=6813 (RML6813) Internal=0 Time=8411 AState=Dialling
66971671mS CD: CALL: 263.1033.0 Deleted
66971672mS CMExtnEvt: RML6813: CALL LOST (CMCauseNormal)
66971673mS CMExtnEvt: RML6813: Extn(6813) Calling Party Number(6813) Type(CMNTypeInternal)
66971673mS CMCallEvt: 263.1033.0 -1 RML6813.0: StateChange: END=X CMCSDialling->CMCSCompletedTone
66971675mS CMExtnTx: v=6813, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 11/01/13 11:33
66971675mS CMExtnTx: v=6813, p1=8012
CMFacility
Line: type=IPLine 250 Call: lid=263 id=3 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
66971676mS CMExtnEvt: v=3 State, new=CMESCompleted old=Dialling,0,0,RML6813
66971677mS CMCallEvt: 0.1036.0 -1 R2 Trunk:5 CHAN=1: StateChange: END=X CMCSCompleted->CMCSDelete
66971677mS CMCallEvt: END CALL:14 (f4f78fac)
66971678mS CMCallEvt: 0.1036.0 -1 BaseEP: DELETE CMEndpoint f4f68344 TOTAL NOW=1 CALL_LIST=0
66971678mS R2Line: line: 5.1: Clear Call
66971680mS CMMap: a=3.2 b=0.0 PCGS CPReserveCodec (pcp[170]b0r1) true
66971680mS CMMap: PCG::UnmapBChan pcp[170]b0r1 cp_b f596bb74 other_cp_b f591da58
66971681mS CMMap: a=3.2 b=2.1 M0
66971681mS CMMap: PCG::UnmapBChan pcp[94]b1r0 cp_b f591da58 other_cp_b 0
66971681mS CMMap: PCG::AddToneGenerator g B1[4] for cp[170]b0r1 append pcp[173]b0r1 (total 1)
66971681mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[173]b0r1 Configure 0.0
66971681mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[173]b0r1 ConnectIndication 0.0
66971682mS CMMap: a=0.0 b=0.0 pcp[170]b0r1 RTPB1
66974921mS CMExtnTx: v=6813, p1=8012
CMFacility
Line: type=IPLine 250 Call: lid=263 id=3 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
66974921mS CMExtnRx: v=6813, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
66974921mS CMCallEvt: 263.1033.0 -1 RML6813.0: StateChange: END=X CMCSCompletedTone->CMCSCompleted
66974922mS CMExtnTx: v=6813, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=263 id=1033 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 11/01/13 11:33
66974922mS CMExtnEvt: v=3 State, new=PortRecoverDelay old=CMESCompleted,0,0,RML6813
66974924mS CMExtnEvt: RML6813: CALL LOST (CMCauseForceClear)
66974924mS CMExtnEvt: RML6813: Extn(6813) Calling Party Number(6813) Type(CMNTypeInternal)
66974924mS CMExtnEvt: RML6813: CMExtnHandler::SetCurrent( id: 1033->0 )
66974925mS CMCallEvt: 263.1033.0 -1 RML6813.-1: StateChange: END=X CMCSCompleted->CMCSDelete
66974926mS CMTARGET: 263.1033.0 -1 BaseEP: ~CMTargetHandler f4f719ac ep f4f7a4f4
66974926mS CMCallEvt: 263.1033.0 -1 BaseEP: DELETE CMEndpoint f4f7a4f4 TOTAL NOW=0 CALL_LIST=0
66974928mS CMMap: a=0.0 b=0.0 pcp[170]b0r1 RTPB0
66974929mS H323Evt: RTP(END): 172.16.67.200/49152 172.16.67.201/49532 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=11659 SENT=353 RECV=339 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
66974929mS CMMap: a=2.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 1, total 32
66974942mS RES: Fri 11/1/2013 11:33:05 FreeMem=55336724(1) CMMsg=6 (8) Buff=5200 948 999 7463 5 Links=24471
66974942mS RES2: IP 500 V2 8.0(46) Tasks=65 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=83 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=47 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034

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

 

[holdmusic34]

Here's where your disconnect event starts:

66970948mS CMTARGET: Problem with Line Id: 9 - check_DNS 1 OperationalTest: 0, IP address: 172.17.160.17
66970948mS CMMap: a=2.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 32

We don't use that service here. Someone else may have a further idea.

Kids, Kids, It's Avaya. You're both right.