AF
Asterisk Forum
обсуждения телефонии, VoIP и IP-PBX
12разделов
5 423тем
34 385сообщений
← К списку тем

Не регистрируются софтфоны (x-lite)

Asterisk GUI 6 сообщений 01.11.2010 12:57 - 21.11.2010 06:54
#1 01.11.2010 12:57

Не регистрируются софтфоны (x-lite)

Добрый день!
Мучаю Asterisk, перечитала кучу форумов, блогов, постов и т.д., но результата нет. Подскажите в чем может быть дело!!??

Конфигурируется * через web-интерфейс. Используется программный комплекс Trixbox.
Asterisk - 192.168.1.100
Х-lite установлен на машине с IP адресом 10.16.5.50.
На checkpoint(фаервол) открыты порты: c * : udp 5060, tcp 1723
на * : udp 5060, rtp 10000-10100

Настройки номера 1751 на * :
Display Name=1751
SIP Alias=1751
Outbound CID=1751
Ring Time=default
Call Waiting=enable
Call Screening=disable
dtmfmode=rtc2833
canreinvite=no
context=from-internal
host=dynamic
nat=yes
port=5060
qualify=yes
dial=SIP/1751

На X-Lite настройки следующие:
Account name: 1751
User ID: 1751
Domain:192.168.1.100
Display name:1751
Authorization name:1751
Register with domain and receive calls: галочка установлена

Во вкладке Topology:
Auto-detect firewall traversal method using ICE

Во вкладке Transport:
Signaling transport: Automatic

В логах X-lite:
[10-11-01]16:34:59.422 | Debug | Resip | "RESIP:TRANSPORT:Adding message to tx buffer to: [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=0 ]" |
[10-11-01]16:34:59.422 | Debug | Resip | "RESIP:TRANSPORT:Processing write for [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=0 ]" |
[10-11-01]16:34:59.422 | Debug | Resip | "RESIP:TRANSPORT:Could not find a connection for [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=0 ]" |
[10-11-01]16:34:59.422 | Debug | Resip | "RESIP:TRANSPORT:Creating fd=2872 V4/TCP" |
[10-11-01]16:34:59.422 | Debug | Resip | "RESIP:TRANSPORT:Opening new connection to [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=0 ]" |
[10-11-01]16:34:59.423 | Debug | Resip | "RESIP:TRANSPORT:ConnectionBase::ConnectionBase, who: [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=0 ] 0C70EC40" |
[10-11-01]16:34:59.423 | Debug | Resip | "RESIP:TRANSPORT:No compression library available: 0C70EC40" |
[10-11-01]16:34:59.423 | Debug | Resip | "RESIP:TRANSPORT:Creating TCP connection [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=0 ] on 2872" |
[10-11-01]16:35:00.424 | Info | Resip | "RESIP:TRANSPORT:Exception writing to socket 2872 code: 10061; closing connection" |
[10-11-01]16:35:00.424 | Debug | Resip | "RESIP:TRANSPORT:ConnectionBase::~ConnectionBase 0C70EC40" |
[10-11-01]16:35:00.424 | Info | Resip | "RESIP:TRANSACTION:Sending ConnectionTerminated [ V4 192.168.1.100:5060 TCP target domain=192.168.1.100 mFlowKey=2872 ] to TUs" |
[10-11-01]16:35:00.424 | Debug | Resip | "RESIP:DNS:Remove vip 192.168.1.100(1)" |
[10-11-01]16:35:00.424 | Info | Resip | "RESIP:TRANSACTION:Try sending request to a different dns result" |
[10-11-01]16:35:00.424 | Info | Resip | "RESIP:TRANSACTION:Ran out of dns entries for 192.168.1.100. Send 503" |
[10-11-01]16:35:00.424 | Debug | Resip | "RESIP:Helper::makeResponse(SipReq: REGISTER 192.168.1.100 tid=5f0fff4215e07e95 cseq=REGISTER
contact=1751@10.16.5.50:21751 / 1 from(tu) code=503 reason=" |
[10-11-01]16:35:00.425 | Debug | Resip | "RESIP:TRANSACTION:Send to TU: TU: DialogUsageManager size=1

SIP/2.0 503 Service Unavailable
Via: SIP/2.0/TCP 10.16.5.50:21751;branch=z9hG4bK-d8754z-5f0fff4215e07e95-1---d8754z-;rport
To: ""1751"";tag=64940f4d
From: ""1751"";tag=64eb13c0
Call-ID: ZWI0ODRiNzI1ZmZkOTc1ZDQ4ZmYzNWEzMThiNzRmMjM.
CSeq: 1 REGISTER
Warning: 499 XXXX-comp.YYYYY.ru """"
Content-Length: 0

" |
[10-11-01]16:35:00.425 | Debug | Resip | "RESIP:DUM:connection terminated message" |
[10-11-01]16:35:00.425 | Debug | Resip | "RESIP:DUM:Got connection terminated event" |
[10-11-01]16:35:00.425 | Debug | Resip | "RESIP:DUM:Processing connection terminated event..." |
[10-11-01]16:35:00.425 | Debug | Resip | "RESIP:DUM:no domain associated with the connection: 2872" |
[10-11-01]16:35:00.426 | Info | Resip | "RESIP:DUM:Got: SipResp: 503 tid=5f0fff4215e07e95 cseq=REGISTER / 1 from(wire)" |
[10-11-01]16:35:00.426 | Debug | Resip | "RESIP:DUM:DialogUsageManager::processResponse:

SipResp: 503 tid=5f0fff4215e07e95 cseq=REGISTER / 1 from(wire)" |
[10-11-01]16:35:00.426 | Debug | Resip | "RESIP:DUM:DialogId::DialogId: ZWI0ODRiNzI1ZmZkOTc1ZDQ4ZmYzNWEzMThiNzRmMjM.-64eb13c0-64940f4d" |
[10-11-01]16:35:00.426 | Debug | Resip | "RESIP:DUM:Registration failed for 192.168.1.100" |
[10-11-01]16:35:00.426 | Debug | CCM | "SipResp: 503 tid=5f0fff4215e07e95 cseq=REGISTER / 1 from(wire)[URI:1751@192.168.1.100]" | sua::CSIPRegistration::onFailure
[10-11-01]16:35:00.426 | Debug | CCM | "SipResp: 503 tid=5f0fff4215e07e95 cseq=REGISTER / 1 from(wire) [URI:1751@192.168.1.100]" | sua::CTransportMonitorUsingRegistration::OnSIPRegistrationFailure
[10-11-01]16:35:00.426 | Debug | CCM | "[F|1|T|503|F] [URI:1751@192.168.1.100]" | sua::CTransportMonitorUsingRegistration::ProcessDnsFailure
[10-11-01]16:35:00.426 | Debug | Resip | "RESIP:DUM:ClientRegistration::~ClientRegistration" |
[10-11-01]16:35:00.426 | Debug | Resip | "RESIP:DUM: ********** DialogSet::~DialogSet: ZWI0ODRiNzI1ZmZkOTc1ZDQ4ZmYzNWEzMThiNzRmMjM.-64eb13c0*************" |
[10-11-01]16:35:00.426 | Debug | CCM | "[URI:1751@192.168.1.100]" | sua::CSIPRegistration::OnAppDialogSetDestroy
[10-11-01]16:35:00.426 | Debug | CCM | "[URI:1751@192.168.1.100]" | sua::CSIPRegistration::InternalShutdown
[10-11-01]16:35:00.427 | Debug | CCM | "Will attempt to re-REGISTER in 5 sec.[URI:1751@192.168.1.100]" | sua::CSIPRegistrationWatcher::OnSIPRegistrationDestroyed
[10-11-01]16:35:00.427 | Debug | AbstractPhone | "[1751@192.168.1.100]::OnSIPRegistrationAttemptFailed" | AbPhone::CAccount::CCCMSink::OnSIPRegistrationAttemptFailed
[10-11-01]16:35:05.427 | Debug | CCM | "Re-trying to REGISTER[URI:1751@192.168.1.100]" | sua::CSIPRegistrationWatcher::OnTimer
[10-11-01]16:35:05.427 | Debug | CCM | "[URI:1751@192.168.1.100]" | sua::CSIPRegistration::Start
[10-11-01]16:35:05.428 | Debug | Resip | "RESIP:DUM:BaseCreator::makeInitialRequest:

0C6EBE80" |
[10-11-01]16:35:05.428 | Debug | Resip | "RESIP:DUM:RegistrationCreator::RegistrationCreator: 0C6EBE80" |
[10-11-01]16:35:05.428 | Debug | Resip | "RESIP:DUM: ************* Created DialogSet(UAC) -- Yzk2NTk3NTk0MWY0NmVlMDY0ZDBhMGVmZjg0YTU3NmU.-7aac5c45*************" |
[10-11-01]16:35:05.428 | Debug | Resip | "RESIP:DUM:SEND:

REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-841ea8c2f26be709-1---d8754z-;rport
Max-Forwards: 70
Contact:
To: ""1751""
From: ""1751"";tag=7aac5c45
Call-ID: Yzk2NTk3NTk0MWY0NmVlMDY0ZDBhMGVmZjg0YTU3NmU.
CSeq: 1 REGISTER
Expires: 3600
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
User-Agent: X-Lite 4 release 4.0 stamp 58832
Content-Length: 0

Уже не знаю, что можно посмотреть и что сделать!
В чем может быть причина!?
#2 02.11.2010 05:08
Дебаг лучше с астериска, потому что на икслайте трудно дебаги смотреть.
А вообще с компьютера пингуется серваг с астериском? И смотреть что в консоли при вызове происходит, со стороны астериска проблему искать, кажется это более правильный вариант.
#3 02.11.2010 06:27
Asterisk с машины пингуется.
Вызов совершить не могу, т.к. x-lite не регистрируется. Хотя * в System Status говорит: вижу 2 телефона!

Смущает вот это в логах астериска:
FONALITY: This thread has already held the conlock, skip lockin

WARNING:Cannot Connect read handle, either: Can't connect to local MySQL server through socket '/tmp/mysql.sock'

Added after 19 minutes:

Поставили x-lite в той же подсети что и *, вырубили фаервол ..... зарегался!

А с другой подсети так же не хочет! Фаервола нет на машине, через чекпоинт уже писала что открывали

Логи странные с *:
[Nov 2 09:46:16] NOTICE[2893] chan_sip.c: Peer '1751' is now UNREACHABLE! Last qualify: 0
[Nov 2 09:46:16] NOTICE[2893] chan_sip.c: Peer '1200' is now UNREACHABLE! Last qualify: 0
[Nov 2 09:47:58] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19866 - вот упорно пытается зарегаться, не получается
[Nov 2 09:47:59] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19868
[Nov 2 09:48:01] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19869
[Nov 2 09:48:05] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19871
[Nov 2 09:48:09] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19873
[Nov 2 09:48:13] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19877
[Nov 2 09:48:17] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 19879

[Nov 2 10:10:10] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 192.168.1.85 port 53858 - вот регается с той же подсети где *
[Nov 2 10:10:10] NOTICE[2893] chan_sip.c: Peer '1200' is now Reachable. (9ms / 2000ms)
[Nov 2 10:10:10] DEBUG[2872] pbx.c: FONALITY: This thread has already held the conlock, skip locking
[Nov 2 10:10:12] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 20101
[Nov 2 10:10:16] NOTICE[2893] chan_sip.c: Peer '1200' is now UNREACHABLE! Last qualify: 9
[Nov 2 10:10:16] DEBUG[2872] pbx.c: FONALITY: This thread has already held the conlock, skip locking
[Nov 2 10:10:16] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 10.16.5.20 port 20105
[Nov 2 10:11:05] VERBOSE[3161] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Nov 2 10:11:06] VERBOSE[3161] logger.c: == Manager 'admin' logged off from 127.0.0.1
[Nov 2 10:11:07] VERBOSE[3163] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Nov 2 10:11:07] VERBOSE[3163] logger.c: == Manager 'admin' logged off from 127.0.0.1
[Nov 2 10:15:28] VERBOSE[2893] logger.c: -- Unregistered SIP '1200'
[Nov 2 10:15:29] NOTICE[2893] chan_sip.c: Peer '1200' is now UNREACHABLE! Last qualify: 0
[Nov 2 10:16:00] VERBOSE[2893] logger.c: -- Registered SIP '1200' at 192.168.1.85 port 38038
#4 02.11.2010 07:33
1 проверте правильно ли у вас организован проброс портов на шлюзе
2 у вас одновременно регистрируются софтфоны с разных машин под одним аккаунтом: Registered SIP '1200' at 192.168.1.85
Registered SIP '1200' at 10.16.5.20
на FONALITY и WARNING не обращайте внимание
#5 15.11.2010 12:22
По поводу одновременной регистрации софтфонов: изначально регистрировался с моей машины (где не может зарегаться), а второй раз с той же подсети что и * (все ок).

В смысле на счет портов? "правильно ли они переброшены...."
#6 21.11.2010 06:54
попробуйте еще открыть TCP 5060
в логах Xlite явно видно что он по TCP пытается соединится.