13:44:19 1105974931mS ISDNL3Evt: v=1 stacknum=1 State, new=Present, old=NullState id=28
13:44:19 1105974932mS CMLineRx: v=1
CMSetup
Line: type=Q931Line 1 Call: lid=1 id=28 in=1
Called[681234] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[07480563987] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
BChan: slot=0 chan=1
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDOrigNotISDN (3)
13:44:19 1105974932mS PRN: Q931Trunk: Found QBChannel to match 0.1 --> 1.2
13:44:19 1105974932mS CMCallEvt: 0.6970.0 -1 BaseEP: NEW CMEndpoint f4e146f8 TOTAL NOW=1 CALL_LIST=0
13:44:19 1105974933mS CMCallEvt: CREATE CALL:1765 (f4d71b70)
13:44:19 1105974933mS CMCallEvt: 0.6971.0 -1 BaseEP: NEW CMEndpoint f4df4030 TOTAL NOW=2 CALL_LIST=0
13:44:19 1105974935mS CD: CALL: 1.28.1 BState=Idle Cut=1 Music=0.0 Aend="Line 1" (1.2) Bend="" [] (0.0) CalledNum=681234 () CallingNum=07480563987 () Internal=0 Time=2 AState=Idle
13:44:19 1105974935mS CMCallEvt: 1.28.1 1765 Q931 Trunk:1 CHAN=1: StateChange: END=A CMCSIdle->CMCSDialInitiated
13:44:19 1105974935mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: LOOKUP CALL ROUTE: type=0 called_party=681234 sub= calling=07480563987 dir=in complete=1 ses=0
13:44:19 1105974935mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: SET BESTMATCH: length 6 vs -1 match=02071231234 dest=VM:CallRecording
13:44:19 1105974936mS CMCallEvt: Priority hike: call 1765 priority 0->1
13:44:19 1105974936mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: LOOKUP ICR: DDI= CGPN=07480563987 (Destination VM:CallRecording ) => CDPN=VM:CallRecording
13:44:19 1105974936mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: ADD TARGET (N): number=VM:CallRecording type=0 depth=1 nobar=1 setorig=1 ses=0
13:44:19 1105974936mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: ADD VM TARGET
13:44:19 1105974937mS CMTARGET: **** 1.28.1 1765 Q931 Trunk:1 CHAN=1: MakeVoicemailTarget pbx=<null> local=1 type=1
13:44:19 1105974937mS CMCallEvt: 0.6972.0 -1 BaseEP: NEW CMEndpoint f4da8420 TOTAL NOW=3 CALL_LIST=1
13:44:19 1105974937mS CMTARGET: 0.6972.0 1765 RAS.0: ADD PRIMARY
13:44:19 1105974937mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: ADD VM TARGET: SUCCEEDED
13:44:19 1105974937mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: INITIAL TARGETING SUCCEEDED
13:44:19 1105974937mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: GetNoAnswerTimer:15
13:44:19 1105974938mS CMCallEvt: 1.28.1 1765 Q931 Trunk:1 CHAN=1: StateChange: END=A CMCSDialInitiated->CMCSDialled
13:44:19 1105974938mS CMLineTx: v=1
CMProceeding
Line: type=Q931Line 1 Call: lid=1 id=28 in=1
BChan: slot=0 chan=1
13:44:19 1105974938mS CMCallEvt: 0.6971.0 1765 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
13:44:19 1105974939mS CMCallEvt: 0.6972.0 1765 RAS.0: StateChange: END=T CMCSIdle->CMCSOffering
13:44:19 1105974939mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 0->6972 )
13:44:19 1105974939mS CMExtnTx: v=RAS, p1=0
CMSetup
Line: type=RAS 1 Call: lid=0 id=1011 in=0
Called[CallRecording] Type=Voicemail (102) Reason=CMDRX_Attendant SndComp Calling[07480563987] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
BChan: slot=21 chan=42
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDOrigNotISDN (3)
IE CMIERespondingPartyNumber (230)(P:0 S:0 T:2 N:1 R:4) number=07480563987
IE CMIEDeviceDetail (231) ac1050650000001c LOCALE=eng HW=15 VER=8 class=CMDeviceISDNTrunk type=0 number=1 channel=1 features=0x20 rx_gain=32 tx_gain=32 ep_callid=28 ipaddr=172.16.80.101 apps=0 loc=0 em_loc=0 features2=0x0 is_spcall=0
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:0 N:1 R:4) number=681234
IE CMIEMohSourceId (247) MOH Source = 1
Display [07480563987>CallRecording]
Timed: 01/08/18 13:44
Locale: eng
13:44:19 1105974940mS CMMap: a=21.42 b=1.254 T
13:44:19 1105974941mS CMExtnRx: v=RAS, p1=0
CMConnect
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=CallRecording
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:102 N:100 R:4) number=CallRecording
IE CMIEDeviceDetail (231) ac10506500001b3c LOCALE=eng HW=15 VER=8 class=CMDeviceVoicemail type=0 number=0 channel=42 features=0x0 rx_gain=32 tx_gain=32 ep_callid=6972 ipaddr=172.16.80.101 apps=0 loc=0 em_loc=0 features2=0x0 is_spcall=0
13:44:19 1105974942mS CMCallEvt: 0.6972.0 1765 RAS.0: StateChange: END=T CMCSOffering->CMCSConnReq
13:44:19 1105974942mS CMCallEvt: 0.6971.0 1765 TargetingEP: RequestEnd 0.6972.0 1765 RAS.0
13:44:19 1105974942mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: CancelTimer CMTCNoAnswerTimeout
13:44:19 1105974943mS CMExtnEvt: v=1011 State, new=Connected old=Idle,0,0,RAS
13:44:19 1105974943mS CMCallEvt: 1.28.1 1765 Q931 Trunk:1 CHAN=1: StateChange: END=A CMCSDialled->CMCSOGConnReq
13:44:19 1105974943mS CMLineTx: v=1
CMConnect
Line: type=Q931Line 1 Call: lid=1 id=28 in=1
BChan: slot=0 chan=1
Display [++fCallRecording,]
13:44:19 1105974943mS CMCallEvt: 0.6971.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
13:44:19 1105974944mS CMCallEvt: 0.6971.0 -1 BaseEP: DELETE CMEndpoint f4df4030 TOTAL NOW=2 CALL_LIST=1
13:44:19 1105974944mS CD: CALL: 1.28.1 BState=Connected Cut=3 Music=0.0 Aend="Line 1" (1.2) Bend="CallRecording(CallRecording)" [VoiceMail] (21.42) CalledNum=CallRecording () CallingNum=07480563987 () Internal=0 Time=11 AState=Connected
13:44:19 1105974945mS CMMap: PCG::MapBChan pcp[89]b1r0 cp_b f57e0cc0 other_cp_b 0 type CGTypeSimple
13:44:19 1105974945mS CMMap: PCG::MapBChan pcp[44]b1r0 cp_b f581ff38 other_cp_b f57e0cc0 type CGTypeSimple
13:44:19 1105974945mS CMMap: a=1.2 b=21.42 M12
13:44:19 1105974946mS ISDNL3Evt: v=1 stacknum=1 State, new=ICProceeding, old=Present id=28
13:44:19 1105974946mS ISDNL3Evt: v=1 stacknum=1 State, new=ConnReq, old=ICProceeding id=28
13:44:20 1105975025mS ISDNL3Evt: v=1 stacknum=1 State, new=Active, old=ConnReq id=28
13:44:20 1105975026mS CMLineRx: v=1
CMConnectAck
Line: type=Q931Line 1 Call: lid=1 id=28 in=1
13:44:20 1105975026mS CMCallEvt: 1.28.1 1765 Q931 Trunk:1 CHAN=1: StateChange: END=A CMCSOGConnReq->CMCSConnected
13:44:20 1105975027mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: ~CMTargetHandler f4e175e0 ep f4e146f8
13:44:20 1105975027mS CMCallEvt: 0.6972.0 1765 RAS.0: StateChange: END=B CMCSConnReq->CMCSConnected
13:44:20 1105975028mS CMExtnTx: v=RAS, p1=0
CMConnectAck
Line: type=RAS 1 Call: lid=0 id=1011 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07480563987] Type=National Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=42
IE CMIERespondingPartyNumber (230)(P:0 S:0 T:2 N:1 R:4) number=07480563987
IE CMIEDeviceDetail (231) ac1050650000001c LOCALE=eng HW=15 VER=8 class=CMDeviceISDNTrunk type=0 number=1 channel=1 features=0x20 rx_gain=32 tx_gain=32 ep_callid=28 ipaddr=172.16.80.101 apps=0 loc=0 em_loc=0 features2=0x0 is_spcall=0
13:44:20 1105975177mS RES: Wed 1/8/2018 13:44:19 FreeMem=56003768 55089416(1) CachedMem=914352 CMMsg=8(8) Buff=5200 1420 1000 12413 10 Links=25174 BTree=0 CPU=13/17/6551/27214/36312/2
13:44:20 1105975177mS RES2: IP 500 V2 8.1(81) Tasks=48 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=152 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=112 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:44:20 1105975177mS RES4: XML MemObjs=45 PoolMem=2097152(1) FreeMem=2082064(1)
13:44:21 1105976392mS H323Evt: Recv: RegistrationRequest 172.16.80.1; Endpoints registered: 48; Endpoints in registration: 0
13:44:22 1105977007mS H323Evt: Recv: RegistrationRequest 172.16.80.11; Endpoints registered: 48; Endpoints in registration: 0
13:44:22 1105977324mS H323Evt: Recv: RegistrationRequest 172.16.80.10; Endpoints registered: 48; Endpoints in registration: 0
13:44:22 1105977453mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
13:44:22 1105977453mS CMExtnRx: v=RAS, p1=0
CMTransfer
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[1234] Type=Default (100) Reason=CMDRdirect SndComp Calling[07480563987] Type=Unknown Plan=Default
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=07480563987
13:44:22 1105977453mS CMCallEvt: 0.6972.0 1765 RAS.0: Transfer CMCauseTransfer
13:44:22 1105977454mS CD: CALL: 1.28.1 BState=Connected Cut=3 Music=0.0 Aend="Line 1" (1.2) Bend="CallRecording(CallRecording)" [VoiceMail] (21.42) CalledNum=CallRecording () CallingNum=07480563987 () Internal=0 Time=2521 AState=Connected
13:44:22 1105977454mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: ADD TARGET (N): number=1234 type=100 depth=1 nobar=1 setorig=1 ses=0
13:44:22 1105977454mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: DEF SC: 1234 0 sc=type=Dial code=?, num=.
13:44:22 1105977455mS CMARS: FindActiveARSByGroupID GroupID=50 - Found
13:44:22 1105977455mS CMARS: MakeCallTarget - Called Number: 1234
13:44:22 1105977455mS CMCallEvt: 0.6973.0 -1 BaseEP: NEW CMEndpoint f4d844e0 TOTAL NOW=3 CALL_LIST=1
13:44:22 1105977456mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: PrepareTransferTargets Found 1 target
13:44:22 1105977456mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: GetNoAnswerTimer:15
13:44:22 1105977456mS CMCallEvt: 0.6974.0 -1 BaseEP: NEW CMEndpoint f4df4030 TOTAL NOW=4 CALL_LIST=1
13:44:22 1105977457mS CMExtnEvt: RAS: CALL LOST (CMCauseTransfer)
13:44:22 1105977457mS CMCallEvt: 0.6972.0 -1 RAS.0: StateChange: END=X CMCSConnected->CMCSCompleted
13:44:22 1105977457mS CMExtnEvt: v=1011 State, new=PortRecoverDelay old=Connected,0,0,RAS
13:44:22 1105977457mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1011 in=0
Called[CallRecording] Type=Voicemail (102) Reason=CMDRX_Attendant Calling[07480563987] Type=National Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=42
Cause=126, Transfer(IPO)
13:44:22 1105977458mS CMMap: a=21.42 b=0.0 T0
13:44:22 1105977459mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 6972->0 )
13:44:22 1105977459mS CMCallEvt: 0.6972.0 -1 RAS.-1: StateChange: END=X CMCSCompleted->CMCSDelete
13:44:22 1105977459mS CMExtnEvt: v=1011 State, new=Idle old=PortRecoverDelay,0,0,RAS
13:44:22 1105977460mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1011 in=0
BChan: slot=21 chan=42
Cause=126, Transfer(IPO)
13:44:22 1105977460mS CMCallEvt: 0.6974.0 1765 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
13:44:22 1105977461mS CMCallEvt: 0.6973.0 1765 ARS for Main: StateChange: END=T CMCSIdle->CMCSOffering
13:44:22 1105977461mS CMCallEvt: 0.6974.0 1765 TargetingEP: RequestEnd 0.6973.0 1765 ARS for Main
13:44:22 1105977461mS CMTARGET: 1.28.1 1765 Q931 Trunk:1 CHAN=1: CancelTimer CMTCNoAnswerTimeout
13:44:22 1105977462mS CMCallEvt: 0.6973.0 1765 ARS for Main: StateChange: END=B CMCSOffering->CMCSOverlapRecv
13:44:22 1105977462mS CMARS: FORM: Main - Received Number: 1234
13:44:22 1105977462mS CMARS: FOUND A SHORT CODE - short_code: N; - Tel: NS02078427650 - Called_Party: 1234 - Line Group Id: 0
13:44:22 1105977462mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
13:44:22 1105977462mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
13:44:22 1105977463mS CMCallEvt: 0.6975.0 -1 BaseEP: NEW CMEndpoint f4d6fa28 TOTAL NOW=5 CALL_LIST=1
13:44:22 1105977464mS CMARS: FOUND LINE - Line Id: 1 - using line group id: 0 - Called Number: 1234 - Calling Number: 02071231235
13:44:22 1105977464mS CMARS: SEND Setup TO LINE
13:44:22 1105977464mS CMCallEvt: 0.6975.0 1765 Q931 Trunk:1 CHAN=-1: StateChange: END=child CMCSIdle->CMCSOffering
13:44:22 1105977464mS CMLineTx: v=1
CMSetup
Line: type=Q931Line 1 Call: lid=0 id=6975 in=0
Called[1234] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[02078427650] Type=Unknown Plan=Unknown
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
Locale: eng
13:44:22 1105977465mS CMCallEvt: 0.6974.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
13:44:22 1105977465mS CMCallEvt: 0.6974.0 -1 BaseEP: DELETE CMEndpoint f4df4030 TOTAL NOW=4 CALL_LIST=1
13:44:22 1105977465mS CMCallEvt: 0.6972.0 -1 BaseEP: DELETE CMEndpoint f4da8420 TOTAL NOW=3 CALL_LIST=1
13:44:22 1105977467mS CMMap: PCG::UnmapBChan pcp[44]b1r0 cp_b f581ff38 other_cp_b f57e0cc0
13:44:22 1105977467mS CMMap: a=1.2 b=21.42 M02
13:44:22 1105977467mS CMMap: PCG::UnmapBChan pcp[89]b1r0 cp_b f57e0cc0 other_cp_b 0
13:44:22 1105977467mS CD: CALL: 1.28.1 BState=Idle Cut=3 Music=0.0 Aend="Line 1" (1.2) Bend="" [Line 1] (0.0) CalledNum=1234 () CallingNum=07480563987 (07480563987) Internal=0 Time=2534 AState=Connected
13:44:22 1105977468mS ISDNL3Evt: v=1 stacknum=1 State, new=Initiated, old=NullState id=6975
13:44:22 1105977656mS ISDNL3Evt: v=1 stacknum=1 State, new=Proceeding, old=Initiated id=6975
13:44:22 1105977657mS CMLineRx: v=1
CMProceeding
Line: type=Q931Line 1 Call: lid=0 id=6975 in=0
BChan: slot=0 chan=2
13:44:22 1105977658mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
13:44:22 1105977658mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
13:44:22 1105977658mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.6973.0 1765 ARS for Main - Call State: CMCSOverlapRecv
13:44:22 1105977658mS CMCallEvt: 0.6973.0 -1 ARS for Main: StateChange: END=X CMCSOverlapRecv->CMCSDelete
13:44:22 1105977659mS CMCallEvt: 0.6975.0 1765 Q931 Trunk:1 CHAN=2: StateChange: END=B CMCSOffering->CMCSAccept
13:44:22 1105977660mS CMCallEvt: 0.6973.0 -1 BaseEP: DELETE CMEndpoint f4d844e0 TOTAL NOW=2 CALL_LIST=1
13:44:22 1105977660mS CD: CALL: 1.28.1 BState=Ringing Cut=3 Music=0.0 Aend="Line 1" (1.2) Bend="Line 1" [Line 1] (1.3) CalledNum=1234 () CallingNum=07480563987 (07480563987) Internal=0 Time=2727 AState=Connected
13:44:22 1105977661mS CMMap: PCG::MapBChan pcp[89]b1r0 cp_b f57e0cc0 other_cp_b 0 type CGTypeSimple
13:44:22 1105977661mS CMMap: PCG::MapBChan pcp[90]b1r0 cp_b f57e0998 other_cp_b f57e0cc0 type CGTypeSimple
13:44:22 1105977661mS CMMap: a=1.2 b=1.3 M12
13:44:22 1105977679mS H323Evt: Recv: RegistrationRequest 172.16.80.14; Endpoints registered: 48; Endpoints in registration: 0
13:44:22 1105977682mS CMLineRx: v=1
CMProgress
Line: type=Q931Line 1 Call: lid=0 id=6975 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Cause=22, Number changed
13:44:22 1105977682mS CMCallEvt: 0.6975.0 1765 Q931 Trunk:1 CHAN=2: StateChange: END=B CMCSAccept->CMCSRinging
13:44:22 1105977683mS CD: CALL: 1.28.1 BState=Ringing Cut=3 Music=0.0 Aend="Line 1" (1.2) Bend="Line 1" [Line 1] (1.3) CalledNum=1234 () CallingNum=07480563987 (07480563987) Internal=0 Time=2750 AState=Connected
13:44:22 1105977696mS ISDNL3Evt: v=1 stacknum=1 State, new=DiscInd, old=Proceeding id=6975
13:44:22 1105977697mS CMLineRx: v=1
CMDisconnect
Line: type=Q931Line 1 Call: lid=0 id=6975 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDInbandPattern (8)
Cause=16, Normal call clearing
13:44:22 1105977697mS CMCallEvt: 0.6975.0 1765 Q931 Trunk:1 CHAN=2: StateChange: END=B CMCSRinging->CMCSDisconnecting
13:44:22 1105977698mS CMCallEvt: 1.28.1 1765 Q931 Trunk:1 CHAN=1: StateChange: END=A CMCSConnected->CMCSICDisconnecting
13:44:22 1105977698mS CMLineTx: v=1
CMDisconnect
Line: type=Q931Line 1 Call: lid=1 id=28 in=1
BChan: slot=0 chan=1
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDInbandPattern (8)
Cause=16, Normal call clearing
13:44:22 1105977698mS CD: CALL: 1.28.1 BState=Disconnecting Cut=3 Music=0.0 Aend="Line 1" (1.2) Bend="Line 1" [Line 1] (1.3) CalledNum=1234 () CallingNum=07480563987 (07480563987) Internal=0 Time=2765 AState=Disconnecting
13:44:22 1105977699mS ISDNL3Evt: v=1 stacknum=1 State, new=DiscReq, old=Active id=28
13:44:22 1105977862mS ISDNL3Evt: v=1 stacknum=1 State, new=NullState, old=DiscReq id=28
13:44:22 1105977863mS CMLineRx: v=1
CMReleaseComp
Line: type=Q931Line 1 Call: lid=1 id=28 in=1
BChan: slot=0 chan=1
13:44:22 1105977864mS CMCallEvt: 1.28.1 1765 Q931 Trunk:1 CHAN=1: StateChange: END=A CMCSICDisconnecting->CMCSCompleted
13:44:22 1105977865mS CMLOGGING: CALL:2018/08/0113:44,00:00:02,000,07480563987,I,1234,681234,,,,0,,""n/a,0
13:44:22 1105977865mS CD: CALL: 1.28.1 BState=Disconnecting Cut=2 Music=0.0 Aend="LLine 1" (1.2) Bend="Line 1" [Line 1] (1.3) CalledNum=1234 () CallingNum=07480563987 (07480563987) Internal=0 Time=2932 AState=Idle
13:44:22 1105977865mS CD: CALL: 1.28.1 Deleted
13:44:22 1105977865mS CMCallEvt: 1.28.1 -1 Q931 Trunk:1 CHAN=1: StateChange: END=X CMCSCompleted->CMCSDelete
13:44:22 1105977866mS CMLineTx: v=1
CMRelease
Line: type=Q931Line 1 Call: lid=0 id=6975 in=0
Cause=16, Normal call clearing
13:44:22 1105977866mS CMCallEvt: 0.6975.0 -1 Q931 Trunk:1 CHAN=2: StateChange: END=X CMCSDisconnecting->CMCSDelete
13:44:22 1105977866mS CMCallEvt: 0.6975.0 -1 BaseEP: DELETE CMEndpoint f4d6fa28 TOTAL NOW=1 CALL_LIST=0
13:44:22 1105977867mS CMCallEvt: END CALL:1765 (f4d71b70)
13:44:22 1105977867mS CMTARGET: 1.28.1 -1 BaseEP: ~CMTargetHandler f4e175e0 ep f4e146f8
13:44:22 1105977868mS CMCallEvt: 1.28.1 -1 BaseEP: DELETE CMEndpoint f4e146f8 TOTAL NOW=0 CALL_LIST=0
13:44:22 1105977868mS CMMap: PCG::UnmapBChan pcp[90]b1r0 cp_b f57e0998 other_cp_b f57e0cc0
13:44:22 1105977868mS CMMap: a=1.2 b=1.3 M02
13:44:22 1105977869mS CMMap: PCG::UnmapBChan pcp[89]b1r0 cp_b f57e0cc0 other_cp_b 0
13:44:22 1105977869mS ISDNL3Evt: v=1 stacknum=1 State, new=ReleaseReq, old=DiscInd id=6975
13:44:22 1105977957mS ISDNL3Evt: v=1 stacknum=1 State, new=NullState, old=ReleaseReq id=6975
13:44:22 1105977957mS CMLineRx: v=1
CMReleaseComp
Line: type=Q931Line 1 Call: lid=0 id=6975 in=0
BChan: slot=0 chan=2
Cause=16, Normal call clearing