Имеется два DVG-2032S с доп модулями, на обоих аналогичная проблема.
Через разное время, разные внутренние номера не проходят перерегистрацию на Asterisk (Kerio Operator) и соответственно нет возможности позвонить и с них и на них. В течении времени все больше номеров отваливается от Asterisk. Лечится все это перезагрузкой шлюза или Asterisk, после нее все номера регистрируются и все повторяется снова.
Поменять конфиги Asterisk нет возможности так как это Kerio Operator, закрытая платформа.
Помогите в решении этой проблемы.
Прошивка DVG-2032S
Firmware Version : 1.02.38.90
Hardware Platform : IXP435
Hardware : C1-1.0
Driver : 1.2.6.2710.223/242
Лог Dlink
Код:
13:32:02 [058868] 11: Session_Progress
13:32:02 [058868] 11: Peer=192.168.1.21#16806, PT=8, RecvOnly=0
13:32:02 [058868] 11: FilterDtmf(1)=0
13:32:02 [058868] 11: RTP[1,1], Peer=192.168.1.21#16806, PT=8/2/1
13:32:02 [058868] 11: ==14:Talking
13:32:02 [058870] 11: 232=RINGBACK
13:32:08 [058930] 11: 232=CONNECTED
13:32:08 [058930] 11: St_Talking/Substatus=0
13:32:08 [058930] 11: Peer=192.168.1.21#16806, PT=8, RecvOnly=0
13:32:08 [058930] 11: Change RTP to 192.168.1.21:16806, pt=8
13:32:08 [058930] 11: RTP[1,1], Peer=192.168.1.21#16806, PT=8/2/1
13:32:16 [059003] 19: Register Retry (Last was rejected)
13:32:16 [059003] 19: 203=REGISTER
13:32:16 [059003] 19: 203=REGISTER_AUTHN
13:32:16 [059003] 19: 203=REGISTERFAIL
13:32:18 [059031] 1: Register Retry (Last was rejected)
13:32:18 [059031] 1: 269=REGISTER
13:32:18 [059031] 1: 269=REGISTER_AUTHN
13:32:18 [059031] 1: 269=REGISTERFAIL
13:32:20 [059043] 13: Register Retry (Last was rejected)
13:32:20 [059043] 13: 230=REGISTER
13:32:20 [059043] 21: Register Retry (Last was rejected)
13:32:20 [059043] 21: 251=REGISTER
13:32:20 [059043] 22: Register Retry (Last was rejected)
13:32:20 [059043] 22: 297=REGISTER
13:32:20 [059043] 13: 230=REGISTER_AUTHN
13:32:20 [059043] 21: 251=REGISTER_AUTHN
13:32:20 [059043] 22: 297=REGISTER_AUTHN
13:32:20 [059044] 13: 230=REGISTERFAIL
13:32:20 [059044] 21: 251=REGISTERFAIL
13:32:20 [059044] 22: 297=REGISTERFAIL
13:32:36 [059211] 19: Register Retry (Last was rejected)
Лог Asterisk
Код:
[19/Dec/2012 14:02:38] {sip} asterisk[1755]: VERBOSE[1837]: chan_sip.c:25669 in handle_request_do: #012<--- SIP read from UDP:192.168.1.58:5060 --->#012REGISTER sip:192.168.1.21 SIP/2.0#012Via: SIP/2.0/UDP 192.168.1.58:5060;branch=z9hG4bK82b6cf5191b9b3da#012From: "267" <sip:267@192.168.1.21>;tag=ed24527e-13458#012To: "267" <sip:267@192.168.1.21>#012Call-ID: D1B9-124B-00000029A121B3AC38C1-008@SipHost#012CSeq: 687 REGISTER#012Contact: <sip:267@192.168.1.58:5060>#012Expires:600#012Max-Forwards:70#012Authorization:Digest username="267",realm="asterisk",nonce="75a5771f",uri="sip:192.168.1.21",response="eebfcd5ce021ad44b95b2144971421c5",algorithm=MD5#012User-Agent: dlink 12-3890-3520-1.2.6.2710-IXP_SP1700#012Content-Length: 0#012#012<------------->
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 0 [ 33]: REGISTER sip:192.168.1.21 SIP/2.0
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 1 [ 65]: Via: SIP/2.0/UDP 192.168.1.58:5060;branch=z9hG4bK82b6cf5191b9b3da
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 2 [ 53]: From: "267" <sip:267@192.168.1.21>;tag=ed24527e-13458
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 3 [ 32]: To: "267" <sip:267@192.168.1.21>
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 4 [ 51]: Call-ID: D1B9-124B-00000029A121B3AC38C1-008@SipHost
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 5 [ 18]: CSeq: 687 REGISTER
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 6 [ 36]: Contact: <sip:267@192.168.1.58:5060>
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 7 [ 11]: Expires:600
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 8 [ 15]: Max-Forwards:70
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 9 [150]: Authorization:Digest username="267",realm="asterisk",nonce="75a5771f",uri="sip:192.168.1.21",response="eebfcd5ce021ad44b95b2144971421c5",algorithm=MD5
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 10 [ 52]: User-Agent: dlink 12-3890-3520-1.2.6.2710-IXP_SP1700
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8651 in parse_request: Header 11 [ 17]: Content-Length: 0
[19/Dec/2012 14:02:38] {sip} asterisk[1755]: VERBOSE[1837]: chan_sip.c:25679 in handle_request_do: --- (12 headers 0 lines) ---
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:8242 in find_call: = Looking for Call ID: D1B9-124B-00000029A121B3AC38C1-008@SipHost (Checking From) --From tag ed24527e-13458 --To-tag
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:138 in ast_sockaddr_split_hostport: Splitting '192.168.1.21' into...
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:192 in ast_sockaddr_split_hostport: ...host '192.168.1.21' and port ''.
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:138 in ast_sockaddr_split_hostport: Splitting '192.168.1.21' into...
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:192 in ast_sockaddr_split_hostport: ...host '192.168.1.21' and port ''.
19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:25435 in handle_incoming: **** Received REGISTER (2) - Command in SIP REGISTER
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:25264 in handle_request_register: Initializing initreq for method REGISTER - callid D1B9-124B-00000029A121B3AC38C1-008@SipHost
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:138 in ast_sockaddr_split_hostport: Splitting '192.168.1.58:5060' into...
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:192 in ast_sockaddr_split_hostport: ...host '192.168.1.58' and port '5060'.
[19/Dec/2012 14:02:38] {sip} asterisk[1755]: VERBOSE[1837]: chan_sip.c:16140 in check_via: Sending to 192.168.1.58:5060 (no NAT)
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: Security.cpp:189 in int Security::authCheck(const sockaddr_in*, const char*): KerioSecurity check 192.168.1.58 (uri:"267" <sip:267@192.168.1.21>).
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:138 in ast_sockaddr_split_hostport: Splitting '192.168.1.21' into...
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: netsock2.c:192 in ast_sockaddr_split_hostport: ...host '192.168.1.21' and port ''.
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: NOTICE[1837]: chan_sip.c:14674 in check_auth: Correct auth, but based on stale nonce received from '"267" <sip:267@192.168.1.21>;tag=ed24527e-13458'
[19/Dec/2012 14:02:38] {sip} asterisk[1755]: VERBOSE[1837]: chan_sip.c:4239 in send_response: #012<--- Transmitting (no NAT) to 192.168.1.58:5060 --->#012SIP/2.0 401 Unauthorized#015#012Via: SIP/2.0/UDP 192.168.1.58:5060;branch=z9hG4bK82b6cf5191b9b3da;received=192.168.1.58#015#012From: "267" <sip:267@192.168.1.21>;tag=ed24527e-13458#015#012To: "267" <sip:267@192.168.1.21>;tag=as0b976edd#015#012Call-ID: D1B9-124B-00000029A121B3AC38C1-008@SipHost#015#012CSeq: 687 REGISTER#015#012Server: Asterisk PBX#015#012Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH#015#012Supported: replaces, timer#015#012WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="545bc586", stale=true#015#012Content-Length: 0#015#012#015#012#012<------------>
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:3411 in __sip_xmit: Trying to put 'SIP/2.0 401' onto UDP socket destined for 192.168.1.58:5060
[19/Dec/2012 14:02:38] {sip} asterisk[1755]: VERBOSE[1837]: chan_sip.c:3999 in sip_scheddestroy: Scheduling destruction of SIP dialog 'D1B9-124B-00000029A121B3AC38C1-008@SipHost' in 32000 ms (Method: REGISTER)
[19/Dec/2012 14:02:38] {asterisk} asterisk[1755]: DEBUG[1837]: chan_sip.c:31084 in securityPostAuth: Kerio security: securityPostAuth - AUTH_CHALLENGE_SENT.