Hi guys
I'm trying to install a test sip line here on my office from Iristel and i have a problem.
After all the configuration, seems look good. I can reveive incomming call perfectly but outgoing call are incompatible. The technician on Iristel dont find the problem and i begin to walk around now... there a trace of outgoing call
13-06-20 17:40:30-354ms Ligne = 18, Canal = 1, Message SIP = Invite, Réf. de l'appel = 46, Direction = Du commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net
13-06-20 17:40:30-381ms Ligne = 18, Canal = 1, Message SIP = Response, Réf. de l'appel = 46, Direction = Vers le commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net, Réponse = 100 Trying
13-06-20 17:40:30-388ms Ligne = 18, Canal = 1, Message SIP = Response, Réf. de l'appel = 46, Direction = Vers le commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net, Réponse = 604 Does Not Exist Anywhere
13-06-20 17:40:30-391ms Ligne = 18, Canal = 1, Message SIP = Ack, Réf. de l'appel = 46, Direction = Du commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net
********** Warning: Logging to Screen Started **********
4143147mS CMCallEvt: 0.1221.0 -1 BaseEP: NEW CMEndpoint f5046230 TOTAL NOW=1 CALL_LIST=0
4143147mS CMCallEvt: 0.1221.0 -1 Mike Cote.-1: NEW CMExtnEndpoint f5046230, Name=Mike Cote, Extn=262, Phys Extn=262
4143147mS CMCallEvt: CREATE CALL:65 (f5062408)
4143147mS CMCallEvt: 0.1222.0 -1 BaseEP: NEW CMEndpoint f5060f38 TOTAL NOW=2 CALL_LIST=0
4143150mS CMCallEvt: 0.1221.0 65 Mike Cote.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
4143151mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=262 dir=out complete=0 ses=0
4143151mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
4143152mS CMCallEvt: 0.1221.0 65 Mike Cote.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
4143153mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143153mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8 sub= calling=262 dir=out complete=0 ses=0
4143154mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8 type=100 depth=1 nobar=1 setorig=1 ses=0
4143155mS CD: CALL: 0.1221.0 BState=Idle Cut=0 Music=0.0 Aend="Mike Cote(262)" (2.17) Bend="" [] (0.0) CalledNum=8 () CallingNum=262 (Mike Cote) Internal=1 Time=8 AState=Dialling
4143381mS RES: Thu 20/6/2013 17:52:47 FreeMem=58732388 58103780(1) CachedMem=628608 CMMsg=9(12) Buff=5200 1406 998 12418 5 Links=30264 BTree=0 CPU=10/15/9269/20763/22475/1
4143381mS RES2: IP 500 V2 8.1(69) Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=81 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=2 TCP=23 TAPI=2 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
4143381mS RES4: XML MemObjs=45 PoolMem=2097152(1) FreeMem=2082064(1)
4143487mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143487mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85 sub= calling=262 dir=out complete=0 ses=0
4143487mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85 type=100 depth=1 nobar=1 setorig=1 ses=0
4143676mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143676mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=851 sub= calling=262 dir=out complete=0 ses=0
4143676mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=851 type=100 depth=1 nobar=1 setorig=1 ses=0
4143849mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143850mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8514 sub= calling=262 dir=out complete=0 ses=0
4143850mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8514 type=100 depth=1 nobar=1 setorig=1 ses=0
4144099mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4144100mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144 sub= calling=262 dir=out complete=0 ses=0
4144100mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144 type=100 depth=1 nobar=1 setorig=1 ses=0
4144302mS Stun: Creating STUNClient to resolve binding for 192.168.150.250:5005, server 217.10.68.152:3478
4144302mS Stun: Creating STUNUdpClient port 5005 address f5004480
4144302mS Stun: StunClient: ResolveIPAndPort 192.168.150.250:5005
4144337mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4144337mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=851449 sub= calling=262 dir=out complete=0 ses=0
4144337mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=851449 type=100 depth=1 nobar=1 setorig=1 ses=0
4144448mS Stun: Response To Enquiry is: 69.70.143.186:5005
4144448mS H323Evt: GK: stQosStunResponse, discovered 69.70.143.186:5005
4144448mS Stun: ~STUNClient 192.168.150.250:5005
4144574mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4144575mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8514498 sub= calling=262 dir=out complete=0 ses=0
4144575mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8514498 type=100 depth=1 nobar=1 setorig=1 ses=0
4145074mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145074mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144983 sub= calling=262 dir=out complete=0 ses=0
4145074mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144983 type=100 depth=1 nobar=1 setorig=1 ses=0
4145337mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145337mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=851449830 sub= calling=262 dir=out complete=0 ses=0
4145337mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=851449830 type=100 depth=1 nobar=1 setorig=1 ses=0
4145586mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145587mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8514498303 sub= calling=262 dir=out complete=0 ses=0
4145587mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8514498303 type=100 depth=1 nobar=1 setorig=1 ses=0
4145812mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145812mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144983030 sub= calling=262 dir=out complete=0 ses=0
4145812mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144983030 type=100 depth=1 nobar=1 setorig=1 ses=0
4146207mS H323Evt: Shared tcp socket for line 17 disconnected
4149812mS CMTARGET: 0.1221.0 65 Mike Cote.0: TimerExpired cause=CMTCDelayedProcessing
4149812mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144983030 sub= calling=262 dir=out complete=1 ses=0
4149812mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144983030 type=100 depth=1 nobar=1 setorig=1 ses=0
4149813mS CMTARGET: 0.1221.0 65 Mike Cote.0: SYS SC: 85144983030 3 5144983030 sc=type=Dial code=8N;, num=Ns"@iristel.net" callinfop->sending_complete=1 secondary_dialtone=
4149813mS CMARS: FindActiveARSByGroupID GroupID=18 - Not Found
4149813mS CMLRQ: FindActiveLRQByGroupID GroupID=18 - Not Found
4149814mS Sip: SIPTrunks: Make Target voip, line group id is 18 and ip 209.58.101.235
4149814mS CMMap: a=2.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 20
4149815mS Sip: License, Valid 1, Available 10, Consumed 0
4149815mS CMCallEvt: 0.1223.0 -1 BaseEP: NEW CMEndpoint f4ffeff0 TOTAL NOW=3 CALL_LIST=1
4149815mS Sip: SIPDialog f4ffdaf8 created, size 1
4149816mS Stun: Info: media ports will be mapped with STUN.
4149821mS CMTARGET: DIAL LINE: 65 GROUP = 18 SUCCESS = f4ffeff0
4149821mS CMTARGET: 0.1221.0 65 Mike Cote.0: INITIAL TARGETING SUCCEEDED
4149821mS CMTARGET: 0.1221.0 65 Mike Cote.0: GetNoAnswerTimer:15
4149822mS CMCallEvt: 0.1221.0 65 Mike Cote.0: StateChange: END=A CMCSDialling->CMCSDialled
4149823mS CMCallEvt: 0.1222.0 65 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
4149824mS CMCallEvt: 18.1223.0 65 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
4149825mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 18 Call: lid=18 id=1223 in=0
Called[5144983030] Type=Default (100) Reason=CMDRdirect SndComp Calling[@iristel.net] Type=Default Plan=Unknown
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Mike Cote
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Mike Cote
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=262
IE CMIEDeviceDetail (231) LOCALE=frc HW=15 VER=8 class=CMDeviceStdPhone type=109 number=29 channel=0 rx_gain=32 tx_gain=32 ep_callid=1221 ipaddr=192.168.150.250 apps=8
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
Display [??>5144983030]
Timed: 20/06/13 17:52
Locale: frc
4149825mS Stun: Creating STUNClient to resolve binding for 192.168.150.250:6000, server 217.10.68.152:3478
4149825mS Stun: Creating STUNUdpClient port 6000 address f5004408
4149825mS Stun: StunClient: ResolveIPAndPort 192.168.150.250:6000
4149825mS Stun: Creating STUNClient to resolve binding for 192.168.150.250:6001, server 217.10.68.152:3478
4149826mS Stun: Creating STUNUdpClient port 6001 address f50100b0
4149826mS Stun: StunClient: ResolveIPAndPort 192.168.150.250:6001
4149826mS CD: CALL: 0.1221.0 BState=Idle Cut=1 Music=0.0 Aend="Mike Cote(262)" (2.17) Bend="Line 18" [Line 18] (0.0) CalledNum=85144983030 () CallingNum=262 (Mike Cote) Internal=0 Time=6679 AState=Dialled
4149881mS RES: Thu 20/6/2013 17:52:54 FreeMem=58712692 58103780(1) CachedMem=608912 CMMsg=9(12) Buff=5200 1407 998 12418 5 Links=30214 BTree=0 CPU=2/5/9269/21114/22475/1
4149881mS RES2: IP 500 V2 8.1(69) Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=89 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=2 TCP=22 TAPI=2 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
4149881mS RES4: XML MemObjs=45 PoolMem=2097152(1) FreeMem=2082064(1)
4149972mS Stun: Response To Enquiry is: 69.70.143.186:6000
4149972mS Sip: CMMediaSTUNFilter::callback_received addr f59dd9f0 (rtp f59dd9f0 rtcp f59f3dd8) rec rtp 0 rtcp 0 video rtp 1 video rtcp 1
4149975mS Stun: Response To Enquiry is: 69.70.143.186:6001
4149975mS Sip: CMMediaSTUNFilter::callback_received addr f59f3dd8 (rtp f59dd9f0 rtcp f59f3dd8) rec rtp 1 rtcp 0 video rtp 1 video rtcp 1
4149976mS Sip: CMMediaSTUNFilter substituting
4149977mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffeff0) received CMSetup
4149977mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) CMSetup received, owner f500068c, dialog f4ffdaf8, dialling 5144983030
4149978mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) Using Responding Party Number: user Mike Cote
4149979mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) SetLocalRTPAddress to 69.70.143.186:6000
4149979mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) SdpClone
4149980mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) INVITE (method) SENT TO 209.58.101.236:5060 (reg required 0 registered 0)
4149980mS SIP Call Tx: 18
INVITE sip:5144983030@iristel.net SIP/2.0
Via: SIP/2.0/UDP 69.70.143.186:5060;rport;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8
From: "15149078573" <sip:15149078573@iristel.net>;tag=b15062befb011a6e
To: <sip:5144983030@iristel.net>
Call-ID: 505e98e1e32df157d5d4013c94b231d1
CSeq: 22474179 INVITE
Contact: "15149078573" <sip:15149078573@69.70.143.186:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 8.1 (69)
Content-Length: 251
v=0
o=UserA 155745338 2330560116 IN IP4 69.70.143.186
s=Session SDP
c=IN IP4 69.70.143.186
t=0 0
m=audio 6000 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
4149981mS SIP Tx: UDP 192.168.150.250:5060 -> 209.58.101.236:5060
4149981mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INITIAL(0) -> SIPDialog::INVITE_SENT(1)
4149982mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSDPState SIPDialog::IDLE(0) -> SIPDialog::OFFER_SENT(1)
4150008mS SIP Rx: UDP 209.58.101.236:39442 -> 192.168.150.250:5060
4150010mS Sip: Find End Point 18.1223.0 65 SIPTrunk Endpoint (f4ffeff0) Sip CallId 505e98e1e32df157d5d4013c94b231d1
4150010mS SIP Call Rx: 18
SIP/2.0 100 Trying
Via:SIP/2.0/UDP 69.70.143.186:5060;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8;rport
From:"15149078573"<sip:15149078573@iristel.net>;tag=b15062befb011a6e
To:<sip:5144983030@iristel.net>
Call-ID:505e98e1e32df157d5d4013c94b231d1
CSeq:22474179 INVITE
Content-Length:0
4150010mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) Process SIP response dialog f4ffdaf8, method INVITE, CodeNum 100 in state SIPDialog::INVITE_SENT(1)
4150011mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 18 Call: lid=18 id=1223 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=85144983030
IE CMIEDeviceDetail (231) LOCALE=frc HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=18 channel=1 rx_gain=32 tx_gain=32 ep_callid=1223 ipaddr=192.168.150.250 apps=8
4150011mS CMCallEvt: 0.1222.0 65 TargetingEP: RequestEnd 18.1223.0 65 SIPTrunk Endpoint
4150011mS CMTARGET: 0.1221.0 65 Mike Cote.0: CancelTimer CMTCNoAnswerTimeout
4150012mS CMCallEvt: 0.1222.0 -1 BaseEP: DELETE CMEndpoint f5060f38 TOTAL NOW=2 CALL_LIST=1
4150012mS CMCallEvt: 18.1223.0 65 SIPTrunk Endpoint: StateChange: END=B CMCSOffering->CMCSAccept
4150014mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INVITE_SENT(1) -> SIPDialog::INV_PROV_RESP_RCVD(5)
4150016mS Sip: Find End Point 18.1223.0 65 SIPTrunk Endpoint (f4ffeff0) Sip CallId 505e98e1e32df157d5d4013c94b231d1
4150017mS SIP Call Rx: 18
SIP/2.0 604 Does not exist anywhere
Via:SIP/2.0/UDP 69.70.143.186:5060;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8;rport
From:"15149078573"<sip:15149078573@iristel.net>;tag=b15062befb011a6e
To:<sip:5144983030@iristel.net>;tag=849286510-1371765312770
Call-ID:505e98e1e32df157d5d4013c94b231d1
CSeq:22474179 INVITE
Content-Length:0
4150017mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) Process SIP response dialog f4ffdaf8, method INVITE, CodeNum 604 in state SIPDialog::INV_PROV_RESP_RCVD(5)
4150018mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) ExtractContactFromMessage: cannot get Contact Header 2012
4150018mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INV_PROV_RESP_RCVD(5) -> SIPDialog::INV_FINAL_RESP_RCVD(16)
4150018mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) SendSIPRequest: ACK SENT TO 209.58.101.236 5060
4150019mS SIP Call Tx: 18
ACK sip:5144983030@iristel.net SIP/2.0
Via: SIP/2.0/UDP 69.70.143.186:5060;rport;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8
From: "15149078573" <sip:15149078573@iristel.net>;tag=b15062befb011a6e
To: <sip:5144983030@iristel.net>;tag=849286510-1371765312770
Call-ID: 505e98e1e32df157d5d4013c94b231d1
CSeq: 22474179 ACK
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
User-Agent: IP Office 8.1 (69)
Content-Length: 0
4150020mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INV_FINAL_RESP_RCVD(16) -> SIPDialog::FINAL(27)
4150021mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 18 Call: lid=18 id=1223 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=85144983030
IE CMIEDeviceDetail (231) LOCALE=frc HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=18 channel=1 rx_gain=32 tx_gain=32 ep_callid=1223 ipaddr=192.168.150.250 apps=8
Cause=1, Unallocated (unassigned) number
4150021mS CMCallEvt: 18.1223.0 65 SIPTrunk Endpoint: StateChange: END=B CMCSAccept->CMCSCompleted
4150023mS PRN: CDR - TCPSend maxqueuesize=500 framecount=500 operational=0
4150025mS CMLOGGING: CALL:2013/06/2017:52,00:00:00,000,262,O,5144983030,85144983030,MikeCote,,,0,,""n/a,0
4150025mS CD: CALL: 0.1221.0 BState=Disconnecting Cut=1 Music=0.0 Aend="Mike Cote(262)" (2.17) Bend="Line 18" [Line 18] (0.0) CalledNum=5144983030 () CallingNum=262 (Mike Cote) Internal=0 Time=6878 AState=Dialled
4150025mS CD: CALL: 0.1221.0 Deleted
4150027mS CMCallEvt: 0.1221.0 -1 Mike Cote.0: StateChange: END=X CMCSDialled->CMCSCompletedTone
4150028mS Sip: 18.1223.0 -1 SIPTrunk Endpoint(f4ffdaf8) KeepDlgOnCmCallLost SIPDialog::FINAL
4150028mS Sip: SIPDialog f4ffdaf8 destroyed, size 0
4150028mS CMCallEvt: 18.1223.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
4150029mS CMCallEvt: END CALL:65 (f5062408)
4150030mS Sip: ~SipTrunkEndpoint 18.1223.0 -1 SIPTrunk Endpoint
4150030mS Stun: ~STUNClient 192.168.150.250:6000
4150030mS Stun: ~STUNClient 192.168.150.250:6001
4150031mS CMCallEvt: 18.1223.0 -1 BaseEP: DELETE CMEndpoint f4ffeff0 TOTAL NOW=1 CALL_LIST=0
4150032mS CMMap: a=21.7 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 5, total 8
4150032mS CMMap: a=21.7 b=1.255 T
4150032mS CMMap: a=21.7 b=2.17 M22
4150033mS CMMap: a=2.18 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 0, total 20
4150916mS PRN: No Transport for 4546300a
4150916mS PRN: IKEfindPolicy: Don't know peer
4150916mS PRN: IKE:rcsIKEMessage Problem processing peer message
********** Warning: Logging to Screen Stopped **********
I'm trying to install a test sip line here on my office from Iristel and i have a problem.
After all the configuration, seems look good. I can reveive incomming call perfectly but outgoing call are incompatible. The technician on Iristel dont find the problem and i begin to walk around now... there a trace of outgoing call
13-06-20 17:40:30-354ms Ligne = 18, Canal = 1, Message SIP = Invite, Réf. de l'appel = 46, Direction = Du commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net
13-06-20 17:40:30-381ms Ligne = 18, Canal = 1, Message SIP = Response, Réf. de l'appel = 46, Direction = Vers le commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net, Réponse = 100 Trying
13-06-20 17:40:30-388ms Ligne = 18, Canal = 1, Message SIP = Response, Réf. de l'appel = 46, Direction = Vers le commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net, Réponse = 604 Does Not Exist Anywhere
13-06-20 17:40:30-391ms Ligne = 18, Canal = 1, Message SIP = Ack, Réf. de l'appel = 46, Direction = Du commutateur, De = 15149078573@iristel.net, À = 5144983030@iristel.net
********** Warning: Logging to Screen Started **********
4143147mS CMCallEvt: 0.1221.0 -1 BaseEP: NEW CMEndpoint f5046230 TOTAL NOW=1 CALL_LIST=0
4143147mS CMCallEvt: 0.1221.0 -1 Mike Cote.-1: NEW CMExtnEndpoint f5046230, Name=Mike Cote, Extn=262, Phys Extn=262
4143147mS CMCallEvt: CREATE CALL:65 (f5062408)
4143147mS CMCallEvt: 0.1222.0 -1 BaseEP: NEW CMEndpoint f5060f38 TOTAL NOW=2 CALL_LIST=0
4143150mS CMCallEvt: 0.1221.0 65 Mike Cote.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
4143151mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=262 dir=out complete=0 ses=0
4143151mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
4143152mS CMCallEvt: 0.1221.0 65 Mike Cote.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
4143153mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143153mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8 sub= calling=262 dir=out complete=0 ses=0
4143154mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8 type=100 depth=1 nobar=1 setorig=1 ses=0
4143155mS CD: CALL: 0.1221.0 BState=Idle Cut=0 Music=0.0 Aend="Mike Cote(262)" (2.17) Bend="" [] (0.0) CalledNum=8 () CallingNum=262 (Mike Cote) Internal=1 Time=8 AState=Dialling
4143381mS RES: Thu 20/6/2013 17:52:47 FreeMem=58732388 58103780(1) CachedMem=628608 CMMsg=9(12) Buff=5200 1406 998 12418 5 Links=30264 BTree=0 CPU=10/15/9269/20763/22475/1
4143381mS RES2: IP 500 V2 8.1(69) Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=81 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=2 TCP=23 TAPI=2 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
4143381mS RES4: XML MemObjs=45 PoolMem=2097152(1) FreeMem=2082064(1)
4143487mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143487mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85 sub= calling=262 dir=out complete=0 ses=0
4143487mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85 type=100 depth=1 nobar=1 setorig=1 ses=0
4143676mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143676mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=851 sub= calling=262 dir=out complete=0 ses=0
4143676mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=851 type=100 depth=1 nobar=1 setorig=1 ses=0
4143849mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4143850mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8514 sub= calling=262 dir=out complete=0 ses=0
4143850mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8514 type=100 depth=1 nobar=1 setorig=1 ses=0
4144099mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4144100mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144 sub= calling=262 dir=out complete=0 ses=0
4144100mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144 type=100 depth=1 nobar=1 setorig=1 ses=0
4144302mS Stun: Creating STUNClient to resolve binding for 192.168.150.250:5005, server 217.10.68.152:3478
4144302mS Stun: Creating STUNUdpClient port 5005 address f5004480
4144302mS Stun: StunClient: ResolveIPAndPort 192.168.150.250:5005
4144337mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4144337mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=851449 sub= calling=262 dir=out complete=0 ses=0
4144337mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=851449 type=100 depth=1 nobar=1 setorig=1 ses=0
4144448mS Stun: Response To Enquiry is: 69.70.143.186:5005
4144448mS H323Evt: GK: stQosStunResponse, discovered 69.70.143.186:5005
4144448mS Stun: ~STUNClient 192.168.150.250:5005
4144574mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4144575mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8514498 sub= calling=262 dir=out complete=0 ses=0
4144575mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8514498 type=100 depth=1 nobar=1 setorig=1 ses=0
4145074mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145074mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144983 sub= calling=262 dir=out complete=0 ses=0
4145074mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144983 type=100 depth=1 nobar=1 setorig=1 ses=0
4145337mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145337mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=851449830 sub= calling=262 dir=out complete=0 ses=0
4145337mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=851449830 type=100 depth=1 nobar=1 setorig=1 ses=0
4145586mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145587mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=8514498303 sub= calling=262 dir=out complete=0 ses=0
4145587mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=8514498303 type=100 depth=1 nobar=1 setorig=1 ses=0
4145812mS CMTARGET: 0.1221.0 65 Mike Cote.0: Setting Hard Timer 4000
4145812mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144983030 sub= calling=262 dir=out complete=0 ses=0
4145812mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144983030 type=100 depth=1 nobar=1 setorig=1 ses=0
4146207mS H323Evt: Shared tcp socket for line 17 disconnected
4149812mS CMTARGET: 0.1221.0 65 Mike Cote.0: TimerExpired cause=CMTCDelayedProcessing
4149812mS CMTARGET: 0.1221.0 65 Mike Cote.0: LOOKUP CALL ROUTE: type=100 called_party=85144983030 sub= calling=262 dir=out complete=1 ses=0
4149812mS CMTARGET: 0.1221.0 65 Mike Cote.0: ADD TARGET (N): number=85144983030 type=100 depth=1 nobar=1 setorig=1 ses=0
4149813mS CMTARGET: 0.1221.0 65 Mike Cote.0: SYS SC: 85144983030 3 5144983030 sc=type=Dial code=8N;, num=Ns"@iristel.net" callinfop->sending_complete=1 secondary_dialtone=
4149813mS CMARS: FindActiveARSByGroupID GroupID=18 - Not Found
4149813mS CMLRQ: FindActiveLRQByGroupID GroupID=18 - Not Found
4149814mS Sip: SIPTrunks: Make Target voip, line group id is 18 and ip 209.58.101.235
4149814mS CMMap: a=2.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 20
4149815mS Sip: License, Valid 1, Available 10, Consumed 0
4149815mS CMCallEvt: 0.1223.0 -1 BaseEP: NEW CMEndpoint f4ffeff0 TOTAL NOW=3 CALL_LIST=1
4149815mS Sip: SIPDialog f4ffdaf8 created, size 1
4149816mS Stun: Info: media ports will be mapped with STUN.
4149821mS CMTARGET: DIAL LINE: 65 GROUP = 18 SUCCESS = f4ffeff0
4149821mS CMTARGET: 0.1221.0 65 Mike Cote.0: INITIAL TARGETING SUCCEEDED
4149821mS CMTARGET: 0.1221.0 65 Mike Cote.0: GetNoAnswerTimer:15
4149822mS CMCallEvt: 0.1221.0 65 Mike Cote.0: StateChange: END=A CMCSDialling->CMCSDialled
4149823mS CMCallEvt: 0.1222.0 65 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
4149824mS CMCallEvt: 18.1223.0 65 SIPTrunk Endpoint: StateChange: END=T CMCSIdle->CMCSOffering
4149825mS CMLineTx: v=0
CMSetup
Line: type=SIPLine 18 Call: lid=18 id=1223 in=0
Called[5144983030] Type=Default (100) Reason=CMDRdirect SndComp Calling[@iristel.net] Type=Default Plan=Unknown
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Mike Cote
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Mike Cote
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=262
IE CMIEDeviceDetail (231) LOCALE=frc HW=15 VER=8 class=CMDeviceStdPhone type=109 number=29 channel=0 rx_gain=32 tx_gain=32 ep_callid=1221 ipaddr=192.168.150.250 apps=8
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
Display [??>5144983030]
Timed: 20/06/13 17:52
Locale: frc
4149825mS Stun: Creating STUNClient to resolve binding for 192.168.150.250:6000, server 217.10.68.152:3478
4149825mS Stun: Creating STUNUdpClient port 6000 address f5004408
4149825mS Stun: StunClient: ResolveIPAndPort 192.168.150.250:6000
4149825mS Stun: Creating STUNClient to resolve binding for 192.168.150.250:6001, server 217.10.68.152:3478
4149826mS Stun: Creating STUNUdpClient port 6001 address f50100b0
4149826mS Stun: StunClient: ResolveIPAndPort 192.168.150.250:6001
4149826mS CD: CALL: 0.1221.0 BState=Idle Cut=1 Music=0.0 Aend="Mike Cote(262)" (2.17) Bend="Line 18" [Line 18] (0.0) CalledNum=85144983030 () CallingNum=262 (Mike Cote) Internal=0 Time=6679 AState=Dialled
4149881mS RES: Thu 20/6/2013 17:52:54 FreeMem=58712692 58103780(1) CachedMem=608912 CMMsg=9(12) Buff=5200 1407 998 12418 5 Links=30214 BTree=0 CPU=2/5/9269/21114/22475/1
4149881mS RES2: IP 500 V2 8.1(69) Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=89 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=2 TCP=22 TAPI=2 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
4149881mS RES4: XML MemObjs=45 PoolMem=2097152(1) FreeMem=2082064(1)
4149972mS Stun: Response To Enquiry is: 69.70.143.186:6000
4149972mS Sip: CMMediaSTUNFilter::callback_received addr f59dd9f0 (rtp f59dd9f0 rtcp f59f3dd8) rec rtp 0 rtcp 0 video rtp 1 video rtcp 1
4149975mS Stun: Response To Enquiry is: 69.70.143.186:6001
4149975mS Sip: CMMediaSTUNFilter::callback_received addr f59f3dd8 (rtp f59dd9f0 rtcp f59f3dd8) rec rtp 1 rtcp 0 video rtp 1 video rtcp 1
4149976mS Sip: CMMediaSTUNFilter substituting
4149977mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffeff0) received CMSetup
4149977mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) CMSetup received, owner f500068c, dialog f4ffdaf8, dialling 5144983030
4149978mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) Using Responding Party Number: user Mike Cote
4149979mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) SetLocalRTPAddress to 69.70.143.186:6000
4149979mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) SdpClone
4149980mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) INVITE (method) SENT TO 209.58.101.236:5060 (reg required 0 registered 0)
4149980mS SIP Call Tx: 18
INVITE sip:5144983030@iristel.net SIP/2.0
Via: SIP/2.0/UDP 69.70.143.186:5060;rport;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8
From: "15149078573" <sip:15149078573@iristel.net>;tag=b15062befb011a6e
To: <sip:5144983030@iristel.net>
Call-ID: 505e98e1e32df157d5d4013c94b231d1
CSeq: 22474179 INVITE
Contact: "15149078573" <sip:15149078573@69.70.143.186:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
Content-Type: application/sdp
Supported: timer
User-Agent: IP Office 8.1 (69)
Content-Length: 251
v=0
o=UserA 155745338 2330560116 IN IP4 69.70.143.186
s=Session SDP
c=IN IP4 69.70.143.186
t=0 0
m=audio 6000 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
4149981mS SIP Tx: UDP 192.168.150.250:5060 -> 209.58.101.236:5060
4149981mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INITIAL(0) -> SIPDialog::INVITE_SENT(1)
4149982mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSDPState SIPDialog::IDLE(0) -> SIPDialog::OFFER_SENT(1)
4150008mS SIP Rx: UDP 209.58.101.236:39442 -> 192.168.150.250:5060
4150010mS Sip: Find End Point 18.1223.0 65 SIPTrunk Endpoint (f4ffeff0) Sip CallId 505e98e1e32df157d5d4013c94b231d1
4150010mS SIP Call Rx: 18
SIP/2.0 100 Trying
Via:SIP/2.0/UDP 69.70.143.186:5060;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8;rport
From:"15149078573"<sip:15149078573@iristel.net>;tag=b15062befb011a6e
To:<sip:5144983030@iristel.net>
Call-ID:505e98e1e32df157d5d4013c94b231d1
CSeq:22474179 INVITE
Content-Length:0
4150010mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) Process SIP response dialog f4ffdaf8, method INVITE, CodeNum 100 in state SIPDialog::INVITE_SENT(1)
4150011mS CMLineRx: v=0
CMProceeding
Line: type=SIPLine 18 Call: lid=18 id=1223 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=85144983030
IE CMIEDeviceDetail (231) LOCALE=frc HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=18 channel=1 rx_gain=32 tx_gain=32 ep_callid=1223 ipaddr=192.168.150.250 apps=8
4150011mS CMCallEvt: 0.1222.0 65 TargetingEP: RequestEnd 18.1223.0 65 SIPTrunk Endpoint
4150011mS CMTARGET: 0.1221.0 65 Mike Cote.0: CancelTimer CMTCNoAnswerTimeout
4150012mS CMCallEvt: 0.1222.0 -1 BaseEP: DELETE CMEndpoint f5060f38 TOTAL NOW=2 CALL_LIST=1
4150012mS CMCallEvt: 18.1223.0 65 SIPTrunk Endpoint: StateChange: END=B CMCSOffering->CMCSAccept
4150014mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INVITE_SENT(1) -> SIPDialog::INV_PROV_RESP_RCVD(5)
4150016mS Sip: Find End Point 18.1223.0 65 SIPTrunk Endpoint (f4ffeff0) Sip CallId 505e98e1e32df157d5d4013c94b231d1
4150017mS SIP Call Rx: 18
SIP/2.0 604 Does not exist anywhere
Via:SIP/2.0/UDP 69.70.143.186:5060;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8;rport
From:"15149078573"<sip:15149078573@iristel.net>;tag=b15062befb011a6e
To:<sip:5144983030@iristel.net>;tag=849286510-1371765312770
Call-ID:505e98e1e32df157d5d4013c94b231d1
CSeq:22474179 INVITE
Content-Length:0
4150017mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) Process SIP response dialog f4ffdaf8, method INVITE, CodeNum 604 in state SIPDialog::INV_PROV_RESP_RCVD(5)
4150018mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) ExtractContactFromMessage: cannot get Contact Header 2012
4150018mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INV_PROV_RESP_RCVD(5) -> SIPDialog::INV_FINAL_RESP_RCVD(16)
4150018mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) SendSIPRequest: ACK SENT TO 209.58.101.236 5060
4150019mS SIP Call Tx: 18
ACK sip:5144983030@iristel.net SIP/2.0
Via: SIP/2.0/UDP 69.70.143.186:5060;rport;branch=z9hG4bK88bfd2fd7827f090914d0adc662a8bf8
From: "15149078573" <sip:15149078573@iristel.net>;tag=b15062befb011a6e
To: <sip:5144983030@iristel.net>;tag=849286510-1371765312770
Call-ID: 505e98e1e32df157d5d4013c94b231d1
CSeq: 22474179 ACK
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, INFO, UPDATE
User-Agent: IP Office 8.1 (69)
Content-Length: 0
4150020mS Sip: 18.1223.0 65 SIPTrunk Endpoint(f4ffdaf8) UpdateSIPCallState SIPDialog::INV_FINAL_RESP_RCVD(16) -> SIPDialog::FINAL(27)
4150021mS CMLineRx: v=0
CMReleaseComp
Line: type=SIPLine 18 Call: lid=18 id=1223 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=85144983030
IE CMIEDeviceDetail (231) LOCALE=frc HW=15 VER=8 class=CMDeviceSIPTrunk type=0 number=18 channel=1 rx_gain=32 tx_gain=32 ep_callid=1223 ipaddr=192.168.150.250 apps=8
Cause=1, Unallocated (unassigned) number
4150021mS CMCallEvt: 18.1223.0 65 SIPTrunk Endpoint: StateChange: END=B CMCSAccept->CMCSCompleted
4150023mS PRN: CDR - TCPSend maxqueuesize=500 framecount=500 operational=0
4150025mS CMLOGGING: CALL:2013/06/2017:52,00:00:00,000,262,O,5144983030,85144983030,MikeCote,,,0,,""n/a,0
4150025mS CD: CALL: 0.1221.0 BState=Disconnecting Cut=1 Music=0.0 Aend="Mike Cote(262)" (2.17) Bend="Line 18" [Line 18] (0.0) CalledNum=5144983030 () CallingNum=262 (Mike Cote) Internal=0 Time=6878 AState=Dialled
4150025mS CD: CALL: 0.1221.0 Deleted
4150027mS CMCallEvt: 0.1221.0 -1 Mike Cote.0: StateChange: END=X CMCSDialled->CMCSCompletedTone
4150028mS Sip: 18.1223.0 -1 SIPTrunk Endpoint(f4ffdaf8) KeepDlgOnCmCallLost SIPDialog::FINAL
4150028mS Sip: SIPDialog f4ffdaf8 destroyed, size 0
4150028mS CMCallEvt: 18.1223.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
4150029mS CMCallEvt: END CALL:65 (f5062408)
4150030mS Sip: ~SipTrunkEndpoint 18.1223.0 -1 SIPTrunk Endpoint
4150030mS Stun: ~STUNClient 192.168.150.250:6000
4150030mS Stun: ~STUNClient 192.168.150.250:6001
4150031mS CMCallEvt: 18.1223.0 -1 BaseEP: DELETE CMEndpoint f4ffeff0 TOTAL NOW=1 CALL_LIST=0
4150032mS CMMap: a=21.7 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 5, total 8
4150032mS CMMap: a=21.7 b=1.255 T
4150032mS CMMap: a=21.7 b=2.17 M22
4150033mS CMMap: a=2.18 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 0, total 20
4150916mS PRN: No Transport for 4546300a
4150916mS PRN: IKEfindPolicy: Don't know peer
4150916mS PRN: IKE:rcsIKEMessage Problem processing peer message
********** Warning: Logging to Screen Stopped **********