asterisk медленно отвечает на запросы

[sokolovas]

В организации стоит Asterisk Realtime собранный на http://www.voiceone.it/ (и порядком переделанный).
На нем порядка 250 внутренних пользователей и 10 внешних многоканальных номеров.
Появилась проблема, что asterisk очень медленно обрабатывает запросы, т.е. звонишь на городской номер, в ivr набираешь добавочный номер сотрудника и проходит секунд 25 прежде чем начинаешь слышать КПВ и вызов уходит на этот внутренний вызов.
Загрузка проца минимальна, памяти тоже хватает, куда копать ума не приложу.
Так же есть еще asterisk2, при попытке позвонить с него на проблемный asterisk1 вижу 7 подряд инвайтов, в итоге на asterisk2 вызов умирает через 10 секунд, а asterisk1 через 9-10 секунд шлет trying, а потом 8 раз declined (это нормально, т.к. на asterisk1 для asterisk2 нет пира, но почему сразу не приходит отбой, а такая задержка?).

[Glukinho]

У вас в хозяйстве стоит Asterisk с realtime, порядком переделанный из какой-то итальянской коробочки, плюс там же какой-то asterisk2, при этом вы уверенно оперируете словами "пир", "trying", "declined", и вы не можете определить, почему медленно обрабатываются вызовы?

Что-то здесь не складывается)

[sokolovas]

Итальянскую коробочку ставил не я, я настраивал только asterisk2.
У меня был рутовый доступ на asterisk1 и для того чтобы можно было звонить с asterisk2 на asterisk1 я достаточно быстро настроил заводят руками пользователя в mysql. Работало весьма стабильно, но в одну сторону. Чтобы с asterisk1 могли звонить на asterisk2 зашел в вэб админку, посмотрел как там заведены транки, по образу и подобию прописал под asterisk2 - звонки заходили, но появилась эта проблема с задержкой. Удалил все настройки в mysql, но проблема осталась. Естественно рестарт сервера делал - не помогло.
Когда что-то не работает я привык делать дамп, но в данном случае это не помогло, т.к. только подтвердил что задержки есть, но не позволяет понять их причину.

[virus_net]

смотреть нужно логи, на каком моменте возникает задержка, т.е. что исполняется в этот момент
а так это может много чего быть. от тормозящего запроса к БД до тормозов при чтении с винта. например при включенной записи вызовов, когда в папке monitor очеееень много файлов.

[awsswa]

sokolovas Вы из Перми случайно ?

[sokolovas]

смотреть нужно логи, на каком моменте возникает задержка, т.е. что исполняется в этот момент
а так это может много чего быть. от тормозящего запроса к БД до тормозов при чтении с винта. например при включенной записи вызовов, когда в папке monitor очеееень много файлов.

Тоже думал, что это скрипт тормозит сначала, но потом обратил внимание на входящий звонок с другого астера, в этот момент в логах ничего нет совсем, пир не прописан и вызов должен просто отбиться без всяких скриптов по дефолтному контексту с exten => _X.,1,hangup, но даже это происходит со значительной задержкой.

[sokolovas]

sokolovas Вы из Перми случайно ?

Географическое положение может быть связано с возникновением таких сложностей?)

[ded]

Во втором окне параллельно смотрите выхлоп tcpdump port 5060
чтобы понять - торможение на каком участке.
В первом окне,когда входящий звонок с другого астера, в этот момент в логах ничего нет совсем, включите sip set debug on.
Всё будет видно.

[sokolovas]

В консоли астериска эти 9 секунд задержки так же и видны.

[2015-11-14 16:13:34] VERBOSE[1348] chan_sip.c:
<--- SIP read from UDP:192.168.1.200:5060 --->
INVITE sip:352@192.168.2.200 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bK30915a2e
Max-Forwards: 70
From: "asterisk" <sip:asterisk@192.168.1.200>;tag=as7ffcfcc6
To: <sip:352@192.168.2.200>
Contact: <sip:asterisk@192.168.1.200:5060>
Call-ID: 3b2e32c809c0dd93102896973b3d3a6b@192.168.1.200:5060
CSeq: 102 INVITE
User-Agent: Asterisk PBX 13.6.0
Date: Sat, 14 Nov 2015 11:14:59 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 261

v=0
o=root 1953058929 1953058929 IN IP4 192.168.1.200
s=Asterisk PBX 13.6.0
c=IN IP4 192.168.1.200
t=0 0
m=audio 10012 RTP/AVP 8 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=maxptime:150
a=sendrecv

<------------->
[2015-11-14 16:13:34] VERBOSE[1348] chan_sip.c: --- (14 headers 12 lines) ---
[2015-11-14 16:13:34] VERBOSE[1348] chan_sip.c: Sending to 192.168.1.200:5060 (no NAT)
[2015-11-14 16:13:34] VERBOSE[1348][C-0000001c] chan_sip.c: Sending to 192.168.1.200:5060 (no NAT)
[2015-11-14 16:13:34] VERBOSE[1348][C-0000001c] chan_sip.c: Using INVITE request as basis request - 3b2e32c809c0dd93102896973b3d3a6b@192.168.1.200:5060
[2015-11-14 16:13:34] VERBOSE[1348][C-0000001c] chan_sip.c: No matching peer for 'asterisk' from '192.168.1.200:5060'
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] netsock2.c: == Using SIP RTP CoS mark 5
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Found RTP audio format 8
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Found RTP audio format 0
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Found RTP audio format 101
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Found audio description format PCMA for ID 8
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Found audio description format PCMU for ID 0
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Found audio description format telephone-event for ID 101
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Capabilities: us - (ulaw|alaw|g729|g722), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing)
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combin
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Peer audio RTP is at port 192.168.1.200:10012
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: Looking for 352 in default (domain 192.168.2.200)
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c: list_route: hop: <sip:asterisk@192.168.1.200:5060>
[2015-11-14 16:13:43] VERBOSE[1348][C-0000001c] chan_sip.c:
<--- Transmitting (no NAT) to 192.168.1.200:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bK30915a2e;received=192.168.1.200
From: "asterisk" <sip:asterisk@192.168.1.200>;tag=as7ffcfcc6
To: <sip:352@192.168.2.200>
Call-ID: 3b2e32c809c0dd93102896973b3d3a6b@192.168.1.200:5060
CSeq: 102 INVITE
Server: Free PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Contact: <sip:352@192.168.2.200:5060>
Content-Length: 0

[2015-11-14 16:13:43] VERBOSE[7214][C-0000001c] pbx.c: -- Executing [352@default:1] Hangup("SIP/192.168.1.200-0000002b", "") in new stack
[2015-11-14 16:13:43] VERBOSE[7214][C-0000001c] pbx.c: == Spawn extension (default, 352, 1) exited non-zero on 'SIP/192.168.1.200-0000002b'
[2015-11-14 16:13:43] VERBOSE[7214][C-0000001c] chan_sip.c: Scheduling destruction of SIP dialog '3b2e32c809c0dd93102896973b3d3a6b@192.168.1.200:5060' in 32000
[2015-11-14 16:13:43] VERBOSE[7214][C-0000001c] chan_sip.c:
<--- Reliably Transmitting (no NAT) to 192.168.1.200:5060 --->
SIP/2.0 603 Declined
Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bK30915a2e;received=192.168.1.200
From: "asterisk" <sip:asterisk@192.168.1.200>;tag=as7ffcfcc6
To: <sip:352@192.168.2.200>;tag=as3e19ba4f
Call-ID: 3b2e32c809c0dd93102896973b3d3a6b@192.168.1.200:5060
CSeq: 102 INVITE
Server: Free PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Session-Expires: 1800;refresher=uas
Content-Length: 0

в 16:13:34 пакет пришел, тут же поняли, что пира нет, но при этом только в 16:13:43 шлет trying и тут же Declined.

[Zavr2008]

а если в cli набрать core show channels в это время - не замерзает?
это я о DNS ..