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!

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

Cant Transfer callls on IP office 5

Status
Not open for further replies.
smartedge1

smartedge1

IS-IT--Management
May 10, 2013
150
NG
We have AVAYA IP office release 10.1.0.8 build 3 which is integrated to a GSM gateway via SIP trunk .We noticed that whenever we have an incoming external call we cant transfer the call to a mobile number . When we press the transfer button and dial the number we want to call we get a call busy error message on the phone . We can transfer this calls to other AVAYA extensions , its just transfering to this sip trunk that gives this issue . Below is the monitor trace for your reference .




17:15:43 2547630mS PRN: Deleted WAV file MOH Source 1
17:15:43 2547631mS PRN: Created Tone MOH Source 1
17:15:43 2547631mS PRN: Stopped tone MOH Source 1
17:15:43 2547631mS PRN: Deleted Tone MOH Source 1
17:15:43 2547631mS PRN: Playing tone MOH Source 1

********** Warning: Logging to Screen Started **********

********** SysMonitor v10.1.0.8.0 build 3 [connected to 192.168.1.200 (00E0070DFA29)] **********
17:15:46 2550189mS PRN: Monitor Status IP 500 V2 10.1.0.8.0 build 3
17:15:46 2550189mS PRN: LAW=A PRI=1, BRI=0, ALOG=0, VCOMP=32, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=3 TYP=1) 1-X=0 CALLS=1(TOT=44)
17:15:49 2553658mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:15:49 2553658mS CMExtnRx: v=1001, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=255 id=1129 in=0
17:15:49 2553658mS CMCallEvt: c0a801c800000469 255.1129.0 44 Agent 2.0: StateChange: END=A CMCSDialling->CMCSCompleted
17:15:49 2553659mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Dialling,0,0,Agent 2
17:15:49 2553661mS CMExtnTx: v=1001, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1129 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 13/07/21 17:15
17:15:49 2553662mS CMLOGGING: CALL:2021/07/1317:15,00:00:00,000,1001,O,,,Agent2,,,1,,"",0,n/a
17:15:49 2553662mS CMExtnEvt: Agent 2: CALL LOST (CMCauseNormal)
17:15:49 2553662mS CMExtnEvt: Agent 2: Extn(1001) Calling Party Number(1001) Type(CMNTypeInternal)
17:15:49 2553662mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 1129->0 )
17:15:49 2553663mS CMCallEvt: c0a801c800000469 255.1129.0 -1 Agent 2.-1: StateChange: END=X CMCSCompleted->CMCSDelete
17:15:49 2553663mS CMCallEvt: 0000000000000000 0.1130.0 -1 BaseEP: DELETE CMEndpoint f18bc0fc TOTAL NOW=1 CALL_LIST=0
17:15:49 2553663mS CMCallEvt: END CALL:44 (f187cf80)
17:15:49 2553664mS CMTARGET: c0a801c800000469 255.1129.0 -1 BaseEP: ~CMTargetHandler f18a1d1c ep f189e560
17:15:49 2553664mS CMCallEvt: c0a801c800000469 255.1129.0 -1 BaseEP: DELETE CMEndpoint f189e560 TOTAL NOW=0 CALL_LIST=0
17:15:49 2553667mS CMMap: a=0.0 b=0.0 pcp[234]b0r1 RTPD0
17:15:49 2553667mS H323Evt: SESS 3a SetOperational local 192.168.1.200:49156 remote 192.168.1.204:50736 to 0
17:15:49 2553667mS H323Evt: SESS 3a: RTP(END): 192.168.1.200/49156 192.168.1.204/50736 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=12037 SENT=602 RECV=593 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
17:15:49 2553668mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder(f566fd08) resource busy 1, total 32
17:15:49 2553949mS RES: Tue 13/7/2021 17:15:50 FreeMem=61834332 Heap=61394904(3) Cache=439428 MemObjs=7061(Max 8356) CMMsg=6(6) ASN=0 Buff=5200 1356 1000 7420 5 Links=51655(51962) BTree=458(596) CB=6056 CPU=05.76% CPUStats=06.49%/8/16/4822/19048/22224
/00.34%/0/02.20% MCR=0 MCW=0 DEV=0
17:15:49 2553949mS RES2: IP 500 V2 10.1.0.8.0 build 3 Tasks=51 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=10+54 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=6 OFF=0) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
17:15:49 2553949mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:15:49 2553949mS RES5: CLog MemObjs=65 FreePoolMem(Objs)=1820(35) TotalMem=5200 StringsTotalMem=103600
17:15:51 2555663mS CMExtnEvt: Agent 2: Recover Timer reason=CMTRWrapUp
17:15:51 2555663mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,Agent 2
17:15:51 2555663mS CMExtnTx: v=1001, p1=0
CMVoiceMailStatus
Line: type=IPLine 250 Call: lid=0 id=-1 in=0
Called[Agent 2 Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Agent 2 Msgs=0]
Timed: 13/07/21 17:15
17:15:54 2558395mS H323Evt: Recv: RegistrationRequest 192.168.1.204; Extn(1001), time since last RRQ-KA 55001, Endpoints registered: 2; Endpoints in registration: 0
17:15:54 2558692mS PRN: BackupTask SMDR_BACKUP

********** SysMonitor v10.1.0.8.0 build 3 [connected to 192.168.1.200 (00E0070DFA29)] **********
17:15:58 2562195mS PRN: Monitor Status IP 500 V2 10.1.0.8.0 build 3
17:15:58 2562195mS PRN: LAW=A PRI=1, BRI=0, ALOG=0, VCOMP=32, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=3 TYP=1) 1-X=0 CALLS=0(TOT=44)
17:15:59 2563452mS SIP Rx: UDP 192.168.1.225:5060 -> 192.168.1.200:5060


17:16:00 2564949mS RES: Tue 13/7/2021 17:16:00 FreeMem=61834324 Heap=61394904(3) Cache=439420 MemObjs=7061(Max 8356) CMMsg=6(6) ASN=0 Buff=5200 1356 1000 7419 5 Links=51655(51962) BTree=458(596) CB=6056 CPU=05.20% CPUStats=05.78%/1/3/4822/19442/22224/
00.04%/1/02.03% MCR=0 MCW=0 DEV=0
17:16:00 2564949mS RES2: IP 500 V2 10.1.0.8.0 build 3 Tasks=51 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=10+52 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=6 OFF=0) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
17:16:00 2564949mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:16:00 2564950mS RES5: CLog MemObjs=65 FreePoolMem(Objs)=1820(35) TotalMem=5200 StringsTotalMem=103600
17:16:02 2566054mS SIP Rx: UDP 192.168.1.225:5060 -> 192.168.1.200:5060
INVITE sip:200@192.168.1.200:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.225:5060;rport;branch=z9hG4bK1193881645
From: "08173228292" <sip:08173228292@192.168.1.200:5060>;tag=731338172
To: <sip:200@192.168.1.200>
Call-ID: 2078951015@192.168.1.225
CSeq: 13 INVITE
Contact: <sip:08173228292@192.168.1.225:5060>
Max-Forwards: 30
User-Agent: dble
Remote-Party-ID: "08173228292" <sip:08173228292@192.168.1.200>;party=calling;screen=no;privacy=off
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REFER, REGISTER, MESSAGE, INFO, SUBSCRIBE
Content-Type: application/sdp
Content-Length: 248

v=0
o=dble 1656 1656 IN IP4 192.168.1.225
s=dble
c=IN IP4 192.168.1.225
t=0 0
m=audio 16384 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
17:16:02 2566057mS CMCallEvt: 0000000000000000 0.1131.0 -1 BaseEP: NEW CMEndpoint f18799cc TOTAL NOW=1 CALL_LIST=0
17:16:02 2566058mS Stun: Info: Line 17: Not using STUN for media in this case.
17:16:02 2566061mS SIP Tx: UDP 192.168.1.200:5060 -> 192.168.1.225:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.225:5060;rport;branch=z9hG4bK1193881645
From: "08173228292" <sip:08173228292@192.168.1.200:5060>;tag=731338172
Call-ID: 2078951015@192.168.1.225
CSeq: 13 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 10.1.0.8.0 build 3
To: <sip:200@192.168.1.200>;tag=0b602dbb606a02c0
Content-Length: 0

17:16:02 2566063mS CMCallEvt: CREATE CALL:45 (f187cf80)
17:16:02 2566064mS CMCallEvt: 0000000000000000 0.1132.0 -1 BaseEP: NEW CMEndpoint f18bc0fc TOTAL NOW=2 CALL_LIST=0
17:16:02 2566067mS CMLineRx: v=0
CMSetup
Line: type=SIPLine 17 Call: lid=17 id=1131 in=1
Called[200] Type=Default (100) Reason=CMDRdirect SndComp Calling[08173228292@192.168.1.200] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=08173228292@192.168.1.200
IE CMIEDeviceDetail (231) c0a801c80000046b LOCALE=eng HW=15 VER=10 class=CMDeviceSIPTrunk type=0 number=17 channel=1 features=0x0 rx_gain=32 tx_gain=32
ep_callid=1131 ipaddr=192.168.1.200 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
IE CMIEDIDNumber (245)(P:100 S:100 T:100 N:100 R:4) number=200
17:16:02 2566067mS CMCallEvt: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: StateChange: END=A CMCSIdle->CMCSDialInitiated
17:16:02 2566067mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: LOOKUP CALL ROUTE: GID=15 type=100 called_party=200 sub= calling=08173228292@192.168.1.200 calling_sub= dir=in complete=1 ses=0
17:16:02 2566067mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: SET BESTMATCH: length 0 vs -1 match= dest=1001
17:16:02 2566067mS CMCallEvt: Priority hike: call 45 priority 0->1
17:16:02 2566068mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: LOOKUP ICR: DDI=200 CGPN=08173228292@192.168.1.200 (Destination 1001 ) => CDPN=1001
17:16:02 2566068mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: ADD TARGET (N): number=1001 type=100 depth=1 nobar=1 setorig=1 ses=0
17:16:02 2566068mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: SET USER: Agent 2 orig=1
17:16:02 2566068mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: ADD USER: Agent 2 depth=1 disallow_cw=0 dnd=0 real_call=1 group_call=0 type(CMNTypeDefault) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0) r_lic=T
17:16:02 2566068mS CMCallEvt: 0000000000000000 0.1133.0 -1 BaseEP: NEW CMEndpoint f189e560 TOTAL NOW=3 CALL_LIST=1
17:16:02 2566068mS CMCallEvt: 0000000000000000 0.1133.0 -1 Agent 2.-1: NEW CMExtnEndpoint f189e560, Name=Agent 2, Extn=1001, Phys Extn=1001
17:16:02 2566070mS CMTARGET: c0a801c80000046d 255.1133.0 45 Agent 2.0: ADD PRIMARY
17:16:02 2566071mS CMTARGET: FoundKnownSystemTargets ICR cache hit
17:16:02 2566071mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: INITIAL TARGETING SUCCEEDED
17:16:02 2566071mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: GetNoAnswerTimer:15
17:16:02 2566071mS CMCallEvt: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: StateChange: END=A CMCSDialInitiated->CMCSDialled
17:16:02 2566073mS CMLineTx: v=0
CMProceeding
Line: type=SIPLine 17 Call: lid=17 id=1131 in=1
17:16:02 2566073mS CMCallEvt: 0000000000000000 0.1132.0 45 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
17:16:02 2566074mS CMCallEvt: c0a801c80000046d 255.1133.0 45 Agent 2.0: StateChange: END=T CMCSIdle->CMCSOffering
17:16:02 2566075mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 0->1133 )
17:16:02 2566076mS CMExtnTx: v=1001, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=255 id=1133 in=0
Called[1001] Type=Default (100) Reason=CMDRdirect SndComp Calling[08173228292@192.168.1.200] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIECallSignalChannelData (8) unknown
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=08173228292
IE CMIECalledPartyName (224)(Type=CMNameInternalUser) name=Agent 2
IE CMIECalledPartyKName (225)(Type=CMNameDefault) name=Agent 2
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=08173228292@192.168.1.200
IE CMIEDeviceDetail (231) c0a801c80000046b LOCALE=eng HW=15 VER=10 class=CMDeviceSIPTrunk type=0 number=17 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1131 ipaddr=192.168.1.200 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=200
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 [08173228292>Agent 2]
Timed: 13/07/21 17:16
Locale: eng
17:16:02 2566076mS CMExtnRx: v=1001, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=255 id=1133 in=0
17:16:02 2566076mS CMCallEvt: c0a801c80000046d 255.1133.0 45 Agent 2.0: StateChange: END=T CMCSOffering->CMCSRinging
17:16:02 2566076mS CMExtnEvt: v=1 State, new=Ringing old=Idle,0,0,Agent 2
17:16:02 2566077mS CMCallEvt: 0000000000000000 0.1132.0 45 TargetingEP: StateChange: END=B CMCSOffering->CMCSRinging
17:16:02 2566077mS CMCallEvt: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: StateChange: END=A CMCSDialled->CMCSRingBack
17:16:02 2566078mS CMLineTx: v=0
CMAlerting
Line: type=SIPLine 17 Call: lid=17 id=1131 in=1
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
AlertingName.Invoke.CodePageISO8859-1
invokeId 14669
user 'Agent 2' presentation Allowed
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Agent 2
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Agent 2
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1001
IE CMIEDeviceDetail (231) c0a801c80000046d LOCALE=eng HW=15 VER=10 class=CMDeviceH323Phone type=88 number=8004 channel=0 features=0x10000400 rx_gain=32 tx_gain=32
ep_callid=1133 ipaddr=192.168.1.200 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x20 is_spcall=0 ignores_dtmf=1 avgsid=
17:16:02 2566080mS SIP Tx: UDP 192.168.1.200:5060 -> 192.168.1.225:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.1.225:5060;rport;branch=z9hG4bK1193881645
From: "08173228292" <sip:08173228292@192.168.1.200:5060>;tag=731338172
Call-ID: 2078951015@192.168.1.225
CSeq: 13 INVITE
Contact: "Main" <sip:200@192.168.1.200:5060;transport=udp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
P-Asserted-Identity: "Main" <sip:200@192.168.1.200:5060>
Supported: timer
Server: IP Office 10.1.0.8.0 build 3
To: <sip:200@192.168.1.200>;tag=0b602dbb606a02c0
Content-Length: 0

17:16:04 2568311mS CMExtnRx: v=1001, p1=0
CMConnect
Line: type=IPLine 250 Call: lid=255 id=1133 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEFastStartInfoData (6) 10 item(s)
17:16:04 2568311mS CMCallEvt: c0a801c80000046d 255.1133.0 45 Agent 2.0: StateChange: END=T CMCSRinging->CMCSConnReq
17:16:04 2568311mS CMCallEvt: 0000000000000000 0.1132.0 45 TargetingEP: RequestEnd c0a801c80000046d 255.1133.0 45 Agent 2.0
17:16:04 2568311mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: CancelTimer CMTCCoverageTimeout
17:16:04 2568311mS CMCallEvt: 0000000000000000 0.1132.0 -1 BaseEP: DELETE CMEndpoint f18bc0fc TOTAL NOW=2 CALL_LIST=1
17:16:04 2568312mS CMExtnEvt: v=1 State, new=Connected old=Ringing,0,0,Agent 2
17:16:04 2568313mS CMCallEvt: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: StateChange: END=A CMCSRingBack->CMCSOGConnReq
17:16:04 2568315mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f566fd08) resource busy 1, total 32
17:16:04 2568315mS CMMap: IP::SetCodec pcp[237]b0r0 0 -> f566fd08
17:16:04 2568320mS CMMap: a=0.17 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f56b4878) resource busy 2, total 32
17:16:04 2568320mS CMMap: IP::SetCodec pcp[236]b0r0 0 -> f56b4878
17:16:04 2568324mS CMLineTx: v=0
CMConnect
Line: type=SIPLine 17 Call: lid=17 id=1131 in=1
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
ConnectedName.Invoke.CodePageISO8859-1
invokeId 14670
user 'Agent 2' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Agent 2
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Agent 2
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1001
IE CMIEDeviceDetail (231) c0a801c80000046d LOCALE=eng HW=15 VER=10 class=CMDeviceH323Phone type=88 number=8004 channel=0 features=0x10000400 rx_gain=32 tx_gain=32
ep_callid=1133 ipaddr=192.168.1.200 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x20 is_spcall=0 ignores_dtmf=1 avgsid=
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 7)
}
17:16:04 2568326mS SIP Tx: UDP 192.168.1.200:5060 -> 192.168.1.225:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.225:5060;rport;branch=z9hG4bK1193881645
From: "08173228292" <sip:08173228292@192.168.1.200:5060>;tag=731338172
Call-ID: 2078951015@192.168.1.225
CSeq: 13 INVITE
Contact: "Main" <sip:200@192.168.1.200:5060;transport=udp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
P-Asserted-Identity: "Main" <sip:200@192.168.1.200:5060>
Supported: timer
Server: IP Office 10.1.0.8.0 build 3
To: <sip:200@192.168.1.200>;tag=0b602dbb606a02c0
Content-Type: application/sdp
Content-Length: 150

v=0
o=UserA 2890087797 3981565001 IN IP4 192.168.1.200
s=Session SDP
c=IN IP4 192.168.1.200
t=0 0
m=audio 49154 RTP/AVP 8
a=rtpmap:8 PCMA/8000
17:16:04 2568330mS H323Evt: SESS 3b SetOperational local 192.168.1.200:0 remote 0.0.0.0:0 to 0
17:16:04 2568330mS H323Evt: SESS 3b Configure: Alaw64K packet size 160
17:16:04 2568330mS H323Evt: SESS 3b SetRemUDP 0 -> 50736, remote IP 0.0.0.0 -> 192.168.1.204
17:16:04 2568330mS CMMap: PCG::MapBChan pcp[237]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
17:16:04 2568330mS H323Evt: SESS 3c SetOperational local 192.168.1.200:0 remote 0.0.0.0:0 to 0
17:16:04 2568331mS H323Evt: SESS 3c Configure: Alaw64K packet size 160
17:16:04 2568331mS H323Evt: SESS 3c SetRemUDP 0 -> 16384, remote IP 0.0.0.0 -> 192.168.1.225
17:16:04 2568331mS CMMap: PCGS CPReserveCodec (pcp[236]b0r1) true
17:16:04 2568331mS CMMap: PCGS CPReserveCodec for the other end (pcp[237]b0r1) true
17:16:04 2568331mS CMMap: PCG::MapBChan pcp[236]b0r1 cp_b f56b46e0 other_cp_b f56b75d4 type CGTypeSimple
17:16:04 2568331mS CMMap: a=0.1 b=0.17 M12
17:16:04 2568331mS CMMap: PlatformConnectionAudioSAP::Bind pcp[236]b0r1 to 0.17
17:16:04 2568331mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[236]b0r1 Configure 0.17
17:16:04 2568332mS PRN: rtpRelayFilter ioctl(open) rc: 0 rtpRelayId: 1
17:16:04 2568332mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Open got rtpRelayId: 1
17:16:04 2568332mS PRN: rtpRelayFilter configure rc: 0 rtpRelayId: 1
17:16:04 2568332mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Configure success rtpRelayId: 1
17:16:04 2568332mS CMMap: PlatformConnectionAudioSAP::ConnectVoice local IP addr 192.168.1.200:49154, Remote IP addr 192.168.1.225:16384
17:16:04 2568332mS CMMap: PlatformConnectionAudioSAP::ConnectVoice DSP IP addr 1.1.1.5:32768, telogyHost IP addr 1.1.1.1:42
17:16:04 2568332mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Start success rtpRelayId: 1
17:16:04 2568332mS CMMap: pcp[236]b0r1 rtpRelayId: 1 SetRTPFilterState RTPFilterPaused(2) -> RTPFilterStarted(1)
17:16:04 2568332mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[236]b0r1 ConnectIndication 0.17
17:16:04 2568332mS PRN: RTCP collector is NOT initialized
17:16:04 2568332mS H323Evt: SESS 3c SetOperational local 192.168.1.200:49154 remote 192.168.1.225:16384 to 1
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::Bind pcp[237]b0r1 to 0.1
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[237]b0r1 Configure 0.1
17:16:04 2568333mS PRN: rtpRelayFilter ioctl(open) rc: 0 rtpRelayId: 2
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Open got rtpRelayId: 2
17:16:04 2568333mS PRN: rtpRelayFilter configure rc: 0 rtpRelayId: 2
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Configure success rtpRelayId: 2
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice local IP addr 192.168.1.200:49152, Remote IP addr 192.168.1.204:50736
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice DSP IP addr 1.1.1.4:32768, telogyHost IP addr 1.1.1.1:10
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice rtpRelay Start success rtpRelayId: 2
17:16:04 2568333mS CMMap: pcp[237]b0r1 rtpRelayId: 2 SetRTPFilterState RTPFilterPaused(2) -> RTPFilterStarted(1)
17:16:04 2568333mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[237]b0r1 ConnectIndication 0.1
17:16:04 2568334mS PRN: RTCP collector is NOT initialized
17:16:04 2568334mS H323Evt: SESS 3b SetOperational local 192.168.1.200:49152 remote 192.168.1.204:50736 to 1
17:16:04 2568334mS PRN: RTCP collector is NOT initialized
17:16:04 2568334mS PRN: RTCP collector is NOT initialized
17:16:04 2568345mS SIP Rx: UDP 192.168.1.225:5060 -> 192.168.1.200:5060
ACK sip:200@192.168.1.200:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.225:5060;rport;branch=z9hG4bK358451271
From: "08173228292" <sip:08173228292@192.168.1.200:5060>;tag=731338172
To: <sip:200@192.168.1.200>;tag=0b602dbb606a02c0
Call-ID: 2078951015@192.168.1.225
CSeq: 13 ACK
Contact: <sip:08173228292@192.168.1.225:5060>
Max-Forwards: 30
User-Agent: dble
Content-Length: 0

17:16:04 2568347mS CMLineRx: v=0
CMConnectAck
Line: type=SIPLine 17 Call: lid=17 id=1131 in=1
Called[] Type=Default (100) Reason=CMDRdirect Calling[08173228292@192.168.1.200] Type=Unknown Plan=Default
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=08173228292@192.168.1.200
IE CMIEDeviceDetail (231) c0a801c80000046b LOCALE=eng HW=15 VER=10 class=CMDeviceSIPTrunk type=0 number=17 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1131 ipaddr=192.168.1.200 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
17:16:04 2568347mS CMCallEvt: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: StateChange: END=A CMCSOGConnReq->CMCSConnected
17:16:04 2568348mS CMTARGET: c0a801c80000046b 17.1131.1 45 SIPTrunk Endpoint: ~CMTargetHandler f18a1d1c ep f18799cc
17:16:04 2568349mS CMCallEvt: c0a801c80000046d 255.1133.0 45 Agent 2.0: StateChange: END=B CMCSConnReq->CMCSConnected
17:16:04 2568354mS CMExtnTx: v=1001, p1=0
CMConnectAck
Line: type=IPLine 250 Call: lid=255 id=1133 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[08173228292@192.168.1.200] Type=Unknown Plan=Default
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=08173228292@192.168.1.200
IE CMIEDeviceDetail (231) c0a801c80000046b LOCALE=eng HW=15 VER=10 class=CMDeviceSIPTrunk type=0 number=17 channel=1 features=0x20 rx_gain=32 tx_gain=32
ep_callid=1131 ipaddr=192.168.1.200 apps=0 loc=999 em_a_loc=999 em_d_loc=0 features2=0x0 is_spcall=1 ignores_dtmf=0 avgsid=
Timed: 13/07/21 17:16
17:16:04 2568354mS H323Evt: PortmAvayaH323Phone::portmAvayaH323PhoneDelay: 1001 - delay disabled
17:16:04 2568354mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:16:04 2568357mS CMMap: PCGS CPReserveCodec (pcp[236]b0r1) true
17:16:04 2568357mS CMMap: PCGS CPReserveCodec for the other end (pcp[237]b0r1) true
17:16:04 2568357mS CMMap: PCGS CPReserveCodec (pcp[236]b0r1) true
17:16:04 2568357mS CMMap: PCGS CPReserveCodec for the other end (pcp[237]b0r1) true
17:16:04 2568357mS CMMap: PCG::MapBChan pcp[236]b0r1 cp_b f56b46e0 other_cp_b f56b75d4 type CGTypeSimple
17:16:04 2568357mS CMMap: a=0.1 b=0.17 M12
17:16:04 2568358mS PRN: RTCP collector is NOT initialized
17:16:04 2568358mS PRN: RTCP collector is NOT initialized
17:16:04 2568358mS PRN: RTCP collector is NOT initialized
17:16:04 2568359mS PRN: RTCP collector is NOT initialized
17:16:04 2568359mS CMMap: PCGS CPReserveCodec (pcp[237]b0r1) true
17:16:04 2568359mS CMMap: PCGS CPReserveCodec for the other end (pcp[236]b0r1) true
17:16:04 2568359mS CMMap: PCGS CPReserveCodec (pcp[237]b0r1) true
17:16:04 2568359mS CMMap: PCGS CPReserveCodec for the other end (pcp[236]b0r1) true
17:16:04 2568359mS CMMap: PCG::MapBChan pcp[237]b0r1 cp_b f56b75d4 other_cp_b f56b46e0 type CGTypeSimple
17:16:04 2568359mS CMMap: a=0.17 b=0.1 M12
17:16:04 2568360mS PRN: RTCP collector is NOT initialized
17:16:04 2568360mS PRN: RTCP collector is NOT initialized
17:16:04 2568360mS PRN: RTCP collector is NOT initialized
17:16:04 2568361mS PRN: RTCP collector is NOT initialized
17:16:08 2572027mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Feature Key Pressed 4:DCPLFeatureXfer
17:16:08 2572027mS CMExtnRx: v=1001, p1=0
CMTransfer
Line: type=IPLine 250 Call: lid=255 id=1133 in=0
17:16:08 2572030mS CMExtnTx: v=1001, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1133 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 13/07/21 17:16
17:16:08 2572031mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:16:08 2572031mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 1133->0 )
17:16:08 2572034mS CMLineTx: v=0
CMFacility
Line: type=SIPLine 17 Call: lid=17 id=1131 in=1
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
HoldNotific.Invoke.CodePageISO8859-1
invokeId 14671
17:16:08 2572037mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Connected,0,0,Agent 2
17:16:08 2572037mS CMCallEvt: 0000000000000000 0.1134.0 -1 BaseEP: NEW CMEndpoint f187e850 TOTAL NOW=3 CALL_LIST=1
17:16:08 2572037mS CMCallEvt: 0000000000000000 0.1134.0 -1 Agent 2.-1: NEW CMExtnEndpoint f187e850, Name=Agent 2, Extn=1001, Phys Extn=1001
17:16:08 2572038mS CMCallEvt: CREATE CALL:46 (f18bdc4c)
17:16:08 2572038mS CMCallEvt: 0000000000000000 0.1135.0 -1 BaseEP: NEW CMEndpoint f18bc0fc TOTAL NOW=4 CALL_LIST=1
17:16:08 2572040mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 0->1134 )
17:16:08 2572040mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,Agent 2
17:16:08 2572042mS CMExtnRx: v=1001, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=255 id=1134 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[08173228292@192.168.1.200] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 10 item(s)
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=08173228292
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Agent 2
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Agent 2
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1001
IE CMIEDeviceDetail (231) c0a801c80000046e LOCALE=eng HW=15 VER=10 class=CMDeviceH323Phone type=88 number=8004 channel=0 features=0x10000400 rx_gain=32 tx_gain=32
ep_callid=1134 ipaddr=192.168.1.200 apps=0 loc=999 em_a_loc=0 em_d_loc=0 features2=0x20 is_spcall=1 ignores_dtmf=1 avgsid=
IE CMIEMohSourceId (247) MOH Source = 1
Locale: eng
17:16:08 2572042mS CMCallEvt: c0a801c80000046e 255.1134.0 46 Agent 2.1: StateChange: END=A CMCSIdle->CMCSDialInitiated
17:16:08 2572042mS CMExtnEvt: v=1 State, new=Dialling old=Idle,0,0,Agent 2
17:16:08 2572042mS CMTARGET: c0a801c80000046e 255.1134.0 46 Agent 2.1: LOOKUP CALL ROUTE: GID=0 type=100 called_party= sub= calling=08173228292@192.168.1.200 calling_sub= dir=out complete=0 ses=0
17:16:08 2572043mS CMTARGET: c0a801c80000046e 255.1134.0 46 Agent 2.1: ADD TARGET (N): number= type=100 depth=1 nobar=0 setorig=1 ses=0
17:16:08 2572043mS CMCallEvt: c0a801c80000046e 255.1134.0 46 Agent 2.1: StateChange: END=A CMCSDialInitiated->CMCSDialling
17:16:08 2572045mS CMMap: IP::SetCodec pcp[238]b0r0 0 -> f566fd08
17:16:08 2572046mS CMExtnTx: v=1001, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1134 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
Timed: 13/07/21 17:16
17:16:08 2572046mS H323Evt: PortmAvayaH323Phone::portmAvayaH323PhoneDelay: 1001 - delay disabled
17:16:08 2572046mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:16:08 2572047mS CMExtnTx: v=1001, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=255 id=1134 in=0
Timed: 13/07/21 17:16
17:16:08 2572048mS CMMap: PCGS CPReserveCodec (pcp[236]b0r1) true
17:16:08 2572049mS CMMap: PCGS CPReserveCodec for the other end (pcp[237]b0r1) true
17:16:08 2572049mS CMMap: PCG::UnmapBChan pcp[236]b0r1 cp_b f56b46e0 other_cp_b f56b75d4
17:16:08 2572049mS CMMap: a=0.1 b=0.17 M02
17:16:08 2572049mS H323Evt: SESS 3c SetOperational local 192.168.1.200:49154 remote 192.168.1.225:16384 to 0
17:16:08 2572049mS H323Evt: SESS 3b SetOperational local 192.168.1.200:49152 remote 192.168.1.204:50736 to 0
17:16:08 2572049mS CMMap: PCG::UnmapBChan pcp[237]b0r1 cp_b 0 other_cp_b 0
17:16:08 2572049mS CMMap: PCG::AddToneGenerator g H1[8] for cp[236]b0r1 append pcp[239]b0r1 (total 1)
17:16:08 2572050mS CMMap: a=0.2 b=0.0 IP::ReserveCodec pcp[239]b0r1 allocated CMRTVocoder(f5670200) resource busy 3, total 32, codec type 4
17:16:08 2572050mS CMMap: a=0.2 b=0.0 H1
17:16:08 2572050mS CMMap: PlatformConnectionAudioSAP::Bind pcp[239]b0r1 to 0.2
17:16:08 2572050mS CMMap: PlatformConnectionAudioSAP::ConnectVoice (connect) pcp[239]b0r1 echo_cancellation set to 0
17:16:08 2572050mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[239]b0r1 Configure 0.2
17:16:08 2572050mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[239]b0r1 ConnectIndication 0.2
17:16:08 2572050mS PRN: RTCP collector is NOT initialized
17:16:08 2572051mS CMMap: a=0.0 b=0.0 pcp[236]b0r1 RTPH1
17:16:08 2572051mS PRN: rtpRelayFilter close rc: 0 rtpRelayId: 1
17:16:08 2572051mS CMMap: PlatformConnectionAudioSAP::DisconnectRtpFilter rtpRelayId: 1 Close success
17:16:08 2572051mS H323Evt: SESS 3c SetOperational local 192.168.1.200:49154 remote 192.168.1.225:16384 to 1
17:16:08 2572051mS PRN: rtpRelayFilter close rc: 0 rtpRelayId: 2
17:16:08 2572052mS CMMap: PlatformConnectionAudioSAP::DisconnectRtpFilter rtpRelayId: 2 Close success
17:16:08 2572052mS H323Evt: SESS 3d SetOperational local 192.168.1.200:0 remote 0.0.0.0:0 to 0
17:16:08 2572052mS H323Evt: SESS 3d Configure: Alaw64K packet size 160
17:16:08 2572052mS H323Evt: SESS 3d SetRemUDP 0 -> 50736, remote IP 0.0.0.0 -> 192.168.1.204
17:16:08 2572052mS CMMap: PCG::AddToneGenerator g D1[1] for cp[238]b0r1 append pcp[240]b0r1 (total 1)
17:16:08 2572053mS CMMap: PlatformConnectionAudioSAP::Bind pcp[240]b0r1 to 0.0
17:16:08 2572053mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[240]b0r1 Configure 0.0
17:16:08 2572053mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[240]b0r1 ConnectIndication 0.0
17:16:08 2572053mS CMMap: a=0.0 b=0.0 pcp[238]b0r1 RTPD1
17:16:08 2572053mS H323Evt: SESS 3d SetOperational local 192.168.1.200:49156 remote 192.168.1.204:50736 to 1
17:16:08 2572463mS RES: Tue 13/7/2021 17:16:08 FreeMem=61698648 Heap=61361368(3) Cache=337280 MemObjs=7891(Max 8356) CMMsg=6(6) ASN=0 Buff=5200 1356 1000 7420 5 Links=51865(51962) BTree=445(596) CB=6044 CPU=05.47% CPUStats=04.97%/1/3/4822/19369/22224/
00.70%/0/02.90% MCR=0 MCW=0 DEV=0
17:16:08 2572463mS RES2: IP 500 V2 10.1.0.8.0 build 3 Tasks=51 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=10+58 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=6 OFF=0) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
17:16:08 2572463mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:16:08 2572464mS RES5: CLog MemObjs=65 FreePoolMem(Objs)=1820(35) TotalMem=5200 StringsTotalMem=103600
17:16:09 2573160mS H323Evt: SESS 3c: RTP(50t): 192.168.1.200/49154 192.168.1.225/16384 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=4830 SENT=225 (avg size=160) RECV=239 (avg size=160)
17:16:09 2573212mS H323Evt: SESS 3d: RTP(50r): 192.168.1.200/49156 192.168.1.204/50736 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=1160 SENT=58 (avg size=164) RECV=50 (avg size=160)

********** SysMonitor v10.1.0.8.0 build 3 [connected to 192.168.1.200 (00E0070DFA29)] **********
17:16:10 2574211mS PRN: Monitor Status IP 500 V2 10.1.0.8.0 build 3
17:16:10 2574211mS PRN: LAW=A PRI=1, BRI=0, ALOG=0, VCOMP=32, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=3 TYP=1) 1-X=0 CALLS=2(TOT=46)
17:16:10 2574644mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: DSS Key Pressed 17
17:16:10 2574645mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,Agent 2: DSS SC Dial Key Pressed 16
17:16:10 2574647mS CMExtnTx: v=1001, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1134 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 13/07/21 17:16
17:16:10 2574647mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:16:10 2574647mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 1134->0 )
17:16:10 2574648mS CMCallEvt: c0a801c80000046e 255.1134.0 46 Agent 2.1: StateChange: END=A CMCSDialling->CMCSCompleted
17:16:10 2574649mS CMLOGGING: CALL:2021/07/1317:16,00:00:00,000,08173228292@192.168.1.200,O,,,Agent2,,,1,,"",0,n/a
17:16:10 2574649mS CMExtnEvt: Agent 2: CALL LOST (CMCauseNormal)
17:16:10 2574649mS CMExtnEvt: Agent 2: Extn(1001) Calling Party Number(08173228292@192.168.1.200) Type(CMNTypeUnknown)
17:16:10 2574649mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Dialling,0,0,Agent 2
17:16:10 2574650mS CMCallEvt: c0a801c80000046e 255.1134.0 -1 Agent 2.-1: StateChange: END=X CMCSCompleted->CMCSDelete
17:16:10 2574650mS CMCallEvt: 0000000000000000 0.1135.0 -1 BaseEP: DELETE CMEndpoint f18bc0fc TOTAL NOW=3 CALL_LIST=1
17:16:10 2574651mS CMCallEvt: END CALL:46 (f18bdc4c)
17:16:10 2574652mS CMTARGET: c0a801c80000046e 255.1134.0 -1 BaseEP: ~CMTargetHandler f18a1d1c ep f187e850
17:16:10 2574652mS CMCallEvt: c0a801c80000046e 255.1134.0 -1 BaseEP: DELETE CMEndpoint f187e850 TOTAL NOW=2 CALL_LIST=1
17:16:10 2574652mS CMCallEvt: 0000000000000000 0.1136.0 -1 BaseEP: NEW CMEndpoint f187e850 TOTAL NOW=3 CALL_LIST=1
17:16:10 2574652mS CMCallEvt: 0000000000000000 0.1136.0 -1 Agent 2.-1: NEW CMExtnEndpoint f187e850, Name=Agent 2, Extn=1001, Phys Extn=1001
17:16:10 2574653mS CMCallEvt: CREATE CALL:47 (f18bdc4c)
17:16:10 2574653mS CMCallEvt: 0000000000000000 0.1137.0 -1 BaseEP: NEW CMEndpoint f18bc0fc TOTAL NOW=4 CALL_LIST=1
17:16:10 2574655mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 0->1136 )
17:16:10 2574655mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,Agent 2
17:16:10 2574657mS CMExtnRx: v=1001, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[08173228292@192.168.1.200] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 10 item(s)
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=08173228292
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=08173228292
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Agent 2
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Agent 2
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=1001
IE CMIEDeviceDetail (231) c0a801c800000470 LOCALE=eng HW=15 VER=10 class=CMDeviceH323Phone type=88 number=8004 channel=0 features=0x10000400 rx_gain=32 tx_gain=32
ep_callid=1136 ipaddr=192.168.1.200 apps=0 loc=999 em_a_loc=0 em_d_loc=0 features2=0x20 is_spcall=1 ignores_dtmf=1 avgsid=
IE CMIEMohSourceId (247) MOH Source = 1
Locale: eng
17:16:10 2574657mS CMCallEvt: c0a801c800000470 255.1136.0 47 Agent 2.1: StateChange: END=A CMCSIdle->CMCSDialInitiated
17:16:10 2574657mS CMExtnEvt: v=1 State, new=Dialling old=Idle,0,0,Agent 2
17:16:10 2574657mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: LOOKUP CALL ROUTE: GID=0 type=100 called_party= sub= calling=08173228292@192.168.1.200 calling_sub= dir=out complete=0 ses=0
17:16:10 2574657mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: ADD TARGET (N): number= type=100 depth=1 nobar=0 setorig=1 ses=0
17:16:10 2574658mS CMCallEvt: c0a801c800000470 255.1136.0 47 Agent 2.1: StateChange: END=A CMCSDialInitiated->CMCSDialling
17:16:10 2574660mS CMMap: IP::SetCodec pcp[241]b0r0 0 -> f566fd08
17:16:10 2574661mS CMExtnTx: v=1001, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 4)
}
Timed: 13/07/21 17:16
17:16:10 2574661mS H323Evt: PortmAvayaH323Phone::portmAvayaH323PhoneDelay: 1001 - delay disabled
17:16:10 2574661mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:16:10 2574662mS CMExtnTx: v=1001, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Timed: 13/07/21 17:16
17:16:10 2574662mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed w
17:16:10 2574665mS H323Evt: SESS 3e SetOperational local 192.168.1.200:0 remote 0.0.0.0:0 to 0
17:16:10 2574665mS H323Evt: SESS 3e Configure: Alaw64K packet size 160
17:16:10 2574665mS H323Evt: SESS 3e SetRemUDP 0 -> 50736, remote IP 0.0.0.0 -> 192.168.1.204
17:16:10 2574665mS CMMap: a=0.0 b=0.0 pcp[241]b0r1 RTPD1
17:16:10 2574665mS H323Evt: SESS 3e SetOperational local 192.168.1.200:49158 remote 192.168.1.204:50736 to 1
17:16:10 2574666mS CMMap: a=0.0 b=0.0 pcp[238]b0r1 RTPD0
17:16:10 2574666mS H323Evt: SESS 3d SetOperational local 192.168.1.200:49156 remote 192.168.1.204:50736 to 0
17:16:10 2574666mS H323Evt: SESS 3d: RTP(END): 192.168.1.200/49156 192.168.1.204/50736 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=2614 SENT=130 RECV=122 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
17:16:11 2575802mS H323Evt: SESS 3e: RTP(50r): 192.168.1.200/49158 192.168.1.204/50736 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=1137 SENT=57 (avg size=164) RECV=50 (avg size=160)
17:16:12 2576242mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 0
17:16:12 2576242mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
17:16:12 2576245mS CMMap: a=0.0 b=0.0 pcp[241]b0r1 RTPD0
17:16:12 2576245mS H323Evt: SESS 3e SetOperational local 192.168.1.200:49158 remote 192.168.1.204:50736 to 0
17:16:12 2576404mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 8
17:16:12 2576404mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[8] Type=Default (100) Reason=CMDRdirect Keypad[8]
17:16:12 2576565mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 0
17:16:12 2576565mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
17:16:12 2576726mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 3
17:16:12 2576726mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[3] Type=Default (100) Reason=CMDRdirect Keypad[3]
17:16:12 2576887mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 3
17:16:12 2576887mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[3] Type=Default (100) Reason=CMDRdirect Keypad[3]
17:16:13 2577048mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 0
17:16:13 2577048mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
17:16:13 2577209mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 6
17:16:13 2577209mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
17:16:13 2577370mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 4
17:16:13 2577370mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[4] Type=Default (100) Reason=CMDRdirect Keypad[4]
17:16:13 2577531mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 6
17:16:13 2577531mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
17:16:13 2577692mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 2
17:16:13 2577692mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
17:16:13 2577759mS H323Evt: Recv: RegistrationRequest 192.168.1.203; Extn(1000), time since last RRQ-KA 55003, Endpoints registered: 2; Endpoints in registration: 0
17:16:13 2577853mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,1001: Digit Key Pressed 9
17:16:13 2577853mS CMExtnRx: v=1001, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
17:16:13 2577854mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: CancelTimer CMTCDelayedProcessing
17:16:13 2577854mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: LOOKUP CALL ROUTE: GID=0 type=100 called_party=08033064629 sub= calling=08173228292@192.168.1.200 calling_sub= dir=out complete=0 ses=0
17:16:13 2577854mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: ADD TARGET (N): number=08033064629 type=100 depth=1 nobar=0 setorig=1 ses=0
17:16:13 2577855mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: DEF SC: 08033064629 0 sc=type=Dial code=?, num=.
17:16:13 2577855mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: CancelTimer CMTCDialToneTimeout
17:16:13 2577855mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: NO INITIAL TARGETS: ??
17:16:13 2577855mS CMTARGET: c0a801c800000470 255.1136.0 47 Agent 2.1: Fallback() targeting failed
17:16:13 2577856mS CMLOGGING: CALL:2021/07/1317:16,00:00:00,000,08173228292@192.168.1.200,O,08033064629,08033064629,Agent2,,,1,,"",0,n/a
17:16:13 2577856mS CMExtnEvt: Agent 2: CALL LOST (CMCauseBusy)
17:16:13 2577856mS CMExtnEvt: Agent 2: Extn(1001) Calling Party Number(08173228292@192.168.1.200) Type(CMNTypeUnknown)
17:16:13 2577857mS CMCallEvt: c0a801c800000470 255.1136.0 -1 Agent 2.1: StateChange: END=X CMCSDialling->CMCSCompletedTone
17:16:13 2577857mS CMExtnEvt: v=1 State, new=CMESCompleted old=Dialling,0,0,Agent 2
17:16:13 2577858mS CMCallEvt: 0000000000000000 0.1137.0 -1 BaseEP: DELETE CMEndpoint f18bc0fc TOTAL NOW=3 CALL_LIST=1
17:16:13 2577858mS CMCallEvt: END CALL:47 (f18bdc4c)
17:16:13 2577860mS CMMap: PCG::AddToneGenerator g B1[4] for cp[241]b0r1 append pcp[242]b0r1 (total 1)
17:16:13 2577860mS CMMap: PlatformConnectionAudioSAP::Bind pcp[242]b0r1 to 0.0
17:16:13 2577860mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[242]b0r1 Configure 0.0
17:16:13 2577861mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[242]b0r1 ConnectIndication 0.0
17:16:13 2577861mS CMMap: a=0.0 b=0.0 pcp[241]b0r1 RTPB1
17:16:13 2577861mS H323Evt: SESS 3e SetOperational local 192.168.1.200:49158 remote 192.168.1.204:50736 to 1
17:16:13 2577871mS RES: Tue 13/7/2021 17:16:14 FreeMem=61748220 Heap=61394204(3) Cache=354016 MemObjs=7762(Max 8356) CMMsg=6(6) ASN=0 Buff=5200 1355 1000 7420 5 Links=51835(51962) BTree=452(596) CB=6044 CPU=05.52% CPUStats=04.91%/6/11/4822/18931/22224
/00.86%/0/02.50% MCR=0 MCW=0 DEV=0
17:16:13 2577871mS RES2: IP 500 V2 10.1.0.8.0 build 3 Tasks=51 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=12+58 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=6 OFF=0) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
17:16:13 2577871mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:16:13 2577871mS RES5: CLog MemObjs=65 FreePoolMem(Objs)=1820(35) TotalMem=5200 StringsTotalMem=103600
17:16:19 2582506mS R2DSP: PRIU DSP 1: is alive
17:16:20 2583453mS SIP Rx: UDP 192.168.1.225:5060 -> 192.168.1.200:5060


17:16:21 2584581mS PRN: Optimizing BTree Lists Completed...Started:2584581 Duration:0 Size:76 Attempted:76
17:16:21 2585551mS CMExtnRx: v=1001, p1=0
CMTransferComplete
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
17:16:21 2585551mS CMExtnTx: v=1001, p1=8004
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
17:16:21 2585551mS CMExtnRx: v=1001, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
17:16:21 2585551mS CMCallEvt: c0a801c800000470 255.1136.0 -1 Agent 2.1: StateChange: END=X CMCSCompletedTone->CMCSCompleted
17:16:21 2585553mS CMExtnTx: v=1001, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=255 id=1136 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 13/07/21 17:16
17:16:21 2585553mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=CMESCompleted,0,0,Agent 2
17:16:21 2585553mS CMExtnEvt: Agent 2: CALL LOST (CMCauseForceClear)
17:16:21 2585553mS CMExtnEvt: Agent 2: Extn(1001) Calling Party Number(08173228292@192.168.1.200) Type(CMNTypeUnknown)
17:16:21 2585553mS CMExtnEvt: Agent 2: CMExtnHandler::SetCurrent( id: 1136->0 )
17:16:21 2585554mS CMCallEvt: c0a801c800000470 255.1136.0 -1 Agent 2.-1: StateChange: END=X CMCSCompleted->CMCSDelete
17:16:21 2585555mS CMTARGET: c0a801c800000470 255.1136.0 -1 BaseEP: ~CMTargetHandler f18a1d1c ep f187e850
17:16:21 2585555mS CMCallEvt: c0a801c800000470 255.1136.0 -1 BaseEP: DELETE CMEndpoint f187e850 TOTAL NOW=2 CALL_LIST=1
17:16:21 2585556mS CMMap: a=0.0 b=0.0 pcp[241]b0r1 RTPB0
17:16:21 2585557mS H323Evt: SESS 3e SetOperational local 192.168.1.200:49158 remote 192.168.1.204:50736 to 0
17:16:21 2585557mS H323Evt: SESS 3e: RTP(END): 192.168.1.200/49158 192.168.1.204/50736 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=10892 SENT=463 RECV=455 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
17:16:21 2585874mS RES: Tue 13/7/2021 17:16:21 FreeMem=61773632 Heap=61394232(3) Cache=379400 MemObjs=7632(Max 8356) CMMsg=6(6) ASN=0 Buff=5200 1356 1000 7420 5 Links=51795(51962) BTree=452(596) CB=6048 CPU=05.03% CPUStats=05.49%/6/12/4822/18877/22224
/00.90%/0/02.47% MCR=0 MCW=0 DEV=0
17:16:21 2585874mS RES2: IP 500 V2 10.1.0.8.0 build 3 Tasks=51 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=10+56 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=1 TCP=23(TLS=6 OFF=0) TAPI=0 Partner=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
17:16:21 2585874mS RES4: XML MemObjs=8 PoolMem=4748404(2) FreeMem=4736284(0) HeapUsed=0
17:16:21 2585874mS RES5: CLog MemObjs=65 FreePoolMem(Objs)=1820(35) TotalMem=5200 StringsTotalMem=103600

********** SysMonitor v10.1.0.8.0 build 3 [connected to 192.168.1.200 (00E0070DFA29)] **********
17:16:22 2586193mS PRN: Monitor Status IP 500 V2 10.1.0.8.0 build 3
17:16:22 2586193mS PRN: LAW=A PRI=1, BRI=0, ALOG=0, VCOMP=32, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=3 TYP=1) 1-X=0 CALLS=1(TOT=47)
17:16:23 2587554mS CMExtnEvt: Agent 2: Recover Timer reason=CMTRWrapUp
17:16:23 2587554mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,Agent 2
17:16:23 2587555mS CMExtnTx: v=1001, p1=0
CMVoiceMailStatus
Line: type=IPLine 250 Call: lid=0 id=-1 in=0
Called[Agent 2 Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Agent 2 Msgs=0]
Timed: 13/07/21 17:16

********** Warning: Logging to Screen Stopped **********
 
Sort by date Sort by votes
Dear All , issue is resolved now . Its was the inhibit switch transfer on the user that caused.
 
Upvote 0 Downvote
Thank you for answering your own question, this may help others in future

It also gos to demonstrate the first principle of diagnosis - the cause is going to be something basic & simple, if you cant see it you are probably looking to deep


Do things on the cheap & it will cost you dear
 
Upvote 0 Downvote
Status
Not open for further replies.

Similar threads

bgmmgj
  • Locked
  • Question
Antivirus/XDR on IP Office Server Edition
Replies
3
Views
359
nnaarrnn
nnaarrnn
AvayaRed
IP Office KB Retirement 1
Replies
4
Views
559
Westi
Westi
rcc1000
  • Question
SCN IP Office Line 9.1.6.0
Replies
7
Views
203
rcc1000
rcc1000
BBIPTS
  • Locked
  • Question
IP Office v12.0 9608G Problem
Replies
2
Views
378
sizbut
sizbut
A
  • Locked
  • Question
Connecting 2 IP Office together
Replies
9
Views
664
derfloh
derfloh

Part and Inventory Search

Sponsor

Back
Top