SIP trunk между сервером с Elastix и Yeastar S20
Добавлено: 19 фев 2020, 18:39
Есть два филиала - мск и спб. Связаны по впн, trunk peer простейший, без авторизаций и прочих заморочек. в какой-то момент перестал работать, не пойму почему. из питера в москву звонки идут нормально, обратно 401 ошибка. прикладываю логи...
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:
Код: Выделить всё
<--- Transmitting SIP request (1131 bytes) to UDP:10.10.16.6:5060 --->
INVITE sip:1193@10.10.16.6:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.88.5:5060;rport;branch=z9hG4bKPj3b81e269-4559-47e3-8bb4-51840ee7121e
From: "5018" <sip:5018@10.10.16.6>;tag=b29ee5d3-1a71-4363-80ae-d43f6d7b567b
To: <sip:1193@10.10.16.6>
Contact: <sip:5018@192.168.88.5:5060>
Call-ID: 4b4aaa23-19cc-4f40-95ed-ead91f855ae3
CSeq: 20768 INVITE
Allow: OPTIONS, NOTIFY, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, REGISTER, REFER, MESSAGE
Supported: timer, replaces, norefersub
Session-Expires: 1800
Min-SE: 90
Diversion: "5018" <sip:5018@10.10.16.6>
Remote-Party-ID: "5018" <sip:5018@10.10.16.6>
P-Asserted-Identity: "5018" <sip:5018@10.10.16.6>
P-Preferred-Identity: "5018" <sip:5018@10.10.16.6>
Max-Forwards: 70
User-Agent: Yeastar S20-30.12.0.9
Content-Type: application/sdp
Content-Length: 284
v=0
o=- 1368401500 1368401500 IN IP4 192.168.88.5
s=Asterisk
c=IN IP4 192.168.88.5
t=0 0
m=audio 10946 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
<--- Received SIP response (571 bytes) from UDP:10.10.16.6:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.88.5:5060;branch=z9hG4bKPj3b81e269-4559-47e3-8bb4-51840ee7121e;received=192.168.88.5;rport=5060
From: "5018" <sip:5018@10.10.16.6>;tag=b29ee5d3-1a71-4363-80ae-d43f6d7b567b
To: <sip:1193@10.10.16.6>;tag=as7c3befda
Call-ID: 4b4aaa23-19cc-4f40-95ed-ead91f855ae3
CSeq: 20768 INVITE
Server: FPBX-2.11.0(11.5.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="13cab10e"
Content-Length: 0
<--- Transmitting SIP request (405 bytes) to UDP:10.10.16.6:5060 --->
ACK sip:1193@10.10.16.6:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.88.5:5060;rport;branch=z9hG4bKPj3b81e269-4559-47e3-8bb4-51840ee7121e
From: "5018" <sip:5018@10.10.16.6>;tag=b29ee5d3-1a71-4363-80ae-d43f6d7b567b
To: <sip:1193@10.10.16.6>;tag=as7c3befda
Call-ID: 4b4aaa23-19cc-4f40-95ed-ead91f855ae3
CSeq: 20768 ACK
Max-Forwards: 70
User-Agent: Yeastar S20-30.12.0.9
Content-Length: 0
[2020-02-19 18:18:03] DEBUG[3343]: res_pjsip_session.c:1593 outbound_invite_auth: Initial INVITE is being challenged.
[2020-02-19 18:18:03] WARNING[3343]: res_pjsip_outbound_authenticator_digest.c:187 digest_create_request_with_auth_from_old: Unable to create request with auth.No auth credentials for any realms in challenge.
[2020-02-19 18:18:03] DEBUG[2162]: cdr.c:2869 cdr_object_finalize: Finalized CDR for PJSIP/5018-00000021 - start 1582125482.495277 answer 0.000000 end 1582125483.189874 dispo NO ANSWER
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: channel.c:2731 ast_hangup: Hanging up channel 'PJSIP/trunk-Navigator-endpoint-00000022'
[2020-02-19 18:18:03] DEBUG[12792]: res_rtp_asterisk.c:5431 ast_rtp_remote_address_set: Setting RTCP address on RTP instance '0xca8f234'
[2020-02-19 18:18:03] DEBUG[12792]: rtp_engine.c:377 instance_destructor: Destroyed RTP instance '0xca8f234'
[2020-02-19 18:18:03] DEBUG[12792]: taskprocessor.c:501 tps_taskprocessor_destroy: destroying taskprocessor '20711c3d-ea5a-435d-a2e9-ea9e67d9e91b'
[2020-02-19 18:18:03] DEBUG[2162]: cdr.c:2869 cdr_object_finalize: Finalized CDR for PJSIP/trunk-Navigator-endpoint-00000022 - start 1582125482.814062 answer 0.000000 end 1582125483.193727 dispo NO ANSWER
[2020-02-19 18:18:03] DEBUG[2162]: cdr.c:1386 cdr_object_create_public_records: CDR for PJSIP/trunk-Navigator-endpoint-00000022 is dialed and has no Party B; discarding
== Everyone is busy/congested at this time (1:0/0/1)
== Setting global variable 'DIALSTATUS' to 'CHANUNAVAIL'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_dial.c:4810 dial_exec_full: Exiting with DIALSTATUS=CHANUNAVAIL.
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Dial
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'NoOp'
-- Executing [1-dial@macro-trunkdial-failover-0.3:23] NoOp("PJSIP/5018-00000021", "CHANUNAVAIL") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: NOOP
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '1'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'GotoIf'
-- Executing [1-dial@macro-trunkdial-failover-0.3:24] GotoIf("PJSIP/5018-00000021", "1?meetme-inviteallow:meetme-invitedeny") in new stack
-- Goto (macro-trunkdial-failover-0.3,1-dial,25)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Gotoif
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4859 pbx_substitute_variables_helper_full: Function LEN() result is '0'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'GotoIf'
-- Executing [1-dial@macro-trunkdial-failover-0.3:25] GotoIf("PJSIP/5018-00000021", "0>1?meetme-invite,1") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:12707 pbx_builtin_gotoif: Not taking any branch
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Gotoif
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Goto'
-- Executing [1-dial@macro-trunkdial-failover-0.3:26] Goto("PJSIP/5018-00000021", "1-CHANUNAVAIL,1") in new stack
-- Goto (macro-trunkdial-failover-0.3,1-CHANUNAVAIL,1)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Goto
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Set'
-- Executing [1-CHANUNAVAIL@macro-trunkdial-failover-0.3:1] Set("PJSIP/5018-00000021", "DLSTAT=9-CHANUNAVAIL") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Set
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Goto'
-- Executing [1-CHANUNAVAIL@macro-trunkdial-failover-0.3:2] Goto("PJSIP/5018-00000021", "addevent,1)") in new stack
-- Goto (macro-trunkdial-failover-0.3,addevent,1)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Goto
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4859 pbx_substitute_variables_helper_full: Function CALLERID(num) result is '5018'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '0'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'GotoIf'
-- Executing [addevent@macro-trunkdial-failover-0.3:1] GotoIf("PJSIP/5018-00000021", "0?4:2") in new stack
-- Goto (macro-trunkdial-failover-0.3,addevent,2)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Gotoif
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '1'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '0'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '3'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4859 pbx_substitute_variables_helper_full: Function IF(0?3:4) result is '4'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Set'
-- Executing [addevent@macro-trunkdial-failover-0.3:2] Set("PJSIP/5018-00000021", "PCOUNT=4") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Set
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4859 pbx_substitute_variables_helper_full: Function CALLERID(num) result is '5018'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Set'
-- Executing [addevent@macro-trunkdial-failover-0.3:3] Set("PJSIP/5018-00000021", "EVENTCONTEXT=provider=trunk-Navigator-endpoint&destnumber=1193&srcnumber=5018") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Set
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'AGI'
-- Executing [addevent@macro-trunkdial-failover-0.3:4] AGI("PJSIP/5018-00000021", "/ysbin/eventadd,2002,provider=trunk-Navigator-endpoint&destnumber=1193&srcnumber=5018") in new stack
-- Launched AGI Script /ysbin/eventadd
-- <PJSIP/5018-00000021>AGI Script /ysbin/eventadd completed, returning 0
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: AGI
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Goto'
-- Executing [addevent@macro-trunkdial-failover-0.3:5] Goto("PJSIP/5018-00000021", "9-CHANUNAVAIL,1") in new stack
-- Goto (macro-trunkdial-failover-0.3,9-CHANUNAVAIL,1)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Goto
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '0'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'GotoIf'
-- Executing [9-CHANUNAVAIL@macro-trunkdial-failover-0.3:1] GotoIf("PJSIP/5018-00000021", "0?3:2") in new stack
-- Goto (macro-trunkdial-failover-0.3,9-CHANUNAVAIL,2)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Gotoif
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'UserEvent'
-- Executing [9-CHANUNAVAIL@macro-trunkdial-failover-0.3:2] UserEvent("PJSIP/5018-00000021", "CallFailed,Cause: Line unreachable") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: UserEvent
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:4928 pbx_substitute_variables_helper_full: Expression result is '0'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'GotoIf'
-- Executing [9-CHANUNAVAIL@macro-trunkdial-failover-0.3:3] GotoIf("PJSIP/5018-00000021", "0?5") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:12707 pbx_builtin_gotoif: Not taking any branch
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:438 _macro_exec: Executed application: Gotoif
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Playback'
-- Executing [9-CHANUNAVAIL@macro-trunkdial-failover-0.3:4] Playback("PJSIP/5018-00000021", "") in new stack
[2020-02-19 18:18:03] WARNING[31396][C-00000011]: app_playback.c:455 playback_exec: Playback requires an argument (filename)
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: app_macro.c:432 _macro_exec: Spawn extension (macro-trunkdial-failover-0.3,9-CHANUNAVAIL,4) exited non-zero on 'PJSIP/5018-00000021' in macro 'trunkdial-failover-0.3'
== Spawn extension (macro-trunkdial-failover-0.3, 9-CHANUNAVAIL, 4) exited non-zero on 'PJSIP/5018-00000021' in macro 'trunkdial-failover-0.3'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:6929 __ast_pbx_run: Spawn extension (DLPN_DialPlan5018,1193,15) exited non-zero on 'PJSIP/5018-00000021'
== Spawn extension (DLPN_DialPlan5018, 1193, 15) exited non-zero on 'PJSIP/5018-00000021'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: channel.c:2582 ast_softhangup_nolock: Soft-Hanging (0x10) up channel 'PJSIP/5018-00000021'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: channel.c:2582 ast_softhangup_nolock: Soft-Hanging (0x80) up channel 'PJSIP/5018-00000021'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'NoOp'
-- Executing [h@DLPN_DialPlan5018:1] NoOp("PJSIP/5018-00000021", "no thing to do") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:5024 pbx_extension_helper: Launching 'Hangup'
-- Executing [h@DLPN_DialPlan5018:2] Hangup("PJSIP/5018-00000021", "") in new stack
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: channel.c:2582 ast_softhangup_nolock: Soft-Hanging (0x20) up channel 'PJSIP/5018-00000021'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: pbx.c:6488 ast_pbx_h_exten_run: Spawn extension (DLPN_DialPlan5018,h,2) exited non-zero on 'PJSIP/5018-00000021'
== Spawn extension (DLPN_DialPlan5018, h, 2) exited non-zero on 'PJSIP/5018-00000021'
[2020-02-19 18:18:03] DEBUG[31396][C-00000011]: channel.c:2731 ast_hangup: Hanging up channel 'PJSIP/5018-00000021'
<--- Transmitting SIP response (423 bytes) to UDP:192.168.22.25:50982 --->
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP 192.168.22.25:50982;rport=50982;received=192.168.22.25;branch=z9hG4bKPjbff5b594822f462f939b8e64ee445ce4
Call-ID: dbd25813f7b74622b85da60ad6a262e7
From: <sip:5018@192.168.88.5>;tag=0d61e2989c2d47ef9040e1b47d827e22
To: <sip:1193@192.168.88.5>;tag=7bcc5bd2-19e8-4c78-91a0-b37e40df7596
CSeq: 11629 INVITE
Server: Yeastar S20-30.12.0.9
Reason: Q.850;cause=21
Content-Length: 0