http://s52.radikal.ru/i138/1304/92/4b7278d5baeb.jpg
Видно, что регистрация на sip прокси есть. Однако при вызове invite от тау на sip прокси не приходит.
http://s020.radikal.ru/i713/1304/3d/f68cd332c741.jpg
Вот лог звонка - видно, что после набора сразу идет busy.
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.152[app:info]slic6. Event 2.
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.152[app:info]slic 6. Off-hook event
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.152[app:info]Set port 6 led to state 'LED_ON'
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.152[app:info]HIO: offhook TDM port '6' port enabled 1
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.152[app:info]HIO: offhook TDM port '6' direction unknown -> outgoing
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.152[app:dbg]port 6(46360090): offhook state: hangup
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.152[app:dbg]regex ID 6: dial reset
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.152[app:dbg]port 6: from state 'hangup' to state 'hangdown'
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.152[app:info]__cmd_engine: device not inited - init device before operation 1
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.232[app:info]vapi: Dev 0. Init TDM bus
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.242[app:info]IFNAME: eth0
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.242[app:info]Configure EMAC 0 for interface eth0
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.242[app:info]vapi: Dev 0. Init Eth addr: <00:11:22:33:44:55>
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.252[app:info]Setting Eth config
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.252[app:info]vapi: Dev 0. Init IP addr: <192.168.253.2>
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.252[app:info]vapi: Master Dev. Set Hairpin Mode: Ok
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.252[app:info]vapi: Master Dev. Type 'M83263'
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.252[app:info]vapi: Master Dev. ARM CODE VERSION: <mspvoip_v5_02_7>
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.332[app:dbg]Port 6: check vapi queue ('free') at vapi_create_chan:551
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.332[app:dbg]Chan 6: current state is INITIAL
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Port 6: set vapi queue MSP to 'busy' with 'create' at vapi_create_chan:579
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]VQ Conn 6 = MSP : 'create' =
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.372[app:info]Creating connection 6....
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Chan 6: INITIAL -> CREATING
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.372[app:info]11166: port 6 to busy
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Port 6: check vapi queue ('busy''create') at vapi_create_chan:551
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Port 6 put cmd 'create',cur 'create' to queue at (vapi_create_chan:557)
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]VQ Conn 6 = MSP : 'create' =
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]VQ Conn 6 + 00 : 'create' + <-get_ptr
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Port 6: check vapi queue ('busy''create') at vapi_start_tone_chan:1023
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Port 6 put cmd 'start_tone',cur 'create' to queue at (vapi_start_tone_chan:1033)
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]VQ Conn 6 = MSP : 'create' =
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]VQ Conn 6 + 00 : 'create' + <-get_ptr
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]VQ Conn 6 + 01 : 'start_tone' +
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.372[app:dbg]Port 6: user port 0, old state hangdown, new state
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.382[app:info]Set port 6 led to state 'LED_ON'
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.382[app:info]pbx -[msg_fxs_state]-> group
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.382[app:info]ITC: [msg_fxs_state] -> group
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.382[app:dbg]-----[GM] self_fxs_state()
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.382[app:dbg]Port 6: new state is hangdown
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.382[app:info]Search for hotnumbers
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.382[app:dbg]dump_port_calls() port 6:
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.382[app:dbg]Q:NONE
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.382[app:dbg]H:((nil),0x00000000,(nil),0) W:((nil),0x00000000,(nil)) N:((nil),0x00000000,(nil))
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.412[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000000
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.422[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.422[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000000 result 0x00000000
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.422[app:info]vapi: Conn 6 - << CREATED >>
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.422[app:dbg]vapi: Conn 6 - fix DTMF detector
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.452[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000046
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.462[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.462[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000046 result 0x00000000
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.462[app:dbg]vapi: Conn 6 - fix CNG generator
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.492[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000047
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.502[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.502[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000047 result 0x00000000
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.502[app:dbg]Chan 6: CREATING -> CREATED
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.512[app:dbg]Port 6: check vapi queue ('busy''create') at vapi_next_ops:2048
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.512[app:dbg]Port 6 get cmd 'create' from queue at (vapi_next_ops:2060)
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.512[app:dbg]VQ Conn 6 + 01 : 'start_tone' + <-get_ptr
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.512[app:dbg]Port 6: check vapi queue ('free') at vapi_create_chan:551
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.512[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.512[app:dbg]chan 6: no need to create - already exists
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.522[app:dbg]Port 6: check vapi queue ('free') at vapi_next_ops:2048
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.522[app:dbg]Port 6 get cmd 'start_tone' from queue at (vapi_next_ops:2060)
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.522[app:dbg]Port 6: check vapi queue ('free') at vapi_start_tone_chan:1023
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.522[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.522[app:dbg]Port 6: set vapi queue MSP to 'busy' with 'start_tone' at vapi_start_tone_chan:1057
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.522[app:dbg]VQ Conn 6 = MSP : 'start_tone' =
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.522[app:info]chan 6 start tone, id=21, direction=TDM
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.552[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x0000091f
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.562[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.562[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x0000091f result 0x00000000
Apr 10 17:11:42 OpenWrt user.info syslog: 17:11:42.562[app:info]Conn 6: Start tone - Successfull
Apr 10 17:11:42 OpenWrt user.debug syslog: 17:11:42.572[app:dbg]Port 6: check vapi queue ('busy''start_tone') at vapi_next_ops:2048
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.182[app:dbg]vapi_proc_event: eVAPI_TONE_DETECT_EVENT
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.182[app:info]vapi: tone detect: Conn 6. Change signal <DTMF digit 0> (duration 525711609 ms) -> <DTMF digit 1> (level 0 dBov)
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.192[app:info]hio: port 6: digit 1 (code 0x11), tone
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: from state 'hangdown' to state 'dial'
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Port 6: check vapi queue ('free') at vapi_stop_tone_chan:1101
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Port 6: set vapi queue MSP to 'busy' with 'stop_tone' at vapi_stop_tone_chan:1147
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]VQ Conn 6 = MSP : 'stop_tone' =
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.192[app:info]chan 6 stop tone
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Port 6: user port 0, old state dial, new state
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.192[app:info]Set port 6 led to state 'LED_ON'
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.192[app:info]pbx -[msg_fxs_state]-> group
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: digit 1
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]06: []
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port_process_digit() regex route (nil), final 1, dt 0
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: no route for <1>, outbound
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: process final route
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]regex_timers_dial_final() no routes found
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: final action
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: no routes found / L timers expired
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: from state 'dial' to state 'busy'
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Port 6: check vapi queue ('busy''stop_tone') at vapi_start_tone_chan:1023
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Port 6 put cmd 'start_tone',cur 'stop_tone' to queue at (vapi_start_tone_chan:1033)
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]VQ Conn 6 = MSP : 'stop_tone' =
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]VQ Conn 6 + 02 : 'start_tone' + <-get_ptr
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]port 6: reset
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]dump_port_calls() port 6:
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Q:NONE
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]H:((nil),0x00000000,(nil),0) W:((nil),0x00000000,(nil)) N:((nil),0x00000000,(nil))
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]free_final_mx: final_mx was NULL for port 6
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.192[app:dbg]Port 6: user port 0, old state busy, new state
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.192[app:info]Set port 6 led to state 'LED_ON'
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.202[app:info]pbx -[msg_fxs_state]-> group
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.202[app:dbg]regex ID 6: dial reset
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.202[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000920
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.192[app:info]ITC: [msg_fxs_state] -> group
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.212[app:dbg]-----[GM] self_fxs_state()
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.212[app:dbg]Port 6: new state is dial
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.212[app:info]ITC: [msg_fxs_state] -> group
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.212[app:dbg]-----[GM] self_fxs_state()
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.212[app:dbg]Port 6: new state is busy
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.202[app:info]Delete all RX-TX medias from port 6
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.212[app:info]Delete all RX-TX medias from port 14
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.222[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.222[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000920 result 0x00000000
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.222[app:info]Conn 6: Stop tone - Successfull
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.232[app:info]vapi: generic event, code 2 <Tone Generation completed>, conn 6
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.242[app:dbg]Port 6: check vapi queue ('busy''stop_tone') at vapi_next_ops:2048
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.242[app:dbg]Port 6 get cmd 'start_tone' from queue at (vapi_next_ops:2060)
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.242[app:dbg]Port 6: check vapi queue ('free') at vapi_start_tone_chan:1023
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.242[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.242[app:dbg]Port 6: set vapi queue MSP to 'busy' with 'start_tone' at vapi_start_tone_chan:1057
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.242[app:dbg]VQ Conn 6 = MSP : 'start_tone' =
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.242[app:info]chan 6 start tone, id=22, direction=TDM
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.272[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x0000091f
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.282[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.282[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x0000091f result 0x00000000
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.282[app:info]Conn 6: Start tone - Successfull
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.292[app:dbg]vapi_proc_event: eVAPI_TONE_DETECT_EVENT
Apr 10 17:11:43 OpenWrt user.info syslog: 17:11:43.292[app:info]vapi: tone detect: Conn 6. End of signal <DTMF digit 1>, duration 78 ms
Apr 10 17:11:43 OpenWrt user.debug syslog: 17:11:43.302[app:dbg]Port 6: check vapi queue ('busy''start_tone') at vapi_next_ops:2048
Apr 10 17:11:44 OpenWrt user.debug syslog: 17:11:44.372[app:dbg]vapi_proc_event: eVAPI_TONE_DETECT_EVENT
Apr 10 17:11:44 OpenWrt user.info syslog: 17:11:44.372[app:info]vapi: tone detect: Conn 6. Detect signal <DTMF digit 2> (level 17 dBov)
Apr 10 17:11:44 OpenWrt user.info syslog: 17:11:44.382[app:info]hio: port 6: digit 2 (code 0x12), tone
Apr 10 17:11:44 OpenWrt user.debug syslog: 17:11:44.452[app:dbg]vapi_proc_event: eVAPI_TONE_DETECT_EVENT
Apr 10 17:11:44 OpenWrt user.info syslog: 17:11:44.452[app:info]vapi: tone detect: Conn 6. End of signal <DTMF digit 2>, duration 90 ms
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.892[app:info]slic6. Event 8.
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.892[app:info]slic 6. Pre-On-hook event
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.892[app:info]HIO: preonhook TDM port '6', port enabled 1
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.892[app:dbg]Port 6: check vapi queue ('free') at vapi_stop_tone_chan:1101
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.892[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.892[app:dbg]Port 6: set vapi queue MSP to 'busy' with 'stop_tone' at vapi_stop_tone_chan:1147
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.892[app:dbg]VQ Conn 6 = MSP : 'stop_tone' =
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.892[app:info]chan 6 stop tone
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.922[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000920
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.932[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.932[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000920 result 0x00000000
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.932[app:info]Conn 6: Stop tone - Successfull
Apr 10 17:11:45 OpenWrt user.info syslog: 17:11:45.942[app:info]vapi: generic event, code 2 <Tone Generation completed>, conn 6
Apr 10 17:11:45 OpenWrt user.debug syslog: 17:11:45.952[app:dbg]Port 6: check vapi queue ('busy''stop_tone') at vapi_next_ops:2048
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]slic6. Event 1.
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]slic 6. On-hook event
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]Set port 6 led to state 'LED_OFF'
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]HIO: onhook TDM port '6', port enabled 1
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]port 6(46360090): onhook state: busy
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]regex ID 6: dial reset
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]port 6: from state 'busy' to state 'hangup'
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Port 6: check vapi queue ('free') at vapi_stop_tone_chan:1101
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]vapi_chan.c:1137: conn 6 peek cmd 'no event' from queue
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]port 6: reset
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]dump_port_calls() port 6:
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Q:NONE
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]H:((nil),0x00000000,(nil),0) W:((nil),0x00000000,(nil)) N:((nil),0x00000000,(nil))
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]Delete all RX-TX medias from port 6
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]Delete all RX-TX medias from port 14
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]free_final_mx: final_mx was NULL for port 6
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Port 6: check vapi queue ('free') at vapi_destroy_chan:726
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]Destroying connection 6...
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Chan 6: current state is CREATED
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Port 6: set vapi queue MSP to 'busy' with 'destroy' at vapi_destroy_chan:752
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]VQ Conn 6 = MSP : 'destroy' =
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.382[app:dbg]Chan 6: CREATED -> DESTROYING
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.382[app:info]Delete all RX-TX medias from port 6
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]Port 6: check vapi queue ('busy''destroy') at vapi_destroy_chan:726
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]Clear vapi queue of Port 6/chan 14
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]Port 6 put cmd 'destroy',cur 'destroy' to queue at (vapi_destroy_chan:733)
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]VQ Conn 14 = MSP : 'destroy' =
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]VQ Conn 14 + 00 : 'destroy' (hold) + <-get_ptr
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.392[app:info]11149: port 6 from busy
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]Port 6: user port 0, old state hangup, new state
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.392[app:info]Set port 6 led to state 'LED_OFF'
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.392[app:info]pbx -[msg_fxs_state]-> group
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.392[app:info]ITC: [msg_fxs_state] -> group
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]-----[GM] self_fxs_state()
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]Port 6: new state is hangup
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]dump_port_calls() port 6:
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]Q:NONE
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.392[app:dbg]H:((nil),0x00000000,(nil),0) W:((nil),0x00000000,(nil)) N:((nil),0x00000000,(nil))
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.392[app:info]Set port 6 led to state 'LED_OFF'
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.422[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000148
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.432[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.432[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000148 result 0x00000000
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.462[app:info]vapi_cb_req: 6 0 result 0x00000000 requid 0x00000103
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.472[app:dbg]vapi_proc_event: VAPI_CB
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.472[app:dbg]vapi_cb_chan: chan 6 reqest_id 0x00000103 result 0x00000000
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.472[app:dbg]Conn 6 destroyed
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.472[app:dbg]Chan 6: DESTROYING -> INITIAL
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.482[app:dbg]Port 6: check vapi queue ('busy''destroy') at vapi_next_ops:2048
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.482[app:dbg]Port 6 get cmd 'destroy' from queue at (vapi_next_ops:2060)
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.482[app:dbg]Port 6: check vapi queue ('free') at vapi_destroy_chan:726
Apr 10 17:11:46 OpenWrt user.info syslog: 17:11:46.482[app:info]Destroying connection 14...
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.482[app:dbg]Chan 14: current state is INITIAL
Apr 10 17:11:46 OpenWrt user.debug syslog: 17:11:46.492[app:dbg]Port 6: check vapi queue ('free') at vapi_next_ops:2048