[Frage] Audiocodes MP-114 und Telekom

zone42

Neuer User
Mitglied seit
20 Jul 2016
Beiträge
9
Punkte für Reaktionen
0
Punkte
1
Ich habe vor, ein MP-114 zu nutzen, um meine alte analoge DECT-Anlage am IP-only-Anschluss der Telekom weiter zu nutzen.

Hat jemand damit Erfahrungen oder sogar Konfigurationsempfehlungen?
 
Mit viel hin und her habe ich es jetzt fast am laufen. INI-Datei könnte ich bei Bedarf auch bereitstellen.

Allerdings nur fast!

Ausgehende Rufe funktionieren scheinbar problemlos. Bei eingehenden Rufen habe ich allerdings ein komisches Problem. Es klingelt korrekt. Wenn dann abgenommen wird, hört der Anrufer weiterhin ein Klingelzeichen. Am internen Gerät gibt's ein Besetztzeichen.

Jemand eine Idee, was da los sein könnte?
 
Woher sollen wir das denn wissen, zuwenig Info, Glaskugel?
 
Ich hätte hier die syslogs einer Session. Die externe Nummer +4917655yyyyyy macht einen Anruf an meine Nummer 03044xxxxxx. Wie gesagt, intern wird abgehoben und man hat ein Besetztzeichen. Extern hört man es weiter klingeln.

Code:
2016-09-25T16:25:30.150780+02:00 mp114.deck2.zone42.org (      lgr_flow)(4468      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:28]
2016-09-25T16:25:30.157357+02:00 mp114.deck2.zone42.org (      lgr_flow)(4470      )  |       | new GetNewSIPCall created - #6 [Time: 15:25:28]
2016-09-25T16:25:30.158190+02:00 mp114.deck2.zone42.org (     sip_stack)(4471      )  new AcSIPCallAPI created - #0 [Time: 15:25:28]
2016-09-25T16:25:30.159217+02:00 mp114.deck2.zone42.org (  lgr_stk_mngr)(4472      )  Resource StackSession <#0> Allocated [Time: 15:25:28]
2016-09-25T16:25:30.162113+02:00 mp114.deck2.zone42.org (      lgr_flow)(4473      )  |       |(SIPTU#6)INVITE State:Idle() [Time: 15:25:28]
2016-09-25T16:25:30.163752+02:00 mp114.deck2.zone42.org (     sip_stack)(4474      )  SIPCall(#6) changes state from Idle to Invited [Time: 15:25:28]
2016-09-25T16:25:30.166172+02:00 mp114.deck2.zone42.org (      lgr_flow)(4475      )  |       |       |       #0:SIP_SETUP_EV(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.167623+02:00 mp114.deck2.zone42.org (     lgr_callf)(4476      )  new Call created - #0 [Time: 15:25:28]
2016-09-25T16:25:30.168842+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4477      )  SIPStackSession::HandleStackSetupEV - NEWCALL: SrcPN=0 [Time: 15:25:28]
2016-09-25T16:25:30.171208+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4478      )  <SESSION #0> SendToCall - event: NEW_CALL_EV  m_Call = 31403512 [Time: 15:25:28]
2016-09-25T16:25:30.171994+02:00 mp114.deck2.zone42.org (      lgr_flow)(4479      )  |       |       #0:NEW_CALL_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.172793+02:00 mp114.deck2.zone42.org (      lgr_flow)(4480      )  |       |       #0:Call changing states from:IdleState to:NewCallState_IP2Tel [Time: 15:25:28]
2016-09-25T16:25:30.173997+02:00 mp114.deck2.zone42.org (       lgr_num)(4481      ) ?? [WARNING] PhoneNumber::RemovePrefix - Trying to remove 12 more then number length 03044xxxxxx [Time: 15:25:28]
2016-09-25T16:25:30.174773+02:00 mp114.deck2.zone42.org (       lgr_num)(4482      )  PhoneNumber::RemovePrefix - Number change from 03044xxxxxx to  [Time: 15:25:28]
2016-09-25T16:25:30.175554+02:00 mp114.deck2.zone42.org (       lgr_num)(4483      )  PhoneNumber::AddPrefix - Number change from  to 03044xxxxxx [Time: 15:25:28]
2016-09-25T16:25:30.176343+02:00 mp114.deck2.zone42.org (      lgr_flow)(4484      )  ServicesMngr::GetEndPoint PhoneNum = 03044xxxxxx#012 [Time: 15:25:28]
2016-09-25T16:25:30.177271+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4485      )  MotherBoard::GetTrunkGroupId - No entry found for: DstNum:03044xxxxxx SrcNum:+4917655yyyyyy SrcIp:d9001764 go to default [Time: 15:25:28]
2016-09-25T16:25:30.180387+02:00 mp114.deck2.zone42.org (      lgr_call)(4486      )  Call::SetCoderListForCall #0 Found 3 Common Coders For Call [Time: 15:25:28]
2016-09-25T16:25:30.181186+02:00 mp114.deck2.zone42.org (      lgr_call)(4487      )  <Call #0> Coder g711Alaw64k20 : 20 [Time: 15:25:28]
2016-09-25T16:25:30.181923+02:00 mp114.deck2.zone42.org (      lgr_call)(4488      )  <Call #0> Coder g711Ulaw64k20 : 20 [Time: 15:25:28]
2016-09-25T16:25:30.182690+02:00 mp114.deck2.zone42.org (      lgr_call)(4489      )  <Call #0> Coder g729wAnnexB20 : 20 [Time: 15:25:28]
2016-09-25T16:25:30.183783+02:00 mp114.deck2.zone42.org ( lgr_profiling)(4490      )  <Call 0> Profiled<Tel=0,Ip=0>: JBMinDel=10 JBOptF=10 EEarlyM=1 FaxTM=1 IPDS=46 IsFaxU=2 PI2IP=-1 SigIPDF=40 CNGMode=0 DTMFUsed=0 NSEMode=0 PlayRBTone2IP=0 RBUdpPort=0 RTPRD=0 SCE=0 VxxTT=2 Dst2Rdrt=0 DTMFVol=20 ECE=1 ECurDis=0 EDigDel=0 ERevP=0 FHPer=700 InG=32 MWIA=0 MWID=0 VVol=33 ReorderTime=255 DIDWink=0 2StageDial=1 DiscOnBusyT=1 DiscOnBrok=1 [Time: 15:25:28]
2016-09-25T16:25:30.184637+02:00 mp114.deck2.zone42.org (      lgr_call)(4491      )  |       |       #0GetNextUI:GlobalUI=1005630112, mACAddrLsb=1026372 [Time: 15:25:28]
2016-09-25T16:25:30.186206+02:00 mp114.deck2.zone42.org (      lgr_call)(4492      )  |       |       #0GetNextUI:GlobalUI=1005630113 [Time: 15:25:28]
2016-09-25T16:25:30.187028+02:00 mp114.deck2.zone42.org (      lgr_flow)(4493      )  |       #0:NEW_CALL_EV   : (p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.190692+02:00 mp114.deck2.zone42.org (     sip_stack)(4494      )  SIPSDPSession#0 - Changing state from SIP_MEDIA_IDLE to SIP_MEDIA_OFFERED [Time: 15:25:28]
2016-09-25T16:25:30.191945+02:00 mp114.deck2.zone42.org (      lgr_flow)(4495      )  |       |(SIPTU#6)TRYING_REQ State:Invited(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.193624+02:00 mp114.deck2.zone42.org (      lgr_flow)(4496      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:28]
2016-09-25T16:25:30.194621+02:00 mp114.deck2.zone42.org SIP/2.0 100 Trying#015#012Via: SIP/2.0/UDP 217.0.23.100:5060;branch=z9hG4bKg3Zqkv7iymr5urhrfm6hxh62ek4ms9qdj#015#012From: <sip:[email protected];user=phone>;tag=h7g4Esbg_p65554t1474813530m55007c642834268s1_3364994906-407543228#015#012To: +493044xxxxxx <sip:[email protected];user=phone>;tag=1c1287023884#015#012Call-ID: p65554t1474813530m55007c642834268s2#015#012CSeq: 1 INVITE#015#012Supported: em,timer,replaces,path,early-session,resource-priority#015#012Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE#015#012Server: Audiocodes-Sip-Gateway-MP-114 FXS_FXO/v.5.60A.034.001#015#012Content-Length: 0#015#012#015#012 [Time: 15:25:28]
2016-09-25T16:25:30.196115+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4498      )  SIPStackSession::HandleStackSetupEV - SETUP: SrcPN=0 [Time: 15:25:28]
2016-09-25T16:25:30.197738+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4499      )  <SESSION #0> SendToCall - event: SETUP_EV  m_Call = 31403512 [Time: 15:25:28]
2016-09-25T16:25:30.200610+02:00 mp114.deck2.zone42.org (      lgr_flow)(4500      )  |       |       #0:SETUP (TO:03044xxxxxx, FROM:+4917655yyyyyy):(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.201616+02:00 mp114.deck2.zone42.org (      lgr_stun)(4501      )  gwSTUN Send simple Request for port 6000 [id=16] [Time: 15:25:28]
2016-09-25T16:25:30.202991+02:00 mp114.deck2.zone42.org (      lgr_stun)(4502      )  gwSTUN Send simple Request for port 6001 [id=16] [Time: 15:25:28]
2016-09-25T16:25:30.204338+02:00 mp114.deck2.zone42.org (      lgr_stun)(4503      )  gwSTUN Send simple Request for port 6002 [id=16] [Time: 15:25:28]
2016-09-25T16:25:30.205692+02:00 mp114.deck2.zone42.org (      lgr_stun)(4504      )  gwSTUN Send simple Request for port 6004 [id=16] [Time: 15:25:28]
2016-09-25T16:25:30.207047+02:00 mp114.deck2.zone42.org (      lgr_stun)(4505      )  gwSTUN Send simple Request for port 6005 [id=16] [Time: 15:25:28]
2016-09-25T16:25:30.217695+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6000 PType=9] (   lgr_psbrdex)(4506      )  InsertCoreEvent- event 97 [Time: 15:25:28]
2016-09-25T16:25:30.219388+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6001 PType=9] (   lgr_psbrdex)(4507      )  InsertCoreEvent- event 97 [Time: 15:25:28]
2016-09-25T16:25:30.221182+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6002 PType=9] (   lgr_psbrdex)(4508      )  InsertCoreEvent- event 97 [Time: 15:25:28]
2016-09-25T16:25:30.222696+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6004 PType=9] (   lgr_psbrdex)(4509      )  InsertCoreEvent- event 97 [Time: 15:25:28]
2016-09-25T16:25:30.224507+02:00 mp114.deck2.zone42.org (      lgr_stun)(4510      )  CallStun mapped Internal-Port:6000 to Mapped-Port:6000 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:28]
2016-09-25T16:25:30.225588+02:00 mp114.deck2.zone42.org (      lgr_stun)(4511      )  CallStun mapped Internal-Port:6001 to Mapped-Port:6001 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:28]
2016-09-25T16:25:30.226663+02:00 mp114.deck2.zone42.org (      lgr_stun)(4512      )  CallStun mapped Internal-Port:6002 to Mapped-Port:6002 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:28]
2016-09-25T16:25:30.227798+02:00 mp114.deck2.zone42.org (      lgr_stun)(4513      )  CallStun mapped Internal-Port:6004 to Mapped-Port:6004 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:28]
2016-09-25T16:25:30.229257+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6005 PType=9] (   lgr_psbrdex)(4514      )  InsertCoreEvent- event 97 [Time: 15:25:28]
2016-09-25T16:25:30.231524+02:00 mp114.deck2.zone42.org (      lgr_stun)(4515      )  CallStun mapped Internal-Port:6005 to Mapped-Port:6005 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:28]
2016-09-25T16:25:30.232358+02:00 mp114.deck2.zone42.org (      lgr_call)(4516      )  <0> CallStun: send the suspended setup#012 [Time: 15:25:28]
2016-09-25T16:25:30.233291+02:00 mp114.deck2.zone42.org (      lgr_flow)(4517      )  |       |       #0:Call changing states from:NewCallState_IP2Tel to:InitiatedState_IP2Tel [Time: 15:25:28]
2016-09-25T16:25:30.234162+02:00 mp114.deck2.zone42.org (      lgr_flow)(4518      )  |       #0:SETUP_EV   : (p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.235423+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4519      )  UpdateChannelParams, Channel 0 #012 [Time: 15:25:28]
2016-09-25T16:25:30.236379+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4520      )  #0:PSOSBoardInterface::ConfigureFaxModemChannelParams FAXTransportType=3 Modem configuration VxxTransportType=2 not allowed, forced to 3#012 [Time: 15:25:28]
2016-09-25T16:25:30.237414+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4521      )  #0:ConfigFaxModemChannelParams NSEMode=0, CNGDetMode=0, FAXTranType=3, VxxTranType=3, VoiceVol= 1, DTMFVol=-11, InGain=0, RTPRedDepth=0, ECE=1, SCE=0, ECNlpMode=0, DJBufMinDelay=10, DJBufOptFac=10) [Time: 15:25:28]
2016-09-25T16:25:30.240019+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4522      )  #0:GenerateRing: ChannelNum=0 RingType:0 [Time: 15:25:28]
2016-09-25T16:25:30.240891+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4523      )  Send::CallerID Name=, Number=+4917655yyyyyy, Time=1525, Date=0925 [Time: 15:25:28]
2016-09-25T16:25:30.241919+02:00 mp114.deck2.zone42.org (      lgr_flow)(4524      )  |       #0:ALERT_EV (send)  : (p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.242759+02:00 mp114.deck2.zone42.org (      lgr_flow)(4525      )  |       |       #0:ALERT_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.243607+02:00 mp114.deck2.zone42.org (      lgr_flow)(4526      )  |       |       #0:Call changing states from:InitiatedState_IP2Tel to:AlertingState_IP2Tel [Time: 15:25:28]
2016-09-25T16:25:30.244550+02:00 mp114.deck2.zone42.org (      lgr_flow)(4527      )  |       |       |       #0:ALERT_EV(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.245572+02:00 mp114.deck2.zone42.org (      lgr_flow)(4528      )  |       |(SIPTU#6)ALERT_REQ State:Invited(p65554t1474813530m55007c642834268s2) [Time: 15:25:28]
2016-09-25T16:25:30.251625+02:00 mp114.deck2.zone42.org (      lgr_flow)(4529      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:28]
2016-09-25T16:25:30.252626+02:00 mp114.deck2.zone42.org SIP/2.0 180 Ringing#015#012Via: SIP/2.0/UDP 217.0.23.100:5060;branch=z9hG4bKg3Zqkv7iymr5urhrfm6hxh62ek4ms9qdj#015#012From: <sip:[email protected];user=phone>;tag=h7g4Esbg_p65554t1474813530m55007c642834268s1_3364994906-407543228#015#012To: +493044xxxxxx <sip:[email protected];user=phone>;tag=1c1287023884#015#012Call-ID: p65554t1474813530m55007c642834268s2#015#012CSeq: 1 INVITE#015#012Contact: <sip:[email protected]:5060>#015#012Record-Route: <sip:217.0.23.100;transport=udp;lr>#015#012Supported: em,timer,replaces,path,early-session,resource-priority#015#012Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE#015#012Server: Audiocodes-Sip-Gateway-MP-114 FXS_FXO/v.5.60A.034.001#015#012Content-Length: 0#015#012#015#012 [Time: 15:25:28]
2016-09-25T16:25:33.351900+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4531      )  recv <-- EV_CALLER_ID_END CID:0 Status <0 - Success>  [Time: 15:25:31]
2016-09-25T16:25:33.374049+02:00 mp114.deck2.zone42.org (      lgr_flow)(4532      )  #0:CALLER_ID_END_EV [Time: 15:25:31]
2016-09-25T16:25:33.375054+02:00 mp114.deck2.zone42.org (      lgr_flow)(4533      )  |       #0:CALLER_ID_END_EV [Time: 15:25:31]
2016-09-25T16:25:33.375898+02:00 mp114.deck2.zone42.org (      lgr_flow)(4534      )  |       #0:OPEN_VOICE-NOT_READY (MS:0, HS:0, Ready:1) [Time: 15:25:31]
2016-09-25T16:25:37.999995+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4535      )  recv <-- OFF_HOOK Ch:0 [Time: 15:25:36]
2016-09-25T16:25:38.003229+02:00 mp114.deck2.zone42.org (      lgr_flow)(4536      )  #0:OFF_HOOK_EV [Time: 15:25:36]
2016-09-25T16:25:38.003996+02:00 mp114.deck2.zone42.org (      lgr_flow)(4537      )  |       #0:OFF_HOOK_EV [Time: 15:25:36]
2016-09-25T16:25:38.005009+02:00 mp114.deck2.zone42.org (      lgr_flow)(4538      )  |       #0:OPEN_VOICE-NOT_READY (MS:0, HS:0, Ready:1) [Time: 15:25:36]
2016-09-25T16:25:38.005805+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4539      )  #0:PSOSBoardInterface::StopPlayTone- Called [Time: 15:25:36]
2016-09-25T16:25:38.006761+02:00 mp114.deck2.zone42.org (      lgr_flow)(4540      )  |       #0:CONNECT_EV (send)  : (p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.007661+02:00 mp114.deck2.zone42.org (      lgr_flow)(4541      )  |       |       #0:CONNECT_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.010373+02:00 mp114.deck2.zone42.org (      lgr_flow)(4542      )  |       |       #0:Call changing states from:AlertingState_IP2Tel to:ConnectedState [Time: 15:25:36]
2016-09-25T16:25:38.011570+02:00 mp114.deck2.zone42.org (      lgr_flow)(4543      )  |       |       |       #0:CONNECT_EV(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.012552+02:00 mp114.deck2.zone42.org (     sip_stack)(4544      )  SIPSDPSession#0 - Changing state from SIP_MEDIA_OFFERED to SIP_MEDIA_COMPLETED [Time: 15:25:36]
2016-09-25T16:25:38.014002+02:00 mp114.deck2.zone42.org (      lgr_flow)(4545      )  |       |(SIPTU#6)CONNECT_REQ State:Invited(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.016373+02:00 mp114.deck2.zone42.org (      lgr_flow)(4546      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.017677+02:00 mp114.deck2.zone42.org SIP/2.0 200 OK#015#012Via: SIP/2.0/UDP 217.0.23.100:5060;branch=z9hG4bKg3Zqkv7iymr5urhrfm6hxh62ek4ms9qdj#015#012From: <sip:[email protected];user=phone>;tag=h7g4Esbg_p65554t1474813530m55007c642834268s1_3364994906-407543228#015#012To: +493044xxxxxx <sip:[email protected];user=phone>;tag=1c1287023884#015#012Call-ID: p65554t1474813530m55007c642834268s2#015#012CSeq: 1 INVITE#015#012Contact: <sip:[email protected]:5060>#015#012Record-Route: <sip:217.0.23.100;transport=udp;lr>#015#012Supported: em,replaces,path,early-session,resource-priority#015#012Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE#015#012Require: timer#015#012Session-Expires: 1800;refresher=uas#015#012Min-SE: 900#015#012Server: Audiocodes-Sip-Gateway-MP-114 FXS_FXO/v.5.60A.034.001#015#012Content-Type: application/sdp#015#012Content-Length: 257#015#012#015#012v=0#015#012o=AudiocodesGW 1287087360 1287087241 IN IP4 91.46.218.203#015#012s=Phone-Call#015#012c=IN IP4 91.46.218.203#015#012t=0 0#015#012m=audio 6000 RTP/AVP 8 96#015#012c=IN IP4 172.16.100.147#015#012a=rtpmap:8 PCMA/8000#015#012a=rtpmap:96 telephone-event/8000#015#012a=fmtp:96 0-15#015#012a=ptime:20#015#012a=sendrecv#015#012 [Time: 15:25:36]
2016-09-25T16:25:38.020318+02:00 mp114.deck2.zone42.org (     sip_stack)(4548      )  #012UdpRtxMngr::Transmit 200 Response 1 INVITE Rtx Left: 6 Dest: 217.0.23.100:5060 CallID: (p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.021775+02:00 mp114.deck2.zone42.org (     sip_stack)(4549      )  SIPCall(#6) changes state from Invited to LocalAccepted [Time: 15:25:36]
2016-09-25T16:25:38.022870+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4550      )  DtmfCapNegotiationAlgorithm :: TxDtmfMethod = DTMF_RFC2833_SUPPORTED [Time: 15:25:36]
2016-09-25T16:25:38.023796+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4551      )  DtmfCapNegotiationAlgorithm :: TxRtpRfc2833Payload = 96 [Time: 15:25:36]
2016-09-25T16:25:38.025342+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4552      )  <SESSION #0> SendToCall - event: DTMF_CONTROL_EV  m_Call = 31403512 [Time: 15:25:36]
2016-09-25T16:25:38.026129+02:00 mp114.deck2.zone42.org (      lgr_flow)(4553      )  |       |       #0:DTMF_CONTROL_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.026972+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4554      )  <SESSION #0> SendToCall - event: OPEN_LOGICAL_CHANNEL_ACK_EV  m_Call = 31403512 [Time: 15:25:36]
2016-09-25T16:25:38.027859+02:00 mp114.deck2.zone42.org (      lgr_flow)(4555      )  |       |       #0:OPEN_LOGICAL_CHANNEL_ACK_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.030752+02:00 mp114.deck2.zone42.org (      lgr_flow)(4556      )  |       #0:OPEN_LOGICAL_CHANNEL_ACK_EV   : (p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.031999+02:00 mp114.deck2.zone42.org (      lgr_flow)(4557      )  |       #0:OPEN_VOICE (IP:217.0.5.103, RTP:13140, RTCP:13141, VoiceCoder:g711Alaw64k20, VbdCoder: InvalidCoder255, Dtmf:gwRFC2833RalayDTMF,Rx payload:96,Tx payload:96 ,RTPmode:1, FaxTransportType: 3,AVoIPMediaType: gwMediaTypeAudioOnly) [Time: 15:25:36]
2016-09-25T16:25:38.033105+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4558      )  #0:ActivateChannel: Socks=14 CID=0 Trunk:-1 BChannel:0 RemoteIP=217.0.5.103 RemotePort=13140 RemoteT38IP= RemoteT38Port=0 RemoteRTCPIP=217.0.5.103 RemoteRTCPPort=13141 FaxModemDet=NO_FAX_MODEM_DETECTED [Time: 15:25:36]
2016-09-25T16:25:38.033957+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4559      )  Open channel: IsVoiceOn: 1, IsT38On: 0, IsVbdOn: 0, IsVideoOn: 0 [Time: 15:25:36]
2016-09-25T16:25:38.034853+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4560      )  #0:OpenChannel:on Trunk -1 BChannel:0 CID=0 with VoiceCoder: g711Alaw64k20 VbdCoder: InvalidCoder255 DetectorSide: 0 FaxModemDet NO_FAX_MODEM_DETECTED [Time: 15:25:36]
2016-09-25T16:25:38.035738+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4561      )  #0:OpenChannel VoiceVolume= 1, DTMFVolume = -11, InputGain = 0, RTPRedundancyDepth = 0 FlashHookPeriod = 700 AgcCmd = 0x13180000#012 [Time: 15:25:36]
2016-09-25T16:25:38.037497+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4562      )  OpenChannel, CoderType = 0, Interval = 3, M = 1#012 [Time: 15:25:36]
2016-09-25T16:25:38.039014+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4563      )  #0:FAXTransportType = 3 [Time: 15:25:36]
2016-09-25T16:25:38.039919+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4564      )  #0:PSOSBoardInterface::ConfigureFaxModemChannelParams FAXTransportType=3 Modem configuration VxxTransportType=2 not allowed, forced to 3#012 [Time: 15:25:36]
2016-09-25T16:25:38.040885+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4565      )  #0:ConfigFaxModemChannelParams NSEMode=0, CNGDetMode=0, FAXTranType=3, VxxTranType=3, VoiceVol= 1, DTMFVol=-11, InGain=0, RTPRedDepth=0, ECE=1, SCE=0, ECNlpMode=0, DJBufMinDelay=10, DJBufOptFac=10) [Time: 15:25:36]
2016-09-25T16:25:38.041747+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4566      )  Detectors: Amd:On=0,Diretion=0, Ans:On=0,Direction=0 En:On=0,Direction=0 Board IBScmd:0xa1 [Time: 15:25:36]
2016-09-25T16:25:38.043293+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4567      )  PCIIFChangeChannelParams failed  RFC2833_PT [Time: 15:25:36]
2016-09-25T16:25:38.046856+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4568      )  Setting ActivateRTP_RTCPCmd.Cmd.IpTosFieldInUdpPacket to 184 [Time: 15:25:36]
2016-09-25T16:25:38.051397+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4569      )  #0:ActivateChannel:RtpPayload: 8 [Time: 15:25:36]
2016-09-25T16:25:38.174436+02:00 mp114.deck2.zone42.org (      lgr_flow)(4570      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.179705+02:00 mp114.deck2.zone42.org (     sip_stack)(4572      )  UdpRtxMngr::Remove 200 Response 1 INVITE [Time: 15:25:36]
2016-09-25T16:25:38.180568+02:00 mp114.deck2.zone42.org (      lgr_flow)(4573      )  |       |(SIPTU#6)ACK State:LocalAccepted(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.181639+02:00 mp114.deck2.zone42.org (     sip_stack)(4574      )  SIPCall(#6) changes state from LocalAccepted to Connected [Time: 15:25:36]
2016-09-25T16:25:38.183387+02:00 mp114.deck2.zone42.org (      lgr_flow)(4575      )  |       |       |       #0:SIP_ACK_EV(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.186170+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4576      )  <SESSION #0> SendToCall - event: CONNECT_ACK_EV  m_Call = 31403512 [Time: 15:25:36]
2016-09-25T16:25:38.187042+02:00 mp114.deck2.zone42.org (      lgr_flow)(4577      )  |       |       #0:CONNECT_ACK_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.187925+02:00 mp114.deck2.zone42.org (      lgr_flow)(4578      )  |       #0:CONNECT_ACK_EV   : (p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.189713+02:00 mp114.deck2.zone42.org (      lgr_flow)(4579      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.196867+02:00 mp114.deck2.zone42.org (      lgr_flow)(4581      )  |       |(SIPTU#6)BYE State:Connected(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.197957+02:00 mp114.deck2.zone42.org (     sip_stack)(4582      )  SIPCall(#6) changes state from Connected to Disconnected [Time: 15:25:36]
2016-09-25T16:25:38.199575+02:00 mp114.deck2.zone42.org (      lgr_flow)(4583      )  |       |       |       #0:SIP_DISCONNECT_EV(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.200457+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4584      )  <SESSION #0> SendToCall - event: RELEASE_EV  m_Call = 31403512 [Time: 15:25:36]
2016-09-25T16:25:38.201249+02:00 mp114.deck2.zone42.org (      lgr_flow)(4585      )  |       |       #0:RELEASE_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.202057+02:00 mp114.deck2.zone42.org (      lgr_flow)(4586      )  |       |       #0:Call changing states from:ConnectedState to:DisconnectingState [Time: 15:25:36]
2016-09-25T16:25:38.203266+02:00 mp114.deck2.zone42.org (      lgr_flow)(4587      )  |       |       #0:RELEASE_ACK_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.206073+02:00 mp114.deck2.zone42.org (      lgr_flow)(4588      )  |       #0:RELEASE_EV  GWAPP_NORMAL_CALL_CLEAR : (p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.206914+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4589      )  #0:PSOSBoardInterface::StopPlayTone- Called [Time: 15:25:36]
2016-09-25T16:25:38.207676+02:00 mp114.deck2.zone42.org (      lgr_flow)(4590      )  |       #0:Close voice Channel [Time: 15:25:36]
2016-09-25T16:25:38.208420+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4591      )  #0:StopRTP_RTCP on channel 0 [Time: 15:25:36]
2016-09-25T16:25:38.209801+02:00 mp114.deck2.zone42.org (      lgr_flow)(4592      )  |       #0:RELEASE_ACK_EV (send)  : (p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.210648+02:00 mp114.deck2.zone42.org (      lgr_flow)(4593      )  |       |       #0:RELEASE_ACK_EV:(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.211519+02:00 mp114.deck2.zone42.org (      lgr_flow)(4594      )  |       |       |       #0:RELEASE_ACK_EV(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.212407+02:00 mp114.deck2.zone42.org (      lgr_flow)(4595      )  |       |(SIPTU#6)DISCONNECT_RESPONSE State:Disconnected(p65554t1474813530m55007c642834268s2) [Time: 15:25:36]
2016-09-25T16:25:38.216235+02:00 mp114.deck2.zone42.org (      lgr_flow)(4596      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.217225+02:00 mp114.deck2.zone42.org SIP/2.0 200 OK#015#012Via: SIP/2.0/UDP 217.0.23.100:5060;branch=z9hG4bKg3Zqkv7imh4kgt3ry7w4tv2s6jie4licw#015#012From: <sip:[email protected];user=phone>;tag=h7g4Esbg_p65554t1474813530m55007c642834268s1_3364994906-407543228#015#012To: +493044xxxxxx <sip:[email protected];user=phone>;tag=1c1287023884#015#012Call-ID: p65554t1474813530m55007c642834268s2#015#012CSeq: 2 BYE#015#012Contact: <sip:[email protected]:5060>#015#012Supported: em,timer,replaces,path,early-session,resource-priority#015#012Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE#015#012Server: Audiocodes-Sip-Gateway-MP-114 FXS_FXO/v.5.60A.034.001#015#012Content-Length: 0#015#012#015#012 [Time: 15:25:36]
2016-09-25T16:25:38.218807+02:00 mp114.deck2.zone42.org (     sip_stack)(4598      )  AcSIPStackAPI::FreeCallAPI - #0 [Time: 15:25:36]
2016-09-25T16:25:38.219567+02:00 mp114.deck2.zone42.org (     sip_stack)(4599      )  Setting ApplicationCall of AcSIPCall 30816928 to NULL [Time: 15:25:36]
2016-09-25T16:25:38.221168+02:00 mp114.deck2.zone42.org (  lgr_stk_mngr)(4600      )  Resource StackSession <#0> Deleted [Time: 15:25:36]
2016-09-25T16:25:38.222071+02:00 mp114.deck2.zone42.org (     lgr_callf)(4601      )  Call #0 deleted [Time: 15:25:36]
2016-09-25T16:25:38.222974+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4602      )  #0:cpDigitMapHndlr_Stop - Stoped (0) [Time: 15:25:36]
2016-09-25T16:25:38.223870+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4603      )  #0:CloseChannel: ChannelNum=0 [Time: 15:25:36]
2016-09-25T16:25:38.227346+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4604      )  Open channel: IsVoiceOn: 1, IsT38On: 0, IsVbdOn: 0, IsVideoOn: 0 [Time: 15:25:36]
2016-09-25T16:25:38.228281+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4605      )  #0:OpenChannel:on Trunk -1 BChannel:0 CID=0 with VoiceCoder: g711Alaw64k20 VbdCoder: InvalidCoder255 DetectorSide: 0 FaxModemDet NO_FAX_MODEM_DETECTED [Time: 15:25:36]
2016-09-25T16:25:38.229154+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4606      )  #0:OpenChannel VoiceVolume= 1, DTMFVolume = -11, InputGain = 0, RTPRedundancyDepth = 0 FlashHookPeriod = 700 AgcCmd = 0x13180000#012 [Time: 15:25:36]
2016-09-25T16:25:38.229977+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4607      )  OpenChannel, CoderType = 0, Interval = 3, M = 1#012 [Time: 15:25:36]
2016-09-25T16:25:38.230674+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4608      )  #0:FAXTransportType = 3 [Time: 15:25:36]
2016-09-25T16:25:38.231521+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4609      )  #0:PSOSBoardInterface::ConfigureFaxModemChannelParams FAXTransportType=3 Modem configuration VxxTransportType=2 not allowed, forced to 3#012 [Time: 15:25:36]
2016-09-25T16:25:38.232468+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4610      )  #0:ConfigFaxModemChannelParams NSEMode=0, CNGDetMode=0, FAXTranType=3, VxxTranType=3, VoiceVol= 1, DTMFVol=-11, InGain=0, RTPRedDepth=0, ECE=1, SCE=0, ECNlpMode=0, DJBufMinDelay=10, DJBufOptFac=10) [Time: 15:25:36]
2016-09-25T16:25:38.235166+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4611      )  Detectors: Amd:On=0,Diretion=0, Ans:On=0,Direction=0 En:On=0,Direction=0 Board IBScmd:0xa1 [Time: 15:25:36]
2016-09-25T16:25:38.237894+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4612      )  #0:PSOSBoardInterface::PlayTone - Called Tone=REORDER_TONE Direction=PLAY_TONE_2_TEL [Time: 15:25:36]
2016-09-25T16:25:38.374338+02:00 mp114.deck2.zone42.org (      lgr_flow)(4613      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.382426+02:00 mp114.deck2.zone42.org (      lgr_flow)(4615      )  |       | new GetNewSIPCall created - #5 [Time: 15:25:36]
2016-09-25T16:25:38.383244+02:00 mp114.deck2.zone42.org (     sip_stack)(4616      )  new AcSIPCallAPI created - #7 [Time: 15:25:36]
2016-09-25T16:25:38.384174+02:00 mp114.deck2.zone42.org (  lgr_stk_mngr)(4617      )  Resource StackSession <#7> Allocated [Time: 15:25:36]
2016-09-25T16:25:38.385545+02:00 mp114.deck2.zone42.org (      lgr_flow)(4618      )  |       |(SIPTU#5)INVITE State:Idle() [Time: 15:25:36]
2016-09-25T16:25:38.387217+02:00 mp114.deck2.zone42.org (     sip_stack)(4619      )  SIPCall(#5) changes state from Idle to Invited [Time: 15:25:36]
2016-09-25T16:25:38.389675+02:00 mp114.deck2.zone42.org (      lgr_flow)(4620      )  |       |       |       #7:SIP_SETUP_EV(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.392716+02:00 mp114.deck2.zone42.org (     lgr_callf)(4621      )  new Call created - #7 [Time: 15:25:36]
2016-09-25T16:25:38.393848+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4622      )  SIPStackSession::HandleStackSetupEV - NEWCALL: SrcPN=0 [Time: 15:25:36]
2016-09-25T16:25:38.394738+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4623      )  <SESSION #7> SendToCall - event: NEW_CALL_EV  m_Call = 31428936 [Time: 15:25:36]
2016-09-25T16:25:38.395535+02:00 mp114.deck2.zone42.org (      lgr_flow)(4624      )  |       |       #7:NEW_CALL_EV:(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.396334+02:00 mp114.deck2.zone42.org (      lgr_flow)(4625      )  |       |       #7:Call changing states from:IdleState to:NewCallState_IP2Tel [Time: 15:25:36]
2016-09-25T16:25:38.397336+02:00 mp114.deck2.zone42.org (       lgr_num)(4626      ) ?? [WARNING] PhoneNumber::RemovePrefix - Trying to remove 12 more then number length 03044xxxxxx [Time: 15:25:36]
2016-09-25T16:25:38.398108+02:00 mp114.deck2.zone42.org (       lgr_num)(4627      )  PhoneNumber::RemovePrefix - Number change from 03044xxxxxx to  [Time: 15:25:36]
2016-09-25T16:25:38.398957+02:00 mp114.deck2.zone42.org (       lgr_num)(4628      )  PhoneNumber::AddPrefix - Number change from  to 03044xxxxxx [Time: 15:25:36]
2016-09-25T16:25:38.402197+02:00 mp114.deck2.zone42.org (      lgr_flow)(4629      )  ServicesMngr::GetEndPoint PhoneNum = 03044xxxxxx#012 [Time: 15:25:36]
2016-09-25T16:25:38.403162+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4630      )  MotherBoard::GetTrunkGroupId - No entry found for: DstNum:03044xxxxxx SrcNum:+4917655yyyyyy SrcIp:d9001764 go to default [Time: 15:25:36]
2016-09-25T16:25:38.404351+02:00 mp114.deck2.zone42.org (      lgr_call)(4631      )  Call::SetCoderListForCall #7 Found 3 Common Coders For Call [Time: 15:25:36]
2016-09-25T16:25:38.405118+02:00 mp114.deck2.zone42.org (      lgr_call)(4632      )  <Call #7> Coder g711Alaw64k20 : 20 [Time: 15:25:36]
2016-09-25T16:25:38.405883+02:00 mp114.deck2.zone42.org (      lgr_call)(4633      )  <Call #7> Coder g711Ulaw64k20 : 20 [Time: 15:25:36]
2016-09-25T16:25:38.406656+02:00 mp114.deck2.zone42.org (      lgr_call)(4634      )  <Call #7> Coder g729wAnnexB20 : 20 [Time: 15:25:36]
2016-09-25T16:25:38.407751+02:00 mp114.deck2.zone42.org ( lgr_profiling)(4635      )  <Call 7> Profiled<Tel=0,Ip=0>: JBMinDel=10 JBOptF=10 EEarlyM=1 FaxTM=1 IPDS=46 IsFaxU=2 PI2IP=-1 SigIPDF=40 CNGMode=0 DTMFUsed=0 NSEMode=0 PlayRBTone2IP=0 RBUdpPort=0 RTPRD=0 SCE=0 VxxTT=2 Dst2Rdrt=0 DTMFVol=20 ECE=1 ECurDis=0 EDigDel=0 ERevP=0 FHPer=700 InG=32 MWIA=0 MWID=0 VVol=33 ReorderTime=255 DIDWink=0 2StageDial=1 DiscOnBusyT=1 DiscOnBrok=1 [Time: 15:25:36]
2016-09-25T16:25:38.409600+02:00 mp114.deck2.zone42.org (      lgr_call)(4636      )  |       |       #7GetNextUI:GlobalUI=1005630113, mACAddrLsb=1026372 [Time: 15:25:36]
2016-09-25T16:25:38.410877+02:00 mp114.deck2.zone42.org (      lgr_call)(4637      )  |       |       #7GetNextUI:GlobalUI=1005630114 [Time: 15:25:36]
2016-09-25T16:25:38.411697+02:00 mp114.deck2.zone42.org (      lgr_flow)(4638      )  |       #0:NEW_CALL_EV   : (p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.413479+02:00 mp114.deck2.zone42.org (     sip_stack)(4639      )  SIPSDPSession#7 - Changing state from SIP_MEDIA_IDLE to SIP_MEDIA_OFFERED [Time: 15:25:36]
2016-09-25T16:25:38.414711+02:00 mp114.deck2.zone42.org (      lgr_flow)(4640      )  |       |(SIPTU#5)TRYING_REQ State:Invited(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.416403+02:00 mp114.deck2.zone42.org (      lgr_flow)(4641      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.418288+02:00 mp114.deck2.zone42.org SIP/2.0 100 Trying#015#012Via: SIP/2.0/UDP 217.0.23.100:5060;branch=z9hG4bKg3Zqkv7ie3zykzgfnkxbn7rrgecmiuub5#015#012From: <sip:[email protected];user=phone>;tag=h7g4Esbg_p65554t1474813530m55007c642834268s3_3373205915-1949460092#015#012To: +493044xxxxxx <sip:[email protected];user=phone>;tag=1c1307582295#015#012Call-ID: p65554t1474813530m55007c642834268s4#015#012CSeq: 1 INVITE#015#012Supported: em,timer,replaces,path,early-session,resource-priority#015#012Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE#015#012Server: Audiocodes-Sip-Gateway-MP-114 FXS_FXO/v.5.60A.034.001#015#012Content-Length: 0#015#012#015#012 [Time: 15:25:36]
2016-09-25T16:25:38.419808+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4643      )  SIPStackSession::HandleStackSetupEV - SETUP: SrcPN=0 [Time: 15:25:36]
2016-09-25T16:25:38.421819+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4644      )  <SESSION #7> SendToCall - event: SETUP_EV  m_Call = 31428936 [Time: 15:25:36]
2016-09-25T16:25:38.422661+02:00 mp114.deck2.zone42.org (      lgr_flow)(4645      )  |       |       #7:SETUP (TO:03044xxxxxx, FROM:+4917655yyyyyy):(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.424512+02:00 mp114.deck2.zone42.org (      lgr_stun)(4646      )  gwSTUN Send simple Request for port 6000 [id=17] [Time: 15:25:36]
2016-09-25T16:25:38.425877+02:00 mp114.deck2.zone42.org (      lgr_stun)(4647      )  gwSTUN Send simple Request for port 6001 [id=17] [Time: 15:25:36]
2016-09-25T16:25:38.427225+02:00 mp114.deck2.zone42.org (      lgr_stun)(4648      )  gwSTUN Send simple Request for port 6002 [id=17] [Time: 15:25:36]
2016-09-25T16:25:38.428586+02:00 mp114.deck2.zone42.org (      lgr_stun)(4649      )  gwSTUN Send simple Request for port 6004 [id=17] [Time: 15:25:36]
2016-09-25T16:25:38.431577+02:00 mp114.deck2.zone42.org (      lgr_stun)(4650      )  gwSTUN Send simple Request for port 6005 [id=17] [Time: 15:25:36]
2016-09-25T16:25:38.441040+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6000 PType=9] (   lgr_psbrdex)(4651      )  InsertCoreEvent- event 97 [Time: 15:25:36]
2016-09-25T16:25:38.442814+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6001 PType=9] (   lgr_psbrdex)(4652      )  InsertCoreEvent- event 97 [Time: 15:25:36]
2016-09-25T16:25:38.444632+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6002 PType=9] (   lgr_psbrdex)(4653      )  InsertCoreEvent- event 97 [Time: 15:25:36]
2016-09-25T16:25:38.446053+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6004 PType=9] (   lgr_psbrdex)(4654      )  InsertCoreEvent- event 97 [Time: 15:25:36]
2016-09-25T16:25:38.447945+02:00 mp114.deck2.zone42.org [Src=217.0.0.129/3478 Dst=6005 PType=9] (   lgr_psbrdex)(4655      )  InsertCoreEvent- event 97 [Time: 15:25:36]
2016-09-25T16:25:38.450872+02:00 mp114.deck2.zone42.org (      lgr_stun)(4656      )  CallStun mapped Internal-Port:6000 to Mapped-Port:6000 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:36]
2016-09-25T16:25:38.451950+02:00 mp114.deck2.zone42.org (      lgr_stun)(4657      )  CallStun mapped Internal-Port:6001 to Mapped-Port:6001 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:36]
2016-09-25T16:25:38.452999+02:00 mp114.deck2.zone42.org (      lgr_stun)(4658      )  CallStun mapped Internal-Port:6002 to Mapped-Port:6002 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:36]
2016-09-25T16:25:38.454062+02:00 mp114.deck2.zone42.org (      lgr_stun)(4659      )  CallStun mapped Internal-Port:6004 to Mapped-Port:6004 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:36]
2016-09-25T16:25:38.455108+02:00 mp114.deck2.zone42.org (      lgr_stun)(4660      )  CallStun mapped Internal-Port:6005 to Mapped-Port:6005 (In IP:0x1502478 Ex IP:0x1502498 [Time: 15:25:36]
2016-09-25T16:25:38.455934+02:00 mp114.deck2.zone42.org (      lgr_call)(4661      )  <7> CallStun: send the suspended setup#012 [Time: 15:25:36]
2016-09-25T16:25:38.457614+02:00 mp114.deck2.zone42.org (      lgr_flow)(4662      )  |       |       #7:Call changing states from:NewCallState_IP2Tel to:InitiatedState_IP2Tel [Time: 15:25:36]
2016-09-25T16:25:38.458554+02:00 mp114.deck2.zone42.org (      lgr_flow)(4663      )  |       #0:SETUP_EV   : (p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.460450+02:00 mp114.deck2.zone42.org (      lgr_flow)(4664      )  |       #0:RELEASE_EV (send) GWAPP_USER_BUSY : (p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.461373+02:00 mp114.deck2.zone42.org (      lgr_flow)(4665      )  |       |       #7:RELEASE_EV:(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.462228+02:00 mp114.deck2.zone42.org (      lgr_flow)(4666      )  |       |       #7:Call changing states from:InitiatedState_IP2Tel to:DisconnectingState [Time: 15:25:36]
2016-09-25T16:25:38.463349+02:00 mp114.deck2.zone42.org (      lgr_flow)(4667      )  |       |       #7:RELEASE_ACK_EV:(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.464239+02:00 mp114.deck2.zone42.org (      lgr_flow)(4668      )  |       |       |       #7:RELEASE_EV(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.466229+02:00 mp114.deck2.zone42.org (      lgr_flow)(4669      )  |       |(SIPTU#5)DISCONNECT_REQ State:Invited(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.468131+02:00 mp114.deck2.zone42.org (      lgr_flow)(4670      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.470632+02:00 mp114.deck2.zone42.org SIP/2.0 486 Busy Here#015#012Via: SIP/2.0/UDP 217.0.23.100:5060;branch=z9hG4bKg3Zqkv7ie3zykzgfnkxbn7rrgecmiuub5#015#012From: <sip:[email protected];user=phone>;tag=h7g4Esbg_p65554t1474813530m55007c642834268s3_3373205915-1949460092#015#012To: +493044xxxxxx <sip:[email protected];user=phone>;tag=1c1307582295#015#012Call-ID: p65554t1474813530m55007c642834268s4#015#012CSeq: 1 INVITE#015#012Record-Route: <sip:217.0.23.100;transport=udp;lr>#015#012Supported: em,timer,replaces,path,early-session,resource-priority#015#012Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE#015#012Server: Audiocodes-Sip-Gateway-MP-114 FXS_FXO/v.5.60A.034.001#015#012Reason: Q.850 ;cause=17 ;text="local"#015#012Content-Length: 0#015#012#015#012 [Time: 15:25:36]
2016-09-25T16:25:38.471692+02:00 mp114.deck2.zone42.org (     sip_stack)(4672      )  #012UdpRtxMngr::Transmit 486 Response 1 INVITE Rtx Left: 6 Dest: 217.0.23.100:5060 CallID: (p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.473085+02:00 mp114.deck2.zone42.org (     sip_stack)(4673      )  SIPCall(#5) changes state from Invited to Disconnected [Time: 15:25:36]
2016-09-25T16:25:38.474183+02:00 mp114.deck2.zone42.org (   lgr_stk_ses)(4674      )  <SESSION #7> SendToCall - event: RELEASE_ACK_EV  m_Call = 31428936 [Time: 15:25:36]
2016-09-25T16:25:38.475520+02:00 mp114.deck2.zone42.org (      lgr_flow)(4675      )  |       |       #7:RELEASE_ACK_EV:(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.476368+02:00 mp114.deck2.zone42.org (     lgr_callf)(4676      )  Call #7 deleted [Time: 15:25:36]
2016-09-25T16:25:38.477140+02:00 mp114.deck2.zone42.org (     sip_stack)(4677      )  AcSIPStackAPI::FreeCallAPI - #7 [Time: 15:25:36]
2016-09-25T16:25:38.477894+02:00 mp114.deck2.zone42.org (     sip_stack)(4678      )  Setting ApplicationCall of AcSIPCall 30805636 to NULL [Time: 15:25:36]
2016-09-25T16:25:38.479821+02:00 mp114.deck2.zone42.org (  lgr_stk_mngr)(4679      )  Resource StackSession <#7> Deleted [Time: 15:25:36]
2016-09-25T16:25:38.481436+02:00 mp114.deck2.zone42.org (     sip_stack)(4680      )  new AcSIPDialogAPI created - #10 [Time: 15:25:36]
2016-09-25T16:25:38.482456+02:00 mp114.deck2.zone42.org (      lgr_flow)(4681      )  |       | new GetNewIndTransaction created - #10 [Time: 15:25:36]
2016-09-25T16:25:38.483290+02:00 mp114.deck2.zone42.org (      lgr_flow)(4682      )  |       |(SIPTU#10)DIALOG_INIT_REQ State:DialogIdle() [Time: 15:25:36]
2016-09-25T16:25:38.485501+02:00 mp114.deck2.zone42.org (     sip_stack)(4683      )  SIPDialog(#10) changes state from DialogIdle to DialogInitiated [Time: 15:25:36]
2016-09-25T16:25:38.486480+02:00 mp114.deck2.zone42.org (      lgr_flow)(4684      )  |       |(SIPTU#10)GENERAL_REQ State:DialogInitiated([email protected]) [Time: 15:25:36]
2016-09-25T16:25:38.490261+02:00 mp114.deck2.zone42.org (      lgr_flow)(4685      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.492231+02:00 mp114.deck2.zone42.org (     sip_stack)(4687      )  #012UdpRtxMngr::Transmit 69 REGISTER Rtx Left: 6 Dest: 217.0.23.100:5060 CallID: ([email protected]) [Time: 15:25:36]
2016-09-25T16:25:38.499610+02:00 mp114.deck2.zone42.org (      lgr_flow)(4688      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:36]
2016-09-25T16:25:38.503649+02:00 mp114.deck2.zone42.org (     sip_stack)(4690      )  UdpRtxMngr::Remove 486 Response 1 INVITE [Time: 15:25:36]
2016-09-25T16:25:38.504537+02:00 mp114.deck2.zone42.org (      lgr_flow)(4691      )  |       |(SIPTU#5)ACK State:Disconnected(p65554t1474813530m55007c642834268s4) [Time: 15:25:36]
2016-09-25T16:25:38.524363+02:00 mp114.deck2.zone42.org (      lgr_flow)(4692      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:37]
2016-09-25T16:25:38.525532+02:00 mp114.deck2.zone42.org SIP/2.0 423 Interval Too Brief#015#012Via: SIP/2.0/UDP 91.46.218.203;branch=z9hG4bKac1307836096#015#012To: <sip:[email protected]>;tag=kflgm1e9k1p6scqeg6sxm3iqz#015#012From: <sip:[email protected]>;tag=1c1307828689#015#012Call-ID: [email protected]#015#012CSeq: 69 REGISTER#015#012Content-Length: 0#015#012Min-Expires: 480#015#012#015#012 [Time: 15:25:37]
2016-09-25T16:25:38.529383+02:00 mp114.deck2.zone42.org (      lgr_flow)(4694      )  |       |(SIPTU#10)423 State:DialogInitiated([email protected]) [Time: 15:25:37]
2016-09-25T16:25:38.530550+02:00 mp114.deck2.zone42.org (      lgr_flow)(4695      )  |       |(SIPTU#10)DIALOG_DISCONNECT_REQ State:DialogInitiated([email protected]) [Time: 15:25:37]
2016-09-25T16:25:38.531402+02:00 mp114.deck2.zone42.org (     sip_stack)(4696      )  SIPDialog(#10) changes state from DialogInitiated to DialogDisconnected [Time: 15:25:37]
2016-09-25T16:25:38.532239+02:00 mp114.deck2.zone42.org (     sip_stack)(4697      )  AcSIPStackAPI::FreeDialogAPI - #10 [Time: 15:25:37]
2016-09-25T16:25:38.533228+02:00 mp114.deck2.zone42.org (     sip_stack)(4698      )  UdpRtxMngr::Remove 69 REGISTER [Time: 15:25:37]
2016-09-25T16:25:38.534479+02:00 mp114.deck2.zone42.org (      lgr_flow)(4699      )  |       | TransactionUserMngr::ReturnDialog - #10 [Time: 15:25:37]
2016-09-25T16:25:38.535302+02:00 mp114.deck2.zone42.org (     sip_stack)(4700      )  SIPDialog(#10) changes state from DialogDisconnected to DialogIdle [Time: 15:25:37]
2016-09-25T16:25:40.552203+02:00 mp114.deck2.zone42.org (     sip_stack)(4701      )  new AcSIPDialogAPI created - #9 [Time: 15:25:39]
2016-09-25T16:25:40.553443+02:00 mp114.deck2.zone42.org (      lgr_flow)(4702      )  |       | new GetNewIndTransaction created - #9 [Time: 15:25:39]
2016-09-25T16:25:40.554327+02:00 mp114.deck2.zone42.org (      lgr_flow)(4703      )  |       |(SIPTU#9)DIALOG_INIT_REQ State:DialogIdle() [Time: 15:25:39]
2016-09-25T16:25:40.555801+02:00 mp114.deck2.zone42.org (     sip_stack)(4704      )  SIPDialog(#9) changes state from DialogIdle to DialogInitiated [Time: 15:25:39]
2016-09-25T16:25:40.557960+02:00 mp114.deck2.zone42.org (      lgr_flow)(4705      )  |       |(SIPTU#9)GENERAL_REQ State:DialogInitiated([email protected]) [Time: 15:25:39]
2016-09-25T16:25:40.560281+02:00 mp114.deck2.zone42.org (      lgr_flow)(4706      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:39]
2016-09-25T16:25:40.562474+02:00 mp114.deck2.zone42.org (     sip_stack)(4708      )  #012UdpRtxMngr::Transmit 70 REGISTER Rtx Left: 6 Dest: 217.0.23.100:5060 CallID: ([email protected]) [Time: 15:25:39]
2016-09-25T16:25:40.625081+02:00 mp114.deck2.zone42.org (      lgr_flow)(4709      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:39]
2016-09-25T16:25:40.626385+02:00 mp114.deck2.zone42.org SIP/2.0 401 Unauthorized 010330345#015#012Via: SIP/2.0/UDP 91.46.218.203;branch=z9hG4bKac1313014814#015#012To: <sip:[email protected]>;tag=h7g4Esbg_ee484e670306b73520c46e25a7e2768d#015#012From: <sip:[email protected]>;tag=1c1313004211#015#012Call-ID: [email protected]#015#012CSeq: 70 REGISTER#015#012Path: <sip:217.0.23.100;transport=udp;lr>#015#012Service-Route: <sip:217.0.23.100:5060;transport=udp;lr>#015#012WWW-Authenticate: Digest realm="tel.t-online.de",nonce="9C2255106FDEE757000000003147117E",stale=true,algorithm=MD5,qop="auth"#015#012Content-Length: 0#015#012#015#012 [Time: 15:25:39]
2016-09-25T16:25:40.629963+02:00 mp114.deck2.zone42.org (      lgr_flow)(4711      )  |       |(SIPTU#9)401 State:DialogInitiated([email protected]) [Time: 15:25:39]
2016-09-25T16:25:40.633300+02:00 mp114.deck2.zone42.org (      lgr_flow)(4712      )  ---- Outgoing SIP Message to 217.0.23.100:5060 from SIPInterface #0 ---- [Time: 15:25:39]
2016-09-25T16:25:40.637103+02:00 mp114.deck2.zone42.org (     sip_stack)(4714      )  #012UdpRtxMngr::Transmit 71 REGISTER Rtx Left: 6 Dest: 217.0.23.100:5060 CallID: ([email protected]) [Time: 15:25:39]
2016-09-25T16:25:40.638607+02:00 mp114.deck2.zone42.org (     sip_stack)(4715      )  UdpRtxMngr::Remove 70 REGISTER [Time: 15:25:39]
2016-09-25T16:25:40.699586+02:00 mp114.deck2.zone42.org (      lgr_flow)(4716      )  ---- Incoming SIP Message from 217.0.23.100:5060 to SIPInterface #0 ---- [Time: 15:25:39]
2016-09-25T16:25:40.700927+02:00 mp114.deck2.zone42.org SIP/2.0 200 OK#015#012Via: SIP/2.0/UDP 91.46.218.203;branch=z9hG4bKac1313197381#015#012To: <sip:[email protected]>;tag=h7g4Esbg_ee484e6703067d4290c46e25a829c2bf#015#012From: <sip:[email protected]>;tag=1c1313004211#015#012Call-ID: [email protected]#015#012CSeq: 71 REGISTER#015#012Contact: <sip:[email protected]:5060>;expires=480#015#012P-Associated-Uri: <sip:[email protected]>#015#012P-Associated-Uri: <tel:+493044xxxxxx>#015#012Path: <sip:217.0.23.100;transport=udp;lr>#015#012Service-Route: <sip:217.0.23.100:5060;transport=udp;lr>#015#012Content-Length: 0#015#012Authentication-Info: qop=auth,rspauth="7ced22d179f92272d345860ebe6308a6",cnonce="0a123bcf",nc=00000001#015#012#015#012 [Time: 15:25:39]
2016-09-25T16:25:40.704960+02:00 mp114.deck2.zone42.org (    lgr_freeid)(4718      ) !! [ERROR] no more free IDs available [Time: 15:25:39]
2016-09-25T16:25:40.705760+02:00 mp114.deck2.zone42.org (     sip_stack)(4719      )  Failed to allocate new P-Associated-URI Header [Time: 15:25:39]
2016-09-25T16:25:40.706692+02:00 mp114.deck2.zone42.org (    lgr_freeid)(4720      ) !! [ERROR] no more free IDs available [Time: 15:25:39]
2016-09-25T16:25:40.707508+02:00 mp114.deck2.zone42.org (     sip_stack)(4721      )  Failed to allocate new P-Associated-URI Header [Time: 15:25:39]
2016-09-25T16:25:40.709347+02:00 mp114.deck2.zone42.org (      lgr_flow)(4722      )  |       |(SIPTU#9)200 OK State:DialogInitiated([email protected]) [Time: 15:25:39]
2016-09-25T16:25:40.710692+02:00 mp114.deck2.zone42.org (     sip_stack)(4723      )  SIPDialog(#9) changes state from DialogInitiated to DialogConnected [Time: 15:25:39]
2016-09-25T16:25:40.711701+02:00 mp114.deck2.zone42.org (      lgr_flow)(4724      )  |       |(SIPTU#9)DIALOG_DISCONNECT_REQ State:DialogConnected([email protected]) [Time: 15:25:39]
2016-09-25T16:25:40.712643+02:00 mp114.deck2.zone42.org (     sip_stack)(4725      )  SIPDialog(#9) changes state from DialogConnected to DialogDisconnected [Time: 15:25:39]
2016-09-25T16:25:40.715123+02:00 mp114.deck2.zone42.org (     sip_stack)(4726      )  AcSIPStackAPI::FreeDialogAPI - #9 [Time: 15:25:39]
2016-09-25T16:25:40.716827+02:00 mp114.deck2.zone42.org (     sip_stack)(4727      )  UdpRtxMngr::Remove 71 REGISTER [Time: 15:25:39]
2016-09-25T16:25:40.718038+02:00 mp114.deck2.zone42.org (      lgr_flow)(4728      )  |       | TransactionUserMngr::ReturnDialog - #9 [Time: 15:25:39]
2016-09-25T16:25:40.718857+02:00 mp114.deck2.zone42.org (     sip_stack)(4729      )  SIPDialog(#9) changes state from DialogDisconnected to DialogIdle [Time: 15:25:39]
2016-09-25T16:25:43.251544+02:00 mp114.deck2.zone42.org (      lgr_flow)(4730      )  |       | TransactionUserMngr::ReturnSIPCall - #6 [Time: 15:25:41]
2016-09-25T16:25:43.252578+02:00 mp114.deck2.zone42.org (     sip_stack)(4731      )  SIPCall(#6) changes state from Disconnected to Idle [Time: 15:25:41]
2016-09-25T16:25:43.550625+02:00 mp114.deck2.zone42.org (      lgr_flow)(4732      )  |       | TransactionUserMngr::ReturnSIPCall - #5 [Time: 15:25:42]
2016-09-25T16:25:43.551672+02:00 mp114.deck2.zone42.org (     sip_stack)(4733      )  SIPCall(#5) changes state from Disconnected to Idle [Time: 15:25:42]
2016-09-25T16:25:49.501047+02:00 mp114.deck2.zone42.org (      lgr_stun)(4734      )  STUN Audit: NAT type = 3, lifetime = 30 [Time: 15:25:47]
2016-09-25T16:25:49.524513+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4735      )  InsertCoreEvent- event 97 [Time: 15:25:48]
2016-09-25T16:25:49.550455+02:00 mp114.deck2.zone42.org (      lgr_stun)(4736      )  STUN Signaling Mapped Address= 91.46.218.203:5060 [Time: 15:25:48]
2016-09-25T16:25:58.876208+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4737      )  recv <-- ON_HOOK Ch:0 [Time: 15:25:57]
2016-09-25T16:25:58.900107+02:00 mp114.deck2.zone42.org (      lgr_flow)(4738      )  #0:ON_HOOK_EV [Time: 15:25:57]
2016-09-25T16:25:58.901121+02:00 mp114.deck2.zone42.org (      lgr_flow)(4739      )  |       #0:ON_HOOK_EV [Time: 15:25:57]
2016-09-25T16:25:58.902063+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4740      )  #0:cpDigitMapHndlr_Stop - Stoped (0) [Time: 15:25:57]
2016-09-25T16:25:58.902843+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4741      )  #0:CloseChannel: ChannelNum=0 [Time: 15:25:57]
2016-09-25T16:25:58.904430+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4742      )  Open channel: IsVoiceOn: 1, IsT38On: 0, IsVbdOn: 0, IsVideoOn: 0 [Time: 15:25:57]
2016-09-25T16:25:58.905419+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4743      )  #0:OpenChannel:on Trunk -1 BChannel:0 CID=0 with VoiceCoder: g711Alaw64k20 VbdCoder: InvalidCoder255 DetectorSide: 0 FaxModemDet NO_FAX_MODEM_DETECTED [Time: 15:25:57]
2016-09-25T16:25:58.906372+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4744      )  #0:OpenChannel VoiceVolume= 1, DTMFVolume = -11, InputGain = 0, RTPRedundancyDepth = 0 FlashHookPeriod = 700 AgcCmd = 0x13180000#012 [Time: 15:25:57]
2016-09-25T16:25:58.907213+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4745      )  OpenChannel, CoderType = 0, Interval = 3, M = 1#012 [Time: 15:25:57]
2016-09-25T16:25:58.908079+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4746      )  #0:FAXTransportType = 3 [Time: 15:25:57]
2016-09-25T16:25:58.910930+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4747      )  #0:PSOSBoardInterface::ConfigureFaxModemChannelParams FAXTransportType=3 Modem configuration VxxTransportType=2 not allowed, forced to 3#012 [Time: 15:25:57]
2016-09-25T16:25:58.911958+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4748      )  #0:ConfigFaxModemChannelParams NSEMode=0, CNGDetMode=0, FAXTranType=3, VxxTranType=3, VoiceVol= 1, DTMFVol=-11, InGain=0, RTPRedDepth=0, ECE=1, SCE=0, ECNlpMode=0, DJBufMinDelay=10, DJBufOptFac=10) [Time: 15:25:57]
2016-09-25T16:25:58.912858+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4749      )  Detectors: Amd:On=0,Diretion=0, Ans:On=0,Direction=0 En:On=0,Direction=0 Board IBScmd:0xa1 [Time: 15:25:57]
2016-09-25T16:25:58.915587+02:00 mp114.deck2.zone42.org (   lgr_psbrdif)(4750      )  #0:PSOSBoardInterface::StopPlayTone- Called [Time: 15:25:57]
2016-09-25T16:25:58.916689+02:00 mp114.deck2.zone42.org (      lgr_flow)(4751      )  #0:LOCAL_END_PLAYING_CALL_PROGRESS_TONE_EV [Time: 15:25:57]
2016-09-25T16:25:58.917493+02:00 mp114.deck2.zone42.org (      lgr_flow)(4752      )  |       #0:LOCAL_END_PLAYING_CALL_PROGRESS_TONE_EV [Time: 15:25:57]
2016-09-25T16:26:19.527313+02:00 mp114.deck2.zone42.org (      lgr_stun)(4753      )  STUN Audit: NAT type = 3, lifetime = 30 [Time: 15:26:18]
2016-09-25T16:26:19.551354+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4754      )  InsertCoreEvent- event 97 [Time: 15:26:18]
2016-09-25T16:26:19.575011+02:00 mp114.deck2.zone42.org (      lgr_stun)(4755      )  STUN Signaling Mapped Address= 91.46.218.203:5060 [Time: 15:26:18]
2016-09-25T16:26:49.554844+02:00 mp114.deck2.zone42.org (      lgr_stun)(4756      )  STUN Audit: NAT type = 3, lifetime = 30 [Time: 15:26:48]
2016-09-25T16:26:49.575778+02:00 mp114.deck2.zone42.org (   lgr_psbrdex)(4757      )  InsertCoreEvent- event 97 [Time: 15:26:48]
2016-09-25T16:26:49.600858+02:00 mp114.deck2.zone42.org (      lgr_stun)(4758      )  STUN Signaling Mapped Address= 91.46.218.203:5060 [Time: 15:26:48]
 
"No entry found" im Zusammenhang mit der 030... deutet mglw. auf ein fehlerhaftes Setup hin.
 
Code:
2016-09-25T16:25:38.470632+02:00 mp114.deck2.zone42.org SIP/2.0 486 Busy Here#015#012Via: SIP/2.0/UDP 217.0.23.100:5060
2016-09-25T16:25:38.473085+02:00 mp114.deck2.zone42.org (     sip_stack)(4673      )  SIPCall(#5) changes state from Invited to Disconnected [Time: 15:25:36]

Das BUSY geht jedemfalls raus, schlechtes NAT (UDP)?
 
"No entry found" im Zusammenhang mit der 030... deutet mglw. auf ein fehlerhaftes Setup hin.
Geht ja noch weiter: "... go to default". Bedeutet aus meiner Sicht, dass es für dieses DstNum/SrcNum-Paar keine spezielle Routing-Regel gibt und deswegen das Default-Routing genommen wird.

Ich denke, dass ist kein Fehler. Oder?

- - - Aktualisiert - - -

Das BUSY geht jedemfalls raus, schlechtes NAT (UDP)?
Ich denke, dass eigentliche Problem liegt weiter vorn und das ist ein Folgefehler. Eigentlich dürfte es in dem beschriebenen Szenario ja kein BUSY geben. Ist ja nur ein Anruf, der entgegengenommen wird.

- - - Aktualisiert - - -

Bin nochmal durch die Logs gegangen und glaube folgendes herausgefunden zu haben:

2016-09-25T16:25:30.150780 kommt das INVITE
2016-09-25T16:25:30.193624 wird mit einem Trying darauf geantwortet
2016-09-25T16:25:30.251625 dann mit einem Ringing
2016-09-25T16:25:38.016373 dann mit einem OK auf das INVITE
2016-09-25T16:25:38.174436 kommt das ACK dazu rein

Bis hierhin sieht aus meiner Sicht alles gut aus.

2016-09-25T16:25:38.189713 kommt unerwartet ein BYE
2016-09-25T16:25:38.216235 gibt's das OK dazu
2016-09-25T16:25:38.374338 kommt ein neues INVITE
2016-09-25T16:25:38.416403 wird mit einem Trying darauf geantwortet
2016-09-25T16:25:38.468131 dann mit einem Busy Here
...

Wieso kommt so kurz nach dem ACK ein BYE?
 
Kann ich irgendwas tun, um dein Gedächtnis ein wenig anzuheizen? :blonk:;-)
 
Ich habe eine heisse Spur, kann mir aber nicht erklären, wie es dazu kommt.

Was ich in einem tcpdump-Mitschnitt sehen kann, ist das die STUN-Detection für die Ports 5060,6000,6001,6002,6004,6005 korrekt erfolgt.

Im SDP-Message-Body im Status SIP/2.0 200 OK zum INVITE sehe ich dann aber folgendes:

Erst kommt ein globales Connection Information (c): IN IP4 91.46.195.197. Das ist aus meiner Sicht so OK.

Dann kommt Media Description, name and address (m): audio 6000 RTP/AVP 8 96 fürs Audio.

Dann kommt allerdings ein Connection Information (c): IN IP4 172.16.100.147, also mit der internen Adresse, was aus meiner Sicht falsch ist und vermutlich zum BYE führt.

Aber wie kommt es dazu? Bug im MP-114? Fehlkonfiguration?
 
Ich hab's gefunden. :)

War wirklich ein Bug in der Firmware. Ein Update auf 6.20A.072 hat geholfen.
 

Zurzeit aktive Besucher

Statistik des Forums

Themen
244,695
Beiträge
2,216,697
Mitglieder
371,315
Neuestes Mitglied
jack-mack
Holen Sie sich 3CX - völlig kostenlos!
Verbinden Sie Ihr Team und Ihre Kunden Telefonie Livechat Videokonferenzen

Gehostet oder selbst-verwaltet. Für bis zu 10 Nutzer dauerhaft kostenlos. Keine Kreditkartendetails erforderlich. Ohne Risiko testen.

3CX
Für diese E-Mail-Adresse besteht bereits ein 3CX-Konto. Sie werden zum Kundenportal weitergeleitet, wo Sie sich anmelden oder Ihr Passwort zurücksetzen können, falls Sie dieses vergessen haben.