Чат  ::   FAQ  ::   Поиск  ::   Регистрация  ::   Вход

Проблема с входящими SIP/2.0 486 Busy Here

Проблемы и их решения Asterisk как такового

Модератор: april22

Проблема с входящими SIP/2.0 486 Busy Here

Сообщение MaxRAF » 11 июн 2019, 10:09

Здравствуйте.

Купил тел. номер у провайдера. Вроде настроил транк, но исходящие работают, входящие нет. Входящие настроил на переадресацию внутреннего номера, но моя АТС говорит SIP/2.0 486 Busy Here и дальше ничего.

Помогите понять мою ошибку в настройках.

Диапазоны IP провайдера:
185.45.152.0/24
185.45.155.0/24
31.139.38.0/24
195.122.19.0/27

На моей АТС транк на порту 5063

Номер, на который звоню: 74993806672

У меня не Asterisk, но надеюсь, что по логам вы сможете помочь. Спасибо.

[Показать] Спойлер:
ЛОГИ
[SPOILER]
2019/06/11 14:57:19.555 0:37.373 Opal Listener:8924 transports.cxx(1198) Opal Created transport UDP this=032AC440
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 transports.cxx(1209) OpalUDP Binding to interface: 172.16.100.15:5060
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 transports.cxx(455) InfLD Phase 3
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 transports.cxx(494) InfLD Phase 11
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sipep.cxx(219) InfLD Phase A 1
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sipep.cxx(223) InfLD Phase A 2
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sipep.cxx(226) InfLD Phase A 3
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sipep.cxx(346) InfLD Phase B 1
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sippdu.cxx(1569) InfDEBUG# SIP_PDU::SIP_PDU this=05117108
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sipep.cxx(351) InfLD Phase B 2
2019/06/11 14:57:19.556 0:37.374 Opal Listener:8924 sipep.cxx(353) SIP Waiting for PDU on udp$185.45.152.161:5060<if=udp$172.16.100.15:5060>
2019/06/11 14:57:19.557 0:37.375 Opal Listener:8924 sippdu.cxx(2047) SIP PDU received: rem=udp$185.45.152.161:5060,local=udp$172.16.100.15:5060,if=172.16.100.15
INVITE sip:647685@172.16.100.15:5060 SIP/2.0
Date: Tue, 11 Jun 2019 04:53:50 GMT

CSeq: 102 INVITE

Via: SIP/2.0/UDP 185.45.152.161;branch=z9hG4bK0573.b1675505b942a3fbfac170c1021d2566.0

Via: SIP/2.0/UDP 37.139.38.35:5060;rport=5060;branch=z9hG4bK02d11188

User-Agent: Zadarma Voip

From: "+79020588670" <sip:+79020588670@sip.zadarma.com>;tag=as0c0cdfe5

Call-ID: 6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060

Supported: replaces

To: <sip:647685@172.16.100.15:5060>

Contact: <sip:+79020588670@37.139.38.35:5060>

CALLED_DID: 74993806672

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE

Content-Type: application/sdp

Content-Length: 411

cc_num: didexternalserver

Max-Forwards: 69

Record-Route: <sip:185.45.152.161;lr=on;ftag=as0c0cdfe5>

hostname: sipbalancer-1

cc_counter: 55



v=0

o=root 297301033 297301033 IN IP4 172.16.100.10

s=Zadarma Voip

c=IN IP4 172.16.100.10

t=0 0

m=audio 12272 RTP/AVP 8 0 18 110 117 119 3 101

a=rtpmap:8 PCMA/8000

a=rtpmap:0 PCMU/8000

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:110 speex/8000

a=rtpmap:117 speex/16000

a=rtpmap:119 speex/32000

a=rtpmap:3 GSM/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

a=sendrecv


2019/06/11 14:57:19.558 0:37.375 Opal Listener:8924 sipep.cxx(357) InfLD Phase B 3
2019/06/11 14:57:19.558 0:37.375 Opal Listener:8924 sipep.cxx(548) TRDEBUG# Case 1 CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.558 0:37.376 Opal Listener:8924 sippdu.cxx(1601) InfDEBUG# SIP_PDU::SIP_PDU this=03A5F5E0
2019/06/11 14:57:19.558 0:37.376 Opal Listener:8924 sippdu.cxx(2107) SIP Sending PDU (479 bytes) to: rem=udp$185.45.152.161:5060,local=udp$172.16.100.15:5060,if=172.16.100.15
SIP/2.0 100 Trying

CSeq: 102 INVITE

Via: SIP/2.0/UDP 185.45.152.161;branch=z9hG4bK0573.b1675505b942a3fbfac170c1021d2566.0

Via: SIP/2.0/UDP 37.139.38.35:5060;rport=5060;branch=z9hG4bK02d11188

From: "+79020588670" <sip:+79020588670@sip.zadarma.com>;tag=as0c0cdfe5

Call-ID: 6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060

To: <sip:647685@172.16.100.15:5060>

Contact: sip:647685@172.16.100.15

Content-Length: 0

Record-Route: <sip:185.45.152.161;lr=on;ftag=as0c0cdfe5>




2019/06/11 14:57:19.559 0:37.377 Opal Listener:8924 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=03A5F5E0
2019/06/11 14:57:19.559 0:37.377 Opal Listener:8924 sipep.cxx(566) TRDEBUG# Case 2 CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.559 0:37.377 Opal Listener:8924 endpoint.cxx(365) TRDEBUG# OpalEndPoint::HasConnection CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.559 0:37.377 Opal Listener:8924 transports.cxx(1198) Opal Created transport UDP this=032AC0B0
2019/06/11 14:57:19.559 0:37.377 Opal Listener:8924 transports.cxx(1209) OpalUDP Binding to interface: 172.16.100.15:5060
2019/06/11 14:57:19.559 0:37.377 Opal Listener:8924 sipep.cxx(321) SIP Created transport udp$185.45.152.161:5060<if=udp$172.16.100.15:5060>
2019/06/11 14:57:19.560 0:37.377 Opal Listener:8924 transports.cxx(1243) OpalUDP Started connect to 185.45.152.161:5060
2019/06/11 14:57:19.560 0:37.377 Opal Listener:8924 ChildOpalManager.cpp(73) Inf ChildOpalManager::CreateCall
2019/06/11 14:57:19.560 0:37.377 Opal Listener:8924 call.cxx(69) Call Created Call[ed42ec4311]
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ChildOpalCall.cpp(26) Inf ChildOpalCall::ChildOpalCall this=032B43E8
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ChildOpalCall.cpp(30) Inf ChildOpalCall::ChildOpalCall locked ok
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 WriteChannel.cpp(12) Inf CWriteChannel::CWriteChannel
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 WriteChannel.cpp(18) Inf CWriteChannel::CWriteChannel locked ok
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 WriteChannel.cpp(35) Inf CWriteChannel::CWriteChannel exit
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ReadChannel.cpp(12) Inf CReadChannel::CReadChannel
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ReadChannel.cpp(18) Inf CReadChannel::CReadChannel locked ok
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ReadChannel.cpp(41) Inf CReadChannel::CReadChannel exit
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ChildOpalCall.cpp(53) Inf ChildOpalCall::ChildOpalCall exit
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ShellSIPEP.cpp(131) Inf ShellSIPEndPoint::CreateConnection
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ShellSIPEP.cpp(135) Inf ShellSIPEndPoint::CreateConnection locked ok
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 H323Connection.cpp(15) Inf CH323Connection::CH323Connection
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 H323Connection.cpp(19) Inf CH323Connection::CH323Connection locked ok
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 H323Connection.cpp(24) Inf CH323Connection::CH323Connection exit
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 ShellSIPEP.cpp(139) Inf ShellSIPEndPoint::CreateConnection new ShellSIPConnection
2019/06/11 14:57:19.560 0:37.378 Opal Listener:8924 connection.cxx(186) OpalCon Created connection Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.561 0:37.378 Opal Listener:8924 rfc2833.cxx(71) RFC2833 Handler created
2019/06/11 14:57:19.561 0:37.378 Opal Listener:8924 rfc2833.cxx(71) RFC2833 Handler created
2019/06/11 14:57:19.561 0:37.378 Opal Listener:8924 sippdu.cxx(1569) InfDEBUG# SIP_PDU::SIP_PDU this=0686A148
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 sipcon.cxx(215) SIP Created connection.
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 sipcon.cxx(217) InfDEBUG# SIPConnection::SIPConnection new this=068698E8
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 ShellCon.cpp(8) Inf ShellConnection::ShellConnection
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 ShellCon.cpp(12) Inf ShellConnection::ShellConnection locked ok
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 ShellCon.cpp(16) Inf ShellConnection::ShellConnection exit
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 ShellSIPCon.cpp(29) Inf ShellSIPConnection::ShellSIPConnection
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 ShellSIPCon.cpp(33) Inf ShellSIPConnection::ShellSIPConnection locked ok
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 ShellSIPCon.cpp(56) Inf ShellSIPConnection::ShellSIPConnection exit
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 H323Connection.cpp(59) Inf CH323Connection::__SetClass
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 H323Connection.cpp(63) Inf CH323Connection::__SetClass locked ok
2019/06/11 14:57:19.561 0:37.379 Opal Listener:8924 H323Connection.cpp(68) Inf CH323Connection::__SetClass exit
2019/06/11 14:57:19.562 0:37.379 ThreadID:2600 H323Connection.cpp(77) Inf CH323Connection::InitCallBack
2019/06/11 14:57:19.562 0:37.379 ThreadID:2600 H323Connection.cpp(81) Inf CH323Connection::InitCallBack locked ok
2019/06/11 14:57:19.562 0:37.379 ThreadID:2600 ShellCon.cpp(38) Inf ShellConnection::InitCallBack
2019/06/11 14:57:19.562 0:37.379 ThreadID:2600 ShellCon.cpp(42) Inf ShellConnection::InitCallBack locked ok
2019/06/11 14:57:19.562 0:37.379 ThreadID:2600 ShellCon.cpp(47) Inf ShellConnection::InitCallBack exit
2019/06/11 14:57:19.562 0:37.379 ThreadID:2600 ChildOpalCall.cpp(439) Inf ChildOpalCall::InitCallBack
2019/06/11 14:57:19.562 0:37.380 ThreadID:2600 ChildOpalCall.cpp(443) Inf ChildOpalCall::InitCallBack locked ok
2019/06/11 14:57:19.562 0:37.380 ThreadID:2600 ChildOpalCall.cpp(448) Inf ChildOpalCall::InitCallBack exit
2019/06/11 14:57:19.562 0:37.380 ThreadID:2600 H323Connection.cpp(123) Inf CH323Connection::InitCallBack exit
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalManager.cpp(81) Inf ChildOpalManager::OnIncomingConnection
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalManager.cpp(85) Inf ChildOpalManager::OnIncomingConnection locked ok
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 call.cxx(289) Call GetOtherPartyConnection Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalManager.cpp(91) Inf ChildOpalManager::OnIncomingConnection SetShellConnection
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalCall.cpp(207) Inf ChildOpalCall::SetShellConnection
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalCall.cpp(211) Inf ChildOpalCall::SetShellConnection locked ok
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalCall.cpp(215) Inf ChildOpalCall::SetShellConnection exit
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 ChildOpalManager.cpp(95) Inf ChildOpalManager::OnIncomingConnection FInfMediaEndPoint->MakeConnection
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 MediaManager.cxx(83) Inf InfMediaEndPoint::MakeConnection
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 MediaManager.cxx(87) Inf InfMediaEndPoint::MakeConnection locked ok
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 MediaManager.cxx(89) Inf InfMediaEndPoint::MakeConnection CreateConnection
2019/06/11 14:57:19.562 0:37.380 Opal Listener:8924 MediaManager.cxx(144) Inf InfMediaEndPoint::CreateConnection
2019/06/11 14:57:19.563 0:37.380 Opal Listener:8924 connection.cxx(186) OpalCon Created connection Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.563 0:37.380 Opal Listener:8924 MediaManager.cxx(183) Inf InfMediaConnection::InfMediaConnection
2019/06/11 14:57:19.563 0:37.380 Opal Listener:8924 MediaManager.cxx(187) Inf InfMediaConnection::InfMediaConnection locked ok
2019/06/11 14:57:19.563 0:37.380 Opal Listener:8924 connection.cxx(1090) OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.563 0:37.380 Opal Listener:8924 MediaManager.cxx(201) Inf InfMediaConnection::InfMediaConnection exit
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 MediaManager.cxx(95) Inf InfMediaEndPoint::MakeConnection connectionsActive.SetAt
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 MediaManager.cxx(99) Inf InfMediaEndPoint::MakeConnection SetInfMediaConnection
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 ChildOpalCall.cpp(222) Inf ChildOpalCall::SetInfMediaConnection
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 ChildOpalCall.cpp(226) Inf ChildOpalCall::SetInfMediaConnection locked ok
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 ChildOpalCall.cpp(230) Inf ChildOpalCall::SetInfMediaConnection exit
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 MediaManager.cxx(110) Inf InfMediaEndPoint::MakeConnection exit
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 ShellSIPEP.cpp(217) Inf ShellSIPEndPoint::CreateConnection exit
2019/06/11 14:57:19.563 0:37.381 Opal Listener:8924 endpoint.cxx(378) TRDEBUG# OpalEndPoint::AddConnection CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.564 0:37.381 Opal Listener:8924 sipep.cxx(361) InfLD Phase B 4
2019/06/11 14:57:19.564 0:37.381 Opal Listener:8924 sipep.cxx(230) InfLD Phase A 4
2019/06/11 14:57:19.564 0:37.381 Opal Listener:8924 sipep.cxx(234) InfLD Phase A 5
2019/06/11 14:57:19.564 0:37.381 Opal Listener:8924 transports.cxx(845) Opal Transport clean up on termination
2019/06/11 14:57:19.564 0:37.381 Opal Listener:8924 transports.cxx(830) Opal Transport Close
2019/06/11 14:57:19.564 0:37.382 Aggregator:5752 sipcon.cxx(1398) SIP Handling PDU 102 INVITE sip:647685@172.16.100.15:5060
2019/06/11 14:57:19.564 0:37.382 Aggregator:5752 ShellSIPCon.cpp(307) Inf ShellSIPConnection::OnReceivedINVITE
2019/06/11 14:57:19.564 0:37.382 Aggregator:5752 sipcon.cxx(1640) SIP Initial INVITE from sip:647685@172.16.100.15:5060
2019/06/11 14:57:19.564 0:37.382 Aggregator:5752 sippdu.cxx(1648) InfDEBUG# SIP_PDU::SIP_PDU this=05117370
2019/06/11 14:57:19.564 0:37.381 Opal Listener:8924 transports.cxx(1216) Opal Deleted transport UDP this=032AC440 udp$185.45.152.161:5060<if=udp$172.16.100.15:5060>
2019/06/11 14:57:19.564 0:37.382 Opal Listener:8924 transports.cxx(497) InfLD Phase 12
2019/06/11 14:57:19.564 0:37.382 Opal Listener:8924 transports.cxx(503) InfLD Phase 13
2019/06/11 14:57:19.564 0:37.382 Opal Listener:8924 transports.cxx(451) InfLD Phase 2
2019/06/11 14:57:19.564 0:37.382 Aggregator:5752 sipcon.cxx(1684) SIP Set Request URI to sip:+79020588670@37.139.38.35:5060
2019/06/11 14:57:19.565 0:37.382 Aggregator:5752 manager.cxx(1143) OPAL Checking incoming call for NAT: local=172.16.100.15, peer=185.45.152.161, sig=37.139.38.35
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 sipcon.cxx(1724) SIP OnIncomingConnection succeeded for INVITE from sip:647685@172.16.100.15:5060 for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 connection.cxx(1090) OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 ShellSIPCon.cpp(250) Inf ShellSIPConnection::OnIncomingConnection
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 ShellSIPCon.cpp(254) Inf ShellSIPConnection::OnIncomingConnection locked ok
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 ShellSIPCon.cpp(598) Inf ShellSIPConnection::CheckSendSetUp
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 ShellSIPCon.cpp(602) Inf ShellSIPConnection::CheckSendSetUp locked ok
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 ShellSIPCon.cpp(612) Inf ShellSIPConnection::CheckSendSetUp INVITE PDU is not yet received
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 call.cxx(289) Call GetOtherPartyConnection Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 sdp.cxx(607) SDP Media session port=12272
2019/06/11 14:57:19.565 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068F9F70
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA010
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA0B0
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA150
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA1F0
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA290
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA330
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(164) InfDEBUG# new SDPMediaFormat this=068FA3D0
2019/06/11 14:57:19.566 0:37.383 Aggregator:5752 sdp.cxx(1335) SDP Adding media session with 8 audio formats
2019/06/11 14:57:19.566 0:37.384 Aggregator:5752 sdp.cxx(710) SDP Unknown media attribute ptime
2019/06/11 14:57:19.566 0:37.384 Aggregator:5752 sdp.cxx(451) SDP Could not find media format for "speex", pt=[pt=110], clock=8000
2019/06/11 14:57:19.566 0:37.384 Aggregator:5752 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA150
2019/06/11 14:57:19.566 0:37.384 Aggregator:5752 sdp.cxx(451) SDP Could not find media format for "speex", pt=[pt=117], clock=16000
2019/06/11 14:57:19.566 0:37.384 Aggregator:5752 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA1F0
2019/06/11 14:57:19.566 0:37.384 Aggregator:5752 sdp.cxx(451) SDP Could not find media format for "speex", pt=[pt=119], clock=32000
2019/06/11 14:57:19.567 0:37.384 Aggregator:5752 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA290
2019/06/11 14:57:19.567 0:37.384 Aggregator:5752 sdp.cxx(847) SIP RTP payload type PCMA matched to codec G.711-ALaw-64k
2019/06/11 14:57:19.567 0:37.384 Aggregator:5752 sdp.cxx(847) SIP RTP payload type PCMU matched to codec G.711-uLaw-64k
2019/06/11 14:57:19.567 0:37.384 Aggregator:5752 sdp.cxx(847) SIP RTP payload type G729 matched to codec G.729
2019/06/11 14:57:19.567 0:37.384 Aggregator:5752 sdp.cxx(847) SIP RTP payload type GSM matched to codec GSM-06.10
2019/06/11 14:57:19.567 0:37.384 Aggregator:5752 call.cxx(289) Call GetOtherPartyConnection Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.567 0:37.385 Aggregator:5752 call.cxx(566) Call IsMediaBypassPossible Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060] session 1
2019/06/11 14:57:19.567 0:37.385 Aggregator:5752 manager.cxx(672) OpalMan IsMediaBypassPossible: session 1
2019/06/11 14:57:19.567 0:37.385 Aggregator:5752 connection.cxx(808) OpalCon IsMediaBypassPossible: default returns false
2019/06/11 14:57:19.567 0:37.385 Aggregator:5752 sipcon.cxx(495) InfQoS SIPConnection::OfferSDPMediaDescription DSCP=46 Service=3 etalon=��019/06/11 14:57:19.567 0:37.385 Aggregator:5752 rtpconn.cxx(494) RTP Cannot find session 1
2019/06/11 14:57:19.568 0:37.385 Aggregator:5752 rtp.cxx(1563) RTP_UDP Session 1, created with NAT flag set to 0
2019/06/11 14:57:19.568 0:37.385 Aggregator:5752 rtpconn.cxx(183) RTPDebug started. SessionID=1 Call=Call[ed42ec4311] local=172.16.100.15 remote=185.45.152.161
2019/06/11 14:57:19.568 0:37.386 Aggregator:5752 rtpconn.cxx(188) RTPDebug FirstPort=5000. SessionID=1 local=172.16.100.15 remote=185.45.152.161
2019/06/11 14:57:19.568 0:37.386 Aggregator:5752 rtp.cxx(1641) InfQoS RTP_UDP::Open tos=؍
2019/06/11 14:57:19.568 0:37.386 Aggregator:5752 rtp.cxx(1647) InfQoS RTP_UDP::Open Data DSCP=46 Service=3
2019/06/11 14:57:19.568 0:37.386 Aggregator:5752 rtp.cxx(1705) RTPDebug trying listen 172.16.100.15 5000 and 5001
2019/06/11 14:57:19.568 0:37.386 Aggregator:5752 rtp.cxx(1750) RTP_UDP Session 1 created: 172.16.100.15:5000-5001 ssrc=826689387
2019/06/11 14:57:19.568 0:37.386 Aggregator:5752 rtpconn.cxx(205) RTPDebug finished Port=5000. SessionID=1 local=172.16.100.15 remote=185.45.152.161
2019/06/11 14:57:19.569 0:37.386 Aggregator:5752 call.cxx(180) Call OnSetUp Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 MediaManager.cxx(221) Inf InfMediaConnection::SetUpConnection
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 MediaManager.cxx(225) Inf InfMediaConnection::SetUpConnection locked ok
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 call.cxx(289) Call GetOtherPartyConnection Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 MediaManager.cxx(230) Inf InfMediaConnection::SetUpConnection AlertingPhase
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 MediaManager.cxx(236) Inf InfMediaConnection::SetUpConnection ConnectedPhase
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 MediaManager.cxx(242) Inf InfMediaConnection::SetUpConnection exit
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 connection.cxx(270) OpalCon OnSetUpConnectionCall[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 endpoint.cxx(395) OpalEP OnSetUpConnection Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.569 0:37.387 Aggregator:5752 ShellSIPCon.cpp(403) Inf ShellSIPConnection::OnAnswerCall
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(105) Inf ShellSIPConnection::GetCall
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(109) Inf ShellSIPConnection::GetCall locked ok
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 connection.cxx(457) OpalCon Answering call: AnswerCallDeferred
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(313) Inf ShellSIPConnection::OnReceivedINVITE inherited called
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(319) Inf ShellSIPConnection::OnReceivedINVITE locked ok
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(598) Inf ShellSIPConnection::CheckSendSetUp
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(602) Inf ShellSIPConnection::CheckSendSetUp locked ok
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellSIPCon.cpp(633) InfCN CPN=647685 CN=647685
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellCon.cpp(180) Inf ShellConnection::OnIncomingCall
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellCon.cpp(184) Inf ShellConnection::OnIncomingCall locked ok
2019/06/11 14:57:19.570 0:37.387 Aggregator:5752 ShellCon.cpp(195) Inf ShellConnection::OnIncomingCall exit
2019/06/11 14:57:19.570 0:37.388 Aggregator:5752 ShellSIPCon.cpp(666) Inf ShellSIPConnection::CheckSendSetUp SetUp sent
2019/06/11 14:57:19.570 0:37.388 Aggregator:5752 ShellSIPCon.cpp(394) Inf ShellSIPConnection::OnReceivedINVITE exit
2019/06/11 14:57:19.570 0:37.388 Aggregator:5752 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=05117108
2019/06/11 14:57:19.572 0:37.390 ThreadID:4764 H323Connection.cpp(232) Inf CH323Connection::Answer
2019/06/11 14:57:19.572 0:37.390 ThreadID:4764 H323Connection.cpp(236) Inf CH323Connection::Answer locked ok
2019/06/11 14:57:19.572 0:37.390 ThreadID:4764 H323Connection.cpp(270) Inf CH323Connection::Answer FChildOpalCall->StopIO
2019/06/11 14:57:19.572 0:37.390 ThreadID:4764 ChildOpalCall.cpp(149) Inf ChildOpalCall::StopIO
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ChildOpalCall.cpp(153) Inf ChildOpalCall::StopIO locked ok
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ChildOpalCall.cpp(157) Inf ChildOpalCall::StopIO FWriteChannel->StopIO
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 WriteChannel.cpp(67) Inf CWriteChannel::StopIO
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 WriteChannel.cpp(71) Inf CWriteChannel::StopIO locked ok
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 WriteChannel.cpp(93) Inf CWriteChannel::StopIO exit
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ChildOpalCall.cpp(164) Inf ChildOpalCall::StopIO FReadChannel->StopIO
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ReadChannel.cpp(73) Inf CReadChannel::StopIO
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ReadChannel.cpp(77) Inf CReadChannel::StopIO locked ok
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ReadChannel.cpp(86) Inf CReadChannel::StopIO exit
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ChildOpalCall.cpp(169) Inf ChildOpalCall::StopIO exit
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 H323Connection.cpp(274) Inf CH323Connection::Answer FChildOpalCall->Clear Code=1
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ShellSIPCon.cpp(118) Inf ShellSIPConnection::ClearCall
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 ShellSIPCon.cpp(122) Inf ShellSIPConnection::ClearCall locked ok
2019/06/11 14:57:19.573 0:37.390 ThreadID:4764 connection.cxx(308) OpalCon Call end reason for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060] set to EndedByLocalUser
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(107) Call Clearing Call[ed42ec4311] reason=EndedByLocalUser
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(109) InfLOG Case D0
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(117) InfLOG Case D2
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(121) InfLOG Case D3
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(125) InfLOG Case D4
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(136) InfLOG Case D5
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(140) InfLOG Case D6
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 call.cxx(145) InfLOG Case D7
2019/06/11 14:57:19.573 0:37.391 ThreadID:4764 connection.cxx(1090) OpalCon SetPhase from SetUpPhase to ReleasingPhase for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.574 0:37.391 ThreadID:4764 connection.cxx(364) OpalCon Releasing Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.574 0:37.391 ThreadID:4764 call.cxx(147) InfLOG Case D8
2019/06/11 14:57:19.574 0:37.391 ThreadID:4764 call.cxx(145) InfLOG Case D7
2019/06/11 14:57:19.574 0:37.391 OnRelease:7144 ShellSIPCon.cpp(232) Inf ShellSIPConnection::OnReleased
2019/06/11 14:57:19.574 0:37.391 OnRelease:7144 ShellSIPCon.cpp(236) Inf ShellSIPConnection::OnReleased locked ok
2019/06/11 14:57:19.574 0:37.391 OnRelease:7144 ShellCon.cpp(156) Inf ShellConnection::OnReleased
2019/06/11 14:57:19.574 0:37.391 OnRelease:7144 ShellCon.cpp(160) Inf ShellConnection::OnReleased locked ok
2019/06/11 14:57:19.574 0:37.391 ThreadID:4764 connection.cxx(1090) OpalCon SetPhase from SetUpPhase to ReleasingPhase for Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.574 0:37.391 ThreadID:4764 connection.cxx(364) OpalCon Releasing Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.574 0:37.392 ThreadID:4764 connection.cxx(308) OpalCon Call end reason for Call[ed42ec4311]-EP<>[InfMedia/1] set to EndedByLocalUser
2019/06/11 14:57:19.574 0:37.392 ThreadID:4764 connection.cxx(398) OpalCon OnReleased Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.574 0:37.392 ThreadID:4764 endpoint.cxx(446) OpalEP OnReleased Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.574 0:37.392 ThreadID:4764 manager.cxx(632) OpalMan OnReleased Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 call.cxx(605) Call OnReleased Call[ed42ec4311]-EP<>[InfMedia/1]
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 connection.cxx(343) OpalCon Already released Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 connection.cxx(651) OpalCon Media streams closed.
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 call.cxx(147) InfLOG Case D8
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 call.cxx(150) InfLOG Case D9
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 ShellSIPCon.cpp(128) Inf ShellSIPConnection::ClearCall exit
2019/06/11 14:57:19.575 0:37.392 ThreadID:4764 H323Connection.cpp(284) Inf CH323Connection::Answer exit
2019/06/11 14:57:19.575 0:37.392 OnRelease:7144 ShellSIPCon.cpp(105) Inf ShellSIPConnection::GetCall
2019/06/11 14:57:19.575 0:37.392 OnRelease:7144 ShellSIPCon.cpp(109) Inf ShellSIPConnection::GetCall locked ok
2019/06/11 14:57:19.575 0:37.392 OnRelease:7144 ShellSIPCon.cpp(105) Inf ShellSIPConnection::GetCall
2019/06/11 14:57:19.575 0:37.392 OnRelease:7144 ShellSIPCon.cpp(109) Inf ShellSIPConnection::GetCall locked ok
2019/06/11 14:57:19.575 0:37.392 OnRelease:7144 ChildOpalCall.cpp(149) Inf ChildOpalCall::StopIO
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 ChildOpalCall.cpp(153) Inf ChildOpalCall::StopIO locked ok
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 ChildOpalCall.cpp(157) Inf ChildOpalCall::StopIO FWriteChannel->StopIO
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 WriteChannel.cpp(67) Inf CWriteChannel::StopIO
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 WriteChannel.cpp(71) Inf CWriteChannel::StopIO locked ok
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 WriteChannel.cpp(93) Inf CWriteChannel::StopIO exit
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 ChildOpalCall.cpp(164) Inf ChildOpalCall::StopIO FReadChannel->StopIO
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 ReadChannel.cpp(73) Inf CReadChannel::StopIO
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 ReadChannel.cpp(77) Inf CReadChannel::StopIO locked ok
2019/06/11 14:57:19.575 0:37.393 OnRelease:7144 ReadChannel.cpp(86) Inf CReadChannel::StopIO exit
2019/06/11 14:57:19.576 0:37.393 OnRelease:7144 ChildOpalCall.cpp(169) Inf ChildOpalCall::StopIO exit
2019/06/11 14:57:19.576 0:37.393 OnRelease:7144 ShellCon.cpp(172) Inf ShellConnection::OnReleased exit
2019/06/11 14:57:19.576 0:37.393 OnRelease:7144 sipcon.cxx(246) SIP OnReleased: Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060], phase = ReleasingPhase
2019/06/11 14:57:19.576 0:37.393 OnRelease:7144 connection.cxx(1090) OpalCon SetPhase from ReleasingPhase to ReleasingPhase for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.576 0:37.393 OnRelease:7144 sippdu.cxx(1601) InfDEBUG# SIP_PDU::SIP_PDU this=0C66F910
2019/06/11 14:57:19.576 0:37.393 OnRelease:7144 sippdu.cxx(2107) SIP Sending PDU (633 bytes) to: rem=udp$185.45.152.161:5060,local=udp$172.16.100.15:5060,if=172.16.100.15
SIP/2.0 486 Busy Here

CSeq: 102 INVITE

Via: SIP/2.0/UDP 185.45.152.161;branch=z9hG4bK0573.b1675505b942a3fbfac170c1021d2566.0

Via: SIP/2.0/UDP 37.139.38.35:5060;rport=5060;branch=z9hG4bK02d11188

User-Agent: Infinity/4.0

From: "+79020588670" <sip:+79020588670@sip.zadarma.com>;tag=as0c0cdfe5

Call-ID: 6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060

To: <sip:647685@172.16.100.15:5060>;tag=3e4474da-561b-1910-95bd-002264cbb6ce

Infinity-CallID:

Infinity-CallInfo:

Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING

Content-Length: 0

Record-Route: <sip:185.45.152.161;lr=on;ftag=as0c0cdfe5>




2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=0C66F910
2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 connection.cxx(651) OpalCon Media streams closed.
2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 connection.cxx(1090) OpalCon SetPhase from ReleasingPhase to ReleasedPhase for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 connection.cxx(398) OpalCon OnReleased Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 endpoint.cxx(446) OpalEP OnReleased Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 manager.cxx(632) OpalMan OnReleased Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.577 0:37.394 OnRelease:7144 call.cxx(605) Call OnReleased Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.577 0:37.395 OnRelease:7144 manager.cxx(463) OpalMan OnClearedCall Call[ed42ec4311] from "sip:+79020588670@sip.zadarma.com" to ":%F1%E8%F1%F2%E5%EC%E0"
2019/06/11 14:57:19.577 0:37.395 OnRelease:7144 connection.cxx(651) OpalCon Media streams closed.
2019/06/11 14:57:19.577 0:37.395 OnRelease:7144 transports.cxx(845) Opal Transport clean up on termination
2019/06/11 14:57:19.577 0:37.395 OnRelease:7144 transports.cxx(830) Opal Transport Close
2019/06/11 14:57:19.577 0:37.395 OnRelease:7144 ShellSIPCon.cpp(243) Inf ShellSIPConnection::OnReleased exit
2019/06/11 14:57:19.577 0:37.395 OnRelease:7144 connection.cxx(389) OpalCon OnRelease thread completed for Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060]
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 transports.cxx(1198) Opal Created transport UDP this=032AC440
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 transports.cxx(1209) OpalUDP Binding to interface: 172.16.100.15:5060
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 transports.cxx(455) InfLD Phase 3
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 transports.cxx(494) InfLD Phase 11
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sipep.cxx(219) InfLD Phase A 1
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sipep.cxx(223) InfLD Phase A 2
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sipep.cxx(226) InfLD Phase A 3
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sipep.cxx(346) InfLD Phase B 1
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sippdu.cxx(1569) InfDEBUG# SIP_PDU::SIP_PDU this=05117108
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sipep.cxx(351) InfLD Phase B 2
2019/06/11 14:57:19.721 0:37.539 Opal Listener:8924 sipep.cxx(353) SIP Waiting for PDU on udp$185.45.152.161:5060<if=udp$172.16.100.15:5060>
2019/06/11 14:57:19.722 0:37.540 Opal Listener:8924 sippdu.cxx(2047) SIP PDU received: rem=udp$185.45.152.161:5060,local=udp$172.16.100.15:5060,if=172.16.100.15
ACK sip:647685@:0 SIP/2.0
CSeq: 102 ACK

Via: SIP/2.0/UDP 185.45.152.161;branch=z9hG4bK0573.b1675505b942a3fbfac170c1021d2566.0

From: "+79020588670" <sip:+79020588670@sip.zadarma.com>;tag=as0c0cdfe5

Call-ID: 6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060

To: <sip:647685@172.16.100.15:5060>;tag=3e4474da-561b-1910-95bd-002264cbb6ce

Content-Length: 0

Max-Forwards: 69




2019/06/11 14:57:19.722 0:37.540 Opal Listener:8924 sipep.cxx(357) InfLD Phase B 3
2019/06/11 14:57:19.722 0:37.540 Opal Listener:8924 sipep.cxx(548) TRDEBUG# Case 1 CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.723 0:37.540 Opal Listener:8924 sipep.cxx(566) TRDEBUG# Case 2 CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.723 0:37.540 Opal Listener:8924 endpoint.cxx(365) TRDEBUG# OpalEndPoint::HasConnection CallID=6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060
2019/06/11 14:57:19.723 0:37.540 Opal Listener:8924 sipep.cxx(384) InfLD Phase B 8
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=05117108
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 sipep.cxx(388) InfLD Phase B 9 end
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 sipep.cxx(230) InfLD Phase A 4
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 sipep.cxx(234) InfLD Phase A 5
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 transports.cxx(845) Opal Transport clean up on termination
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 transports.cxx(830) Opal Transport Close
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 transports.cxx(1216) Opal Deleted transport UDP this=032AC440 udp$185.45.152.161:5060<if=udp$172.16.100.15:5060>
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 transports.cxx(497) InfLD Phase 12
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 transports.cxx(503) InfLD Phase 13
2019/06/11 14:57:19.723 0:37.541 Opal Listener:8924 transports.cxx(451) InfLD Phase 2
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 MediaManager.cxx(211) Inf InfMediaConnection::~InfMediaConnection
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 MediaManager.cxx(743) FaxDebug# Close 1
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 MediaManager.cxx(747) FaxDebug# Close 2
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 connection.cxx(246) OpalCon Connection Call[ed42ec4311]-EP<>[InfMedia/1] destroyed.
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ShellSIPCon.cpp(90) Inf ShellSIPConnection::InternalDelete
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ShellCon.cpp(54) Inf ShellConnection::LeaveCallBack
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ShellCon.cpp(58) Inf ShellConnection::LeaveCallBack locked ok
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ShellCon.cpp(68) Inf ShellConnection::LeaveCallBack exit
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ShellSIPCon.cpp(105) Inf ShellSIPConnection::GetCall
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ShellSIPCon.cpp(109) Inf ShellSIPConnection::GetCall locked ok
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ChildOpalCall.cpp(455) Inf ChildOpalCall::LeaveCallBack
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ChildOpalCall.cpp(459) Inf ChildOpalCall::LeaveCallBack locked ok
2019/06/11 14:57:20.398 0:38.216 Opal Garbage:5860 ChildOpalCall.cpp(469) Inf ChildOpalCall::LeaveCallBack exit
2019/06/11 14:57:20.399 0:38.217 Opal Garbage:5860 ShellSIPCon.cpp(98) Inf ShellSIPConnection::InternalDelete exit
2019/06/11 14:57:20.399 0:38.217 ThreadID:5788 ShellSIPCon.cpp(76) Inf SIPConnectionDeleteThreadProc thread=5788 connection=068698E8
2019/06/11 14:57:21.169 0:38.988 Opal Listener:7380 transports.cxx(1198) Opal Created transport UDP this=032AC440
2019/06/11 14:57:21.170 0:38.988 Opal Listener:7380 transports.cxx(1209) OpalUDP Binding to interface: 172.16.100.15:5082
2019/06/11 14:57:21.170 0:38.988 Opal Listener:7380 transports.cxx(455) InfLD Phase 3
2019/06/11 14:57:21.170 0:38.988 Opal Listener:7380 transports.cxx(494) InfLD Phase 11
2019/06/11 14:57:21.170 0:38.988 Opal Listener:7380 sipep.cxx(219) InfLD Phase A 1
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(223) InfLD Phase A 2
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(226) InfLD Phase A 3
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(346) InfLD Phase B 1
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sippdu.cxx(1569) InfDEBUG# SIP_PDU::SIP_PDU this=05117108
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(351) InfLD Phase B 2
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(353) SIP Waiting for PDU on udp$109.69.176.249:5060<if=udp$172.16.100.15:5082>
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sippdu.cxx(1954) SIP Invalid datagram from udp$109.69.176.249:5060 - 2 bytes.
d a ..
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(368) InfLD Phase B 5
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(373) InfLD Phase B 6
2019/06/11 14:57:21.170 0:38.989 Opal Listener:7380 sipep.cxx(384) InfLD Phase B 8
2019/06/11 14:57:21.171 0:38.989 Opal Listener:7380 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=05117108
2019/06/11 14:57:21.171 0:38.989 Opal Listener:7380 sipep.cxx(388) InfLD Phase B 9 end
2019/06/11 14:57:21.171 0:38.989 Opal Listener:7380 sipep.cxx(230) InfLD Phase A 4
2019/06/11 14:57:21.171 0:38.989 Opal Listener:7380 sipep.cxx(234) InfLD Phase A 5
2019/06/11 14:57:21.171 0:38.989 Opal Listener:7380 transports.cxx(845) Opal Transport clean up on termination
2019/06/11 14:57:21.171 0:38.989 Opal Listener:7380 transports.cxx(830) Opal Transport Close
2019/06/11 14:57:21.171 0:38.990 Opal Listener:7380 transports.cxx(1216) Opal Deleted transport UDP this=032AC440 udp$109.69.176.249:5060<if=udp$172.16.100.15:5082>
2019/06/11 14:57:21.171 0:38.990 Opal Listener:7380 transports.cxx(497) InfLD Phase 12
2019/06/11 14:57:21.171 0:38.990 Opal Listener:7380 transports.cxx(503) InfLD Phase 13
2019/06/11 14:57:21.171 0:38.990 Opal Listener:7380 transports.cxx(451) InfLD Phase 2
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellSIPCon.cpp(63) Inf ShellSIPConnection::~ShellSIPConnection
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellSIPCon.cpp(67) Inf ShellSIPConnection::~ShellSIPConnection locked ok
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellSIPCon.cpp(69) Inf ShellSIPConnection::~ShellSIPConnection exit
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellCon.cpp(23) Inf ShellConnection::~ShellConnection
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellCon.cpp(27) Inf ShellConnection::~ShellConnection locked ok
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellCon.cpp(54) Inf ShellConnection::LeaveCallBack
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellCon.cpp(58) Inf ShellConnection::LeaveCallBack locked ok
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellCon.cpp(68) Inf ShellConnection::LeaveCallBack exit
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 ShellCon.cpp(31) Inf ShellConnection::~ShellConnection exit
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 sipcon.cxx(225) InfDEBUG# SIPConnection::~SIPConnection this=068698E8
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 sipcon.cxx(228) InfDEBUG# SIPConnection::~SIPConnection 1
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=05117370
2019/06/11 14:57:21.399 0:39.217 ThreadID:5788 sdp.h(307) InfDEBUG# ~SDPSessionDescription this=068F9ED0
2019/06/11 14:57:21.399 0:39.218 ThreadID:2604 H323Connection.cpp(31) Inf CH323Connection::~CH323Connection
2019/06/11 14:57:21.399 0:39.218 ThreadID:2604 H323Connection.cpp(35) Inf CH323Connection::~CH323Connection exit
2019/06/11 14:57:21.399 0:39.218 ThreadID:5788 sdp.h(169) InfDEBUG# ~SDPMediaDescription this=03242968
2019/06/11 14:57:21.399 0:39.218 ThreadID:5788 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068F9F70
2019/06/11 14:57:21.399 0:39.218 ThreadID:5788 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA010
2019/06/11 14:57:21.399 0:39.218 ThreadID:5788 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA0B0
2019/06/11 14:57:21.400 0:39.218 ThreadID:5788 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA330
2019/06/11 14:57:21.400 0:39.218 ThreadID:5788 sdp.h(86) InfDEBUG# ~SDPMediaFormat this=068FA3D0
2019/06/11 14:57:21.400 0:39.218 ThreadID:5788 sipcon.cxx(231) InfDEBUG# SIPConnection::~SIPConnection 2
2019/06/11 14:57:21.400 0:39.218 ThreadID:5788 transports.cxx(845) Opal Transport clean up on termination
2019/06/11 14:57:21.400 0:39.218 ThreadID:5788 transports.cxx(830) Opal Transport Close
2019/06/11 14:57:21.400 0:39.218 ThreadID:5788 transports.cxx(1216) Opal Deleted transport UDP this=032AC0B0 udp$185.45.152.161:5060<if=udp$172.16.100.15:5060>
2019/06/11 14:57:21.400 0:39.219 ThreadID:5788 sipcon.cxx(237) InfDEBUG# SIPConnection::~SIPConnection 3
2019/06/11 14:57:21.400 0:39.219 ThreadID:5788 sipcon.cxx(240) SIP Deleted connection.
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 sippdu.cxx(1673) InfDEBUG# SIP_PDU::~SIP_PDU this=0686A148
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 rtpconn.cxx(417) RTP Deleting session 1
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 rtp.cxx(1776) RTP_UDP Session 1, Shutting down read.
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 rtp.cxx(696) InfLID Switching off jitter buffer.
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 rtp.cxx(1789) RTP_UDP Session 1, Shutting down write.
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 connection.cxx(246) OpalCon Connection Call[ed42ec4311]-EP<sip>[6b75ca9e394d258d098773dd29cf3c40@37.139.38.35:5060] destroyed.
2019/06/11 14:57:21.401 0:39.219 ThreadID:5788 ShellSIPCon.cpp(82) Inf SIPConnectionDeleteThreadProc finished thread=5788
2019/06/11 14:57:22.399 0:40.217 Opal Garbage:5860 ChildOpalCall.cpp(111) Inf ChildOpalCall::InternalDelete
2019/06/11 14:57:22.399 0:40.217 Opal Garbage:5860 ChildOpalCall.cpp(455) Inf ChildOpalCall::LeaveCallBack
2019/06/11 14:57:22.399 0:40.217 Opal Garbage:5860 ChildOpalCall.cpp(459) Inf ChildOpalCall::LeaveCallBack locked ok
2019/06/11 14:57:22.399 0:40.217 Opal Garbage:5860 ChildOpalCall.cpp(469) Inf ChildOpalCall::LeaveCallBack exit
2019/06/11 14:57:22.399 0:40.218 Opal Garbage:5860 ChildOpalCall.cpp(117) Inf ChildOpalCall::InternalDelete exit
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ChildOpalCall.cpp(97) Inf CallDeleteThreadProc thread=3792
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ChildOpalCall.cpp(60) Inf ChildOpalCall::~ChildOpalCall this=032B43E8
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ChildOpalCall.cpp(64) Inf ChildOpalCall::~ChildOpalCall locked ok
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ChildOpalCall.cpp(69) Inf ChildOpalCall::~ChildOpalCall delete FWriteChannel
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 WriteChannel.cpp(42) Inf CWriteChannel::~CWriteChannel
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 WriteChannel.cpp(48) Inf CWriteChannel::~CWriteChannel locked ok
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 WriteChannel.cpp(67) Inf CWriteChannel::StopIO
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 WriteChannel.cpp(71) Inf CWriteChannel::StopIO locked ok
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 WriteChannel.cpp(93) Inf CWriteChannel::StopIO exit
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 WriteChannel.cpp(52) Inf CWriteChannel::~CWriteChannel exit
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ChildOpalCall.cpp(78) Inf ChildOpalCall::~ChildOpalCall delete FReadChannel
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ReadChannel.cpp(48) Inf CReadChannel::~CReadChannel
2019/06/11 14:57:22.399 0:40.218 ThreadID:3792 ReadChannel.cpp(54) Inf CReadChannel::~CReadChannel locked ok
2019/06/11 14:57:22.400 0:40.218 ThreadID:3792 ReadChannel.cpp(73) Inf CReadChannel::StopIO
2019/06/11 14:57:22.400 0:40.218 ThreadID:3792 ReadChannel.cpp(77) Inf CReadChannel::StopIO locked ok
2019/06/11 14:57:22.400 0:40.218 ThreadID:3792 ReadChannel.cpp(86) Inf CReadChannel::StopIO exit
2019/06/11 14:57:22.400 0:40.218 ThreadID:3792 ReadChannel.cpp(66) Inf CReadChannel::~CReadChannel exit
2019/06/11 14:57:22.400 0:40.218 ThreadID:3792 ChildOpalCall.cpp(84) Inf ChildOpalCall::~ChildOpalCall LeaveCallBack
2019/06/11 14:57:22.400 0:40.218 ThreadID:3792 ChildOpalCall.cpp(455) Inf ChildOpalCall::LeaveCallBack
2019/06/11 14:57:22.400 0:40.219 ThreadID:3792 ChildOpalCall.cpp(459) Inf ChildOpalCall::LeaveCallBack locked ok
2019/06/11 14:57:22.400 0:40.219 ThreadID:3792 ChildOpalCall.cpp(469) Inf ChildOpalCall::LeaveCallBack exit
2019/06/11 14:57:22.400 0:40.219 ThreadID:3792 ChildOpalCall.cpp(90) Inf ChildOpalCall::~ChildOpalCall exit
2019/06/11 14:57:22.400 0:40.219 ThreadID:3792 call.cxx(79) Call Call[ed42ec4311] destroyed.
2019/06/11 14:57:22.400 0:40.219 ThreadID:3792 ChildOpalCall.cpp(103) Inf CallDeleteThreadProc finished thread=3792
2019/06/11 14:57:25.414 0:43.234 Opal Listener:8924 transports.cxx(1198) Opal Created transport UDP this=032AC0B0
2019/06/11 14:57:25.414 0:43.234 Opal Listener:8924 transports.cxx(1209) OpalUDP Binding to interface: 172.16.100.15:5060
2019/06/11 14:57:25.414 0:43.234 Opal Listener:8924 transports.cxx(455) InfLD Phase 3
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 transports.cxx(494) InfLD Phase 11
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 sipep.cxx(219) InfLD Phase A 1
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 sipep.cxx(223) InfLD Phase A 2
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 sipep.cxx(226) InfLD Phase A 3
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 sipep.cxx(346) InfLD Phase B 1
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 sippdu.cxx(1569) InfDEBUG# SIP_PDU::SIP_PDU this=05117370
2019/06/11 14:57:25.415 0:43.234 Opal Listener:8924 sipep.cxx(351) InfLD Phase B 2

[/spoiler]
MaxRAF
 
Сообщений: 6
Зарегистрирован: 25 фев 2011, 10:23

Re: Проблема с входящими SIP/2.0 486 Busy Here

Сообщение april22 » 11 июн 2019, 10:13

To: <sip:647685@172.16.100.15:5060> - не настораживает ?!
Своими вопросами , вы загоняете меня в ГУГЛЬ.
april22
 
Сообщений: 2076
Зарегистрирован: 09 июл 2012, 09:47

Re: Проблема с входящими SIP/2.0 486 Busy Here

Сообщение MaxRAF » 11 июн 2019, 10:29

Огромнейшее спасибо! На фаерволе сменил 5060, на 5063 и всё ок.
MaxRAF
 
Сообщений: 6
Зарегистрирован: 25 фев 2011, 10:23


Вернуться в Конфигурация и настройка Asterisk

Кто сейчас на форуме

Сейчас этот форум просматривают: нет зарегистрированных пользователей и гости: 5

cron
© 2008 — 2019 Asterisk.ru
Digium, Asterisk and AsteriskNOW are registered trademarks of Digium, Inc.
Design and development by PostMet-Netzwerk GmbH