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

Пауза между набором номера и собственно звонком

Новичком считается только что прочитавший «Астериск - будущее телефонии»
http://asterisk.ru/knowledgebase/books
и пытающийся сделать большее

Модератор: april22

Пауза между набором номера и собственно звонком

Сообщение chardisdze » 28 ноя 2018, 15:11

Доброго дня!
Для теста поднял FreePBX-подобный Asterisk 13.23.1
Вроде бы все заработало, НО...
Между набором номера и собственно звонком (гудками) есть пауза в 10-25 секунд.
Перепробовал кучу всяких ухищрений, описанный на подобных ресурсах - не помогает.
Кусочек Debagа звонка:
[Показать] Спойлер:
[2018-11-28 13:36:36] DEBUG[2118]: chan_sip.c:9425 __find_call: = Looking for Call ID: 4276517606@192.168.0.235 (Checking From) --From tag 1211855411 --To-tag
[2018-11-28 13:36:36] DEBUG[2118]: acl.c:992 ast_ouraddrfor: For destination '192.168.0.235', our source address is '192.168.0.220'.
[2018-11-28 13:36:36] DEBUG[2118]: chan_sip.c:3907 ast_sip_ouraddrfor: Setting AST_TRANSPORT_UDP with address 192.168.0.220:5060
[2018-11-28 13:36:36] DEBUG[2118]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.235:5063' into...
[2018-11-28 13:36:36] DEBUG[2118]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.235' and port '5063'.
[2018-11-28 13:36:36] DEBUG[2118]: chan_sip.c:9012 __sip_alloc: Allocating new SIP dialog for 4276517606@192.168.0.235 - INVITE (No RTP)
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: chan_sip.c:28833 handle_incoming: **** Received INVITE (5) - Command in SIP INVITE
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: sip/reqresp_parser.c:1711 parse_sip_options: Begin: parsing SIP "Supported: replaces"
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: sip/reqresp_parser.c:1726 parse_sip_options: Found SIP option: -replaces-
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: sip/reqresp_parser.c:1734 parse_sip_options: Matched SIP option: replaces
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.235:5063' into...
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.235' and port '5063'.
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.220' into...
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.220' and port ''.
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: chan_sip.c:3750 __sip_xmit: Trying to put 'SIP/2.0 401' onto UDP socket destined for 192.168.0.235:5063
[2018-11-28 13:36:36] DEBUG[2118]: chan_sip.c:9425 __find_call: = Looking for Call ID: 4276517606@192.168.0.235 (Checking From) --From tag 1211855411 --To-tag as19425dbd
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: chan_sip.c:28833 handle_incoming: **** Received ACK (6) - Command in SIP ACK
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: chan_sip.c:4534 __sip_ack: Stopping retransmission on '4276517606@192.168.0.235' of Response 1: Match Found
[2018-11-28 13:36:36] DEBUG[2118]: chan_sip.c:9425 __find_call: = Looking for Call ID: 4276517606@192.168.0.235 (Checking From) --From tag 1211855411 --To-tag
[2018-11-28 13:36:36] DEBUG[2118]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.220' into...
[2018-11-28 13:36:36] DEBUG[2118]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.220' and port ''.
[2018-11-28 13:36:36] DEBUG[2118]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.220' into...
[2018-11-28 13:36:36] DEBUG[2118]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.220' and port ''.
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: chan_sip.c:28833 handle_incoming: **** Received INVITE (5) - Command in SIP INVITE
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.235:5063' into...
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.235' and port '5063'.
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.220' into...
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.220' and port ''.
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: rtp_engine.c:459 ast_rtp_instance_new: Using engine 'asterisk' for RTP instance '0x7fe5a4006790'
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: res_rtp_asterisk.c:3185 ast_rtp_new: Allocated port 16620 for RTP instance '0x7fe5a4006790'
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: rtp_engine.c:476 ast_rtp_instance_new: RTP instance '0x7fe5a4006790' is setup and ready to go
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting 'asterisk-freepbx' into...
[2018-11-28 13:36:36] DEBUG[2118][C-00000001]: netsock2.c:226 ast_sockaddr_split_hostport: ...host 'asterisk-freepbx' and port ''.

-------------------------------------------------------------------------------------------ПАУЗА----------------------------------------------------------------------------------------------------

[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: res_rtp_asterisk.c:5955 ast_rtp_prop_set: Setup RTCP on RTP instance '0x7fe5a4006790'
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:5795 do_setnat: Setting NAT on RTP to Off
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10335 process_sdp: Processing session-level SDP v=0... UNSUPPORTED OR FAILED.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10335 process_sdp: Processing session-level SDP o=- 20203 20203 IN IP4 192.168.0.235... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10335 process_sdp: Processing session-level SDP s=SDP data... UNSUPPORTED OR FAILED.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '192.168.0.235' into...
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '192.168.0.235' and port ''.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10335 process_sdp: Processing session-level SDP c=IN IP4 192.168.0.235... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10335 process_sdp: Processing session-level SDP t=0 0... UNSUPPORTED OR FAILED.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: rtp_engine.c:764 ast_rtp_codecs_payloads_set_m_type: Setting tx payload type 0 based on m type on 0x7fe5593962a0
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: rtp_engine.c:764 ast_rtp_codecs_payloads_set_m_type: Setting tx payload type 8 based on m type on 0x7fe5593962a0
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: rtp_engine.c:764 ast_rtp_codecs_payloads_set_m_type: Setting tx payload type 18 based on m type on 0x7fe5593962a0
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: rtp_engine.c:764 ast_rtp_codecs_payloads_set_m_type: Setting tx payload type 9 based on m type on 0x7fe5593962a0
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: rtp_engine.c:764 ast_rtp_codecs_payloads_set_m_type: Setting tx payload type 101 based on m type on 0x7fe5593962a0
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=rtpmap:0 PCMU/8000... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=rtpmap:8 PCMA/8000... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=rtpmap:18 G729/8000... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=fmtp:18 annexb=no... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=rtpmap:9 G722/8000... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=fmtp:101 0-15... UNSUPPORTED OR FAILED.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=rtpmap:101 telephone-event/8000... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=ptime:20... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: chan_sip.c:10798 process_sdp: Processing media-level (audio) SDP a=sendrecv... OK.
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: acl.c:992 ast_ouraddrfor: For destination '192.168.0.235', our source address is '192.168.0.220'.


Чисто логически понимаю что netsock2.c пытается расколоть "asterisk-freepbx" на адрес и порт. Думаю что в этом загвоздка, хотя может я и не прав.
Если это так, то как запретить или поправить этот процесс?
Направьте в нужном направлении, пожалуйста.
chardisdze
 
Сообщений: 77
Зарегистрирован: 17 июн 2016, 17:18

Re: Пауза между набором номера и собственно звонком

Сообщение ded » 28 ноя 2018, 18:00

Не прав.
В ИП-телефонах (!) существует внутренний диал-план, количество цифр набранных с минимальной паузой между ними (interdigit timeout) после которых они оправляют этот номер внабор на станцию.
Если не прописан никакой диал-план, то они выжидают некоторое время таймаута, и тогда посылают. В мобильном то телефоне почти всё так же, только вы набираете цифры и отправляете их в набор кнопкой с трубкой. На некоторых ИП телефонах этот набор можно ускорить нажав на софт-кнопку dial после цифр, на аналоговых - решётку.
ded
 
Сообщений: 13484
Зарегистрирован: 26 авг 2010, 19:00

Re: Пауза между набором номера и собственно звонком

Сообщение chardisdze » 29 ноя 2018, 09:35

Нажатие dial и было. Не было бы лога debaga тогда до паузы.
Этот же телефон нормально без паузы работает на другом сервере, но там версия другая 13.22.0.
Вся загвоздка именно в этом: астер как будто подвисает перед
[Показать] Спойлер:
[2018-11-28 13:36:56] DEBUG[2118][C-00000001]: res_rtp_asterisk.c:5955 ast_rtp_prop_set: Setup RTCP on RTP instance '0x7fe5a4006790'
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5

Может быть это из за того что 13.23.1 на VMWare крутится...
Хотя в htop нагрузки нет почти никакой.
chardisdze
 
Сообщений: 77
Зарегистрирован: 17 июн 2016, 17:18

Re: Пауза между набором номера и собственно звонком

Сообщение chardisdze » 29 ноя 2018, 11:38

Большое спасибо всем отозвавшимся.
Проблема решена.
Сам накосячил. Надо было правильно настроить или правильно отключить NAT.
chardisdze
 
Сообщений: 77
Зарегистрирован: 17 июн 2016, 17:18


Вернуться в Вопросы новичков

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

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

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