TAU-32M.IP добавляет цифру к номера хотлайна

[powetr]

Имеет TAU-32M.IP. Версия 2.11.Кратко- ТАУ добавляет цифру к номеру хотлайна, не всегда правда.В саппорт писал- ответа месяц нет, все данные предоставлял.Вот кратко:
---==================-------------
Что имеем: Тау-32м.ip 192.168.17.230 с одним модулем 8FXO, порты модуля зарегистрированы на астериск (192.168.17.220) как пользователи с 1730 по 1737.
У каждого порта прописан номер горячей линии - с 1740 по 1747 соотвественно.То есть, при звонке на номер 1734 шлюз перенаправляет вызов на номер горячей линии 1744.
Однако, port 4 (1734) был замечен в добавлении лишней цифры к номеру горячей линии : вместо 1744 набирал 17443 ( есть дамп и лог).Однако делал это не всегда,
а достаточно редко, гдето с периодичностью неделя.В то же самое время он мог и нормально отрабатывать, набирая 1744.
В то же самое вермя, по включенному логу можно заметить, что с данной линии FXO ( port 4) приходил донабор с помощью DTMF как раз добавляемой цифры "3"!.Далее
видно, что шлюз формирует вызов именно от 1734 к 17443!Возможно, эти события связаны, и шлюз добавляет к номеру горячей линни цифру донабора.
Изложенное добавление цифр к номеру горячей линии происходит и на других линиях, с примерно такой же периодичностью.Возможно, какой то телефонный фрикер пытается
взломать телефонную сеть, осуществив транзитный звонок через шлюз нашей компании ( а так и происходит- в городе нумерация 5 знаков, хорошо что ГТС 17443 отбивает как несуществующий)
Теперь факты.Вот пример из лога трассировки:
===============================================
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.411)[app:info]sip: outgoing call 00040198 from endpoint 4
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.413)[app:info]sip_paramss_create() normal - using cur proxy [192.168.17.220] if proxy call
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.422)[app:info]sip_paramss_create() to host is <(null)>- should not have port, to user is <17443> use proxy 1
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.430)[app:info]sip: call 00040198: sip INVITE from sip:1734@192.168.17.220 to sip:17443@192.168.17.220
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.432)[app:info]sip: call 00040198: targeturl is <sip:17443@192.168.17.220>
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.468)[app:info]make_sdp: SDP: s=Session SDP#012m=audio 36266 RTP/AVP 8 0 96#012a=rtpmap:8 PCMA/8000#012a=rtpmap:0 PCMU/8000#012a=rtpmap:96 telephone-event/8000#012a=fmtp:96 0-16#012a=silenceSupp:off - - - -
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.476)[sip]nua(0x60a600): adding session usage
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.482)[sip]send 873 bytes to udp/[192.168.17.220]:5060 at 00:36:28.327743:
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.483)[sip] ------------------------------------------------------------------------
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.485)[app:info]SIP: got nua_r_set_params : 200(OK)
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.489)[sip] INVITE sip:17443@192.168.17.220 SIP/2.0
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.492)[sip] Via: SIP/2.0/UDP 192.168.17.230;rport;branch=z9hG4bKv3rQmKe6Ny6eB
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.495)[sip] Max-Forwards: 70
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.496)[sip] From: "1734" <sip:1734@192.168.17.220>;tag=D88QeytHHrtpH
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.498)[sip] To: <sip:17443@192.168.17.220>
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.500)[sip] Call-ID: 9f4af55e-cd56-1232-69ac-a8f94b09192c
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.502)[sip] CSeq: 1081094 INVITE
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.504)[sip] Contact: <sip:1734@192.168.17.230>
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.506)[sip] User-Agent: TAU-72 build 2.11.1 sofia-sip/1.12.10
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.508)[sip] Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, INFO
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.510)[sip] Supported: timer, 100rel, replaces
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.512)[sip] Min-SE: 120
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.513)[sip] Content-Type: application/sdp
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.516)[sip] Content-Disposition: session
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.518)[sip] Content-Length: 270
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.520)[sip]
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.521)[sip] v=0
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.523)[sip] o=- 5430418972655147349 2672584091500311064 IN IP4 192.168.17.230
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.526)[sip] s=Session SDP
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.527)[sip] c=IN IP4 192.168.17.230
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.529)[sip] t=0 0
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.531)[sip] m=audio 36266 RTP/AVP 8 0 96
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.533)[sip] a=rtpmap:8 PCMA/8000
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.535)[sip] a=rtpmap:0 PCMU/8000
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.537)[sip] a=rtpmap:96 telephone-event/8000
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.539)[sip] a=fmtp:96 0-16
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.541)[sip] a=silenceSupp:off - - - -
А вот явно виден донабор, предшествующий вышеприведенному: ( itc_call_to_port_eng() USER: 17443 - вот отсюда уже чтото не так)
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.269)[app:info]vapi: tone detect: Conn 4. End of signal <DTMF digit 3>, duration 700 ms
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.270)[app:info]port 4(FXO): detect digit '3'/0x3 on TDM
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.349)[app:info]port 4: PHONE_FROM = (1734)
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.350)[app:info]port 4: NAME_FROM = (1734)
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.359)[app:info]Call accepted
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.360)[app:info]add_call_to_global:280 - enter
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.366)[app:info]__itc_call_to_port_eng() USER: 17443; PHONE: 1734; NAME: 1734; R_USER: ;
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.368)[app:info]pbx -[msg_call]-> sip
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.377)[vapi]<APPITF> Entered VAPI_StopTone: conn(4)
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.378)[vapi]<APPITF> VAPI param debug: VAPI_StopTone: 4,0,0xbed01aec
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.380)[vapi]<APPITF> VAPI_StopTone: Exiting status(-68012), conn(4)
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.382)[app:info]chan 4 stop tone
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.385)[app:info]voip_lock: set voip lock
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.387)[app:info]pbx -[msg_fxs_state]-> group
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.394)[app:info]Conn 4: Stop tone - Successfull
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.405)[app:info]ITC: [msg_fxs_state] -> group
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.410)[app:info]ITC: [msg_call] -> sip
Oct 13 08:34:43 192.168.17.230 gmdep-tau32: 2.11.1|(43.411)[app:info]sip: outgoing call 00040198 from endpoint 4
======================================================================
Во вложении - полный лог за 13 октября, там есть и правильный набор, и ошибочный набор с дополнительными цифрами.Имеется также дамп wireshark, но в данном случае
данные аутентичны, и приводить их на данной стадии считаю ненужным.
---============++++++++++++++++++++++=========================-------------------
У кого было похожее? Проблема как раз в том, что IP АТС не понимает что это за 5-значный номер и посылает звонок не туда куда нужно.Что такое потеря входящего звонка для бизнеса объяснять не нужно надеюсь.
Ну и следующее.Что делать/куда бежать?

[Evgeniy]

День добрый.
Первое, что могу посоветовать - обновить версию ПО до версии 2.12, проверит воспроизведение проблемы на ней.
Вышлите дамп на 3036@eltex.org , кусками логи можно не прикладывать к задаче.