Guilherme1000
Technical User
Hello,
Could you help me with this one?
I have an IP Office V2 connected to an Audiocodes FXS to SIP Trunk. When I receive a call coming from the E1, I hang up on my fxs and try to do a transfer. The other FXS answers normally but when I try to finish the transfer the call drops.
I receive 503. service unavailable from the IP Office.
10:28:02 1100963550mS PRN: Updates IO list size 1 updated list size 1
10:28:02 1100963550mS PRN: Sending Updates out to f49e58e0 started
10:28:02 1100963550mS PRN: Sending Updates out to f49e58e0 finished
10:28:02 1100963551mS PRN: Config Write Completed
10:28:02 1100963595mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
INVITE sip:07182228525@172.8.4.250:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844108124
Max-Forwards: 70
From: <sip:6083@172.8.4.101>;tag=1c831449231
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 INVITE
Contact: <sip:6083@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Type: application/sdp
Content-Length: 201
v=0
o=AudiocodesGW 831481056 831480976 IN IP4 172.8.4.101
s=Phone-Call
c=IN IP4 0.0.0.0
t=0 0
m=audio 6150 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=ptime:20
a=inactive
a=rtcp:6151 IN IP4 172.8.4.101
10:28:02 1100963601mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844108124
From: <sip:6083@172.8.4.101>;tag=1c831449231
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Content-Length: 0
10:28:02 1100963609mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844108124
From: <sip:6083@172.8.4.101>;tag=1c831449231
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 INVITE
Contact: "Anonymous" <sip:07182228525@172.8.4.250:5060;transport=udp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Content-Type: application/sdp
Content-Length: 156
v=0
o=UserA 2221736179 31913132 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49168 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=inactive
10:28:02 1100963612mS CMMap: PCG::UnmapBChan pcp[105]b1r0 cp_b f54408d0 other_cp_b f548b820
10:28:02 1100963612mS CMMap: a=0.19 b=1.19 M02
10:28:02 1100963612mS H323Evt: SetOperational 13930 172.8.4.250:49168 to 0
10:28:02 1100963612mS CMMap: PCG::UnmapBChan pcp[976]b0r1 cp_b 0 other_cp_b 0
10:28:02 1100963612mS CMMap: a=1.19 b=0.0 H1
10:28:02 1100963613mS CMMap: PlatformConnectionAudioSAP:
isconnectVoice rtpRelay ID: 3 Close success
10:28:02 1100963615mS CD: CALL: 1.30.1 BState=Connected Cut=1 Music=1.0 Aend="Line 1" (1.19) Bend="DDR 6083(6183)" [Line 19] (0.0) CalledNum=6083 (DDR 6083) CallingNum=07182228525 () Internal=0 Time=10204 AState=Connected
10:28:02 1100963645mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
ACK sip:07182228525@172.8.4.250:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844176016
Max-Forwards: 70
From: <sip:6083@172.8.4.101>;tag=1c831449231
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 ACK
Contact: <sip:6083@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:03 1100964152mS RES: Mon 6/7/2015 10:28:02 FreeMem=48536860 46902612(1) CachedMem=1634248 CMMsg=8(8) Buff=5200 1364 1000 7430 5 Links=31222 BTree=12890 CPU=08.51% CPUStats=15/22/4048/15211/20319/2/0 MCR=0 MCW=0
10:28:03 1100964153mS RES2: IP 500 V2 9.0.0.0 build 829 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=123 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=26(TLS=4) TAPI=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:28:03 1100964153mS RES4: XML MemObjs=56 PoolMem=3145765(2) FreeMem=3130377(2)
10:28:03 1100964445mS SIP Rx: UDP 172.8.4.64:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.64:5060;branch=z9hG4bK-195e3069
From: "Antonio/Andre" <sip:6064@172.8.4.250>;tag=296680066b564566o0
To: "Antonio/Andre" <sip:6064@172.8.4.250>
Call-ID: bb3b9cc5-7d2a36ea@172.8.4.64
CSeq: 71889 REGISTER
Max-Forwards: 70
Authorization: Digest username="6064",realm="ipoffice",nonce="8bf1faa3e5c35120f4f3",uri="sip:172.8.4.250",algorithm=MD5,response="424b7ce42227aa2b7c72c70398bef67f"
Contact: "Antonio/Andre" <sip:6064@172.8.4.64:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:03 1100964450mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.64:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.64:5060;branch=z9hG4bK-195e3069
From: "Antonio/Andre" <sip:6064@172.8.4.250>;tag=296680066b564566o0
Call-ID: bb3b9cc5-7d2a36ea@172.8.4.64
CSeq: 71889 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6064@172.8.4.64:5060>
Date: Mon, 06 Jul 2015 13:28:03 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Antonio/Andre" <sip:6064@172.8.4.250>;tag=0f875b4f219553b9
Content-Length: 0
10:28:03 1100964833mS SIP Rx: UDP 172.8.4.12:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.12:5060;branch=z9hG4bK-776d0b49
From: "Renata Janaina" <sip:6012@172.8.4.250>;tag=8752fba5ffef6634o0
To: "Renata Janaina" <sip:6012@172.8.4.250>
Call-ID: e13faefa-422bc214@172.8.4.12
CSeq: 38914 REGISTER
Max-Forwards: 70
Authorization: Digest username="6012",realm="ipoffice",nonce="a545febc6a5e738bbbcd",uri="sip:172.8.4.250",algorithm=MD5,response="89e5df00c9850eba88f66ec240e5e2f5"
Contact: "Renata Janaina" <sip:6012@172.8.4.12:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:03 1100964837mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.12:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.12:5060;branch=z9hG4bK-776d0b49
From: "Renata Janaina" <sip:6012@172.8.4.250>;tag=8752fba5ffef6634o0
Call-ID: e13faefa-422bc214@172.8.4.12
CSeq: 38914 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6012@172.8.4.12:5060>
Date: Mon, 06 Jul 2015 13:28:03 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Renata Janaina" <sip:6012@172.8.4.250>;tag=4e48d68134502e80
Content-Length: 0
10:28:04 1100965573mS SIP Rx: UDP 172.8.4.89:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.89:5060;branch=z9hG4bK-808198ee
From: "Fabiano Mehmeri" <sip:6089@172.8.4.250>;tag=8532101fab41cc79o0
To: "Fabiano Mehmeri" <sip:6089@172.8.4.250>
Call-ID: 754cc9e6-45218495@172.8.4.89
CSeq: 61892 REGISTER
Max-Forwards: 70
Authorization: Digest username="6089",realm="ipoffice",nonce="e6ac6074d1baa9da3608",uri="sip:172.8.4.250",algorithm=MD5,response="6e66dd443f6d3f0a4796b5b52d745c22"
Contact: "Fabiano Mehmeri" <sip:6089@172.8.4.89:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:04 1100965577mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.89:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.89:5060;branch=z9hG4bK-808198ee
From: "Fabiano Mehmeri" <sip:6089@172.8.4.250>;tag=8532101fab41cc79o0
Call-ID: 754cc9e6-45218495@172.8.4.89
CSeq: 61892 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6089@172.8.4.89:5060>
Date: Mon, 06 Jul 2015 13:28:04 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Fabiano Mehmeri" <sip:6089@172.8.4.250>;tag=c6457f9ccff5c5ee
Content-Length: 0
10:28:05 1100966319mS H323Evt: Recv: RegistrationRequest 172.8.4.8; Endpoints registered: 4; Endpoints in registration: 0
10:28:05 1100966395mS SIP Rx: UDP 172.8.4.61:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.61:5060;branch=z9hG4bK-31b3d439
From: "Raimundo Trindade" <sip:6061@172.8.4.250>;tag=ee0fc614e5b0068ao0
To: "Raimundo Trindade" <sip:6061@172.8.4.250>
Call-ID: 2605df0a-bb54d13a@172.8.4.61
CSeq: 26394 REGISTER
Max-Forwards: 70
Authorization: Digest username="6061",realm="ipoffice",nonce="1de7845505e53f987eef",uri="sip:172.8.4.250",algorithm=MD5,response="4448099fca9800c99b5d6708eab357f5"
Contact: "Raimundo Trindade" <sip:6061@172.8.4.61:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:05 1100966399mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.61:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.61:5060;branch=z9hG4bK-31b3d439
From: "Raimundo Trindade" <sip:6061@172.8.4.250>;tag=ee0fc614e5b0068ao0
Call-ID: 2605df0a-bb54d13a@172.8.4.61
CSeq: 26394 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6061@172.8.4.61:5060>
Date: Mon, 06 Jul 2015 13:28:04 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Raimundo Trindade" <sip:6061@172.8.4.250>;tag=6345fd824b76199c
Content-Length: 0
10:28:06 1100967946mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
10:28:06 1100967947mS CMExtnRx: v=RAS, p1=0
CMTransfer
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[6200] Type=Default (100) Reason=CMDRdirect SndComp
10:28:06 1100967947mS CMCallEvt: 0.99163.0 22915 RAS.0: Transfer CMCauseTransfer
10:28:06 1100967947mS CD: CALL: 1.25.1 BState=Connected Cut=3 Music=0.0 Aend="Line 1" (1.16) Bend="URA(URA)" [VoiceMail] (21.11) CalledNum=URA () CallingNum=07133594218 () Internal=0 Time=38790 AState=Connected
10:28:06 1100967947mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD TARGET (N): number=6200 type=100 depth=1 nobar=1 setorig=1 ses=0
10:28:06 1100967947mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: HG(Atendimento,6200,172.8.4.250) Requires Routing To Master(1). IsLocalExecutive(1)
10:28:06 1100967947mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: HG call targeting occuring here
10:28:06 1100967948mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: PrimeForHGTarget: Atendimento setorig=1 recall=0 resetExtnVars 1
10:28:06 1100967948mS CMCallEvt: Priority hike: call 22915 priority 1->5
10:28:06 1100967948mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTarget Atendimento (depth=1) allowq=1 type=CMNTypeDefault
10:28:06 1100967948mS CMCallEvt: 0.99171.0 -1 BaseEP: NEW CMEndpoint f491a2f0 TOTAL NOW=18 CALL_LIST=8
10:28:06 1100967948mS CMTARGET: FoundKnownSystemTargets ICR cache hit
10:28:06 1100967949mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: PrepareTransferTargets Found 1 target
10:28:06 1100967949mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: GetNoAnswerTimer:15
10:28:06 1100967949mS CMCallEvt: 0.99172.0 -1 BaseEP: NEW CMEndpoint f47ce9d0 TOTAL NOW=19 CALL_LIST=8
10:28:06 1100967951mS CMExtnEvt: RAS: CALL LOST (CMCauseTransfer)
10:28:06 1100967951mS CMCallEvt: 0.99163.0 -1 RAS.0: StateChange: END=X CMCSConnected->CMCSCompleted
10:28:06 1100967951mS CMExtnEvt: v=1012 State, new=PortRecoverDelay old=Connected,0,0,RAS
10:28:06 1100967951mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1012 in=0
Called[URA] Type=Voicemail (102) Reason=CMDRX_Attendant Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=11
Cause=126, Transfer(IPO)
10:28:06 1100967952mS CMMap: a=21.11 b=0.0 T0
10:28:06 1100967953mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 99163->0 )
10:28:06 1100967953mS CMCallEvt: 0.99163.0 -1 RAS.-1: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:06 1100967953mS CMExtnEvt: v=1012 State, new=Idle old=PortRecoverDelay,0,0,RAS
10:28:06 1100967954mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1012 in=0
BChan: slot=21 chan=11
Cause=126, Transfer(IPO)
10:28:06 1100967954mS CMCallEvt: 0.99172.0 22915 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:28:06 1100967955mS CMCallEvt: 0.99171.0 22915 ACDTep(Atendimento): StateChange: END=T CMCSIdle->CMCSOffering
10:28:06 1100967955mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: CancelTimer CMTCNoAnswerTimeout
10:28:06 1100967955mS CMCallEvt: 0.99171.0 22915 ACDTep(Atendimento): StateChange: END=T CMCSOffering->CMCSRinging
10:28:06 1100967955mS CMCallEvt: 0.99172.0 22915 TargetingEP: StateChange: END=B CMCSOffering->CMCSRinging
10:28:06 1100967958mS CMCallEvt: 0.99163.0 -1 BaseEP: DELETE CMEndpoint f48891d0 TOTAL NOW=18 CALL_LIST=8
10:28:06 1100967959mS CMMap: PCG::UnmapBChan pcp[45]b1r0 cp_b f5481f78 other_cp_b f5440f40
10:28:06 1100967959mS CMMap: a=1.16 b=21.11 M02
10:28:06 1100967960mS CMMap: PCG::UnmapBChan pcp[103]b1r0 cp_b f5440f40 other_cp_b 0
10:28:06 1100967960mS CMMap: a=1.16 b=0.0 R1
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: PrimeForHGTarget: Atendimento setorig=0 recall=0 resetExtnVars 0
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTarget Atendimento (depth=0) allowq=0 type=CMNTypeDefault
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTargetRingRotary(Sequential) Atendimento ring_attempt_count 0 index 0
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD USER: DDR 6046 depth=1 disallow_cw=1 dnd=0 real_call=1 group_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x34), allow_redir(1) remote=00000000 simult 0 (0)
10:28:06 1100967963mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD TARGET (N): number=6046 type=100 depth=2 nobar=1 setorig=0 ses=0
10:28:06 1100967963mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: SYS SC: 6046 4 sc=type=Dial code=6046, num=6046 callinfop->sending_complete=1 secondary_dialtone=
10:28:06 1100967963mS CMARS: FindActiveARSByGroupID GroupID=101 - Not Found
10:28:06 1100967964mS CMLRQ: FindActiveLRQByGroupID GroupID=101 - Not Found
10:28:06 1100967964mS CMMap: a=0.17 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 8, total 32
10:28:06 1100967965mS CMCallEvt: 0.99173.0 -1 BaseEP: NEW CMEndpoint f490a7d0 TOTAL NOW=19 CALL_LIST=8
10:28:06 1100967965mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:06 1100967967mS CMTARGET: DIAL LINE: 22915 GROUP = 101 SUCCESS = f490a7d0
10:28:06 1100967968mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: SelectTargetAvailable 1 targets
10:28:06 1100967968mS CMCallEvt: 19.99173.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
10:28:06 1100967970mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99173 in=0
Called[6046] Type=Default (100) Reason=CMDRdirect SndComp Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECalledPartyName (224)(Type=CMNameDefault) name=DDR 6046
IE CMIERespondingPartyNumber (230)(P:0 S:3 T:2 N:1 R:4) number=07133594218
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceISDNTrunk type=0 number=1 channel=15 features=0x20 rx_gain=32 tx_gain=32 ep_callid=25 ipaddr=172.8.4.250 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIERedirectingPartyName (232)(Type=CMNameDefault) name=Atendimento
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEOriginalCalledPartyName (236)(Type=CMNameDefault) name=Atendimento
IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:4 N:1 R:4) number=34176000
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
UUI type=User2User [6200..] [0x36 0x32 0x30 0x30 0xff 0xff ]
Display [07133594218>Atendimento]
Timed: 06/07/15 10:28
Locale: ptb
10:28:06 1100967972mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6046@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 INVITE
Contact: "Anonymous" <sip:07133594218@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 297
v=0
o=UserA 1719714674 2147859453 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49160 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:06 1100967973mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: GetNoAnswerTimer:15
10:28:06 1100967974mS CD: CALL: 1.25.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.16) Bend="Line 19" [Line 19] (0.0) CalledNum=6200 (Atendimento) CallingNum=07133594218 () Internal=0 Time=38817 AState=Connected
10:28:07 1100968045mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>;tag=1c849639670
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:07 1100968048mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99173 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6046@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99173 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:07 1100968048mS CMCallEvt: 19.99173.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSOffering->CMCSAccept
10:28:07 1100968065mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 302 Moved Temporarily
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>;tag=1c849639670
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 INVITE
Contact: <sip:6001@172.8.4.250>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Diversion: <tel:6046>;reason=user-busy
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Reason: SIP ;cause=486 ;text="486 Busy Here"
Content-Length: 0
10:28:07 1100968069mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
ACK sip:6046@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>;tag=1c849639670
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 0
10:28:07 1100968072mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6001@172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKffd43471a9fa29c66648d30e9cd8533e
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6001@172.8.4.250>
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781511 INVITE
Contact: "Anonymous" <sip:07133594218@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Type: application/sdp
Content-Length: 297
v=0
o=UserA 1719714674 2147859453 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49160 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:07 1100968136mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKffd43471a9fa29c66648d30e9cd8533e
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6001@172.8.4.250>;tag=1c849753481
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781511 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Reason: Q.850 ;cause=3
Content-Length: 0
10:28:07 1100968140mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
ACK sip:6001@172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKffd43471a9fa29c66648d30e9cd8533e
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6001@172.8.4.250>;tag=1c849753481
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781511 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 0
10:28:07 1100968141mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 19 Call: lid=19 id=99173 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6001@172.8.4.250
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99173 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
Cause=178,
10:28:07 1100968141mS CMCallEvt: 19.99173.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSAccept->CMCSCompleted
10:28:07 1100968143mS CMCallEvt: 19.99173.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:07 1100968143mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AdjustNoAnswerTimer 10ms
10:28:07 1100968144mS CMCallEvt: 19.99173.0 -1 BaseEP: DELETE CMEndpoint f490a7d0 TOTAL NOW=18 CALL_LIST=8
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: TimerExpired cause=CMTCNoAnswerTimeout
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: Retarget NOANSWER EXCEPTED=0000000c ValidTargets=8
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: RetargetNoAnswer on HUNTGROUP=Atendimento. Ring Attempt 1
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTarget Atendimento (depth=1) allowq=0 type=CMNTypeDefault
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTargetRingRotary(Sequential) Atendimento ring_attempt_count 1 index 1
10:28:07 1100968154mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD USER: DDR 6047 depth=2 disallow_cw=1 dnd=0 real_call=1 group_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x34), allow_redir(1) remote=00000000 simult 0 (0)
10:28:07 1100968154mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD TARGET (N): number=6047 type=100 depth=3 nobar=1 setorig=0 ses=0
10:28:07 1100968155mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: SYS SC: 6047 4 sc=type=Dial code=6047, num=6047 callinfop->sending_complete=1 secondary_dialtone=
10:28:07 1100968155mS CMARS: FindActiveARSByGroupID GroupID=101 - Not Found
10:28:07 1100968155mS CMLRQ: FindActiveLRQByGroupID GroupID=101 - Not Found
10:28:07 1100968156mS CMCallEvt: 0.99174.0 -1 BaseEP: NEW CMEndpoint f490a7d0 TOTAL NOW=19 CALL_LIST=8
10:28:07 1100968157mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:07 1100968159mS CMTARGET: DIAL LINE: 22915 GROUP = 101 SUCCESS = f490a7d0
10:28:07 1100968160mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: GetNoAnswerTimer:15
10:28:07 1100968160mS CMCallEvt: 19.99174.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
10:28:07 1100968162mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99174 in=0
Called[6047] Type=Default (100) Reason=CMDRdirect SndComp Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECalledPartyName (224)(Type=CMNameDefault) name=DDR 6047
IE CMIERespondingPartyNumber (230)(P:0 S:3 T:2 N:1 R:4) number=07133594218
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceISDNTrunk type=0 number=1 channel=15 features=0x20 rx_gain=32 tx_gain=32 ep_callid=25 ipaddr=172.8.4.250 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIERedirectingPartyName (232)(Type=CMNameDefault) name=Atendimento
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEOriginalCalledPartyName (236)(Type=CMNameDefault) name=Atendimento
IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:4 N:1 R:4) number=34176000
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
UUI type=User2User [6200..] [0x36 0x32 0x30 0x30 0xff 0xff ]
Display [07133594218>Atendimento]
Timed: 06/07/15 10:28
Locale: ptb
10:28:07 1100968164mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6047@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKf295bbe3905a270201f3e8c61b8f80cb
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=44344ebadb7009f4
To: <sip:6047@172.8.4.101>
Call-ID: 9c14eaebde1ec6cfb109efb81a5be86c
CSeq: 8492412 INVITE
Contact: "Anonymous" <sip:07133594218@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 297
v=0
o=UserA 2996652209 2799076108 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49160 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:07 1100968165mS CD: CALL: 1.25.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.16) Bend="Line 19" [Line 19] (0.0) CalledNum=6200 (Atendimento) CallingNum=07133594218 () Internal=0 Time=39008 AState=Connected
10:28:07 1100968223mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKf295bbe3905a270201f3e8c61b8f80cb
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=44344ebadb7009f4
To: <sip:6047@172.8.4.101>;tag=1c849859734
Call-ID: 9c14eaebde1ec6cfb109efb81a5be86c
CSeq: 8492412 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:07 1100968226mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99174 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6047@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99174 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:07 1100968226mS CMCallEvt: 19.99174.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSOffering->CMCSAccept
10:28:07 1100968251mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKf295bbe3905a270201f3e8c61b8f80cb
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=44344ebadb7009f4
To: <sip:6047@172.8.4.101>;tag=1c849859734
Call-ID: 9c14eaebde1ec6cfb109efb81a5be86c
CSeq: 8492412 INVITE
Contact: <sip:6047@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:07 1100968254mS CMLineRx: v=0
CMAlerting
Line: type=SIPLine 19 Call: lid=19 id=99174 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6047@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99174 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:07 1100968254mS CMCallEvt: 19.99174.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSAccept->CMCSRinging
10:28:07 1100968264mS CD: CALL: 1.25.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.16) Bend="Line 19" [Line 19] (0.0) CalledNum=6200 (Atendimento) CallingNum=07133594218 () Internal=0 Time=39107 AState=Connected
10:28:07 1100968546mS SIP Rx: UDP 172.8.4.21:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.21:5060;branch=z9hG4bK-d54a8250
From: "Riane Queiroz" <sip:6021@172.8.4.250>;tag=bdd3ba26efad51ebo0
To: "Riane Queiroz" <sip:6021@172.8.4.250>
Call-ID: e0e67b50-cf7871ff@172.8.4.21
CSeq: 64271 REGISTER
Max-Forwards: 70
Authorization: Digest username="6021",realm="ipoffice",nonce="9c706cfc12c02280d13c",uri="sip:172.8.4.250",algorithm=MD5,response="70c5289091e0cec7e384f1021cc270df"
Contact: "Riane Queiroz" <sip:6021@172.8.4.21:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:07 1100968550mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.21:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.21:5060;branch=z9hG4bK-d54a8250
From: "Riane Queiroz" <sip:6021@172.8.4.250>;tag=bdd3ba26efad51ebo0
Call-ID: e0e67b50-cf7871ff@172.8.4.21
CSeq: 64271 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6021@172.8.4.21:5060>
Date: Mon, 06 Jul 2015 13:28:07 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Riane Queiroz" <sip:6021@172.8.4.250>;tag=2be9329b1b057815
Content-Length: 0
10:28:08 1100969239mS SIP Rx: UDP 172.8.4.31:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.31:5060;branch=z9hG4bK-db8c18c6
From: "Gabriela Simões" <sip:6031@172.8.4.250>;tag=97e22e1d4cc914d6o0
To: "Gabriela Simões" <sip:6031@172.8.4.250>
Call-ID: 39b38395-df0efe14@172.8.4.31
CSeq: 79552 REGISTER
Max-Forwards: 70
Authorization: Digest username="6031",realm="ipoffice",nonce="c1232ff0b1cbf70beb86",uri="sip:172.8.4.250",algorithm=MD5,response="0bbd11dd1e1be23a70bd9075e2ac4c73"
Contact: "Gabriela Simões" <sip:6031@172.8.4.31:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:08 1100969244mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.31:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.31:5060;branch=z9hG4bK-db8c18c6
From: "Gabriela Simões" <sip:6031@172.8.4.250>;tag=97e22e1d4cc914d6o0
Call-ID: 39b38395-df0efe14@172.8.4.31
CSeq: 79552 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6031@172.8.4.31:5060>
Date: Mon, 06 Jul 2015 13:28:08 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Gabriela Simões" <sip:6031@172.8.4.250>;tag=9c05b2c65e03d56f
Content-Length: 0
10:28:08 1100969427mS ISDNL3Evt: v=1 stacknum=1 State, new=ReleaseReq, old=Active id=22
10:28:08 1100969545mS SIP Rx: UDP 172.8.4.102:5060 -> 172.8.4.250:5060
BYE sip:07131132604@172.8.4.250:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 172.8.4.102;branch=z9hG4bKac866691028
Max-Forwards: 70
From: <sip:6042@172.8.4.102>;tag=1c814063425
To: "Anonymous" <sip:07131132604@172.8.4.102>;tag=1d48255a0c4ae174
Call-ID: 8ca9bd5f1c66428ab83942b4492710b7
CSeq: 1 BYE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Reason: Q.850 ;cause=16
Content-Length: 0
10:28:08 1100969548mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.102:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.102;branch=z9hG4bKac866691028
From: <sip:6042@172.8.4.102>;tag=1c814063425
Call-ID: 8ca9bd5f1c66428ab83942b4492710b7
CSeq: 1 BYE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Anonymous" <sip:07131132604@172.8.4.102>;tag=1d48255a0c4ae174
Content-Length: 0
10:28:08 1100969549mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 20 Call: lid=20 id=99158 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07131132604] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6042
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=20 channel=1 features=0x0 rx_gain=32 tx_gain=32 ep_callid=99158 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
Cause=16, Normal call clearing
10:28:08 1100969549mS CMCallEvt: 20.99158.0 22913 SIPTrunk Endpoint: StateChange: END=B CMCSConnected->CMCSCompleted
10:28:08 1100969552mS CMLOGGING: CALL:2015/07/0610:27,00:00:33,008,07131132604,I,6042,34176042,,,,0,,""n/a,0
10:28:08 1100969553mS CD: CALL: 1.22.1 BState=Disconnecting Cut=1 Music=0.0 Aend="Line 1" (1.15) Bend="DDR 6042(6142)" [Line 20] (0.0) CalledNum=6042 (DDR 6042) CallingNum=07131132604 () Internal=0 Time=42174 AState=Connected
10:28:08 1100969553mS CD: CALL: 1.22.1 Deleted
10:28:08 1100969554mS CMLineTx: v=1
CMDisconnect
Line: type=Q931Line 1 Call: lid=1 id=22 in=1
Cause=16, Normal call clearing
10:28:08 1100969554mS CMCallEvt: 1.22.1 -1 Q931 Trunk:1 CHAN=14: StateChange: END=X CMCSConnected->CMCSCompleted
10:28:08 1100969555mS CMCallEvt: 20.99158.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:08 1100969555mS CMCallEvt: END CALL:22913 (f47d7568)
10:28:08 1100969557mS CMCallEvt: 20.99158.0 -1 BaseEP: DELETE CMEndpoint f4a0bd00 TOTAL NOW=18 CALL_LIST=7
10:28:08 1100969558mS CMMap: PCG::UnmapBChan pcp[102]b1r0 cp_b f5441278 other_cp_b f548f2c0
10:28:08 1100969559mS CMMap: a=0.1 b=1.15 M02
10:28:08 1100969559mS CMMap: PlatformConnectionAudioSAP:
isconnectVoice rtpRelay ID: 5 Close success
10:28:08 1100969559mS H323Evt: SetOperational 13929 172.8.4.250:49158 to 0
10:28:08 1100969559mS CMMap: PCG::UnmapBChan pcp[972]b0r1 cp_b 0 other_cp_b 0
10:28:08 1100969560mS H323Evt: RTP(END): 172.8.4.250/49158 172.8.4.102/6030 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=33541 SENT=1668 RECV=1671 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
10:28:08 1100969561mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 8, total 32
10:28:08 1100969623mS ISDNL3Evt: v=1 stacknum=1 State, new=NullState, old=ReleaseReq id=22
10:28:08 1100969624mS CMLineRx: v=1
CMReleaseComp
Line: type=Q931Line 1 Call: lid=1 id=22 in=1
BChan: slot=0 chan=14
Cause=16, Normal call clearing
10:28:08 1100969624mS CMCallEvt: 1.22.1 -1 Q931 Trunk:1 CHAN=14: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:08 1100969625mS CMCallEvt: 1.22.1 -1 BaseEP: DELETE CMEndpoint f47d0500 TOTAL NOW=17 CALL_LIST=7
10:28:08 1100969675mS RES: Mon 6/7/2015 10:28:08 FreeMem=48515076 46902612(1) CachedMem=1612464 CMMsg=8(8) Buff=5200 1364 999 7429 5 Links=31253 BTree=12891 CPU=07.05% CPUStats=12/21/4048/15580/20319/1/0 MCR=0 MCW=0
10:28:08 1100969675mS RES2: IP 500 V2 9.0.0.0 build 829 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=129 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=26(TLS=4) TAPI=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:28:08 1100969675mS RES4: XML MemObjs=56 PoolMem=3145765(2) FreeMem=3130377(2)
10:28:09 1100970459mS PRN: Optimizing BTree Lists Completed...Started:1100970024
10:28:10 1100971699mS ISDNL3Evt: v=1 stacknum=1 State, new=Present, old=NullState id=15
10:28:10 1100971700mS CMLineRx: v=1
CMSetup
Line: type=Q931Line 1 Call: lid=1 id=15 in=1
Called[34176009] Type=SubscriberNumber (4) Reason=CMDRdirect SndComp Calling[07133972576] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
BChan: slot=0 chan=19
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDNotISDN (1)
10:28:10 1100971700mS PRN: Q931Trunk: Found QBChannel to match 0.19 --> 1.20
10:28:10 1100971701mS CMCallEvt: 0.99175.0 -1 BaseEP: NEW CMEndpoint f47d0500 TOTAL NOW=18 CALL_LIST=7
10:28:10 1100971701mS CMCallEvt: CREATE CALL:22918 (f47d7568)
10:28:10 1100971701mS CMCallEvt: 0.99176.0 -1 BaseEP: NEW CMEndpoint f4830eb0 TOTAL NOW=19 CALL_LIST=7
10:28:10 1100971705mS CD: CALL: 1.15.1 BState=Idle Cut=1 Music=0.0 Aend="Line 1" (1.20) Bend="" [] (0.0) CalledNum=34176009 () CallingNum=07133972576 () Internal=0 Time=3 AState=Idle
10:28:10 1100971705mS CMCallEvt: 1.15.1 22918 Q931 Trunk:1 CHAN=19: StateChange: END=A CMCSIdle->CMCSDialInitiated
10:28:10 1100971705mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: LOOKUP CALL ROUTE: type=4 called_party=34176009 sub= calling=07133972576 dir=in complete=1 ses=0
10:28:10 1100971705mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: SET BESTMATCH: length 8 vs -1 match=7134176009 dest=6009
10:28:10 1100971706mS CMCallEvt: Priority hike: call 22918 priority 0->1
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: LOOKUP ICR: DDI= CGPN=07133972576 (Destination 6009 ) => CDPN=6009
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: ADD TARGET (N): number=6009 type=4 depth=1 nobar=1 setorig=1 ses=0
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: SET USER: Adriane Barros orig=1
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: ADD USER: Adriane Barros depth=1 disallow_cw=0 dnd=0 real_call=1 group_call=0 type(CMNTypeSubscriberNumber) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0)
10:28:10 1100971707mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 8, total 32
10:28:10 1100971707mS CMCallEvt: 0.99177.0 -1 BaseEP: NEW CMEndpoint f48891d0 TOTAL NOW=20 CALL_LIST=8
10:28:10 1100971707mS CMCallEvt: 0.99177.0 -1 Adriane Barros.-1: NEW CMExtnEndpoint f48891d0, Name=Adriane Barros, Extn=6009, Phys Extn=6009
10:28:10 1100971709mS CMTARGET: 347.99177.0 22918 Adriane Barros.0: ADD PRIMARY
10:28:10 1100971709mS CMTARGET: FoundKnownSystemTargets ICR cache hit
10:28:10 1100971709mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: INITIAL TARGETING SUCCEEDED
10:28:10 1100971710mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: GetNoAnswerTimer:15
10:28:10 1100971710mS CMCallEvt: 1.15.1 22918 Q931 Trunk:1 CHAN=19: StateChange: END=A CMCSDialInitiated->CMCSDialled
10:28:10 1100971710mS CMLineTx: v=1
CMProceeding
Line: type=Q931Line 1 Call: lid=1 id=15 in=1
BChan: slot=0 chan=19
10:28:10 1100971711mS CMCallEvt: 0.99176.0 22918 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:28:10 1100971712mS CMCallEvt: 347.99177.0 22918 Adriane Barros.0: StateChange: END=T CMCSIdle->CMCSOffering
10:28:10 1100971713mS CMExtnEvt: Adriane Barros: CMExtnHandler::SetCurrent( id: 0->99177 )
10:28:10 1100971713mS CMExtnTx: v=6009, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=347 id=99177 in=0
Called[6009] Type=SubscriberNumber (4) Reason=CMDRdirect SndComp Calling[07133972576] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIECallSignalChannelData (8) unknown
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDNotISDN (1)
IE CMIECalledPartyName (224)(Type=CMNameDefault) name=Adriane Barros
IE CMIECalledPartyKName (225)(Type=CMNameDefault) name=Adriane Barros
IE CMIERespondingPartyNumber (230)(P:0 S:3 T:2 N:1 R:4) number=07133972576
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceISDNTrunk type=0 number=1 channel=19 features=0x20 rx_gain=32 tx_gain=32 ep_callid=15 ipaddr=172.8.4.250 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:4 N:1 R:4) number=34176009
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
Display [07133972576>Adriane Barros]
Timed: 06/07/15 10:28
Locale: ptb
10:28:10 1100971714mS CMExtnRx: v=6009, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=347 id=99177 in=0
10:28:10 1100971714mS CMCallEvt: 347.99177.0 22918 Adriane Barros.0: StateChange: END=T CMCSOffering->CMCSRinging
10:28:10 1100971714mS CMExtnEvt: v=3 State, new=Ringing old=Idle,0,0,Adriane Barros
10:28:10 1100971715mS CMCallEvt: 0.99176.0 22918 TargetingEP: StateChange: END=B CMCSOffering->CMCSRinging
10:28:10 1100971715mS CMCallEvt: 1.15.1 22918 Q931 Trunk:1 CHAN=19: StateChange: END=A CMCSDialled->CMCSRingBack
10:28:10 1100971716mS CMLineTx: v=1
CMAlerting
Line: type=Q931Line 1 Call: lid=1 id=15 in=1
BChan: slot=0 chan=19
10:28:10 1100971719mS CD: CALL: 1.15.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.20) Bend="Adriane Barros(6009)" [Adriane Barros(6009)] (0.0) CalledNum=6009 (Adriane Barros) CallingNum=07133972576 () Internal=0 Time=18 AState=Ringing
10:28:10 1100971721mS CMMap: a=1.20 b=0.0 R1
10:28:10 1100971724mS ISDNL3Evt: v=1 stacknum=1 State, new=ICProceeding, old=Present id=15
10:28:10 1100971724mS ISDNL3Evt: v=1 stacknum=1 State, new=Received, old=ICProceeding id=15
10:28:11 1100972021mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
INVITE sip:6081@172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac854641530
Max-Forwards: 70
From: "34176083" <sip:6083@0.0.0.0>;tag=1c854638850
To: <sip:6081@172.8.4.250>
Call-ID: 854638599149200022143@172.8.4.101
CSeq: 1 INVITE
Contact: <sip:6083@172.8.4.101>
Supported: em,100rel,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 276
v=0
o=AudiocodesGW 854629393 854629311 IN IP4 172.8.4.101
s=Phone-Call
c=IN IP4 172.8.4.101
t=0 0
m=audio 6150 RTP/AVP 8 0 18
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=sendrecv
a=rtcp:6151 IN IP4 172.8.4.101
10:28:11 1100972024mS CMCallEvt: 0.99178.0 -1 BaseEP: NEW CMEndpoint f4a0bd00 TOTAL NOW=21 CALL_LIST=8
10:28:11 1100972025mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:11 1100972027mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac854641530
From: "34176083" <sip:6083@0.0.0.0>;tag=1c854638850
Call-ID: 854638599149200022143@172.8.4.101
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: <sip:6081@172.8.4.250>;tag=e6027ec9c58f35cf
Content-Length: 0
10:28:11 1100972030mS CMCallEvt: CREATE CALL:22919 (f4886f00)
10:28:11 1100972030mS CMCallEvt: 0.99179.0 -1 BaseEP: NEW CMEndpoint f48ee718 TOTAL NOW=22 CALL_LIST=8
10:28:11 1100972033mS CMLineRx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99178 in=1
Called[6081] Type=Default (100) Reason=CMDRdirect SndComp Calling[6083@172.8.4.101] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit 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=6083@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=4 features=0x0 rx_gain=32 tx_gain=32 ep_callid=99178 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:11 1100972033mS CD: CALL: 19.99178.1 BState=Idle Cut=1 Music=0.0 Aend="Line 19" (0.0) Bend="" [] (0.0) CalledNum=6081 () CallingNum=6083@172.8.4.101 () Internal=0 Time=3 AState=Idle
10:28:11 1100972034mS CMCallEvt: 19.99178.1 22919 SIPTrunk Endpoint: StateChange: END=A CMCSIdle->CMCSDialInitiated
10:28:11 1100972034mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: LOOKUP CALL ROUTE: type=100 called_party=6081 sub= calling=6083@172.8.4.101 dir=in complete=1 ses=0
10:28:11 1100972034mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: SET BESTMATCH: length 0 vs -1 match= dest=.
10:28:11 1100972034mS CMCallEvt: Priority hike: call 22919 priority 0->1
10:28:11 1100972034mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: LOOKUP ICR: DDI=6081 CGPN=6083@172.8.4.101 (Destination . ) => CDPN=6081
10:28:11 1100972035mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: ADD TARGET (N): number=6081 type=100 depth=1 nobar=1 setorig=1 ses=0
10:28:11 1100972035mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: SYS SC: 6081 4 sc=type=Dial code=6081, num=6081 callinfop->sending_complete=1 secondary_dialtone=
10:28:11 1100972036mS CMARS: FindActiveARSByGroupID GroupID=101 - Not Found
10:28:11 1100972036mS CMLRQ: FindActiveLRQByGroupID GroupID=101 - Not Found
10:28:11 1100972036mS CMCallEvt: 0.99180.0 -1 BaseEP: NEW CMEndpoint f4a51408 TOTAL NOW=23 CALL_LIST=9
10:28:11 1100972037mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:11 1100972039mS CMTARGET: DIAL LINE: 22919 GROUP = 101 SUCCESS = f4a51408
10:28:11 1100972040mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: INITIAL TARGETING SUCCEEDED
10:28:11 1100972040mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: GetNoAnswerTimer:15
10:28:11 1100972040mS CMCallEvt: 19.99178.1 22919 SIPTrunk Endpoint: StateChange: END=A CMCSDialInitiated->CMCSDialled
10:28:11 1100972041mS CMLineTx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99178 in=1
10:28:11 1100972042mS CMCallEvt: 0.99179.0 22919 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:28:11 1100972042mS CMCallEvt: 19.99180.0 22919 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
10:28:11 1100972044mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99180 in=0
Called[6081] Type=Default (100) Reason=CMDRdirect SndComp Calling[6083@172.8.4.101] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6083@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=4 features=0x20 rx_gain=32 tx_gain=32 ep_callid=99178 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:100 N:100 R:4) number=6081
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
Display [6083>6081]
Timed: 06/07/15 10:28
Locale: ptb
10:28:11 1100972046mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6081@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bK7724feb754f77df39e40d109a64145c4
From: "Anonymous" <sip:6083@172.8.4.101>;tag=2fbda000139ba163
To: <sip:6081@172.8.4.101>
Call-ID: 5b616c3ee256e6060e737f6a3fa58336
CSeq: 1283723576 INVITE
Contact: "Anonymous" <sip:6083@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 297
v=0
o=UserA 1337636048 3368748320 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49162 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:11 1100972117mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bK7724feb754f77df39e40d109a64145c4
From: "Anonymous" <sip:6083@172.8.4.101>;tag=2fbda000139ba163
To: <sip:6081@172.8.4.101>;tag=1c854730363
Call-ID: 5b616c3ee256e6060e737f6a3fa58336
CSeq: 1283723576 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:11 1100972120mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99180 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[6083@172.8.4.101] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6081
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=5 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99180 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:11 1100972120mS CMCallEvt: 0.99179.0 22919 TargetingEP: RequestEnd 19.99180.0 22919 SIPTrunk Endpoint
10:28:11 1100972120mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: CancelTimer CMTCNoAnswerTimeout
10:28:11 1100972120mS CMCallEvt: 0.99179.0 -1 BaseEP: DELETE CMEndpoint f48ee718 TOTAL NOW=22 CALL_LIST=9
10:28:11 1100972121mS CMCallEvt: 19.99180.0 22919 SIPTrunk Endpoint: StateChange: END=B CMCSOffering->CMCSAccept
10:28:11 1100972141mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bK7724feb754f77df39e40d109a64145c4
From: "Anonymous" <sip:6083@172.8.4.101>;tag=2fbda000139ba163
To: <sip:6081@172.8.4.101>;tag=1c854730363
Call-ID: 5b616c3ee256e6060e737f6a3fa58336
CSeq: 1283723576 INVITE
Contact: <sip:6081@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:11 1100972144mS CMLineRx: v=0
CMAlerting
Line: type=SIPLine 19 Call: lid=19 id=99180 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[6083@172.8.4.101] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6081
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=5 features=0x0 rx_gain=32 tx_gain=32 ep_callid=99180 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:11 1100972144mS CMCallEvt: 19.99180.0 22919 SIPTrunk Endpoint: StateChange: END=B CMCSAccept->CMCSRinging
10:28:11 1100972145mS CMCallEvt: 19.99178.1 22919 SIPTrunk Endpoint: StateChange: END=A CMCSDialled->CMCSRingBack
10:28:11 1100972146mS CMLineTx: v=0
CMAlerting
Line: type=SIPLine 19 Call: lid=19 i
Could you help me with this one?
I have an IP Office V2 connected to an Audiocodes FXS to SIP Trunk. When I receive a call coming from the E1, I hang up on my fxs and try to do a transfer. The other FXS answers normally but when I try to finish the transfer the call drops.
I receive 503. service unavailable from the IP Office.
10:28:02 1100963550mS PRN: Updates IO list size 1 updated list size 1
10:28:02 1100963550mS PRN: Sending Updates out to f49e58e0 started
10:28:02 1100963550mS PRN: Sending Updates out to f49e58e0 finished
10:28:02 1100963551mS PRN: Config Write Completed
10:28:02 1100963595mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
INVITE sip:07182228525@172.8.4.250:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844108124
Max-Forwards: 70
From: <sip:6083@172.8.4.101>;tag=1c831449231
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 INVITE
Contact: <sip:6083@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Type: application/sdp
Content-Length: 201
v=0
o=AudiocodesGW 831481056 831480976 IN IP4 172.8.4.101
s=Phone-Call
c=IN IP4 0.0.0.0
t=0 0
m=audio 6150 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=ptime:20
a=inactive
a=rtcp:6151 IN IP4 172.8.4.101
10:28:02 1100963601mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844108124
From: <sip:6083@172.8.4.101>;tag=1c831449231
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Content-Length: 0
10:28:02 1100963609mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844108124
From: <sip:6083@172.8.4.101>;tag=1c831449231
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 INVITE
Contact: "Anonymous" <sip:07182228525@172.8.4.250:5060;transport=udp>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Content-Type: application/sdp
Content-Length: 156
v=0
o=UserA 2221736179 31913132 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49168 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=inactive
10:28:02 1100963612mS CMMap: PCG::UnmapBChan pcp[105]b1r0 cp_b f54408d0 other_cp_b f548b820
10:28:02 1100963612mS CMMap: a=0.19 b=1.19 M02
10:28:02 1100963612mS H323Evt: SetOperational 13930 172.8.4.250:49168 to 0
10:28:02 1100963612mS CMMap: PCG::UnmapBChan pcp[976]b0r1 cp_b 0 other_cp_b 0
10:28:02 1100963612mS CMMap: a=1.19 b=0.0 H1
10:28:02 1100963613mS CMMap: PlatformConnectionAudioSAP:
10:28:02 1100963615mS CD: CALL: 1.30.1 BState=Connected Cut=1 Music=1.0 Aend="Line 1" (1.19) Bend="DDR 6083(6183)" [Line 19] (0.0) CalledNum=6083 (DDR 6083) CallingNum=07182228525 () Internal=0 Time=10204 AState=Connected
10:28:02 1100963645mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
ACK sip:07182228525@172.8.4.250:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac844176016
Max-Forwards: 70
From: <sip:6083@172.8.4.101>;tag=1c831449231
To: "Anonymous" <sip:07182228525@172.8.4.101>;tag=ae6ff35ccd51686f
Call-ID: 6ed2445895ecb65ce37b918b3394e443
CSeq: 1 ACK
Contact: <sip:6083@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:03 1100964152mS RES: Mon 6/7/2015 10:28:02 FreeMem=48536860 46902612(1) CachedMem=1634248 CMMsg=8(8) Buff=5200 1364 1000 7430 5 Links=31222 BTree=12890 CPU=08.51% CPUStats=15/22/4048/15211/20319/2/0 MCR=0 MCW=0
10:28:03 1100964153mS RES2: IP 500 V2 9.0.0.0 build 829 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=123 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=26(TLS=4) TAPI=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:28:03 1100964153mS RES4: XML MemObjs=56 PoolMem=3145765(2) FreeMem=3130377(2)
10:28:03 1100964445mS SIP Rx: UDP 172.8.4.64:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.64:5060;branch=z9hG4bK-195e3069
From: "Antonio/Andre" <sip:6064@172.8.4.250>;tag=296680066b564566o0
To: "Antonio/Andre" <sip:6064@172.8.4.250>
Call-ID: bb3b9cc5-7d2a36ea@172.8.4.64
CSeq: 71889 REGISTER
Max-Forwards: 70
Authorization: Digest username="6064",realm="ipoffice",nonce="8bf1faa3e5c35120f4f3",uri="sip:172.8.4.250",algorithm=MD5,response="424b7ce42227aa2b7c72c70398bef67f"
Contact: "Antonio/Andre" <sip:6064@172.8.4.64:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:03 1100964450mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.64:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.64:5060;branch=z9hG4bK-195e3069
From: "Antonio/Andre" <sip:6064@172.8.4.250>;tag=296680066b564566o0
Call-ID: bb3b9cc5-7d2a36ea@172.8.4.64
CSeq: 71889 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6064@172.8.4.64:5060>
Date: Mon, 06 Jul 2015 13:28:03 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Antonio/Andre" <sip:6064@172.8.4.250>;tag=0f875b4f219553b9
Content-Length: 0
10:28:03 1100964833mS SIP Rx: UDP 172.8.4.12:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.12:5060;branch=z9hG4bK-776d0b49
From: "Renata Janaina" <sip:6012@172.8.4.250>;tag=8752fba5ffef6634o0
To: "Renata Janaina" <sip:6012@172.8.4.250>
Call-ID: e13faefa-422bc214@172.8.4.12
CSeq: 38914 REGISTER
Max-Forwards: 70
Authorization: Digest username="6012",realm="ipoffice",nonce="a545febc6a5e738bbbcd",uri="sip:172.8.4.250",algorithm=MD5,response="89e5df00c9850eba88f66ec240e5e2f5"
Contact: "Renata Janaina" <sip:6012@172.8.4.12:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:03 1100964837mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.12:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.12:5060;branch=z9hG4bK-776d0b49
From: "Renata Janaina" <sip:6012@172.8.4.250>;tag=8752fba5ffef6634o0
Call-ID: e13faefa-422bc214@172.8.4.12
CSeq: 38914 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6012@172.8.4.12:5060>
Date: Mon, 06 Jul 2015 13:28:03 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Renata Janaina" <sip:6012@172.8.4.250>;tag=4e48d68134502e80
Content-Length: 0
10:28:04 1100965573mS SIP Rx: UDP 172.8.4.89:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.89:5060;branch=z9hG4bK-808198ee
From: "Fabiano Mehmeri" <sip:6089@172.8.4.250>;tag=8532101fab41cc79o0
To: "Fabiano Mehmeri" <sip:6089@172.8.4.250>
Call-ID: 754cc9e6-45218495@172.8.4.89
CSeq: 61892 REGISTER
Max-Forwards: 70
Authorization: Digest username="6089",realm="ipoffice",nonce="e6ac6074d1baa9da3608",uri="sip:172.8.4.250",algorithm=MD5,response="6e66dd443f6d3f0a4796b5b52d745c22"
Contact: "Fabiano Mehmeri" <sip:6089@172.8.4.89:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:04 1100965577mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.89:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.89:5060;branch=z9hG4bK-808198ee
From: "Fabiano Mehmeri" <sip:6089@172.8.4.250>;tag=8532101fab41cc79o0
Call-ID: 754cc9e6-45218495@172.8.4.89
CSeq: 61892 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6089@172.8.4.89:5060>
Date: Mon, 06 Jul 2015 13:28:04 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Fabiano Mehmeri" <sip:6089@172.8.4.250>;tag=c6457f9ccff5c5ee
Content-Length: 0
10:28:05 1100966319mS H323Evt: Recv: RegistrationRequest 172.8.4.8; Endpoints registered: 4; Endpoints in registration: 0
10:28:05 1100966395mS SIP Rx: UDP 172.8.4.61:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.61:5060;branch=z9hG4bK-31b3d439
From: "Raimundo Trindade" <sip:6061@172.8.4.250>;tag=ee0fc614e5b0068ao0
To: "Raimundo Trindade" <sip:6061@172.8.4.250>
Call-ID: 2605df0a-bb54d13a@172.8.4.61
CSeq: 26394 REGISTER
Max-Forwards: 70
Authorization: Digest username="6061",realm="ipoffice",nonce="1de7845505e53f987eef",uri="sip:172.8.4.250",algorithm=MD5,response="4448099fca9800c99b5d6708eab357f5"
Contact: "Raimundo Trindade" <sip:6061@172.8.4.61:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:05 1100966399mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.61:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.61:5060;branch=z9hG4bK-31b3d439
From: "Raimundo Trindade" <sip:6061@172.8.4.250>;tag=ee0fc614e5b0068ao0
Call-ID: 2605df0a-bb54d13a@172.8.4.61
CSeq: 26394 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6061@172.8.4.61:5060>
Date: Mon, 06 Jul 2015 13:28:04 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Raimundo Trindade" <sip:6061@172.8.4.250>;tag=6345fd824b76199c
Content-Length: 0
10:28:06 1100967946mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
10:28:06 1100967947mS CMExtnRx: v=RAS, p1=0
CMTransfer
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[6200] Type=Default (100) Reason=CMDRdirect SndComp
10:28:06 1100967947mS CMCallEvt: 0.99163.0 22915 RAS.0: Transfer CMCauseTransfer
10:28:06 1100967947mS CD: CALL: 1.25.1 BState=Connected Cut=3 Music=0.0 Aend="Line 1" (1.16) Bend="URA(URA)" [VoiceMail] (21.11) CalledNum=URA () CallingNum=07133594218 () Internal=0 Time=38790 AState=Connected
10:28:06 1100967947mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD TARGET (N): number=6200 type=100 depth=1 nobar=1 setorig=1 ses=0
10:28:06 1100967947mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: HG(Atendimento,6200,172.8.4.250) Requires Routing To Master(1). IsLocalExecutive(1)
10:28:06 1100967947mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: HG call targeting occuring here
10:28:06 1100967948mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: PrimeForHGTarget: Atendimento setorig=1 recall=0 resetExtnVars 1
10:28:06 1100967948mS CMCallEvt: Priority hike: call 22915 priority 1->5
10:28:06 1100967948mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTarget Atendimento (depth=1) allowq=1 type=CMNTypeDefault
10:28:06 1100967948mS CMCallEvt: 0.99171.0 -1 BaseEP: NEW CMEndpoint f491a2f0 TOTAL NOW=18 CALL_LIST=8
10:28:06 1100967948mS CMTARGET: FoundKnownSystemTargets ICR cache hit
10:28:06 1100967949mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: PrepareTransferTargets Found 1 target
10:28:06 1100967949mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: GetNoAnswerTimer:15
10:28:06 1100967949mS CMCallEvt: 0.99172.0 -1 BaseEP: NEW CMEndpoint f47ce9d0 TOTAL NOW=19 CALL_LIST=8
10:28:06 1100967951mS CMExtnEvt: RAS: CALL LOST (CMCauseTransfer)
10:28:06 1100967951mS CMCallEvt: 0.99163.0 -1 RAS.0: StateChange: END=X CMCSConnected->CMCSCompleted
10:28:06 1100967951mS CMExtnEvt: v=1012 State, new=PortRecoverDelay old=Connected,0,0,RAS
10:28:06 1100967951mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1012 in=0
Called[URA] Type=Voicemail (102) Reason=CMDRX_Attendant Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=11
Cause=126, Transfer(IPO)
10:28:06 1100967952mS CMMap: a=21.11 b=0.0 T0
10:28:06 1100967953mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 99163->0 )
10:28:06 1100967953mS CMCallEvt: 0.99163.0 -1 RAS.-1: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:06 1100967953mS CMExtnEvt: v=1012 State, new=Idle old=PortRecoverDelay,0,0,RAS
10:28:06 1100967954mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1012 in=0
BChan: slot=21 chan=11
Cause=126, Transfer(IPO)
10:28:06 1100967954mS CMCallEvt: 0.99172.0 22915 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:28:06 1100967955mS CMCallEvt: 0.99171.0 22915 ACDTep(Atendimento): StateChange: END=T CMCSIdle->CMCSOffering
10:28:06 1100967955mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: CancelTimer CMTCNoAnswerTimeout
10:28:06 1100967955mS CMCallEvt: 0.99171.0 22915 ACDTep(Atendimento): StateChange: END=T CMCSOffering->CMCSRinging
10:28:06 1100967955mS CMCallEvt: 0.99172.0 22915 TargetingEP: StateChange: END=B CMCSOffering->CMCSRinging
10:28:06 1100967958mS CMCallEvt: 0.99163.0 -1 BaseEP: DELETE CMEndpoint f48891d0 TOTAL NOW=18 CALL_LIST=8
10:28:06 1100967959mS CMMap: PCG::UnmapBChan pcp[45]b1r0 cp_b f5481f78 other_cp_b f5440f40
10:28:06 1100967959mS CMMap: a=1.16 b=21.11 M02
10:28:06 1100967960mS CMMap: PCG::UnmapBChan pcp[103]b1r0 cp_b f5440f40 other_cp_b 0
10:28:06 1100967960mS CMMap: a=1.16 b=0.0 R1
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: PrimeForHGTarget: Atendimento setorig=0 recall=0 resetExtnVars 0
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTarget Atendimento (depth=0) allowq=0 type=CMNTypeDefault
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTargetRingRotary(Sequential) Atendimento ring_attempt_count 0 index 0
10:28:06 1100967962mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD USER: DDR 6046 depth=1 disallow_cw=1 dnd=0 real_call=1 group_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x34), allow_redir(1) remote=00000000 simult 0 (0)
10:28:06 1100967963mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD TARGET (N): number=6046 type=100 depth=2 nobar=1 setorig=0 ses=0
10:28:06 1100967963mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: SYS SC: 6046 4 sc=type=Dial code=6046, num=6046 callinfop->sending_complete=1 secondary_dialtone=
10:28:06 1100967963mS CMARS: FindActiveARSByGroupID GroupID=101 - Not Found
10:28:06 1100967964mS CMLRQ: FindActiveLRQByGroupID GroupID=101 - Not Found
10:28:06 1100967964mS CMMap: a=0.17 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 8, total 32
10:28:06 1100967965mS CMCallEvt: 0.99173.0 -1 BaseEP: NEW CMEndpoint f490a7d0 TOTAL NOW=19 CALL_LIST=8
10:28:06 1100967965mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:06 1100967967mS CMTARGET: DIAL LINE: 22915 GROUP = 101 SUCCESS = f490a7d0
10:28:06 1100967968mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: SelectTargetAvailable 1 targets
10:28:06 1100967968mS CMCallEvt: 19.99173.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
10:28:06 1100967970mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99173 in=0
Called[6046] Type=Default (100) Reason=CMDRdirect SndComp Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECalledPartyName (224)(Type=CMNameDefault) name=DDR 6046
IE CMIERespondingPartyNumber (230)(P:0 S:3 T:2 N:1 R:4) number=07133594218
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceISDNTrunk type=0 number=1 channel=15 features=0x20 rx_gain=32 tx_gain=32 ep_callid=25 ipaddr=172.8.4.250 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIERedirectingPartyName (232)(Type=CMNameDefault) name=Atendimento
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEOriginalCalledPartyName (236)(Type=CMNameDefault) name=Atendimento
IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:4 N:1 R:4) number=34176000
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
UUI type=User2User [6200..] [0x36 0x32 0x30 0x30 0xff 0xff ]
Display [07133594218>Atendimento]
Timed: 06/07/15 10:28
Locale: ptb
10:28:06 1100967972mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6046@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 INVITE
Contact: "Anonymous" <sip:07133594218@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 297
v=0
o=UserA 1719714674 2147859453 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49160 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:06 1100967973mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: GetNoAnswerTimer:15
10:28:06 1100967974mS CD: CALL: 1.25.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.16) Bend="Line 19" [Line 19] (0.0) CalledNum=6200 (Atendimento) CallingNum=07133594218 () Internal=0 Time=38817 AState=Connected
10:28:07 1100968045mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>;tag=1c849639670
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:07 1100968048mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99173 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6046@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99173 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:07 1100968048mS CMCallEvt: 19.99173.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSOffering->CMCSAccept
10:28:07 1100968065mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 302 Moved Temporarily
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>;tag=1c849639670
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 INVITE
Contact: <sip:6001@172.8.4.250>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Diversion: <tel:6046>;reason=user-busy
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Reason: SIP ;cause=486 ;text="486 Busy Here"
Content-Length: 0
10:28:07 1100968069mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
ACK sip:6046@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKc5dd64000342d90dbb05a2fbc4cd3fb2
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6046@172.8.4.101>;tag=1c849639670
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781510 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 0
10:28:07 1100968072mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6001@172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKffd43471a9fa29c66648d30e9cd8533e
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6001@172.8.4.250>
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781511 INVITE
Contact: "Anonymous" <sip:07133594218@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Type: application/sdp
Content-Length: 297
v=0
o=UserA 1719714674 2147859453 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49160 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:07 1100968136mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKffd43471a9fa29c66648d30e9cd8533e
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6001@172.8.4.250>;tag=1c849753481
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781511 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Reason: Q.850 ;cause=3
Content-Length: 0
10:28:07 1100968140mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
ACK sip:6001@172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKffd43471a9fa29c66648d30e9cd8533e
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=e24bacfb21c91fac
To: <sip:6001@172.8.4.250>;tag=1c849753481
Call-ID: b5c18262380821e2b51c6ea12206c5b3
CSeq: 1823781511 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 0
10:28:07 1100968141mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 19 Call: lid=19 id=99173 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6001@172.8.4.250
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99173 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
Cause=178,
10:28:07 1100968141mS CMCallEvt: 19.99173.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSAccept->CMCSCompleted
10:28:07 1100968143mS CMCallEvt: 19.99173.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:07 1100968143mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AdjustNoAnswerTimer 10ms
10:28:07 1100968144mS CMCallEvt: 19.99173.0 -1 BaseEP: DELETE CMEndpoint f490a7d0 TOTAL NOW=18 CALL_LIST=8
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: TimerExpired cause=CMTCNoAnswerTimeout
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: Retarget NOANSWER EXCEPTED=0000000c ValidTargets=8
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: RetargetNoAnswer on HUNTGROUP=Atendimento. Ring Attempt 1
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTarget Atendimento (depth=1) allowq=0 type=CMNTypeDefault
10:28:07 1100968153mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: AddHGTargetRingRotary(Sequential) Atendimento ring_attempt_count 1 index 1
10:28:07 1100968154mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD USER: DDR 6047 depth=2 disallow_cw=1 dnd=0 real_call=1 group_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x34), allow_redir(1) remote=00000000 simult 0 (0)
10:28:07 1100968154mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: ADD TARGET (N): number=6047 type=100 depth=3 nobar=1 setorig=0 ses=0
10:28:07 1100968155mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: SYS SC: 6047 4 sc=type=Dial code=6047, num=6047 callinfop->sending_complete=1 secondary_dialtone=
10:28:07 1100968155mS CMARS: FindActiveARSByGroupID GroupID=101 - Not Found
10:28:07 1100968155mS CMLRQ: FindActiveLRQByGroupID GroupID=101 - Not Found
10:28:07 1100968156mS CMCallEvt: 0.99174.0 -1 BaseEP: NEW CMEndpoint f490a7d0 TOTAL NOW=19 CALL_LIST=8
10:28:07 1100968157mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:07 1100968159mS CMTARGET: DIAL LINE: 22915 GROUP = 101 SUCCESS = f490a7d0
10:28:07 1100968160mS CMTARGET: 1.25.1 22915 Q931 Trunk:1 CHAN=15: GetNoAnswerTimer:15
10:28:07 1100968160mS CMCallEvt: 19.99174.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
10:28:07 1100968162mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99174 in=0
Called[6047] Type=Default (100) Reason=CMDRdirect SndComp Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECalledPartyName (224)(Type=CMNameDefault) name=DDR 6047
IE CMIERespondingPartyNumber (230)(P:0 S:3 T:2 N:1 R:4) number=07133594218
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceISDNTrunk type=0 number=1 channel=15 features=0x20 rx_gain=32 tx_gain=32 ep_callid=25 ipaddr=172.8.4.250 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIERedirectingPartyName (232)(Type=CMNameDefault) name=Atendimento
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEOriginalCalledPartyName (236)(Type=CMNameDefault) name=Atendimento
IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:1) number=6200
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:4 N:1 R:4) number=34176000
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
UUI type=User2User [6200..] [0x36 0x32 0x30 0x30 0xff 0xff ]
Display [07133594218>Atendimento]
Timed: 06/07/15 10:28
Locale: ptb
10:28:07 1100968164mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6047@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKf295bbe3905a270201f3e8c61b8f80cb
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=44344ebadb7009f4
To: <sip:6047@172.8.4.101>
Call-ID: 9c14eaebde1ec6cfb109efb81a5be86c
CSeq: 8492412 INVITE
Contact: "Anonymous" <sip:07133594218@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 297
v=0
o=UserA 2996652209 2799076108 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49160 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:07 1100968165mS CD: CALL: 1.25.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.16) Bend="Line 19" [Line 19] (0.0) CalledNum=6200 (Atendimento) CallingNum=07133594218 () Internal=0 Time=39008 AState=Connected
10:28:07 1100968223mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKf295bbe3905a270201f3e8c61b8f80cb
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=44344ebadb7009f4
To: <sip:6047@172.8.4.101>;tag=1c849859734
Call-ID: 9c14eaebde1ec6cfb109efb81a5be86c
CSeq: 8492412 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:07 1100968226mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99174 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6047@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99174 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:07 1100968226mS CMCallEvt: 19.99174.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSOffering->CMCSAccept
10:28:07 1100968251mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bKf295bbe3905a270201f3e8c61b8f80cb
From: "Anonymous" <sip:07133594218@172.8.4.101>;tag=44344ebadb7009f4
To: <sip:6047@172.8.4.101>;tag=1c849859734
Call-ID: 9c14eaebde1ec6cfb109efb81a5be86c
CSeq: 8492412 INVITE
Contact: <sip:6047@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:07 1100968254mS CMLineRx: v=0
CMAlerting
Line: type=SIPLine 19 Call: lid=19 id=99174 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07133594218] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6047@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=3 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99174 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:07 1100968254mS CMCallEvt: 19.99174.0 22915 SIPTrunk Endpoint: StateChange: END=T CMCSAccept->CMCSRinging
10:28:07 1100968264mS CD: CALL: 1.25.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.16) Bend="Line 19" [Line 19] (0.0) CalledNum=6200 (Atendimento) CallingNum=07133594218 () Internal=0 Time=39107 AState=Connected
10:28:07 1100968546mS SIP Rx: UDP 172.8.4.21:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.21:5060;branch=z9hG4bK-d54a8250
From: "Riane Queiroz" <sip:6021@172.8.4.250>;tag=bdd3ba26efad51ebo0
To: "Riane Queiroz" <sip:6021@172.8.4.250>
Call-ID: e0e67b50-cf7871ff@172.8.4.21
CSeq: 64271 REGISTER
Max-Forwards: 70
Authorization: Digest username="6021",realm="ipoffice",nonce="9c706cfc12c02280d13c",uri="sip:172.8.4.250",algorithm=MD5,response="70c5289091e0cec7e384f1021cc270df"
Contact: "Riane Queiroz" <sip:6021@172.8.4.21:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:07 1100968550mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.21:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.21:5060;branch=z9hG4bK-d54a8250
From: "Riane Queiroz" <sip:6021@172.8.4.250>;tag=bdd3ba26efad51ebo0
Call-ID: e0e67b50-cf7871ff@172.8.4.21
CSeq: 64271 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6021@172.8.4.21:5060>
Date: Mon, 06 Jul 2015 13:28:07 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Riane Queiroz" <sip:6021@172.8.4.250>;tag=2be9329b1b057815
Content-Length: 0
10:28:08 1100969239mS SIP Rx: UDP 172.8.4.31:5060 -> 172.8.4.250:5060
REGISTER sip:172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.31:5060;branch=z9hG4bK-db8c18c6
From: "Gabriela Simões" <sip:6031@172.8.4.250>;tag=97e22e1d4cc914d6o0
To: "Gabriela Simões" <sip:6031@172.8.4.250>
Call-ID: 39b38395-df0efe14@172.8.4.31
CSeq: 79552 REGISTER
Max-Forwards: 70
Authorization: Digest username="6031",realm="ipoffice",nonce="c1232ff0b1cbf70beb86",uri="sip:172.8.4.250",algorithm=MD5,response="0bbd11dd1e1be23a70bd9075e2ac4c73"
Contact: "Gabriela Simões" <sip:6031@172.8.4.31:5060>;expires=120
User-Agent: Linksys/SPA921-5.1.5
Content-Length: 0
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces
10:28:08 1100969244mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.31:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.31:5060;branch=z9hG4bK-db8c18c6
From: "Gabriela Simões" <sip:6031@172.8.4.250>;tag=97e22e1d4cc914d6o0
Call-ID: 39b38395-df0efe14@172.8.4.31
CSeq: 79552 REGISTER
User-Agent: IP Office 9.0.0.0 build 829
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:6031@172.8.4.31:5060>
Date: Mon, 06 Jul 2015 13:28:08 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Gabriela Simões" <sip:6031@172.8.4.250>;tag=9c05b2c65e03d56f
Content-Length: 0
10:28:08 1100969427mS ISDNL3Evt: v=1 stacknum=1 State, new=ReleaseReq, old=Active id=22
10:28:08 1100969545mS SIP Rx: UDP 172.8.4.102:5060 -> 172.8.4.250:5060
BYE sip:07131132604@172.8.4.250:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 172.8.4.102;branch=z9hG4bKac866691028
Max-Forwards: 70
From: <sip:6042@172.8.4.102>;tag=1c814063425
To: "Anonymous" <sip:07131132604@172.8.4.102>;tag=1d48255a0c4ae174
Call-ID: 8ca9bd5f1c66428ab83942b4492710b7
CSeq: 1 BYE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Reason: Q.850 ;cause=16
Content-Length: 0
10:28:08 1100969548mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.102:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.8.4.102;branch=z9hG4bKac866691028
From: <sip:6042@172.8.4.102>;tag=1c814063425
Call-ID: 8ca9bd5f1c66428ab83942b4492710b7
CSeq: 1 BYE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: "Anonymous" <sip:07131132604@172.8.4.102>;tag=1d48255a0c4ae174
Content-Length: 0
10:28:08 1100969549mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 20 Call: lid=20 id=99158 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[07131132604] Type=National Plan=ISDN Pres=Allowed (0)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6042
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=20 channel=1 features=0x0 rx_gain=32 tx_gain=32 ep_callid=99158 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
Cause=16, Normal call clearing
10:28:08 1100969549mS CMCallEvt: 20.99158.0 22913 SIPTrunk Endpoint: StateChange: END=B CMCSConnected->CMCSCompleted
10:28:08 1100969552mS CMLOGGING: CALL:2015/07/0610:27,00:00:33,008,07131132604,I,6042,34176042,,,,0,,""n/a,0
10:28:08 1100969553mS CD: CALL: 1.22.1 BState=Disconnecting Cut=1 Music=0.0 Aend="Line 1" (1.15) Bend="DDR 6042(6142)" [Line 20] (0.0) CalledNum=6042 (DDR 6042) CallingNum=07131132604 () Internal=0 Time=42174 AState=Connected
10:28:08 1100969553mS CD: CALL: 1.22.1 Deleted
10:28:08 1100969554mS CMLineTx: v=1
CMDisconnect
Line: type=Q931Line 1 Call: lid=1 id=22 in=1
Cause=16, Normal call clearing
10:28:08 1100969554mS CMCallEvt: 1.22.1 -1 Q931 Trunk:1 CHAN=14: StateChange: END=X CMCSConnected->CMCSCompleted
10:28:08 1100969555mS CMCallEvt: 20.99158.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:08 1100969555mS CMCallEvt: END CALL:22913 (f47d7568)
10:28:08 1100969557mS CMCallEvt: 20.99158.0 -1 BaseEP: DELETE CMEndpoint f4a0bd00 TOTAL NOW=18 CALL_LIST=7
10:28:08 1100969558mS CMMap: PCG::UnmapBChan pcp[102]b1r0 cp_b f5441278 other_cp_b f548f2c0
10:28:08 1100969559mS CMMap: a=0.1 b=1.15 M02
10:28:08 1100969559mS CMMap: PlatformConnectionAudioSAP:
10:28:08 1100969559mS H323Evt: SetOperational 13929 172.8.4.250:49158 to 0
10:28:08 1100969559mS CMMap: PCG::UnmapBChan pcp[972]b0r1 cp_b 0 other_cp_b 0
10:28:08 1100969560mS H323Evt: RTP(END): 172.8.4.250/49158 172.8.4.102/6030 CODEC=Alaw64K(4) PKTSZ=160 RFC2833=off AGE=33541 SENT=1668 RECV=1671 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
10:28:08 1100969561mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 8, total 32
10:28:08 1100969623mS ISDNL3Evt: v=1 stacknum=1 State, new=NullState, old=ReleaseReq id=22
10:28:08 1100969624mS CMLineRx: v=1
CMReleaseComp
Line: type=Q931Line 1 Call: lid=1 id=22 in=1
BChan: slot=0 chan=14
Cause=16, Normal call clearing
10:28:08 1100969624mS CMCallEvt: 1.22.1 -1 Q931 Trunk:1 CHAN=14: StateChange: END=X CMCSCompleted->CMCSDelete
10:28:08 1100969625mS CMCallEvt: 1.22.1 -1 BaseEP: DELETE CMEndpoint f47d0500 TOTAL NOW=17 CALL_LIST=7
10:28:08 1100969675mS RES: Mon 6/7/2015 10:28:08 FreeMem=48515076 46902612(1) CachedMem=1612464 CMMsg=8(8) Buff=5200 1364 999 7429 5 Links=31253 BTree=12891 CPU=07.05% CPUStats=12/21/4048/15580/20319/1/0 MCR=0 MCW=0
10:28:08 1100969675mS RES2: IP 500 V2 9.0.0.0 build 829 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=129 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=26(TLS=4) TAPI=1 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
10:28:08 1100969675mS RES4: XML MemObjs=56 PoolMem=3145765(2) FreeMem=3130377(2)
10:28:09 1100970459mS PRN: Optimizing BTree Lists Completed...Started:1100970024
10:28:10 1100971699mS ISDNL3Evt: v=1 stacknum=1 State, new=Present, old=NullState id=15
10:28:10 1100971700mS CMLineRx: v=1
CMSetup
Line: type=Q931Line 1 Call: lid=1 id=15 in=1
Called[34176009] Type=SubscriberNumber (4) Reason=CMDRdirect SndComp Calling[07133972576] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
BChan: slot=0 chan=19
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDNotISDN (1)
10:28:10 1100971700mS PRN: Q931Trunk: Found QBChannel to match 0.19 --> 1.20
10:28:10 1100971701mS CMCallEvt: 0.99175.0 -1 BaseEP: NEW CMEndpoint f47d0500 TOTAL NOW=18 CALL_LIST=7
10:28:10 1100971701mS CMCallEvt: CREATE CALL:22918 (f47d7568)
10:28:10 1100971701mS CMCallEvt: 0.99176.0 -1 BaseEP: NEW CMEndpoint f4830eb0 TOTAL NOW=19 CALL_LIST=7
10:28:10 1100971705mS CD: CALL: 1.15.1 BState=Idle Cut=1 Music=0.0 Aend="Line 1" (1.20) Bend="" [] (0.0) CalledNum=34176009 () CallingNum=07133972576 () Internal=0 Time=3 AState=Idle
10:28:10 1100971705mS CMCallEvt: 1.15.1 22918 Q931 Trunk:1 CHAN=19: StateChange: END=A CMCSIdle->CMCSDialInitiated
10:28:10 1100971705mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: LOOKUP CALL ROUTE: type=4 called_party=34176009 sub= calling=07133972576 dir=in complete=1 ses=0
10:28:10 1100971705mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: SET BESTMATCH: length 8 vs -1 match=7134176009 dest=6009
10:28:10 1100971706mS CMCallEvt: Priority hike: call 22918 priority 0->1
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: LOOKUP ICR: DDI= CGPN=07133972576 (Destination 6009 ) => CDPN=6009
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: ADD TARGET (N): number=6009 type=4 depth=1 nobar=1 setorig=1 ses=0
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: SET USER: Adriane Barros orig=1
10:28:10 1100971706mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: ADD USER: Adriane Barros depth=1 disallow_cw=0 dnd=0 real_call=1 group_call=0 type(CMNTypeSubscriberNumber) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0)
10:28:10 1100971707mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 8, total 32
10:28:10 1100971707mS CMCallEvt: 0.99177.0 -1 BaseEP: NEW CMEndpoint f48891d0 TOTAL NOW=20 CALL_LIST=8
10:28:10 1100971707mS CMCallEvt: 0.99177.0 -1 Adriane Barros.-1: NEW CMExtnEndpoint f48891d0, Name=Adriane Barros, Extn=6009, Phys Extn=6009
10:28:10 1100971709mS CMTARGET: 347.99177.0 22918 Adriane Barros.0: ADD PRIMARY
10:28:10 1100971709mS CMTARGET: FoundKnownSystemTargets ICR cache hit
10:28:10 1100971709mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: INITIAL TARGETING SUCCEEDED
10:28:10 1100971710mS CMTARGET: 1.15.1 22918 Q931 Trunk:1 CHAN=19: GetNoAnswerTimer:15
10:28:10 1100971710mS CMCallEvt: 1.15.1 22918 Q931 Trunk:1 CHAN=19: StateChange: END=A CMCSDialInitiated->CMCSDialled
10:28:10 1100971710mS CMLineTx: v=1
CMProceeding
Line: type=Q931Line 1 Call: lid=1 id=15 in=1
BChan: slot=0 chan=19
10:28:10 1100971711mS CMCallEvt: 0.99176.0 22918 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:28:10 1100971712mS CMCallEvt: 347.99177.0 22918 Adriane Barros.0: StateChange: END=T CMCSIdle->CMCSOffering
10:28:10 1100971713mS CMExtnEvt: Adriane Barros: CMExtnHandler::SetCurrent( id: 0->99177 )
10:28:10 1100971713mS CMExtnTx: v=6009, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=347 id=99177 in=0
Called[6009] Type=SubscriberNumber (4) Reason=CMDRdirect SndComp Calling[07133972576] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 8 item(s)
IE CMIECallSignalChannelData (8) unknown
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDNotISDN (1)
IE CMIECalledPartyName (224)(Type=CMNameDefault) name=Adriane Barros
IE CMIECalledPartyKName (225)(Type=CMNameDefault) name=Adriane Barros
IE CMIERespondingPartyNumber (230)(P:0 S:3 T:2 N:1 R:4) number=07133972576
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceISDNTrunk type=0 number=1 channel=19 features=0x20 rx_gain=32 tx_gain=32 ep_callid=15 ipaddr=172.8.4.250 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:4 N:1 R:4) number=34176009
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
Display [07133972576>Adriane Barros]
Timed: 06/07/15 10:28
Locale: ptb
10:28:10 1100971714mS CMExtnRx: v=6009, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=347 id=99177 in=0
10:28:10 1100971714mS CMCallEvt: 347.99177.0 22918 Adriane Barros.0: StateChange: END=T CMCSOffering->CMCSRinging
10:28:10 1100971714mS CMExtnEvt: v=3 State, new=Ringing old=Idle,0,0,Adriane Barros
10:28:10 1100971715mS CMCallEvt: 0.99176.0 22918 TargetingEP: StateChange: END=B CMCSOffering->CMCSRinging
10:28:10 1100971715mS CMCallEvt: 1.15.1 22918 Q931 Trunk:1 CHAN=19: StateChange: END=A CMCSDialled->CMCSRingBack
10:28:10 1100971716mS CMLineTx: v=1
CMAlerting
Line: type=Q931Line 1 Call: lid=1 id=15 in=1
BChan: slot=0 chan=19
10:28:10 1100971719mS CD: CALL: 1.15.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 1" (1.20) Bend="Adriane Barros(6009)" [Adriane Barros(6009)] (0.0) CalledNum=6009 (Adriane Barros) CallingNum=07133972576 () Internal=0 Time=18 AState=Ringing
10:28:10 1100971721mS CMMap: a=1.20 b=0.0 R1
10:28:10 1100971724mS ISDNL3Evt: v=1 stacknum=1 State, new=ICProceeding, old=Present id=15
10:28:10 1100971724mS ISDNL3Evt: v=1 stacknum=1 State, new=Received, old=ICProceeding id=15
10:28:11 1100972021mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
INVITE sip:6081@172.8.4.250 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac854641530
Max-Forwards: 70
From: "34176083" <sip:6083@0.0.0.0>;tag=1c854638850
To: <sip:6081@172.8.4.250>
Call-ID: 854638599149200022143@172.8.4.101
CSeq: 1 INVITE
Contact: <sip:6083@172.8.4.101>
Supported: em,100rel,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
User-Agent: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 276
v=0
o=AudiocodesGW 854629393 854629311 IN IP4 172.8.4.101
s=Phone-Call
c=IN IP4 172.8.4.101
t=0 0
m=audio 6150 RTP/AVP 8 0 18
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=sendrecv
a=rtcp:6151 IN IP4 172.8.4.101
10:28:11 1100972024mS CMCallEvt: 0.99178.0 -1 BaseEP: NEW CMEndpoint f4a0bd00 TOTAL NOW=21 CALL_LIST=8
10:28:11 1100972025mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:11 1100972027mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.101;branch=z9hG4bKac854641530
From: "34176083" <sip:6083@0.0.0.0>;tag=1c854638850
Call-ID: 854638599149200022143@172.8.4.101
CSeq: 1 INVITE
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Supported: timer
Server: IP Office 9.0.0.0 build 829
To: <sip:6081@172.8.4.250>;tag=e6027ec9c58f35cf
Content-Length: 0
10:28:11 1100972030mS CMCallEvt: CREATE CALL:22919 (f4886f00)
10:28:11 1100972030mS CMCallEvt: 0.99179.0 -1 BaseEP: NEW CMEndpoint f48ee718 TOTAL NOW=22 CALL_LIST=8
10:28:11 1100972033mS CMLineRx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99178 in=1
Called[6081] Type=Default (100) Reason=CMDRdirect SndComp Calling[6083@172.8.4.101] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit 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=6083@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=4 features=0x0 rx_gain=32 tx_gain=32 ep_callid=99178 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:11 1100972033mS CD: CALL: 19.99178.1 BState=Idle Cut=1 Music=0.0 Aend="Line 19" (0.0) Bend="" [] (0.0) CalledNum=6081 () CallingNum=6083@172.8.4.101 () Internal=0 Time=3 AState=Idle
10:28:11 1100972034mS CMCallEvt: 19.99178.1 22919 SIPTrunk Endpoint: StateChange: END=A CMCSIdle->CMCSDialInitiated
10:28:11 1100972034mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: LOOKUP CALL ROUTE: type=100 called_party=6081 sub= calling=6083@172.8.4.101 dir=in complete=1 ses=0
10:28:11 1100972034mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: SET BESTMATCH: length 0 vs -1 match= dest=.
10:28:11 1100972034mS CMCallEvt: Priority hike: call 22919 priority 0->1
10:28:11 1100972034mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: LOOKUP ICR: DDI=6081 CGPN=6083@172.8.4.101 (Destination . ) => CDPN=6081
10:28:11 1100972035mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: ADD TARGET (N): number=6081 type=100 depth=1 nobar=1 setorig=1 ses=0
10:28:11 1100972035mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: SYS SC: 6081 4 sc=type=Dial code=6081, num=6081 callinfop->sending_complete=1 secondary_dialtone=
10:28:11 1100972036mS CMARS: FindActiveARSByGroupID GroupID=101 - Not Found
10:28:11 1100972036mS CMLRQ: FindActiveLRQByGroupID GroupID=101 - Not Found
10:28:11 1100972036mS CMCallEvt: 0.99180.0 -1 BaseEP: NEW CMEndpoint f4a51408 TOTAL NOW=23 CALL_LIST=9
10:28:11 1100972037mS Stun: Info: Line 19: Not using STUN for media in this case.
10:28:11 1100972039mS CMTARGET: DIAL LINE: 22919 GROUP = 101 SUCCESS = f4a51408
10:28:11 1100972040mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: INITIAL TARGETING SUCCEEDED
10:28:11 1100972040mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: GetNoAnswerTimer:15
10:28:11 1100972040mS CMCallEvt: 19.99178.1 22919 SIPTrunk Endpoint: StateChange: END=A CMCSDialInitiated->CMCSDialled
10:28:11 1100972041mS CMLineTx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99178 in=1
10:28:11 1100972042mS CMCallEvt: 0.99179.0 22919 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
10:28:11 1100972042mS CMCallEvt: 19.99180.0 22919 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
10:28:11 1100972044mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 19 Call: lid=19 id=99180 in=0
Called[6081] Type=Default (100) Reason=CMDRdirect SndComp Calling[6083@172.8.4.101] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIEFastStartInfoData (6) 14 item(s)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6083@172.8.4.101
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=4 features=0x20 rx_gain=32 tx_gain=32 ep_callid=99178 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:100 N:100 R:4) number=6081
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIESecurityData (253) 2 item(s)
Display [6083>6081]
Timed: 06/07/15 10:28
Locale: ptb
10:28:11 1100972046mS SIP Tx: UDP 172.8.4.250:5060 -> 172.8.4.101:5060
INVITE sip:6081@172.8.4.101 SIP/2.0
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bK7724feb754f77df39e40d109a64145c4
From: "Anonymous" <sip:6083@172.8.4.101>;tag=2fbda000139ba163
To: <sip:6081@172.8.4.101>
Call-ID: 5b616c3ee256e6060e737f6a3fa58336
CSeq: 1283723576 INVITE
Contact: "Anonymous" <sip:6083@172.8.4.250:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,REFER,NOTIFY,UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 9.0.0.0 build 829
Content-Length: 297
v=0
o=UserA 1337636048 3368748320 IN IP4 172.8.4.250
s=Session SDP
c=IN IP4 172.8.4.250
t=0 0
m=audio 49162 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
10:28:11 1100972117mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bK7724feb754f77df39e40d109a64145c4
From: "Anonymous" <sip:6083@172.8.4.101>;tag=2fbda000139ba163
To: <sip:6081@172.8.4.101>;tag=1c854730363
Call-ID: 5b616c3ee256e6060e737f6a3fa58336
CSeq: 1283723576 INVITE
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:11 1100972120mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 19 Call: lid=19 id=99180 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[6083@172.8.4.101] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6081
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=5 features=0x1 rx_gain=32 tx_gain=32 ep_callid=99180 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:11 1100972120mS CMCallEvt: 0.99179.0 22919 TargetingEP: RequestEnd 19.99180.0 22919 SIPTrunk Endpoint
10:28:11 1100972120mS CMTARGET: 19.99178.1 22919 SIPTrunk Endpoint: CancelTimer CMTCNoAnswerTimeout
10:28:11 1100972120mS CMCallEvt: 0.99179.0 -1 BaseEP: DELETE CMEndpoint f48ee718 TOTAL NOW=22 CALL_LIST=9
10:28:11 1100972121mS CMCallEvt: 19.99180.0 22919 SIPTrunk Endpoint: StateChange: END=B CMCSOffering->CMCSAccept
10:28:11 1100972141mS SIP Rx: UDP 172.8.4.101:5060 -> 172.8.4.250:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 172.8.4.250:5060;rport;branch=z9hG4bK7724feb754f77df39e40d109a64145c4
From: "Anonymous" <sip:6083@172.8.4.101>;tag=2fbda000139ba163
To: <sip:6081@172.8.4.101>;tag=1c854730363
Call-ID: 5b616c3ee256e6060e737f6a3fa58336
CSeq: 1283723576 INVITE
Contact: <sip:6081@172.8.4.101>
Supported: em,timer,replaces,path,early-session,resource-priority
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE
Server: Audiocodes-Sip-Gateway-MP-124 FXS/v.5.00A.041.001
Content-Length: 0
10:28:11 1100972144mS CMLineRx: v=0
CMAlerting
Line: type=SIPLine 19 Call: lid=19 id=99180 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[6083@172.8.4.101] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=6081
IE CMIEDeviceDetail (231) LOCALE=ptb HW=15 VER=9 class=CMDeviceSIPTrunk type=0 number=19 channel=5 features=0x0 rx_gain=32 tx_gain=32 ep_callid=99180 ipaddr=172.8.4.250 apps=0 loc=999 em_loc=999 features2=0x0
10:28:11 1100972144mS CMCallEvt: 19.99180.0 22919 SIPTrunk Endpoint: StateChange: END=B CMCSAccept->CMCSRinging
10:28:11 1100972145mS CMCallEvt: 19.99178.1 22919 SIPTrunk Endpoint: StateChange: END=A CMCSDialled->CMCSRingBack
10:28:11 1100972146mS CMLineTx: v=0
CMAlerting
Line: type=SIPLine 19 Call: lid=19 i