После обновления ПО до версии 1.9.0 перестала отрабатываться решетка в наборе (функция stop dial at #). Причем, есть подозрение, что это происходит только при наборе номеров начинающихся со звездочки.
Вот кусок лога при звонке на номер *60. Dial timeout на шлюзе выставлен на 4 секунды. Эти 4 секунды и видны в логе, после того как шлюз распознал набор решетки.
Код: Выделить всё
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.513[app:dbg]HIO: port 1 <Talk/hangdown> msg <Digit>
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.515[app:dbg]port 1 (hangdown): digit * [tone] : (call or dvo tune) in Wed Jun 6 09:05:55 2012
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.516[app:dbg]Port 1: Start dial duration timer (300)
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.518[app:dbg]port 1: from state 'hangdown' to state 'dial'
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.519[app:dbg]Chan 1: current state is CREATED
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.521[app:dbg]Port 1: check vapi queue ('free') at vapi_stop_tone_chan:1409
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.522[app:dbg]Port 1: set vapi queue MSP to 'busy' with 'stop_tone' at vapi_stop_tone_chan:1430
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.524[app:dbg]VQ Port 1 = MSP : 'stop_tone' =
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.526[app:dbg]Port 1: check vapi queue ('busy''stop_tone') at __cmd_engine:322
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.528[app:dbg]NO DVO ENABLED
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.530[app:dbg]search_table_route(): dialed: <*>:1, final 0xbec8dcdc, dt 0xbec8dcd8, port 1
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.531[app:dbg]search_table_route(): dialed: <*>:1, final 1, dt 0, port 1, entry <__none__>
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.533[app:dbg]port_process_digit() table route (nil), final 1, dt 0
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.534[app:dbg]port 1: no route for <*>, outbound
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.535[app:dbg]dial_reset_table_timer() table timeout 4
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.539[app:dbg][GM] self_fxs_state()
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.545[app:dbg]Port 1: check vapi queue ('busy''stop_tone') at vapi_cb_chan:3338
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.550[app:dbg]Port 1: new state is dial
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.552[app:dbg]Port 1: set vapi queue MSP to 'free' with at vapi_cb_chan:3339
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.556[app:dbg]Port 1: check vapi queue ('free') at vapi_next_ops:2727
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.557[app:dbg]Port 1 get cmd 'no event' from queue at (vapi_next_ops:2734)
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.808[app:dbg]HIO: port 1 <Talk/dial> msg <Digit>
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.809[app:dbg]port 1 (dial): digit 6 [tone] : (call or dvo tune) in Wed Jun 6 09:05:55 2012
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.811[app:dbg]search_table_route(): dialed: <*6>:2, final 0xbec8dcdc, dt 0xbec8dcd8, port 1
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.813[app:dbg]search_table_route(): dialed: <*6>:2, final 1, dt 0, port 1, entry <__none__>
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.814[app:dbg]port_process_digit() table route (nil), final 1, dt 0
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.815[app:dbg]port 1: no route for <*6>, outbound
Jun 6 09:05:55 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(55.817[app:dbg]dial_reset_table_timer() table timeout 4
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.107[app:dbg]HIO: port 1 <Talk/dial> msg <Digit>
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.109[app:dbg]port 1 (dial): digit 0 [tone] : (call or dvo tune) in Wed Jun 6 09:05:56 2012
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.111[app:dbg]search_table_route(): dialed: <*60>:3, final 0xbec8dcdc, dt 0xbec8dcd8, port 1
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.112[app:dbg]search_table_route(): dialed: <*60>:3, final 1, dt 0, port 1, entry <__none__>
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.114[app:dbg]port_process_digit() table route (nil), final 1, dt 0
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.115[app:dbg]port 1: no route for <*60>, outbound
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.117[app:dbg]dial_reset_table_timer() table timeout 4
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.345[app:dbg]HIO: port 1 <Talk/dial> msg <Digit>
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.347[app:dbg]port 1 (dial): digit # [tone] : (call or dvo tune) in Wed Jun 6 09:05:56 2012
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.349[app:dbg]Check stop dial
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.350[app:dbg]search_table_route(): dialed: <*60>:3, final 0xbec8dcdc, dt 0xbec8dcd8, port 1
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.352[app:dbg]search_table_route(): dialed: <*60>:3, final 1, dt 514584, port 1, entry <__none__>
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.353[app:dbg]port_process_digit() table route (nil), final 1, dt 0
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.355[app:dbg]port 1: no route for <*60>, outbound
Jun 6 09:05:56 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(56.356[app:dbg]dial_reset_table_timer() table timeout 4
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.106[app:dbg]port 1 (dial): timer (dial table)
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.108[app:dbg]search_table_route(): dialed: <*60>:3, final 0xbec8dd3c, dt (nil), port 1
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.109[app:dbg]search_table_route(): dialed: <*60>:3, final 1, dt -1, port 1, entry <__none__>
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.111[app:dbg]pbx: allocating memory for new call
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.112[app:dbg]pbx: created new outgoing call for port 1
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.114[app:dbg]port 1: routing by outbound proxy(SIP)
Jun 6 09:06:00 1k-fxs72-1.rshu.tel 1k-fxs72-1: 1.9.0|(00.115[app:dbg]port 1: -> calling to sip//*60
На новом шлюзе, который к нам недавно приехал уже с версией ПО 1.9.0, проблема тоже присутствует.