Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

  • Congratulations Mike Lewis on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

IVR setup on SIP trunk no sound

Status
Not open for further replies.

rsv23

Systems Engineer
Feb 13, 2019
239
PH
Hi Guys,

Just wondering if someone has encountered an IVR setup in VMpro has no sound when using on a SIP trunk.

But when setting up on a PRI, it works perfectly.

Our system is server edition. The SIP trunk is setup in one of the expansion servers where the PRI is also setup.
 
I've seen several sites with this issue and the SIP gateway was filtering "media" traffic.

- IP Office Tech
 
Thanks for the reply.

Can you please advise what solution done to get this fixed?
 
Ask your SIP trunk vendor to check their gateway for filtering the "Media" from VMPro.

- IP Office Tech
 
Spoke to the SIP vendor and they confirmed the Vmpro address is not filtered.

I run a trace and found this:

17:08:57 34919345mS RES: Sat 17/12/2022 17:08:57 FreeMem=55960228 Heap=55601016(1) Cache=359212 MemObjs=12441(Max 13384) CMMsg=4(5) ASN=0 Buff=5200 1364 1000 7427 5 Links=55317(55522) BTree=831(1777) CB=6059 MCT=0 CPU=06.77% CPUStats=05.83%/1/4/4942/13
852/15031/00.36%/1/02.97% MCR=0 MCW=0 DEV=0
17:08:57 34919345mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+61 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=27(TLS=6 OFF=0) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:08:57 34919346mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:08:57 34919346mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150
17:09:07 34929949mS H323Evt: v=0 stacknum=18 State, new=NullState, old=NullState id=-1
17:09:07 34929950mS H323Evt: v=0 stacknum=18 State, new=Present, old=NullState id=23
17:09:07 34929953mS CMLineRx: v=18
CMSetup
Line: type=IPLine 18 Call: lid=18 id=23 in=1
Called[045628401] Type=Default (100) Reason=CMDRdirect SndComp Calling[1031] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageBmpString
invokeId 38096
user 'Robel ACW' presentation Allowed
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIECallingPartyName (110)(Type=CMNameInternalUser) name=Robel ACW
IE CMIEFarEndCMCallIdData (182) Far End CM Call: lid=0 (0000) id=126561 (1ee61) in=0 (0000)
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 CMIECallingPartyKName (226)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1031
IE CMIEDeviceDetail (231) 0a0a0c050001ee5e LOCALE=aru HW=11 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110020 rx_gain=32 tx_gain=32
ep_callid=126558 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIEDIDNumber (245)(P:100 S:100 T:100 N:100 R:4) number=045628401
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
17:09:07 34929954mS CMCallEvt: 0000000000000000 0.1313.0 -1 BaseEP: NEW CMEndpoint f16c0844 TOTAL NOW=3 CALL_LIST=1
17:09:07 34929954mS CMCallEvt: CREATE CALL:23 (f16c2ff4)
17:09:07 34929955mS CMCallEvt: 0000000000000000 0.1314.0 -1 BaseEP: NEW CMEndpoint f16dba60 TOTAL NOW=4 CALL_LIST=1
17:09:07 34929957mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: StateChange: END=A CMCSIdle->CMCSDialInitiated
17:09:07 34929958mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: LOOKUP CALL ROUTE: GID=0 type=100 called_party=045628401 sub= calling=1031 calling_sub= dir=out complete=1 ses=0
17:09:07 34929959mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: ADD TARGET (N): number=045628401 type=100 depth=1 nobar=1 setorig=1 ses=0
17:09:07 34929959mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: DEF SC: 045628401 0 sc=type=Dial code=?, num=.
17:09:07 34929960mS CMARS: FindActiveARSByGroupID GroupID=53 - Found
17:09:07 34929960mS CMARS: MakeCallTarget - Called Number: 045628401
17:09:07 34929960mS CMCallEvt: 0000000000000000 0.1315.0 -1 BaseEP: NEW CMEndpoint f16b4660 TOTAL NOW=5 CALL_LIST=2
17:09:07 34929961mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: INITIAL TARGETING SUCCEEDED
17:09:07 34929962mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: GetNoAnswerTimer:15
17:09:07 34929962mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: StateChange: END=A CMCSDialInitiated->CMCSDialled
17:09:07 34929964mS CMLineTx: v=18
CMProceeding
Line: type=IPLine 18 Call: lid=18 id=23 in=1
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)
17:09:07 34929964mS CMCallEvt: 0000000000000000 0.1314.0 23 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
17:09:07 34929965mS CMCallEvt: 0000000000000000 0.1315.0 23 ARS for BRI B 2025: StateChange: END=T CMCSIdle->CMCSOffering
17:09:07 34929965mS CMCallEvt: 0000000000000000 0.1314.0 23 TargetingEP: RequestEnd 0000000000000000 0.1315.0 23 ARS for BRI B 2025
17:09:07 34929966mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: CancelTimer CMTCNoAnswerTimeout
17:09:07 34929967mS CMCallEvt: 0000000000000000 0.1315.0 23 ARS for BRI B 2025: StateChange: END=B CMCSOffering->CMCSOverlapRecv
17:09:07 34929967mS CMARS: FORM: BRI B 2025 - Received Number: 045628401
17:09:07 34929967mS CMARS: FOUND A SHORT CODE - short_code: N; - Tel: Ns042432025 - Called_Party: 045628401 - Line Group Id: 12
17:09:07 34929967mS CMARS: SetCurrentTarget: Short_Code: N; - Line_Group_ID: 12
17:09:07 34929967mS CMARS: FindActiveARSByGroupID GroupID=12 - Not Found
17:09:07 34929968mS CMLRQ: FindActiveLRQByGroupID GroupID=12 - Not Found
17:09:07 34929968mS CMTARGET: Group Id: 12 has NOT been found in Line: 5
17:09:07 34929968mS CMMap: a=2.17 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f53951f0) resource busy 2, total 42
17:09:07 34929969mS CMCallEvt: 0000000000000000 0.1316.0 -1 BaseEP: NEW CMEndpoint f16a932c TOTAL NOW=6 CALL_LIST=2
17:09:07 34929969mS CMARS: ModifyCMARSTarget: Short_Code: N; - Line_Group_ID: 12 set line status to CMARS_TRYING
17:09:07 34929969mS CMARS: FOUND LINE - Line Id: 6 - using line group id: 12 (code N;, line 12) - Called Number: 045628401 - Calling Number: 042432025
17:09:07 34929970mS CMARS: SEND Setup TO LINE
17:09:07 34929970mS CMCallEvt: 0a0a0c0600000524 0.1316.0 23 Q931 Trunk:6 CHAN=-1: StateChange: END=child CMCSIdle->CMCSOffering
17:09:07 34929970mS CMLineTx: v=6
CMSetup
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
Called[045628401] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[042432025] Type=Unknown Plan=Unknown
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
Locale: aru
17:09:07 34929971mS CMCallEvt: 0000000000000000 0.1314.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
17:09:07 34929971mS CMCallEvt: 0000000000000000 0.1314.0 -1 BaseEP: DELETE CMEndpoint f16dba60 TOTAL NOW=5 CALL_LIST=2
17:09:07 34929974mS ISDNL3Evt: v=6 stacknum=6 State, new=Initiated, old=NullState id=1316
17:09:07 34929974mS H323Evt: v=0 stacknum=18 State, new=ICProceeding, old=Present id=23
17:09:08 34930127mS ISDNL3Evt: v=6 stacknum=6 State, new=Proceeding, old=Initiated id=1316
17:09:08 34930127mS CMLineRx: v=6
CMProceeding
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
BChan: slot=0 chan=2
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
17:09:08 34930128mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
17:09:08 34930129mS CMARS: CallProceeding with PI=8 received
17:09:08 34930129mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
17:09:08 34930129mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0a0a0c050001ee5e 0.1315.0 23 ARS for BRI B 2025 - Call State: CMCSOverlapRecv
17:09:08 34930129mS CMCallEvt: 0a0a0c050001ee5e 0.1315.0 -1 ARS for BRI B 2025: StateChange: END=X CMCSOverlapRecv->CMCSDelete
17:09:08 34930130mS CMCallEvt: 0a0a0c0600000524 0.1316.0 23 Q931 Trunk:6 CHAN=2: StateChange: END=B CMCSOffering->CMCSAccept
17:09:08 34930132mS CMMap: IP::SetCodec pcp[138]b0r0 0 -> f53951f0
17:09:08 34930134mS CMLineTx: v=18
CMProgress
Line: type=IPLine 18 Call: lid=18 id=23 in=1
BChan: slot=3 chan=6
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
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=045628401
IE CMIEDeviceDetail (231) 0a0a0c0600000524 LOCALE=aru HW=15 VER=11 class=CMDeviceISDNTrunk type=0 number=6 channel=2 features=0x1 rx_gain=32 tx_gain=32
ep_callid=1316 ipaddr=10.10.12.6 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
17:09:08 34930135mS CMCallEvt: 0a0a0c050001ee5e 0.1315.0 -1 BaseEP: DELETE CMEndpoint f16b4660 TOTAL NOW=4 CALL_LIST=2
17:09:08 34930138mS H323Evt: SESS 1d SetOperational local 10.10.12.6:0 remote 0.0.0.0:0 to 0
17:09:08 34930138mS H323Evt: SESS 1d Configure: Alaw64K packet size 160
17:09:08 34930139mS H323Evt: SESS 1d SetRemUDP 0 -> 48400, remote IP 0.0.0.0 -> 10.10.12.5
17:09:08 34930139mS H323Evt: SESS 1d SetRfc2833: (1) rx payload 101 tx payload 101
17:09:08 34930139mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
17:09:08 34930139mS CMMap: PCGS CPReserveCodec for the other end (pcp[138]b0r1) true
17:09:08 34930140mS CMMap: PCG::MapBChan pcp[107]b1r0 cp_b f53513f0 other_cp_b f5395054 type CGTypeSimple
17:09:08 34930140mS CMMap: a=2.17 b=3.6 M12
17:09:08 34930140mS CMMap: PlatformConnectionAudioSAP::Bind pcp[138]b0r1 to 2.17
17:09:08 34930140mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[138]b0r1 Configure 2.17
17:09:08 34930140mS PRN: rtpRelayFilter ioctl(open) rc: 0 rtpRelayId: 2
17:09:08 34930141mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Open got rtpRelayId: 2
17:09:08 34930141mS PRN: rtpRelayFilter configure rc: 0 rtpRelayId: 2
17:09:08 34930141mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Configure success rtpRelayId: 2
17:09:08 34930141mS CMMap: PlatformConnectionAudioSAP::ConnectVoice local IP addr 10.10.12.6:46752, Remote IP addr 10.10.12.5:48400
17:09:08 34930141mS CMMap: PlatformConnectionAudioSAP::ConnectVoice DSP IP addr 1.1.1.7:32768, telogyHost IP addr 1.1.1.1:62
17:09:08 34930141mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Start success rtpRelayId: 2
17:09:08 34930142mS CMMap: pcp[138]b0r1 rtpRelayId: 2 SetRTPFilterState RTPFilterPaused(2) -> RTPFilterStarted(1)
17:09:08 34930142mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[138]b0r1 ConnectIndication 2.17
17:09:08 34930142mS PRN: RTCP collector is NOT initialized
17:09:08 34930142mS H323Evt: SESS 1d SetOperational local 10.10.12.6:46752 remote 10.10.12.5:48400 to 1
17:09:08 34930142mS PRN: RTCP collector is NOT initialized
17:09:08 34930377mS RES: Sat 17/12/2022 17:09:07 FreeMem=55920572 Heap=55592620(2) Cache=327952 MemObjs=12592(Max 13384) CMMsg=4(5) ASN=0 Buff=5200 1364 1000 7415 5 Links=55389(55522) BTree=845(1777) CB=6054 MCT=0 CPU=07.23% CPUStats=15.57%/20/31/4942/
12729/15031/00.62%/1/03.11% MCR=0 MCW=0 DEV=0
17:09:08 34930378mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+62 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=27(TLS=6 OFF=0) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:09:08 34930378mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:09:08 34930378mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150
17:09:08 34930384mS CMLineRx: v=6
CMProgress
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDDestNotISDN (2)
17:09:08 34930385mS CMCallEvt: 0a0a0c0600000524 0.1316.0 23 Q931 Trunk:6 CHAN=2: StateChange: END=B CMCSAccept->CMCSRinging
17:09:08 34930386mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: StateChange: END=A CMCSDialled->CMCSRingBack
17:09:08 34930389mS CMLineTx: v=18
CMProgress
Line: type=IPLine 18 Call: lid=18 id=23 in=1
BChan: slot=3 chan=6
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDDestNotISDN (2)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=045628401
IE CMIEDeviceDetail (231) 0a0a0c0600000524 LOCALE=aru HW=15 VER=11 class=CMDeviceISDNTrunk type=0 number=6 channel=2 features=0x0 rx_gain=32 tx_gain=32
ep_callid=1316 ipaddr=10.10.12.6 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
17:09:08 34930391mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:08 34930391mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:08 34930391mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:08 34930391mS CMMap: a=3.6 b=2.17 M12
17:09:08 34930392mS PRN: RTCP collector is NOT initialized
17:09:08 34930392mS PRN: RTCP collector is NOT initialized
17:09:08 34930509mS SIP Rx: UDP 10.59.108.25:5060 -> 10.255.1.194:5060
INVITE sip:045628401@10.255.1.194:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 10.59.108.25:5060;branch=z9hG4bK89c79eb336a4f689eee85330fab54e036233c45f-0-476a6ea6-639dbf741c75f51f;_aluscr_
Route: <sip:045628401@du.ae;user=phone>
Content-Length: 290
From: <sip:042432025@du.com.ae;user=phone>;tag=6233c45f-639dbf741c7443b4-gm-pt-lucentPCSF-054983
To: <sip:045628401@du.ae;user=phone>
Call-ID: LU-1671282548477378-65269734@i4.sbc.du.com
CSeq: 1 INVITE
Max-Forwards: 68
Request-Disposition: no-fork
P-Asserted-Identity: <sip:042432025@du.com.ae;user=phone>
P-Asserted-Identity: <tel:042432025;phone-context=+971>
Contact: <sip:lucentNGFS-083444@10.59.108.25:5060;x-afi=128;encoded-parm=QbkRBthOEgsTXgkTBA0HHiUrKz1CQElBR0BBNhEMGAklOiF0dGguJTpkJiIufn9jfz8wN2FkY3ZqPUFCXVFBQVhKUh5BXAZYVlRTVg__>
Supported: norefersub,histinfo,100rel
Allow: INVITE,BYE,REGISTER,ACK,OPTIONS,CANCEL,SUBSCRIBE,NOTIFY,PRACK,INFO,REFER,UPDATE
Content-Type: application/sdp
History-Info: <sip:045628401@du.ae;user=phone>;index=1
P-Called-Party-ID: <sip:045628401@du.ae;user=phone>
P-NOKIA.Traffica: S1;i="8AC82F87835900F5D3447597@4d70ffffffff"
P-NOKIA.Traffica: I1;t=1671282548.385

v=0
o=LucentPCSF 1684390706 1684390706 IN IP4 i4.sbc.du.com
s=-
c=IN IP4 10.59.109.72
t=0 0
m=audio 43098 RTP/AVP 96 8 0 18 9 97 13
a=rtpmap:96 AMR/8000
a=fmtp:96 mode-change-capability=2; max-red=0
a=fmtp:18 annexb=yes
a=rtpmap:97 telephone-event/8000
a=ptime:20
a=maxptime:20
17:09:08 34930514mS CMCallEvt: 0000000000000000 0.1317.0 -1 BaseEP: NEW CMEndpoint f4fc2d64 TOTAL NOW=5 CALL_LIST=2
17:09:08 34930515mS NAT: Info: Line 25: Not using STUN for media in this case.
17:09:08 34930517mS SIP Tx: UDP 10.255.1.194:5060 -> 10.59.108.25:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.59.108.25:5060;branch=z9hG4bK89c79eb336a4f689eee85330fab54e036233c45f-0-476a6ea6-639dbf741c75f51f;_aluscr_
From: <sip:042432025@du.com.ae;user=phone>;tag=6233c45f-639dbf741c7443b4-gm-pt-lucentPCSF-054983
Call-ID: LU-1671282548477378-65269734@i4.sbc.du.com
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,UPDATE
Supported: timer,100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:045628401@du.ae;user=phone>;tag=55143420adf80876
Content-Length: 0

17:09:08 34930520mS CMCallEvt: CREATE CALL:24 (f16b72d8)
17:09:08 34930521mS CMCallEvt: 0000000000000000 0.1318.0 -1 BaseEP: NEW CMEndpoint f16dba60 TOTAL NOW=6 CALL_LIST=2
17:09:08 34930523mS CMLineRx: v=0
CMSetup
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
Called[045628401] Type=Default (100) Reason=CMDRdirect SndComp Calling[042432025@du.com.ae] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=042432025@du.com.ae
IE CMIEDeviceDetail (231) 0a0a0c0600000525 LOCALE=aru HW=15 VER=11 class=CMDeviceSIPTrunk type=0 number=25 channel=1 features=0x0 rx_gain=32 tx_gain=32
ep_callid=1317 ipaddr=10.10.12.6 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
17:09:08 34930524mS CMCallEvt: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: StateChange: END=A CMCSIdle->CMCSDialInitiated
17:09:08 34930524mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: LOOKUP CALL ROUTE: GID=100 type=100 called_party=045628401 sub= calling=042432025@du.com.ae calling_sub= dir=in complete=1 ses=0
17:09:08 34930524mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: SET BESTMATCH: length 0 vs -1 match= dest=1208
17:09:08 34930524mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: SET BESTMATCH: length 9 vs 0 match=045628401 dest=VM:ExtendedHours
17:09:08 34930525mS CMCallEvt: Priority hike: call 24 priority 0->1
17:09:08 34930525mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: LOOKUP ICR: DDI=045628401 CGPN=042432025@du.com.ae (Destination VM:ExtendedHours ) => CDPN=VM:ExtendedHours
17:09:08 34930525mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: ADD TARGET (N): number=VM:ExtendedHours type=100 depth=1 nobar=1 setorig=1 ses=0
17:09:08 34930525mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: ADD VM TARGET
17:09:08 34930526mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: MakeVoicemailTarget pbx=<null> local=1 type=2
17:09:08 34930526mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: MakeTargetLine number 18
17:09:08 34930526mS CMCallEvt: 0000000000000000 0.1319.0 -1 BaseEP: NEW CMEndpoint f16b4d78 TOTAL NOW=7 CALL_LIST=3
17:09:08 34930528mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: ADD VM TARGET: SUCCEEDED
17:09:08 34930529mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: INITIAL TARGETING SUCCEEDED
17:09:08 34930529mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: GetNoAnswerTimer:15
17:09:08 34930529mS CMCallEvt: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: StateChange: END=A CMCSDialInitiated->CMCSDialled
17:09:08 34930530mS CMLineTx: v=0
CMProceeding
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
17:09:08 34930531mS CMCallEvt: 0000000000000000 0.1318.0 24 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
17:09:08 34930532mS CMCallEvt: 0a0a0c0600000527 0.1319.0 24 H323TrunkEP: StateChange: END=T CMCSIdle->CMCSOffering
17:09:08 34930533mS CMLineTx: v=18
CMSetup
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
Called[] Type=Voicemail (102) Reason=CMDRX_Attendant SndComp Calling[042432025@du.com.ae] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIECallSignalChannelData (8) unknown
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 97, rxp 97, 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=042432025@du.com.ae
IE CMIEDeviceDetail (231) 0a0a0c0600000525 LOCALE=aru HW=15 VER=11 class=CMDeviceSIPTrunk type=0 number=25 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1317 ipaddr=10.10.12.6 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:100 N:100 R:4) number=045628401
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
Display [++ffExtendedHours]
Timed: 17/12/22 17:09
Locale: aru
17:09:08 34930536mS H323Evt: v=0 stacknum=18 State, new=NullState, old=NullState id=-1
17:09:08 34930538mS H323Evt: v=0 stacknum=18 State, new=Initiated, old=NullState id=1319
17:09:08 34930558mS H323Evt: v=0 stacknum=18 State, new=Proceeding, old=Initiated id=1319
17:09:08 34930558mS CMLineRx: v=18
CMProceeding
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
IE CMIEFarEndCMCallIdData (182) Far End CM Call: lid=7 (0007) id=539 (021b) in=1 (0001)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 97, rxp 97, fmtp = <null>, misc 12 (misc oob 1 misc rfc2833 0 prio oob 0 prio rfc2833 1)
17:09:08 34930559mS CMCallEvt: 0000000000000000 0.1318.0 24 TargetingEP: RequestEnd 0a0a0c0600000527 0.1319.0 24 H323TrunkEP
17:09:08 34930559mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: CancelTimer CMTCNoAnswerTimeout
17:09:08 34930559mS CMCallEvt: 0000000000000000 0.1318.0 -1 BaseEP: DELETE CMEndpoint f16dba60 TOTAL NOW=6 CALL_LIST=3
17:09:08 34930560mS CMCallEvt: 0a0a0c0600000527 0.1319.0 24 H323TrunkEP: StateChange: END=B CMCSOffering->CMCSAccept
17:09:08 34930561mS CMLineTx: v=0
CMFacility
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
IE CMIEFarEndCMCallIdData (182) Far End CM Call: lid=7 (0007) id=539 (021b) in=1 (0001)
17:09:08 34930565mS H323Evt: v=0 stacknum=18 State, new=Active, old=Proceeding id=1319
17:09:08 34930568mS CMLineRx: v=18
CMConnect
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
ConnectedName.Invoke.CodePageBmpString
invokeId 38097
user 'ExtendedHours' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEPrimitiveData (7)
IE CMIEFarEndCMCallIdData (182) Far End CM Call: lid=7 (0007) id=539 (021b) in=1 (0001)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 97, rxp 97, fmtp = <null>, misc 12 (misc oob 1 misc rfc2833 0 prio oob 0 prio rfc2833 1)
IE CMIERespondingPartyName (228)(Type=CMName_VMPro) name=ExtendedHours
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:102 N:100 R:4) number=ExtendedHours
IE CMIEDeviceDetail (231) 0a0a0c050001ee64 LOCALE=aru HW=11 VER=11 class=CMDeviceVoicemail type=0 number=0 channel=0 features=0x0 rx_gain=32 tx_gain=32
ep_callid=126564 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
17:09:08 34930569mS CMCallEvt: 0a0a0c050001ee64 0.1319.0 24 H323TrunkEP: StateChange: END=B CMCSAccept->CMCSConnReq
17:09:08 34930569mS CMCallEvt: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: StateChange: END=A CMCSDialled->CMCSOGConnReq
17:09:08 34930577mS CMLineTx: v=0
CMConnect
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
ConnectedName.Invoke.CodePageISO8859-1
invokeId 14631
user 'ExtendedHours' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEFarEndCMCallIdData (182) Far End CM Call: lid=7 (0007) id=539 (021b) in=1 (0001)
IE CMIERespondingPartyName (228)(Type=CMName_VMPro) name=ExtendedHours
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:102 N:100 R:4) number=ExtendedHours
IE CMIEDeviceDetail (231) 0a0a0c050001ee64 LOCALE=aru HW=11 VER=11 class=CMDeviceVoicemail type=0 number=0 channel=0 features=0x0 rx_gain=32 tx_gain=32
ep_callid=126564 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 1)
}
17:09:08 34930579mS SIP Tx: UDP 10.255.1.194:5060 -> 10.59.108.25:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.59.108.25:5060;branch=z9hG4bK89c79eb336a4f689eee85330fab54e036233c45f-0-476a6ea6-639dbf741c75f51f;_aluscr_
From: <sip:042432025@du.com.ae;user=phone>;tag=6233c45f-639dbf741c7443b4-gm-pt-lucentPCSF-054983
Call-ID: LU-1671282548477378-65269734@i4.sbc.du.com
CSeq: 1 INVITE
Contact: <sip:045628401@10.255.1.194:5060;transport=udp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,UPDATE
Supported: timer,100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:045628401@du.ae;user=phone>;tag=55143420adf80876
Content-Type: application/sdp
Content-Length: 201

v=0
o=UserA 3724505615 3300135745 IN IP4 10.255.1.194
s=Session SDP
c=IN IP4 10.255.1.194
t=0 0
m=audio 40750 RTP/AVP 8 97
a=rtpmap:8 PCMA/8000
a=rtpmap:97 telephone-event/8000
a=fmtp:97 0-15
17:09:08 34930582mS CMLineTx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
17:09:08 34930584mS CMLineTx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
IE CMIEPrimitiveData (7)
17:09:08 34930587mS H323Evt: SESS 1e SetOperational local 10.10.12.6:0 remote 0.0.0.0:0 to 0
17:09:08 34930587mS H323Evt: SESS 1e Configure: Alaw64K packet size 160
17:09:08 34930587mS H323Evt: SESS 1e SetRemUDP 0 -> 48386, remote IP 0.0.0.0 -> 10.10.12.5
17:09:08 34930587mS H323Evt: SESS 1e SetRfc2833: (1) rx payload 97 tx payload 97
17:09:08 34930587mS CMMap: PCG::MapBChan pcp[140]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
17:09:08 34930588mS H323Evt: SESS 1f SetOperational local 10.255.1.194:0 remote 0.0.0.0:0 to 0
17:09:08 34930588mS H323Evt: SESS 1f Configure: Alaw64K packet size 160
17:09:08 34930588mS H323Evt: SESS 1f SetRemUDP 0 -> 43098, remote IP 0.0.0.0 -> 10.59.109.72
17:09:08 34930588mS H323Evt: SESS 1f SetRfc2833: (1) rx payload 97 tx payload 97
17:09:08 34930589mS H323Evt: SESS 1f SetHnt (rtp keepalives): enabled 3, send_initial_packet 0, send_periodic_packets 0
17:09:08 34930589mS CMMap: PCG::MapBChan pcp[139]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
17:09:08 34930589mS CMMap: PCG::MapBChan cp RTP local 10.255.1.194:40750 remote 10.59.109.72:43098 , cp_other RTP local: 10.10.12.6:46754 remote 10.10.12.5:48386
17:09:08 34930590mS CMMap: PCG::MapBChan cp oob 0 rfc_2833 1 , cp_other oob 0, rfc_2833 1, cp behind_nat 0 cp_other behind_nat 0
17:09:08 34930590mS PRN: rtpRelayFilter ioctl(open) rc: 0 rtpRelayId: 3
17:09:08 34930590mS CMMap: PCG::MapBChan rtpRelay Open got rtpRelayId: 3
17:09:08 34930590mS PRN: rtpRelayFilter configure rc: 0 rtpRelayId: 3
17:09:08 34930590mS CMMap: PCG::MapBChan rtpRelay Configure success rtpRelayId: 3
17:09:08 34930590mS CMMap: PCG::MapBChan rtpRelay Start success rtpRelayId: 3
17:09:08 34930590mS CMMap: pcp[139]b0r1 rtpRelayId: 3 SetRTPFilterState RTPFilterPaused(2) -> RTPFilterStarted(1)
17:09:08 34930591mS CMMap: pcp[140]b0r1 rtpRelayId: 3 SetRTPFilterState RTPFilterPaused(2) -> RTPFilterStarted(1)
17:09:08 34930591mS H323Evt: SESS 1f SetOperational local 10.255.1.194:40750 remote 10.59.109.72:43098 to 1
17:09:08 34930591mS H323Evt: SESS 1e SetOperational local 10.10.12.6:46754 remote 10.10.12.5:48386 to 1
17:09:08 34930622mS CMLineRx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
IE CMIEPrimitiveData (7)
17:09:08 34930627mS CMLineRx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
IE CMIEPrimitiveData (7)
17:09:08 34930909mS SIP Rx: UDP 10.59.108.25:5060 -> 10.255.1.194:5060
ACK sip:045628401@10.255.1.194:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 10.59.108.25:5060;branch=z9hG4bK0140401484881591;_aluscr_
Content-Length: 0
From: <sip:042432025@du.com.ae;user=phone>;tag=6233c45f-639dbf741c7443b4-gm-pt-lucentPCSF-054983
To: <sip:045628401@du.ae;user=phone>;tag=55143420adf80876
Call-ID: LU-1671282548477378-65269734@i4.sbc.du.com
CSeq: 1 ACK
Max-Forwards: 68
Request-Disposition: no-fork
Contact: <sip:lucentNGFS-083444@10.59.108.25:5060;x-afi=128;encoded-parm=QbkRBthOEgsTXgkTBA0HHiUrKz1CQElBR0BBNhEMGAklOiF0dGguJTpkJiIufn9jfz8wN2FkY3ZqPUFCXVFBQVhKUh5BXAZYVlRTVg__>
P-NOKIA.Traffica: S1;i="8AC82F87835900F5D3447597@4d70ffffffff"

17:09:08 34930913mS CMLineRx: v=0
CMConnectAck
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
Called[] Type=Default (100) Reason=CMDRdirect Calling[042432025@du.com.ae] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=042432025@du.com.ae
IE CMIEDeviceDetail (231) 0a0a0c0600000525 LOCALE=aru HW=15 VER=11 class=CMDeviceSIPTrunk type=0 number=25 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1317 ipaddr=10.10.12.6 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
17:09:08 34930913mS CMCallEvt: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: StateChange: END=A CMCSOGConnReq->CMCSConnected
17:09:08 34930913mS CMTARGET: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: ~CMTargetHandler f16c7044 ep f4fc2d64
17:09:08 34930914mS CMCallEvt: 0a0a0c050001ee64 0.1319.0 24 H323TrunkEP: StateChange: END=B CMCSConnReq->CMCSConnected
17:09:08 34930916mS CMLineTx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[042432025@du.com.ae] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=042432025@du.com.ae
IE CMIEDeviceDetail (231) 0a0a0c0600000525 LOCALE=aru HW=15 VER=11 class=CMDeviceSIPTrunk type=0 number=25 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1317 ipaddr=10.10.12.6 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
17:09:09 34931101mS ISDNL3Evt: v=6 stacknum=6 State, new=Active, old=Proceeding id=1316
17:09:09 34931101mS CMLineRx: v=6
CMConnect
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDDestNotISDN (2)
17:09:09 34931102mS CMCallEvt: 0a0a0c0600000524 0.1316.0 23 Q931 Trunk:6 CHAN=2: StateChange: END=B CMCSRinging->CMCSConnReq
17:09:09 34931103mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: StateChange: END=A CMCSRingBack->CMCSOGConnReq
17:09:09 34931104mS CMLineTx: v=18
CMConnect
Line: type=IPLine 18 Call: lid=18 id=23 in=1
BChan: slot=3 chan=6
IE CMIEPrimitiveData (7)
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDDestNotISDN (2)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=045628401
IE CMIEDeviceDetail (231) 0a0a0c0600000524 LOCALE=aru HW=15 VER=11 class=CMDeviceISDNTrunk type=0 number=6 channel=2 features=0x0 rx_gain=32 tx_gain=32
ep_callid=1316 ipaddr=10.10.12.6 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
17:09:09 34931107mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931107mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931107mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:09 34931107mS CMMap: a=3.6 b=2.17 M12
17:09:09 34931107mS PRN: RTCP collector is NOT initialized
17:09:09 34931108mS PRN: RTCP collector is NOT initialized
17:09:09 34931109mS H323Evt: v=0 stacknum=18 State, new=Active, old=ICProceeding id=23
17:09:09 34931112mS CMLineRx: v=18
CMConnectAck
Line: type=IPLine 18 Call: lid=18 id=23 in=1
17:09:09 34931112mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: StateChange: END=A CMCSOGConnReq->CMCSConnected
17:09:09 34931112mS CMTARGET: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: ~CMTargetHandler f16d54e8 ep f16c0844
17:09:09 34931114mS CMCallEvt: 0a0a0c0600000524 0.1316.0 23 Q931 Trunk:6 CHAN=2: StateChange: END=B CMCSConnReq->CMCSConnected
17:09:09 34931117mS CMLineTx: v=6
CMConnectAck
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
BChan: slot=0 chan=2
17:09:09 34931118mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931118mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931118mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:09 34931119mS CMMap: a=3.6 b=2.17 M12
17:09:09 34931119mS PRN: RTCP collector is NOT initialized
17:09:09 34931120mS PRN: RTCP collector is NOT initialized
17:09:09 34931121mS CMLineRx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIEPrimitiveData (7)
17:09:09 34931125mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931125mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931125mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:09 34931126mS CMMap: a=3.6 b=2.17 M12
17:09:09 34931126mS PRN: RTCP collector is NOT initialized
17:09:09 34931126mS PRN: RTCP collector is NOT initialized
17:09:09 34931130mS CMLineRx: v=18
CMUserInformation
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIERecordingEvent (251) recording_start=1
17:09:09 34931133mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931134mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931134mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:09 34931134mS CMMap: a=3.6 b=2.17 M12
17:09:09 34931135mS PRN: RTCP collector is NOT initialized
17:09:09 34931135mS PRN: RTCP collector is NOT initialized
17:09:09 34931140mS CMLineRx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIEPrimitiveData (7)
17:09:09 34931142mS CMLineTx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIEPrimitiveData (7)
17:09:09 34931144mS CMLineRx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIEPrimitiveData (7)
17:09:09 34931146mS CMLineTx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIEPrimitiveData (7)
17:09:09 34931147mS CMLineRx: v=18
CMFacility
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Robel ACW
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1031
IE CMIEDeviceDetail (231) 0a0a0c050001ee5e LOCALE=aru HW=11 VER=11 class=CMDeviceSIPPhone type=151 number=1 channel=0 features=0x20110020 rx_gain=32 tx_gain=32
ep_callid=126558 ipaddr=10.10.12.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x0 is_spcall=0 ignores_dtmf=0 avgsid=
17:09:09 34931152mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931152mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:09 34931152mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:09 34931152mS CMMap: a=3.6 b=2.17 M12
17:09:09 34931152mS PRN: RTCP collector is NOT initialized
17:09:09 34931153mS PRN: RTCP collector is NOT initialized
17:09:13 34935117mS PRN: Monitor Status S-Edition Expansion (V2) 11.0.0.0.0 build 849
17:09:13 34935118mS PRN: LAW=A PRI=0, BRI=2, ALOG=4, VCOMP=42, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=5 VMAIL=1(VER=3 TYP=2) 1-X=0 CALLS=3(TOT=24)
17:09:14 34936298mS RES: Sat 17/12/2022 17:09:14 FreeMem=55861236 Heap=55569552(2) Cache=291684 MemObjs=13282(Max 13505) CMMsg=4(5) ASN=0 Buff=5200 1363 1000 7426 5 Links=55557(55588) BTree=858(1777) CB=6046 MCT=0 CPU=08.15% CPUStats=07.35%/1/4/4942/13
532/15031/00.96%/1/03.69% MCR=0 MCW=0 DEV=0
17:09:14 34936298mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+64 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=27(TLS=6 OFF=0) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:09:14 34936299mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:09:14 34936299mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150
17:09:26 34948696mS CMLineRx: v=18
CMUserInformation
Line: type=IPLine 18 Call: lid=18 id=23 in=1
IE CMIERecordingEvent (251) recording_start=0
17:09:26 34948700mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:26 34948700mS CMMap: a=3.6 b=0.0 PCGS CPReserveCodec (pcp[138]b0r1) true
17:09:26 34948700mS CMMap: PCG::MapBChan pcp[138]b0r1 cp_b f5395054 other_cp_b f53513f0 type CGTypeSimple
17:09:26 34948701mS CMMap: a=3.6 b=2.17 M12
17:09:26 34948701mS PRN: RTCP collector is NOT initialized
17:09:26 34948701mS PRN: RTCP collector is NOT initialized
17:09:26 34948704mS H323Evt: v=0 stacknum=18 State, new=NullState, old=Active id=23
17:09:26 34948705mS CMLineRx: v=18
CMReleaseComp
Line: type=IPLine 18 Call: lid=18 id=23 in=1
Cause=16, Normal call clearing
17:09:26 34948705mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 23 H323TrunkEP: StateChange: END=A CMCSConnected->CMCSCompleted
17:09:26 34948708mS CMLOGGING: CALL:2022/12/1717:09,00:00:17,000,1031,I,045628401,045628401,RobelACW,,,0,,"",0,n/a
17:09:26 34948709mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 -1 H323TrunkEP: StateChange: END=X CMCSCompleted->CMCSDelete
17:09:26 34948710mS CMLineTx: v=6
CMDisconnect
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
Cause=16, Normal call clearing
17:09:26 34948711mS CMCallEvt: 0a0a0c0600000524 0.1316.0 -1 Q931 Trunk:6 CHAN=2: StateChange: END=X CMCSConnected->CMCSCompleted
17:09:26 34948711mS CMCallEvt: END CALL:23 (f16c2ff4)
17:09:26 34948712mS CMCallEvt: 0a0a0c050001ee5e 18.23.1 -1 BaseEP: DELETE CMEndpoint f16c0844 TOTAL NOW=5 CALL_LIST=2
17:09:26 34948713mS CMMap: PCG::UnmapBChan pcp[107]b1r0 cp_b f53513f0 other_cp_b f5395054
17:09:26 34948714mS CMMap: a=2.17 b=3.6 M02
17:09:26 34948714mS PRN: rtpRelayFilter close rc: 0 rtpRelayId: 2
17:09:26 34948714mS CMMap: PlatformConnectionAudioSAP::DisconnectRtpFilter rtpRelayId: 2 Close success
17:09:26 34948715mS H323Evt: SESS 1d SetOperational local 10.10.12.6:46752 remote 10.10.12.5:48400 to 0
17:09:26 34948715mS CMMap: PCG::UnmapBChan pcp[138]b0r1 cp_b 0 other_cp_b 0
17:09:26 34948716mS H323Evt: SESS 1d: RTP(END): 10.10.12.6/46752 10.10.12.5/48400 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=on AGE=18578 SENT=920 RECV=920 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
17:09:26 34948717mS CMMap: a=2.17 b=0.0 Mapper::FreeCodec freed CMRTVocoder(f53951f0) resource busy 2, total 42
17:09:26 34948718mS ISDNL3Evt: v=6 stacknum=6 State, new=DiscReq, old=Active id=1316
17:09:26 34948753mS ISDNL3Evt: v=6 stacknum=6 State, new=NullState, old=DiscReq id=1316
17:09:26 34948754mS CMLineRx: v=6
CMReleaseComp
Line: type=Q931Line 6 Call: lid=0 id=1316 in=0
BChan: slot=0 chan=2
Cause=16, Normal call clearing
17:09:26 34948754mS CMCallEvt: 0a0a0c0600000524 0.1316.0 -1 Q931 Trunk:6 CHAN=2: StateChange: END=X CMCSCompleted->CMCSDelete
17:09:26 34948755mS CMCallEvt: 0a0a0c0600000524 0.1316.0 -1 BaseEP: DELETE CMEndpoint f16a932c TOTAL NOW=4 CALL_LIST=2
17:09:26 34948814mS RES: Sat 17/12/2022 17:09:26 FreeMem=55894628 Heap=55568996(2) Cache=325632 MemObjs=13119(Max 13505) CMMsg=4(5) ASN=0 Buff=5200 1364 1000 7421 5 Links=55480(55588) BTree=856(1777) CB=6051 MCT=0 CPU=07.65% CPUStats=06.09%/1/5/4942/13
764/15031/00.93%/1/03.65% MCR=0 MCW=0 DEV=0
17:09:26 34948814mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+63 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=27(TLS=6 OFF=0) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:09:26 34948814mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:09:26 34948815mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150
17:09:26 34948892mS SIP Rx: UDP 10.59.108.25:5060 -> 10.255.1.194:5060
BYE sip:045628401@10.255.1.194:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 10.59.108.25:5060;branch=z9hG4bK1a537df7494c11261fd120aa0f339b2b6233c45f-0-476a7252-639dbf863366e7da;_aluscr_
Content-Length: 0
From: <sip:042432025@du.com.ae;user=phone>;tag=6233c45f-639dbf741c7443b4-gm-pt-lucentPCSF-054983
To: <sip:045628401@du.ae;user=phone>;tag=55143420adf80876
Call-ID: LU-1671282548477378-65269734@i4.sbc.du.com
CSeq: 2 BYE
Max-Forwards: 68
Request-Disposition: no-fork
Reason: X.int;reasoncode=0x00000000;add-info=01CA.FFFE.0000
Reason: Q.850;cause=16
P-NOKIA.Traffica: S1;i="8AC82F87835900F5D3447597@4d70ffffffff"

17:09:26 34948896mS SIP Tx: UDP 10.255.1.194:5060 -> 10.59.108.25:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.59.108.25:5060;branch=z9hG4bK1a537df7494c11261fd120aa0f339b2b6233c45f-0-476a7252-639dbf863366e7da;_aluscr_
From: <sip:042432025@du.com.ae;user=phone>;tag=6233c45f-639dbf741c7443b4-gm-pt-lucentPCSF-054983
Call-ID: LU-1671282548477378-65269734@i4.sbc.du.com
CSeq: 2 BYE
Supported: timer,100rel
Server: IP Office 11.0.0.0.0 build 849
To: <sip:045628401@du.ae;user=phone>;tag=55143420adf80876
Content-Length: 0

17:09:26 34948897mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
Called[] Type=Default (100) Reason=CMDRdirect Calling[042432025@du.com.ae] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=042432025@du.com.ae
IE CMIEDeviceDetail (231) 0a0a0c0600000525 LOCALE=aru HW=15 VER=11 class=CMDeviceSIPTrunk type=0 number=25 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1317 ipaddr=10.10.12.6 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
Cause=16, Normal call clearing
17:09:26 34948898mS CMCallEvt: 0a0a0c0600000525 25.1317.1 24 SIPTrunk Endpoint: StateChange: END=A CMCSConnected->CMCSCompleted
17:09:26 34948900mS CMLineTx: v=0
CMFacility
Line: type=SIPLine 25 Call: lid=25 id=1317 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:09:26 34948901mS CMLOGGING: CALL:2022/12/1717:09,00:00:17,000,042432025@du.com.ae,I,ExtendedHours,045628401,,,,0,,"",0,n/a
17:09:26 34948902mS CMCallEvt: 0a0a0c0600000525 25.1317.1 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
17:09:26 34948903mS CMLineTx: v=18
CMReleaseComp
Line: type=IPLine 18 Call: lid=0 id=1319 in=0
Cause=16, Normal call clearing
17:09:26 34948903mS CMCallEvt: 0a0a0c050001ee64 0.1319.0 -1 H323TrunkEP: StateChange: END=X CMCSConnected->CMCSDelete
17:09:26 34948904mS CMCallEvt: 0a0a0c050001ee64 0.1319.0 -1 BaseEP: DELETE CMEndpoint f16b4d78 TOTAL NOW=3 CALL_LIST=1
17:09:26 34948904mS CMCallEvt: END CALL:24 (f16b72d8)
17:09:26 34948906mS CMCallEvt: 0a0a0c0600000525 25.1317.1 -1 BaseEP: DELETE CMEndpoint f4fc2d64 TOTAL NOW=2 CALL_LIST=1
17:09:26 34948908mS CMMap: PCG::UnmapBChan pcp[140]b0r1 cp_b 0 other_cp_b 0
17:09:26 34948908mS H323Evt: SESS 1e SetOperational local 10.10.12.6:46754 remote 10.10.12.5:48386 to 0
17:09:26 34948908mS H323Evt: SESS 1f SetOperational local 10.255.1.194:40750 remote 10.59.109.72:43098 to 0
17:09:26 34948908mS PRN: rtpRelayFilter close rc: 0 rtpRelayId: 3
17:09:26 34948908mS CMMap: PCG::UMMapBChan rtpRelayId: 3 Close success
17:09:26 34948908mS CMMap: PCG::UnmapBChan pcp[139]b0r1 cp_b 0 other_cp_b 0
17:09:26 34948909mS H323Evt: SESS 1e: RTP(END): 10.10.12.6/46754 10.10.12.5/48386 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=on AGE=18322 SENT=904 RECV=917 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
17:09:26 34948910mS H323Evt: SESS 1f: RTP(END): 10.255.1.194/40750 10.59.109.72/43098 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=on AGE=18321 SENT=914 RECV=907 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
17:09:26 34948911mS H323Evt: v=0 stacknum=18 State, new=ReleaseReq, old=Active id=1319
17:09:26 34948911mS H323Evt: v=0 stacknum=18 State, new=NullState, old=ReleaseReq id=1319
17:09:32 34954319mS RES: Sat 17/12/2022 17:09:31 FreeMem=55959052 Heap=55582108(1) Cache=376944 MemObjs=12445(Max 13505) CMMsg=4(5) ASN=0 Buff=5200 1364 1000 7427 5 Links=55318(55588) BTree=854(1777) CB=6059 MCT=0 CPU=07.81% CPUStats=06.89%/4/8/4942/13
669/15031/00.41%/0/02.98% MCR=0 MCW=0 DEV=0
17:09:32 34954319mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+60 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=28(TLS=6 OFF=0) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:09:32 34954320mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:09:32 34954320mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150
17:09:34 34956255mS PRN: Config Write Wake Up
17:09:34 34956755mS PRN: Config Write Completed

********** SysMonitor v11.1.0.2.0 build 14 [connected to 10.10.12.6 (Unified Dubai (Server Edition(E)))] **********
17:09:43 34965960mS PRN: Monitor Status S-Edition Expansion (V2) 11.0.0.0.0 build 849
17:09:43 34965960mS PRN: LAW=A PRI=0, BRI=2, ALOG=4, VCOMP=42, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=5 VMAIL=1(VER=3 TYP=2) 1-X=0 CALLS=1(TOT=24)
17:09:46 34968664mS PRN: Service Access Connection from 10.10.12.5(49456) to Port 8443
17:09:46 34968848mS RES: Sat 17/12/2022 17:09:46 FreeMem=55942692 Heap=55587016(0) Cache=355676 MemObjs=12515(Max 13505) CMMsg=4(5) ASN=0 Buff=5200 1364 1000 7423 5 Links=55325(55588) BTree=854(1777) CB=6058 MCT=0 CPU=06.65% CPUStats=05.89%/1/5/4942/14
103/15031/00.38%/0/02.94% MCR=0 MCW=0 DEV=0
17:09:46 34968848mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+60 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=28(TLS=7 OFF=1) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:09:46 34968849mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:09:46 34968849mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150
17:09:56 34978855mS RES: Sat 17/12/2022 17:09:56 FreeMem=55960228 Heap=55587016(0) Cache=373212 MemObjs=12441(Max 13505) CMMsg=4(5) ASN=0 Buff=5200 1364 1000 7427 5 Links=55317(55588) BTree=854(1777) CB=6059 MCT=0 CPU=07.34% CPUStats=06.49%/1/4/4942/14
006/15031/00.37%/0/02.93% MCR=0 MCW=0 DEV=0
17:09:56 34978856mS RES2: (SE-E) IP 500 V2 11.0.0.0.0 build 849 Tasks=59 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+60 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=27(TLS=6 OFF=0) TAPI=1 Partner=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=
2034
17:09:56 34978856mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:09:56 34978856mS RES5: CLog MemObjs=70 FreePoolMem(Objs)=1560(30) TotalMem=5200 StringsTotalMem=80150

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




 
Status
Not open for further replies.

Part and Inventory Search

Sponsor

Back
Top