SMG2 - Asterisk
Добавлено: 10 авг 2016 15:13
Доброго дня.
Прошу помощи в настрйоке оборудования SMG2. Обнаружилась проблема при входящих вызовах. Провайдер присылает 10 цифр, а SMG2 почему-то первую отрезает и отправляет в Asterisk
Также возникает проблема односторонней слышимости. Asterisk, SMG2 в одной плоской сети без NAT, Кодек согласованный g711alaw
Прошу помощи в настрйоке оборудования SMG2. Обнаружилась проблема при входящих вызовах. Провайдер присылает 10 цифр, а SMG2 почему-то первую отрезает и отправляет в Asterisk
Код: Выделить всё
SMG-2. SN: VI45000322 Software Version: V.3.1.3.1116. 2/S Build: Apr 21 2016 16:21:07
Log started at: 10:23:40.224015
10:23:51.997290 [INFO] Q931. Line 00/00. Call 809C. RX 43
DUMP: 08.02.00.9C.05.A1.04.03.80.90.A3.18.03.A9.83.86.
6C.0C.21.81.39.32.36.33.35.38.38.36.38.39.70.0B.
A1.34.39.36.32.32.37.30.31.38.36.
0x009C (from orig), MSG=SETUP:
[sending complete]
[bearer capability:
cap=speech
std=CCITT
rate=64 kbit/s
mode=circuit
layer1=G.711 A-law]
[channel id: channel=6 (exclusive)] Coding=CCITT
[calling party number: 9260000000 (type=national, plan=ISDN, present.allowed, verifed & pass)]
[called party number: 4962270186 (type=national, plan=ISDN)]
---------------------------------
10:23:51.997443 [INFO] Q931. Line 00/00. Create Call, entry 00. Call 809C (Incoming)
10:23:51.997507 [INFO] Q931. Line 00/00. Call 809C. Incoming SETUP. Check chan id
10:23:51.997561 [INFO] Check IE 'Channel ID': channel id='as indicated' chan=6, mode excl
10:23:51.997619 [INFO] Q931. Line 00/00. Search B-chan: chan 6, mask 00010001 - chan ok: mask 00010001
10:23:51.997669 [INFO] Check IE 'Bearer capablity: {speech}{64 kbit/s}{G.711 A-law}
10:23:51.997727 [INFO] Check IE 'Called party number': {type=0x02, plan=0x01} <4962270186> (10)
10:23:51.997785 [INFO] Check IE 'Calling party number': {type=0x02, plan=0x01}, {presentation=0, screening=1} <0000000000> (10)
10:23:51.997838 [INFO] Q931. Line 00/00. Call 809C. Incoming SETUP. CgPN <000000000>(9), CdPN <4962270186>(10) isdn flag=03
10:23:51.997921 [INFO] Port PRI:00:00. VChan set (chan 6) - 'line 0, chan 24'
10:23:51.997996 [INFO] Port PRI:00:00. Seize (v-chan:06, TG:00). Cld:'<none>'(0). (Trunk) . Clg-len: 9. clg-set: y. COS: -1. RADIUS=-1
10:23:51.998058 [INFO] Port PRI:00:00. ModTable in [-1:-1], out [-1:-1], out redir:orig [-1:-1]
10:23:51.998120 [INFO] Port PRI:00:00. CgPN: <263588689>(9) <set> <national> <isdn/telephony> <allowed> <verifed&pass>. cat [9].
10:23:51.998179 [INFO] Port PRI:00:00. Calling number: 263588689, use for sorm: all digits
10:23:51.998237 [INFO] Port PRI:00:00. Calling Info (pres allowed): <263588689>. <Category=9>
10:23:51.998290 [INFO] Port PRI:00:00. CgPN: <263588689>(9) <set> <national> <isdn/telephony> <allowed> <verifed&pass>. cat [9].
10:23:51.998349 [INFO] Port PRI:00:00. Set state 'In-Dial'
10:23:51.998402 [INFO] Q931. Line 00/00. Call 809C. Incoming seize - PLAN 0. COS 0
10:23:51.998454 [INFO] Q931. Line 00/00. Call 809C. Incoming SETUP. proc dial
10:23:51.998505 [INFO] Q931. Line 00/00. Call 809C. State 'Overlap Receiving'
10:23:51.998560 [INFO] Q931. Line 00/00. Call 809C. In Dial: 4962270186{EndOfDial}
10:23:51.998613 [INFO] Q931. Line 00/00. Call 809C. Timer 'T302' (15 sec) start in state 'Overlap Receiving'
10:23:51.998688 [INFO] Port PRI:00:00. Dial In (in=11, need rm=0): <4><9><6><2><2><7><0><1><8><6>[.]
10:23:51.998747 [INFO] Port PRI:00:00. In Digit 11 sym: called buf <4962270186.>
10:23:51.998797 [INFO] Port PRI:00:00. Dial buf <4962270186>(10)
10:23:51.998852 [INFO] Port PRI:00:00. Dial Proc (state In-Dial, called len 11): <4962270186.> Compl.
10:23:51.998904 [INFO] Port PRI:00:00. Dial Proc. RADIUS return-code: [0].
10:23:51.998958 [INFO] Port PRI:00:00. Search route. Mode: 'calling'. Num: <263588689>(9).# Complete
10:23:51.999037 [INFO] Port PRI:00:00. Search route. result: route not found. res (-1)
10:23:51.999096 [INFO] Port PRI:00:00. Search route. Mode: 'called'. Num: <4962270186.>(11).# Complete
10:23:51.999361 [INFO] Port PRI:00:00. Search route. result: found route: prefix[0]. res (10)
10:23:51.999423 [INFO] Port PRI:00:00. Process route to prefix[0]. (0 attempt)
10:23:51.999479 [INFO] Port PRI:00:00. Send 'End of Dial' to incoming call
10:23:51.999533 [INFO] Q931. Line 00/00. Call 809C. End Dial in state 'Overlap Receiving' (condition for call proceeding reached)
10:23:51.999587 [INFO] Q931. Line 00/00. Call 809C. Timer 'T302' stop in state 'Overlap Receiving'
10:23:51.999735 [INFO] Q931. Line 00/00. Call 809C. TX 11
DUMP: 08.02.80.9C.02.18.03.A9.83.86.
0x009C (to orig), MSG=CALL PROCEEDING:
[channel id: channel=6 (exclusive)] Coding=CCITT
---------------------------------
10:23:51.999873 [INFO] Q931. Line 00/00. Call 809C. State 'Incoming Call Proceeding'
10:23:51.999943 [INFO] Port PRI:00:00. Prefix 00: type 'TRUNK', idx=1
10:23:51.999998 [INFO] Port PRI:00:00. Accs on
10:23:52.000052 [INFO] Port PRI:00:00. Link to TG 01. Out modifiers-table: clg[-1], cld[-1], redir[-1], orig[-1], generic[-1]
10:23:52.000166 [INFO] Port PRI:00:00. Link to TG 01. Setup mode: enblock <ST>
10:23:52.000225 [INFO] Port PRI:00:00. Link to TG 01: mode Local. Dir=0, Cld=2 Select Order=. In buf: ~4962270186.
10:23:52.000280 [INFO] Port PRI:00:00. TG: Link entry to SIPT[00]
10:23:52.000337 [INFO] Port PRI:00:00. Outgoing setup to SIPT:0000.
10:23:52.000391 [INFO] SIPT[00]. Seize from port PRI:00:00.
10:23:52.000481 [INFO] Port SIPT:041d. Check out-calling-modify: '263588689'(9). ModTable[-1], ClgMod[-1]
10:23:52.000545 [INFO] Port SIPT:041d. Check out-calling-from-RADIUS-modify: '263588689'(9). ClgMod[-1]
10:23:52.000602 [INFO] SIPT[00]. Seize - interface 0 [ID: 01]: set host:port 172.17.17.3:5060
10:23:52.000660 [INFO] Port SIPT:041d. Set parent PRI:00:00
10:23:52.000712 [INFO] Port SIPT:041d. VChanIP set - 'line 0, chan 24'
10:23:52.000787 [INFO] Port SIPT:041d. Create msp-conn Conn[0006].
10:23:52.000865 [INFO] Conn[0006]: Set state 'Idle'->'AllocReq'
10:23:52.001065 [INFO] Port SIPT:041d. Set new IP Conn[0006] with chan[24]
10:23:52.001146 [INFO] Conn[0006]: set network interface in state 'AllocReq'. IP <172.17.17.2>. net-dev [0]
10:23:52.001200 [INFO] SIP. Callref 041d. IP-conn [0006] ready
10:23:52.001258 [INFO] Port SIPT:041d. loc 0, trunk-loc 0. peer-loc 0, peer-tunk-loc: 0
10:23:52.001312 [INFO] Port PRI:00:00. loc 0, trunk-loc 0. peer-loc 0, peer-tunk-loc: 0
10:23:52.001368 [INFO] Conn[0006]. Set owner Port SIPT:041d (previous was SIPT:041d)
10:23:52.001424 [INFO] Conn[0006]: set network interface in state 'AllocReq'. IP <172.17.17.2>. net-dev [0]
10:23:52.001475 [INFO] SIPT[00]. Seize - dst '172.17.17.3:5060' src-port 0
10:23:52.001525 [INFO] SIPT[00]. Seize CgPN: <263588689>(9) <set> <national> <isdn/telephony> <allowed> <verifed&pass>. cat [9](0x39)
10:23:52.001581 [INFO] SIPT[00]. Seize - calling category: '9' convert to ISUP category 229
10:23:52.001633 [INFO] SIPT[00]. Seize - enblock mode
10:23:52.001737 [INFO] Port SIPT:041d. Set state 'Wait-Num'
10:23:52.001805 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 00
10:23:52.001860 [INFO] Port SIPT:041d. Dial Out=4 (ext)
10:23:52.001914 [INFO] Port SIPT:041d. Check out-called-modify: '4'(1). ModTable[-1], CldMod[-1]
10:23:52.001971 [INFO] SIP. Callref 041d. Dial 4
10:23:52.002021 [INFO] Port SIPT:041d. Dial Out: called len 00, append 01 (max digit 30)
10:23:52.002084 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 01
10:23:52.002135 [INFO] Port SIPT:041d. Dial Out=9 (ext)
10:23:52.002366 [INFO] SIP. Callref 041d. Dial 9
10:23:52.002432 [INFO] Port SIPT:041d. Dial Out: called len 01, append 01 (max digit 30)
10:23:52.002498 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 02
10:23:52.002550 [INFO] Port SIPT:041d. Dial Out=6 (ext)
10:23:52.002603 [INFO] SIP. Callref 041d. Dial 6
10:23:52.002653 [INFO] Port SIPT:041d. Dial Out: called len 02, append 01 (max digit 30)
10:23:52.002740 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 03
10:23:52.002797 [INFO] Port SIPT:041d. Dial Out=2 (ext)
10:23:52.002851 [INFO] SIP. Callref 041d. Dial 2
10:23:52.002901 [INFO] Port SIPT:041d. Dial Out: called len 03, append 01 (max digit 30)
10:23:52.003014 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 04
10:23:52.003075 [INFO] Port SIPT:041d. Dial Out=2 (ext)
10:23:52.003130 [INFO] SIP. Callref 041d. Dial 2
10:23:52.003179 [INFO] Port SIPT:041d. Dial Out: called len 04, append 01 (max digit 30)
10:23:52.003242 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 05
10:23:52.003293 [INFO] Port SIPT:041d. Dial Out=7 (ext)
10:23:52.003345 [INFO] SIP. Callref 041d. Dial 7
10:23:52.003451 [INFO] Port SIPT:041d. Dial Out: called len 05, append 01 (max digit 30)
10:23:52.003518 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 06
10:23:52.003571 [INFO] Port SIPT:041d. Dial Out=0 (ext)
10:23:52.003624 [INFO] SIP. Callref 041d. Dial 0
10:23:52.003673 [INFO] Port SIPT:041d. Dial Out: called len 06, append 01 (max digit 30)
10:23:52.003855 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 07
10:23:52.003928 [INFO] Port SIPT:041d. Dial Out=1 (ext)
10:23:52.004071 [INFO] SIP. Callref 041d. Dial 1
10:23:52.004132 [INFO] Port SIPT:041d. Dial Out: called len 07, append 01 (max digit 30)
10:23:52.004198 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 08
10:23:52.004251 [INFO] Port SIPT:041d. Dial Out=8 (ext)
10:23:52.004304 [INFO] SIP. Callref 041d. Dial 8
10:23:52.004353 [INFO] Port SIPT:041d. Dial Out: called len 08, append 01 (max digit 30)
10:23:52.004416 [INFO] Port SIPT:041d. Query Next Digit - peer PRI:00:00 (next.digit=n). Called len 11, proceed 09
10:23:52.004468 [INFO] Port SIPT:041d. Dial Out=6. (ext)
10:23:52.004522 [INFO] SIP. Callref 041d. Dial 6.
10:23:52.004571 [INFO] Port SIPT:041d. Dial Out: called len 09, append 02 (max digit 30)
10:23:52.004622 [INFO] Port SIPT:041d. Dial Out: 'End_of_Dial' digit/stop dial
10:23:52.004669 [INFO] SIP. Callref 041d. New state 'SIPT_OVL_SENDING'
10:23:52.004724 [INFO] Port SIPT:041d. Setup Ack (peer=PRI:00:00)
10:23:52.004776 [INFO] Port SIPT:041d. Set state 'Out-Dial'
10:23:52.004830 [INFO] Port PRI:00:00. Setup Acked in state In-Dial. (peer=SIPT:041d)
10:23:52.004885 [INFO] Port PRI:00:00. LinkUp to SIPT:041d
10:23:52.004938 [INFO] Port SIPT:041d. Activate IP-conn [0006]
10:23:52.004988 [INFO] Conn[0006]: try activate. state 'AllocReq'.no media
10:23:52.005063 [INFO] SIP. Callref 041d. Prepare media requested
10:23:52.005137 [INFO] SIP. Callref 041d. Send Media-Info. [core/sipt_proc.c:1836]
10:23:52.005193 [INFO] SIP. Callref 041d. Media-Info (offer): [172.17.17.2]
10:23:52.005248 [INFO] SIP. Callref 041d.
o=mgapp 1886473504 956220475 IN IP4 172.17.17.2
c=IN IP4 172.17.17.2
10:23:52.005318 [INFO] Valid
m[0]: audio 20072 RTP/AVP 8 101
a[0]:8 G711.A [set]
a[1]:101 NTE [set]
a[2]:ptime:20
a[3]:sendrecv
10:23:52.005455 [INFO] SIP. Callref 041d. Prepare media finished (should send)
10:23:52.005518 [INFO] SIP. Callref 041d. Mode: 'SIP' Destination: [172.17.17.3:5060] localport [0] (with media)
10:23:52.005582 [INFO] Port PRI:00:00. Get CallerId: '-none-' (0) no set-flg
10:23:52.005632 [INFO] SIP. Callref 041d. Get display name: <>(0)
10:23:52.005684 [INFO] SIP. Callref 041d. Seize (media ready)
10:23:52.005733 [INFO] SIP. Callref 041d. Media-Info encode. Media-list size: 1
10:23:52.005829 [INFO] PBXIPC-SIP. TX. seize
10:23:52.005879 [INFO] # callref 041d
10:23:52.005926 [INFO] # trunkID 01
10:23:52.005971 [INFO] # Hostname '172.17.17.3'
10:23:52.006018 [INFO] # port 5060
10:23:52.006064 [INFO] # cdpn <4962270186> (10) cat 0x00
10:23:52.006111 [INFO] # cgpn <263588689> (9) cat 0xe5
10:23:52.006158 [INFO] # SDP len (215)
10:23:52.006333 [INFO] Port PRI:00:00. Prefix linked: called len 11, proceed 11
10:23:52.007687 [INFO] Conn[0006]: Set state 'AllocReq'->'Allocated'
10:23:52.007920 [INFO] Conn[0006]: Set state 'Allocated'->'DisableReq'
10:23:52.008903 [INFO] Conn[0006]: Created (disabled). State 'DisableReq'
10:23:52.009004 [INFO] Conn[0006]: Set state 'DisableReq'->'Disabled'
10:23:52.009072 [INFO] Port SIPT:041d. Created IP-conn [0006].
10:23:52.009124 [INFO] Conn[0006]: try activate. state 'Disabled'.no media
10:23:52.010499 [INFO] PBXIPC-SIP. RX. answer
10:23:52.010602 [INFO] # callref 041d
10:23:52.010655 [INFO] # cause 180
10:23:52.010703 [INFO] # Call-ID len (32)
10:23:52.010749 [INFO] # Display name ''
10:23:52.010881 [INFO] SIP. Callref 041d. Response 180 in state 'SIPT_OVL_SENDING' call-ID: 1-EVL.JdDnqWzBEaV5gzRNHpkNHDiTcY
10:23:52.010950 [INFO] SIP. Callref 041d. Set display name: <>(0)
10:23:52.011003 [INFO] SIP. Callref 041d. Alert in state 'SIPT_OVL_SENDING'
10:23:52.011054 [INFO] SIP. Callref 041d. New state 'SIPT_DELIVERED'
10:23:52.011134 [INFO] SIP. Callref 041d. ISDN flg: BCI=0x50: 'ISDN All Way' 'Change' 'Send'
10:23:52.011202 [INFO] Port SIPT:041d. Alert (peer=PRI:00:00)
10:23:52.011252 [INFO] Port SIPT:041d. Stop Dial, reason 'alert'
10:23:52.011314 [INFO] Port PRI:00:00. LinkUp to SIPT:041d
10:23:52.011367 [INFO] Port SIPT:041d. Activate IP-conn [0006]
10:23:52.011418 [INFO] Conn[0006]: try activate. state 'Disabled'.no media
10:23:52.011472 [INFO] Port SIPT:041d. Set state 'Out-Call'
10:23:52.011525 [INFO] Port PRI:00:00. Set state 'In-Call'
10:23:52.011582 [INFO] Port PRI:00:00. LinkUp to SIPT:041d
10:23:52.011633 [INFO] Port SIPT:041d. Activate IP-conn [0006]
10:23:52.011682 [INFO] Conn[0006]: try activate. state 'Disabled'.no media
10:23:52.011736 [INFO] Port SIPT:041d. Dir[1], obci-req[1]. Call-ind: change[1], obci[0:0], isdn: allway[1], fwd_acs[1]
10:23:52.011790 [INFO] Port SIPT:041d. Dir[1], obci-req[0]. Call-ind: change[1], obci[0:0], isdn: allway[1], fwd_acs[1]
10:23:52.011845 [INFO] Q931. Line 00/00. Call 809C. Call Received
10:23:52.011896 [INFO] Q931. Line 00/00. Call 809C. Send 'Alert'
10:23:52.011969 [INFO] Q931. Line 00/00. Call 809C. TX 6
DUMP: 08.02.80.9C.01.
0x009C (to orig), MSG=ALERTING:
---------------------------------
10:23:52.012067 [INFO] Q931. Line 00/00. Call 809C. State 'Call Received'
10:23:52.012130 [INFO] Port SIPT:041d. TDM-RingBack for IP-conn [0006], mode [0]
10:23:52.012182 [INFO] Conn[0006]: RingBack. State 'Disabled', ip <not set>, flag <0>
10:23:52.040754 [INFO] Conn[0006]. Start tone 'RINGBACKTONE'(23), direction 'TDM' in state 'Disabled'
10:23:52.041844 [INFO] Conn[0006]: Tone started
10:23:54.045815 [INFO] PBXIPC-SIP. RX. media-connected
10:23:54.045944 [INFO] # callref 041d
10:23:54.046182 [INFO] PBXIPC-SIP. RX. answer
10:23:54.046249 [INFO] # callref 041d
10:23:54.046300 [INFO] # cause 200
10:23:54.046348 [INFO] # Call-ID len (32)
10:23:54.046394 [INFO] # Display name ''
10:23:54.046442 [INFO] # SDP len (246)
10:23:54.049166 [INFO] SIP. Callref 041d. MediaConnected in state 'SIPT_DELIVERED'
10:23:54.049307 [INFO] SIP. Callref 041d. Media connected. Mode: 'inactive'
10:23:54.049367 [INFO] Port SIPT:041d. Media-connected for IP-conn [0006]
10:23:54.049418 [INFO] Conn[0006]: Media connected indication
10:23:54.049469 [INFO] Conn[0006]: try activate. state 'Disabled'.no media
10:23:54.049523 [INFO] Port SIPT:041d. Set IP-conn [0006] inactive
10:23:54.049573 [INFO] Conn[0006]: SendRecv set 'inactive' in state 'Disabled'
10:23:54.049641 [INFO] SIP. Callref 041d. Response 200 in state 'SIPT_DELIVERED' call-ID: 1-EVL.JdDnqWzBEaV5gzRNHpkNHDiTcY
10:23:54.049777 [INFO] SIP. Callref 041d. Set Media-Info. Count[1]
10:23:54.049844 [INFO] SIP. Callref 041d. Media-Info (answer): [172.17.17.3]
10:23:54.049902 [INFO] SIP. Callref 041d.
o= 0 0 IN IP4 172.17.17.3
c=IN IP4 172.17.17.3
10:23:54.050039 [INFO] Valid
m[0]: audio 15544 RTP/AVP 8 101
a[0]:8 G711.A [set]
a[1]:101 NTE [set]
a[2]:ptime:20
a[3]:sendrecv
10:23:54.050106 [INFO] SIP. Callref 041d. Media negotiate. Interface: 0
10:23:54.050166 [INFO] SIP. Callref 041d. Media negotiate <answer>. [172.17.17.3]. List-count: 1
10:23:54.050220 [INFO] SIP. Callref 041d. Media negotiate. Codec found: G711.A. PT 8. idx [0]. sendrecv
10:23:54.050275 [INFO] Port SIPT:041d. Set IP-conn [0006] sendrecv
10:23:54.050324 [INFO] Conn[0006]: SendRecv set 'sendrecv' in state 'Disabled'
10:23:54.050389 [INFO] Port SIPT:041d. IP-conn [0006]. Set Tune
10:23:54.050441 [INFO] Conn[0006]: Set tune: vad 'off', cng 'off', ecan 'off'
pte [20], rtcp_period [0], rtcp_ctrl [0], dscp [0]
dtmf_mode 'rfc2833' dtmf_pt rx [101] dtmf_pt tx [101] fax_mode [1]
use_vbd 'off' vbd_codec [2] vbd_pt [0]
NAT: N, t38transit: 0
10:23:54.050504 [INFO] SIP. Callref 041d. Use codec: G711.A sendrecv. PT 8.
10:23:54.050563 [INFO] Port SIPT:041d. IP-conn [0006]. Set Media-Info: [172.17.17.3:15544]
10:23:54.050618 [INFO] Conn[0006]: Set media-info in state 'Disabled'. [172.17.17.3:15544]
10:23:54.050676 [INFO] Conn[0006]: [172.17.17.2:20072] <-> [172.17.17.3:15544]
10:23:54.050727 [INFO] Conn[0006]: Codec: G.711A , payload [8], DTMF-PT: 101
10:23:54.050782 [INFO] Conn[0006]: try get remote MAC for <172.17.17.3>
10:23:54.051001 [INFO] Conn[0006]: found remote MAC for <172.17.17.3> - [f4:6d:04:1d:e8:25]. net-dev [0]
10:23:54.051078 [INFO] Conn[0006]: Deactivate in state 'Disabled'
10:23:54.051132 [INFO] Conn[0006]: try activate. state 'Disabled'.has media
10:23:54.051192 [INFO] Conn[0006]: Activate [172.17.17.2:20072] <-> [172.17.17.3:15544]
MAC_loc.src [02:31:52:63:74:80], MAC_loc.dst [02:00:04:00:00:02]
MAC_ext.src [a8:f9:4b:8a:6b:1c], MAC_ext.dst [f4:6d:04:1d:e8:25]
10:23:54.051262 [INFO] Conn[0006]: Start voice. Codec G711A, vad=off, cng=off. Ptime=20 ms. PT [8] SSRC=179744b2
10:23:54.051357 [INFO] Conn[0006]: Stop tone (last one 'RINGBACKTONE'(23), direction 'TDM')
10:23:54.051556 [INFO] Conn[0006]: VAPI_SendConnectionMessage: size 216
10:23:54.051638 [INFO] Conn[0006]: Set state 'Disabled'->'ActivateReq'
10:23:54.051698 [INFO] Conn[0006]: Set codecs-info in state 'ActivateReq'. Count: 2
10:23:54.051750 [INFO] Conn[0006]: G711.A PT [8]
10:23:54.051806 [INFO] SIP. Callref 041d. Set display name: <>(0)
10:23:54.051858 [INFO] SIP. Callref 041d. Connect in state 'SIPT_DELIVERED'
10:23:54.051906 [INFO] SIP. Callref 041d. New state 'SIPT_ACTIVE'
10:23:54.051964 [INFO] Port SIPT:041d. Answer
10:23:54.052023 [INFO] Port SIPT:041d. Set RADIUS-answer flag
10:23:54.052074 [INFO] Port SIPT:041d. Set state 'Talk'
10:23:54.052130 [INFO] Port PRI:00:00. Answer from peer (SIPT:041d)
10:23:54.052180 [INFO] Port PRI:00:00. Self: ext, Peer: ext.
10:23:54.052229 [INFO] Port SIPT:041d. Self: ext, Peer: ext.
10:23:54.052285 [INFO] Port PRI:00:00. Set RADIUS-talk flag
10:23:54.052337 [INFO] Port PRI:00:00. Set state 'Talk'
10:23:54.052389 [INFO] Q931. Line 00/00. Call 809C. Answer
10:23:54.052629 [INFO] Port SIPT:041d. Dir[1], obci-req[0]. Call-ind: change[0], obci[0:0], isdn: allway[1], fwd_acs[1]
10:23:54.052710 [INFO] Q931. Line 00/00. Call 809C. Send 'Answer'. PI-sent[2]
10:23:54.052772 [INFO] Port PRI:00:00. LinkUp to SIPT:041d
10:23:54.052826 [INFO] Port SIPT:041d. Activate IP-conn [0006]
10:23:54.052877 [INFO] Conn[0006]: try activate. state 'ActivateReq'.has media
10:23:54.052930 [INFO] Q931. Line 00/00. Call 809C. State 'Active'
10:23:54.053137 [INFO] Q931. Line 00/00. Call 809C. TX 6
DUMP: 08.02.80.9C.07.
0x009C (to orig), MSG=CONNECT:
---------------------------------
10:23:54.053281 [INFO] Port PRI:00:00. LinkUp to SIPT:041d
10:23:54.053348 [INFO] Port SIPT:041d. Activate IP-conn [0006]
10:23:54.053961 [INFO] Conn[0006]: try activate. state 'ActivateReq'.has media
10:23:54.054053 [INFO] Conn[0006]: Tone stopped
10:23:54.054118 [INFO] Conn[0006]: Tone stopped
10:23:54.054588 [INFO] Conn[0006]: Tone finished
10:23:54.055569 [INFO] Conn[0006]: Params set. State 'ActivateReq'
10:23:54.055642 [INFO] Conn[0006]: Enable connection
10:23:54.058738 [INFO] Conn[0006]: Activated
10:23:54.058838 [INFO] Conn[0006]: Set state 'ActivateReq'->'Active'
10:23:54.058917 [INFO] Conn[0006]: set rtp-cfg. <172.17.17.2:20072>:[02.31.52.63.74.80] <-> <172.17.17.3:15544>:[f4.6d.04.1d.e8.25]. flg[1]
10:23:54.058987 [INFO] Port SIPT:041d. Changed IP-conn [0006]
10:23:54.065547 [INFO] Conn[0006]: Event 'SSRC Change': new [0x71de8919], prev [0x00000000]
10:23:54.079065 [INFO] Q931. Line 00/00. Call 809C. RX 5
DUMP: 08.02.00.9C.0F.
0x009C (from orig), MSG=CONNECT ACKNOWLEDGE:
---------------------------------
10:23:55.260750 [INFO] PBXIPC-SIP. RX. keep-alive-req
10:23:55.260877 [INFO] # requestID 0302
10:23:55.260932 [INFO] # trunkID 01
10:23:55.260980 [INFO] # Hostname '172.17.17.3'
10:23:55.261028 [INFO] # port 5060
10:23:55.261146 [INFO] SIP. Request 0302. Got keep-alive request for trunkID [1] (outside of dialog)
10:23:55.261226 [INFO] SIP. Callref 0302. Media-Info encode. Media-list size: 1
10:23:55.261317 [INFO] SIP. Request 0302. Send keep-alive reply for trunkID [1]
10:23:55.261376 [INFO] PBXIPC-SIP. TX. keep-alive-rsp
10:23:55.261424 [INFO] # requestID 0302
10:23:55.261470 [INFO] # trunkID 01
10:23:55.261515 [INFO] # SDP len (165)
10:23:55.261559 [INFO] # cause 200
10:23:59.927042 [INFO] Q931. Line 00/00. Call 809C. RX 9
DUMP: 08.02.00.9C.45.08.02.84.90.
0x009C (from orig), MSG=DISCONNECT:
[cause: Normal call clearing (location=public network serving remote user, std=CCITT)]
---------------------------------
10:23:59.927193 [INFO] Q931. Line 00/00. Call 809C. Recv 'Disconnect'. Cause: 'Normal call clearing'
10:23:59.927250 [INFO] Q931. Line 00/00. Call 809C. State 'Release Request'
10:23:59.927308 [INFO] Q931. Line 00/00. Call 809C. Timer 'T308' (4 sec) start in state 'Release Request'
10:23:59.927391 [INFO] Q931. Line 00/00. Call 809C. TX 10
DUMP: 08.02.80.9C.4D.08.02.84.90.
0x009C (to orig), MSG=RELEASE:
[cause: Normal call clearing (location=public network serving remote user, std=CCITT)]
---------------------------------
10:23:59.927521 [INFO] Port PRI:00:00. Release, cause 'Normal call clearing', dcl '0', loc '0', peer 'SIPT:041d'
10:23:59.927593 [INFO] Port PRI:00:00. Save CDR. disabled. [0x0]
10:23:59.927651 [INFO] Port PRI:00:00. Set state 'Release'
10:23:59.927707 [INFO] Port PRI:00:00. Release peer 'SIPT:041d', cause 'Normal call clearing', dcl '1', loc '0'
10:23:59.927764 [INFO] Port SIPT:041d. Disconnect from PRI:00:00, cause 'Normal call clearing', dcl '1', loc '0'
10:23:59.927818 [INFO] Port SIPT:041d. Disconnect, cause 'Normal call clearing', dcl '1', loc '0'
10:23:59.927876 [INFO] Port SIPT:041d. Save CDR. disabled. [0x0]
10:23:59.927928 [INFO] Port SIPT:041d. Set signal: 'BUSY'
10:23:59.927985 [INFO] SIP. Callref 041d. Release, cause 'Normal call clearing', loc '0'
10:23:59.928032 [INFO] SIP. Callref 041d. Disconnect. cause 'Normal call clearing', loc '0', reply '0'
10:23:59.928084 [INFO] Port SIPT:041d. Deactivate IP-conn [0006]
10:23:59.928133 [INFO] Conn[0006]: Deactivate in state 'Active'
10:23:59.928293 [INFO] Conn[0006]: Set state 'Active'->'DisableReq'
10:23:59.928368 [INFO] Port SIPT:041d. Release, cause 'Normal call clearing', dcl '0', loc '0'
10:23:59.928426 [INFO] Port SIPT:041d. Save CDR. disabled. [0x0]
10:23:59.928480 [INFO] Port SIPT:041d. Set state 'Release'
10:23:59.928530 [INFO] Port SIPT:041d. Free IP-conn [0006]
10:23:59.928583 [INFO] Conn[0006]: Destroy in state 'DisableReq'. [check] - set destroy-flg
10:23:59.928697 [INFO] SIP. Callref 041d. New state 'SIPT_RELEASE_REQUEST'
10:23:59.928759 [INFO] SIP. Callref 041d. Disconnect (sip-reply 0)
10:23:59.928831 [INFO] PBXIPC-SIP. TX. rel-req
10:23:59.928880 [INFO] # callref 041d
10:23:59.928926 [INFO] # q850-cause 16
10:23:59.928972 [INFO] # cause 480
10:23:59.929534 [INFO] Conn[0006]: Close flag set - destroy chan.
10:23:59.929632 [INFO] Conn[0006]: Destroy in state 'DisableReq'.
10:23:59.929687 [INFO] Port SIPT:041d. Destroy Conn[0006].
10:23:59.929737 [INFO] Conn[0006]: Set state 'DisableReq'->'DeallocReq'
10:23:59.932407 [INFO] Conn[0006]: Destroyed
10:23:59.932563 [INFO] Conn[0006]: clr rtp-cfg. <172.17.17.2:20072>:[02.31.52.63.74.80] <-> <172.17.17.3:15544>:[f4.6d.04.1d.e8.25]. flg[1]
10:23:59.932635 [INFO] Conn[0006]: Set state 'DeallocReq'->'Idle'
10:23:59.934459 [INFO] PBXIPC-SIP. RX. rel-cplt
10:23:59.934563 [INFO] # callref 041d
10:23:59.934615 [INFO] # cause 200
10:23:59.934746 [INFO] SIP. Callref 041d. Release complete
10:23:59.934815 [INFO] SIP. Callref 041d. New state 'SIPT_IDLE'
10:23:59.934878 [INFO] Port SIPT:041d. Release Complete, cause 'Normal call clearing', dcl '0', loc '0'
10:23:59.934940 [INFO] Port SIPT:041d. Save CDR. disabled. [0x0]
10:23:59.935009 [INFO] Port SIPT:041d. Set state 'Ready'
10:23:59.966787 [INFO] Q931. Line 00/00. Call 809C. RX 5
DUMP: 08.02.00.9C.5A.
0x009C (from orig), MSG=RELEASE COMPLETE:
---------------------------------
10:23:59.966928 [INFO] Q931. Line 00/00. Call 809C. Recv 'Release complete'
10:23:59.966989 [INFO] Port PRI:00:00. Release Complete, cause 'Normal, unspecified', dcl '0', loc '4'
10:23:59.967053 [INFO] Port PRI:00:00. Save CDR. disabled. [0x0]
10:23:59.967124 [INFO] Port PRI:00:00. Set state 'Ready'
10:23:59.967178 [INFO] Q931. Line 00/00. Call 809C. State 'Null'
SMG-2. SN: VI45000322 Software Version: V.3.1.3.1116. 2/S Build: Apr 21 2016 16:21:07
Log stopped at: 10:24:02.573605
Также возникает проблема односторонней слышимости. Asterisk, SMG2 в одной плоской сети без NAT, Кодек согласованный g711alaw