Доброе время суток. Проблема существует уже давно, собственные усилия ничего не дали, надеюсь на помощь. Дано: DVX-7090 rev. A1, FW - App_1.4.3-1_6480 (установлена в августе этого года в сервисном центре dlink), OS - Sys_1.0.1-7 (аналогично). Отдавалась атс в сервисный центр после неудачного обновления прошивки (была взята с фтп). Работала ли до этого 7090 если честно не знаю (занимался этим не я). Но после возвращения из сервисного центра добиться работы так и не удалось. Собственно проблема: Есть 1 soft phone, dvx-7090 и шлюз провайдера (гипертел). Шлюз зарегистрирован на атс как External. При попытке вызова на внешнюю линию идет либо отбой (если в настройках шлюза "Dst leg error handling" установлено в "Disconnect src"), либо выдается сообщение CallCannotBeProcessAtTheMoment (если соответственно установлено "Play prompt"). В настройках маршрутизации в целях максимально упростить схему правило Dial gateway у меня сейчас стоит на 1 месте, поля регулярных выражений установлены по умолчанию. Все элементы схемы входят в 1 группу.
Вот CU и SU логи одной из сессий:
Код:
2009/12/07 17:55:24.731 INF Setup MeraSystems.Kernel.LogStream MeraSystems.Kernel+StdLogger+MultiFileLogStream
2009/12/07 17:55:24.734 INF Kernel assembly full name: MeraSystems.Kernel, Version=4.0.0.0, Culture=neutral
2009/12/07 17:55:24.734 INF Amalteya service assembly full name: MeraSystems.VoIP.Amalteya, Version=4.0.0.3, Culture=neutral
2009/12/07 17:55:24.734 INF Basic classes assembly full name: MeraSystems.VoIP, Version=3.0.0.0, Culture=neutral
2009/12/07 17:55:42.051 INF 00000000000000000000000000000000 Loading plugin description : /mera/Phoenix/Plugins/loader.plugin
2009/12/07 17:55:42.107 INF 00000000000000000000000000000000 Checking files 01/01/0001 00:00:00 - 07/20/2009 14:14:00
2009/12/07 17:55:42.123 INF 00000000000000000000000000000000 Checking files 07/20/2009 14:14:00 - 07/20/2009 14:14:00
2009/12/07 17:55:42.646 INF 00000000000000000000000000000000 <<<<< Application version: 1.2.3488.25620 >>>>
2009/12/07 17:55:42.671 INF 00000000000000000000000000000000 CdrManager: Init(): CDR manager will start at 12/08/2009 03:00:00 with period 1.00:00:00
2009/12/07 17:55:42.850 INF 00000000000000000000000000000000 MeraSystems.VoIP.Amalteya.Service Start. Version 4.0.0.2.
2009/12/07 17:56:44.676 INF 00000000000000000000000000000000 Switch Switch(): >>> Switch Default subscribed database notification!
2009/12/07 17:56:44.680 INF 00000000000000000000000000000000 MeraSystems.VoIP.Amalteya.Service Switch added: Default
2009/12/07 17:56:44.740 INF 00000000000000000000000000000000 MeraSystems.VoIP.Phoenix.Switch End point added: id = h323
2009/12/07 17:56:44.773 INF 00000000000000000000000000000000 MeraSystems.VoIP.Phoenix.Switch End point added: id = sip
2009/12/07 17:56:44.802 INF 00000000000000000000000000000000 EndPoint: PerformExtRegistration(): Send external register to 026410404 ip=217.150.198.101:5060
2009/12/07 17:56:44.803 INF 00000000000000000000000000000000 EndPoint: PerformExtRegistration(): Params type=sip login=026410404 pass=0d6c42 ttl=120
2009/12/07 17:56:44.836 INF 00000000000000000000000000000000 MediaProcessor AddSwitchInfo(): Switch ID=Default G.729Limit=15 G.723Limit=15 G.723Used=0 G.729Used=0
2009/12/07 17:56:44.845 WRN 00000000000000000000000000000000 MeraSystems.VoIP.Phoenix.Switch OnUnknownRequest: Unable to handle unknown request "onConfigChange". Command outer xml: <event name="onConfigChange" switchId="Default" balancer="off"></event>
2009/12/07 17:56:45.163 INF 00000000000000000000000000000000 EndPoint: OnExternalRegisterEndPoint(): External registration with 026410404 success!
2009/12/07 17:58:31.511 INF 00000000000000000000000000000000 EndPoint: OnRegisterPhone(): RRQ from 101 at 77.41.77.88:3729. Auth RQ.
2009/12/07 17:58:31.690 INF 7083b3ec84d54af18a7e0027f9f3fa73 EndPoint: OnRegistSuccess(): RCF for id=101 addr=77.41.77.88 p=3729 n=101, regId=821f33f0-5bfa-4c39-91c0-068de92c41c6
2009/12/07 17:59:53.191 INF 204716005c080010800100900b0eee7e Call: OnRegisterCall(): *******************************************************
2009/12/07 17:59:53.192 INF 204716005c080010800100900b0eee7e Call: OnRegisterCall(): Incoming call src=101 address=77.41.77.88 dst=89160286113
2009/12/07 17:59:53.229 INF 204716005c080010800100900b0eee7e Call: OnRegisterCall(): Incoming call capabilities = <capabilities></capabilities>
2009/12/07 17:59:53.283 INF 2021077d687d455580e9ccbdc0ccd5f1 Conference: OnCapabilitiesCall(): incoming >>> Caps (DB): G.729A/2, G.729/2, G.723.1/1, PCMA/20, PCMU/20, GSMFR/1
2009/12/07 17:59:53.285 INF 2021077d687d455580e9ccbdc0ccd5f1 Conference: OnCapabilitiesCall(): incoming >>> Caps (device): PCMU/0, PCMA/0, GSMFR/0
2009/12/07 17:59:53.301 INF 2021077d687d455580e9ccbdc0ccd5f1 Conference: OnCapabilitiesCall(): Caps1: PCMA/0, PCMU/0, GSMFR/0
2009/12/07 17:59:53.305 INF 00000000000000000000000000000000 RoutingProcessor .ctor(): >>> RoutingProcessor subscribed database notification!
2009/12/07 17:59:53.313 INF 00000000000000000000000000000000 RoutingProcessor: GetRules(): Rules cache is not valid. Update from DB
2009/12/07 17:59:53.554 INF 204716005c080010800100900b0eee7e Rule: GetRoute(): Rule description: Inc
2009/12/07 17:59:53.576 INF 204716005c080010800100900b0eee7e UserRoute: .ctor(): --->>> Follow to USER route src=101, dst=89160286113
2009/12/07 17:59:53.585 INF 204716005c080010800100900b0eee7e Rule: GetRoute(): Rule description: Out
2009/12/07 17:59:53.587 INF 204716005c080010800100900b0eee7e GwRoute: .ctor(): --->>> Follow to GATEWAY route src=101, dst=89160286113, gw=723a3da8-23c0-4055-b6a5-592bdc7d10fb
2009/12/07 17:59:53.599 INF 204716005c080010800100900b0eee7e Conference: DialOutgoingTerminal(): DialUser: 101 -> 026410404
2009/12/07 17:59:53.646 INF 9a0ee36df94841c89902b589c50a989c Conference: CreateOutgoingCall(): Caps2: PCMA/20, PCMU/20, GSMFR/1, G.729A/2, G.729/2, G.723.1/1
2009/12/07 17:59:53.729 INF 9a0ee36df94841c89902b589c50a989c Call: OnRegisterCall(): <<< outgoing src=101 dst=89160286113
2009/12/07 17:59:53.906 INF 9a0ee36df94841c89902b589c50a989c Conference: OnUnregisterCall() <<< outgoing src=101 dst=89160286113 reasonCode=3 reason=Not Found
2009/12/07 17:59:53.947 INF 9a0ee36df94841c89902b589c50a989c Conference: ProcessForward(): There is nowhere to forward. Play prompt CallCannotBeProcessAtTheMoment.wav
2009/12/07 17:59:54.004 INF 204716005c080010800100900b0eee7e Conference: OnMediaStart(): incoming >>> Call src=101 dst=89160286113 caps_start: PCMU/0,
2009/12/07 18:00:00.789 INF 204716005c080010800100900b0eee7e Conference: OnUnregisterCall() >>> incoming src=101 dst=89160286113 reasonCode=16 reason=Normal call termination
2009/12/07 18:00:16.011 INF 00000000000000000000000000000000 RoutingProcessor: InvalidateCache(): Reset rules cache.
2009/12/07 18:00:40.321 INF c06c3c00ba080010800700900b0eee7e Call: OnRegisterCall(): *******************************************************
2009/12/07 18:00:40.321 INF c06c3c00ba080010800700900b0eee7e Call: OnRegisterCall(): Incoming call src=101 address=77.41.77.88 dst=89160286113
2009/12/07 18:00:40.330 INF c06c3c00ba080010800700900b0eee7e Call: OnRegisterCall(): Incoming call capabilities = <capabilities></capabilities>
2009/12/07 18:00:40.414 INF c079a6ba683c40cd9011ee187f97a07d Conference: OnCapabilitiesCall(): incoming >>> Caps (DB): G.729A/2, G.729/2, G.723.1/1, PCMA/20, PCMU/20, GSMFR/1
2009/12/07 18:00:40.415 INF c079a6ba683c40cd9011ee187f97a07d Conference: OnCapabilitiesCall(): incoming >>> Caps (device): PCMU/0, PCMA/0, GSMFR/0
2009/12/07 18:00:40.415 INF c079a6ba683c40cd9011ee187f97a07d Conference: OnCapabilitiesCall(): Caps1: PCMA/0, PCMU/0, GSMFR/0
2009/12/07 18:00:40.417 INF 00000000000000000000000000000000 RoutingProcessor: GetRules(): Rules cache is not valid. Update from DB
2009/12/07 18:00:40.437 INF c06c3c00ba080010800700900b0eee7e Rule: GetRoute(): Rule description: Out
2009/12/07 18:00:40.437 INF c06c3c00ba080010800700900b0eee7e GwRoute: .ctor(): --->>> Follow to GATEWAY route src=101, dst=89160286113, gw=723a3da8-23c0-4055-b6a5-592bdc7d10fb
2009/12/07 18:00:40.444 INF c06c3c00ba080010800700900b0eee7e Conference: DialOutgoingTerminal(): DialUser: 101 -> 026410404
2009/12/07 18:00:40.446 INF 12f36be8f38940ef83549da1e7f1807e Conference: CreateOutgoingCall(): Caps2: PCMA/20, PCMU/20, GSMFR/1, G.729A/2, G.729/2, G.723.1/1
2009/12/07 18:00:40.509 INF 12f36be8f38940ef83549da1e7f1807e Call: OnRegisterCall(): <<< outgoing src=101 dst=89160286113
2009/12/07 18:00:40.622 INF 12f36be8f38940ef83549da1e7f1807e Conference: OnUnregisterCall() <<< outgoing src=101 dst=89160286113 reasonCode=3 reason=Not Found
2009/12/07 18:00:40.627 INF 12f36be8f38940ef83549da1e7f1807e Conference: ProcessForward(): There is nowhere to forward. Play prompt CallCannotBeProcessAtTheMoment.wav
2009/12/07 18:00:40.706 INF c06c3c00ba080010800700900b0eee7e Conference: OnMediaStart(): incoming >>> Call src=101 dst=89160286113 caps_start: PCMU/0,
2009/12/07 18:00:43.944 INF c06c3c00ba080010800700900b0eee7e Conference: OnUnregisterCall() >>> incoming src=101 dst=89160286113 reasonCode=16 reason=Normal call termination
2009/12/07 18:03:04.460 INF 00000000000000000000000000000000 EndPoint: OnUnregisterPhone(): Terminal id=101 addr=77.41.77.88 regId=821f33f0-5bfa-4c39-91c0-068de92c41c6 was removed
2009/12/07 18:03:14.618 INF 00000000000000000000000000000000 EndPoint: OnRegisterPhone(): RRQ from 101 at 77.41.77.88:3750. Auth RQ.
2009/12/07 18:03:14.857 INF 7083b3ec84d54af18a7e0027f9f3fa73 EndPoint: OnRegistSuccess(): RCF for id=101 addr=77.41.77.88 p=3750 n=101, regId=aae6074c-cf4b-4544-b7b7-ad623412df14
2009/12/07 18:03:46.388 INF 809445002e0a0010800f00900b0eee7e Call: OnRegisterCall(): *******************************************************
2009/12/07 18:03:46.389 INF 809445002e0a0010800f00900b0eee7e Call: OnRegisterCall(): Incoming call src=101 address=77.41.77.88 dst=89160286113
2009/12/07 18:03:46.399 INF 809445002e0a0010800f00900b0eee7e Call: OnRegisterCall(): Incoming call capabilities = <capabilities></capabilities>
2009/12/07 18:03:46.443 INF d4cd2115b0254e878a8052ead92701eb Conference: OnCapabilitiesCall(): incoming >>> Caps (DB): PCMU/20, PCMA/20, G.729A/2, G.729/2, G.723.1/1, GSMFR/1
2009/12/07 18:03:46.459 INF d4cd2115b0254e878a8052ead92701eb Conference: OnCapabilitiesCall(): incoming >>> Caps (device): PCMU/0, PCMA/0, GSMFR/0
2009/12/07 18:03:46.460 INF d4cd2115b0254e878a8052ead92701eb Conference: OnCapabilitiesCall(): Caps1: PCMU/0, PCMA/0, GSMFR/0
2009/12/07 18:03:46.462 INF 809445002e0a0010800f00900b0eee7e Rule: GetRoute(): Rule description: Out
2009/12/07 18:03:46.463 INF 809445002e0a0010800f00900b0eee7e GwRoute: .ctor(): --->>> Follow to GATEWAY route src=101, dst=89160286113, gw=723a3da8-23c0-4055-b6a5-592bdc7d10fb
2009/12/07 18:03:46.469 INF 809445002e0a0010800f00900b0eee7e Conference: DialOutgoingTerminal(): DialUser: 101 -> 026410404
2009/12/07 18:03:46.474 INF 655ec069de904dfa818bac5f517a270f Conference: CreateOutgoingCall(): Caps2: PCMU/20, PCMA/20, GSMFR/1, G.729A/2, G.729/2, G.723.1/1
2009/12/07 18:03:46.564 INF 655ec069de904dfa818bac5f517a270f Call: OnRegisterCall(): <<< outgoing src=101 dst=89160286113
2009/12/07 18:03:46.632 INF 655ec069de904dfa818bac5f517a270f Conference: OnUnregisterCall() <<< outgoing src=101 dst=89160286113 reasonCode=3 reason=Not Found
2009/12/07 18:03:46.637 INF 655ec069de904dfa818bac5f517a270f Conference: ProcessForward(): There is nowhere to forward. Play prompt CallCannotBeProcessAtTheMoment.wav
2009/12/07 18:03:46.715 INF 809445002e0a0010800f00900b0eee7e Conference: OnMediaStart(): incoming >>> Call src=101 dst=89160286113 caps_start: PCMU/0,
2009/12/07 18:03:50.154 INF 809445002e0a0010800f00900b0eee7e Conference: OnUnregisterCall() >>> incoming src=101 dst=89160286113 reasonCode=16 reason=Normal call termination
Код:
Damos (Linux) version 1.5.7 build 4-dl6480 (Jul 24 2009)
(C) 2004-2009 Mera.RU
Dmesg contents: ------
Dmesg end ------
2009/12/07 17:55:23:INF:SwitchManager.cpp:3707:Started
2009/12/07 17:55:23:ERR:CuTcp.cpp:266:Controlling connection socket error 111
2009/12/07 17:56:13:INF:ControlConnection.cpp:612:Control unit 127.0.0.1:5001: can not connect; trying next one ...
2009/12/07 17:56:44:INF:SwitchManager.cpp:456:Switch accepted. Switch name = Default
2009/12/07 17:56:44:INF:SwitchManager.cpp:2057:Creating SIP listener on 127.0.0.1:5060
2009/12/07 17:56:44:INF:SwitchManager.cpp:2057:Creating SIP listener on 192.168.224.226:5060
2009/12/07 17:56:44:INF:SwitchManager.cpp:2057:Creating SIP listener on 213.221.5.19:5060
2009/12/07 17:56:44:INF:ControlConnection.cpp:678:Control unit 127.0.0.1:5001 on
2009/12/07 17:56:44:INF:dInterface.cpp:2245:H.323 endpoint accepted
2009/12/07 17:56:44:INF:dInterface.cpp:1959:SIP endpoint accepted
2009/12/07 17:56:45:INF:BaseClasses.cpp:4977:Registered on registrar 0fea0ad7-ec73-48cc-9144-1c99f231306e endpoint=sip
2009/12/07 17:58:31:INF:ControlConnection.cpp:2882:SIP user accepted: Phone ID=101, Registration ID=821f33f0-5bfa-4c39-91c0-068de92c41c6, Registrar ID=213.221.5.19
2009/12/07 17:59:53:INF:BaseClasses.cpp:8552:Sip Call created: 0x8b17760
2009/12/07 17:59:53:INF:dInterface.cpp:924:Opening incoming SIP leg 20471600-5c08-0010-8001-00900b0eee7e from=101 to=89160286113 fromIP=77.41.77.88:3729 toIP=213.221.5.19:5060 registrationID=821f33f0-5bfa-4c39-91c0-068de92c41c6 startlineURL=89160286113
2009/12/07 17:59:53:INF:BaseClasses.cpp:8552:Sip Call created: 0x8b18348
2009/12/07 17:59:53:INF:..//RtpFilters/RtpTransceiver.h:196:RTP channel created: 0x8ca86c0 load=0
2009/12/07 17:59:53:INF:dInterface.cpp:924:Opening outgoing SIP leg 9a0ee36d-f948-41c8-9902-b589c50a989c from=101 to=89160286113 fromIP=213.221.5.19:5060 toIP=217.150.198.101:5060 registrationID= startlineURL=
2009/12/07 17:59:53:INF:..//RtpFilters/RtpTransceiver.h:167:RTP channel deleted: 0x8ca86c0, nat = false, dst = 0.0.0.0:0, sent = 0, recv = 0, sent RTCP = 0, recv RTCP = 0, sent T.38 = 0, recv T.38 = 0
2009/12/07 17:59:53:INF:BaseClasses.cpp:9522:Closing leg 9a0ee36d-f948-41c8-9902-b589c50a989c cause= 404 codec= PCMA (active conferences= 0)
2009/12/07 17:59:53:INF:..//RtpFilters/RtpTransceiver.h:196:RTP channel created: 0x8ca86c0 load=0
2009/12/07 18:00:00:INF:..//RtpFilters/RtpTransceiver.h:167:RTP channel deleted: 0x8ca86c0, nat = false, dst = 77.41.77.88:40000, sent = 337, recv = 0, sent RTCP = 0, recv RTCP = 0, sent T.38 = 0, recv T.38 = 0
2009/12/07 18:00:00:INF:BaseClasses.cpp:9522:Closing leg 20471600-5c08-0010-8001-00900b0eee7e cause= 200 codec= PCMU (active conferences= 0)
2009/12/07 18:00:03:INF:BaseClasses.cpp:8761:Sip Call deleted: 0x8b18348
2009/12/07 18:00:10:INF:BaseClasses.cpp:8761:Sip Call deleted: 0x8b17760
2009/12/07 18:00:40:INF:BaseClasses.cpp:8552:Sip Call created: 0x8b17760
2009/12/07 18:00:40:INF:dInterface.cpp:924:Opening incoming SIP leg c06c3c00-ba08-0010-8007-00900b0eee7e from=101 to=89160286113 fromIP=77.41.77.88:3729 toIP=213.221.5.19:5060 registrationID=821f33f0-5bfa-4c39-91c0-068de92c41c6 startlineURL=89160286113
2009/12/07 18:00:40:INF:BaseClasses.cpp:8552:Sip Call created: 0x8b18348
2009/12/07 18:00:40:INF:..//RtpFilters/RtpTransceiver.h:196:RTP channel created: 0x8ca8648 load=0
2009/12/07 18:00:40:INF:dInterface.cpp:924:Opening outgoing SIP leg 12f36be8-f389-40ef-8354-9da1e7f1807e from=101 to=89160286113 fromIP=213.221.5.19:5060 toIP=217.150.198.101:5060 registrationID= startlineURL=
2009/12/07 18:00:40:INF:..//RtpFilters/RtpTransceiver.h:167:RTP channel deleted: 0x8ca8648, nat = false, dst = 0.0.0.0:0, sent = 0, recv = 0, sent RTCP = 0, recv RTCP = 0, sent T.38 = 0, recv T.38 = 0
2009/12/07 18:00:40:INF:BaseClasses.cpp:9522:Closing leg 12f36be8-f389-40ef-8354-9da1e7f1807e cause= 404 codec= PCMA (active conferences= 0)
2009/12/07 18:00:40:INF:..//RtpFilters/RtpTransceiver.h:196:RTP channel created: 0x8ca8648 load=0
2009/12/07 18:00:43:INF:..//RtpFilters/RtpTransceiver.h:167:RTP channel deleted: 0x8ca8648, nat = false, dst = 77.41.77.88:40010, sent = 160, recv = 0, sent RTCP = 0, recv RTCP = 0, sent T.38 = 0, recv T.38 = 0
2009/12/07 18:00:43:INF:BaseClasses.cpp:9522:Closing leg c06c3c00-ba08-0010-8007-00900b0eee7e cause= 200 codec= PCMU (active conferences= 0)
2009/12/07 18:00:50:INF:BaseClasses.cpp:8761:Sip Call deleted: 0x8b18348
2009/12/07 18:00:53:INF:BaseClasses.cpp:8761:Sip Call deleted: 0x8b17760
2009/12/07 18:03:04:INF:SwitchManager.cpp:3421:SIP user unregistered: username=101, registration_id_=821f33f0-5bfa-4c39-91c0-068de92c41c6, reason=Unregistered
2009/12/07 18:03:14:INF:ControlConnection.cpp:2882:SIP user accepted: Phone ID=101, Registration ID=aae6074c-cf4b-4544-b7b7-ad623412df14, Registrar ID=213.221.5.19
2009/12/07 18:03:46:INF:BaseClasses.cpp:8552:Sip Call created: 0x8b17760
2009/12/07 18:03:46:INF:dInterface.cpp:924:Opening incoming SIP leg 80944500-2e0a-0010-800f-00900b0eee7e from=101 to=89160286113 fromIP=77.41.77.88:3750 toIP=213.221.5.19:5060 registrationID=aae6074c-cf4b-4544-b7b7-ad623412df14 startlineURL=89160286113
2009/12/07 18:03:46:INF:BaseClasses.cpp:8552:Sip Call created: 0x8b18348
2009/12/07 18:03:46:INF:..//RtpFilters/RtpTransceiver.h:196:RTP channel created: 0x8ca8d10 load=0
2009/12/07 18:03:46:INF:dInterface.cpp:924:Opening outgoing SIP leg 655ec069-de90-4dfa-818b-ac5f517a270f from=101 to=89160286113 fromIP=213.221.5.19:5060 toIP=217.150.198.101:5060 registrationID= startlineURL=
2009/12/07 18:03:46:INF:..//RtpFilters/RtpTransceiver.h:167:RTP channel deleted: 0x8ca8d10, nat = false, dst = 0.0.0.0:0, sent = 0, recv = 0, sent RTCP = 0, recv RTCP = 0, sent T.38 = 0, recv T.38 = 0
2009/12/07 18:03:46:INF:BaseClasses.cpp:9522:Closing leg 655ec069-de90-4dfa-818b-ac5f517a270f cause= 404 codec= PCMU (active conferences= 0)
2009/12/07 18:03:46:INF:..//RtpFilters/RtpTransceiver.h:196:RTP channel created: 0x8ca8d10 load=0
2009/12/07 18:03:50:INF:..//RtpFilters/RtpTransceiver.h:167:RTP channel deleted: 0x8ca8d10, nat = false, dst = 77.41.77.88:40014, sent = 171, recv = 0, sent RTCP = 0, recv RTCP = 0, sent T.38 = 0, recv T.38 = 0
2009/12/07 18:03:50:INF:BaseClasses.cpp:9522:Closing leg 80944500-2e0a-0010-800f-00900b0eee7e cause= 200 codec= PCMU (active conferences= 0)
2009/12/07 18:03:56:INF:BaseClasses.cpp:8761:Sip Call deleted: 0x8b18348
2009/12/07 18:04:00:INF:BaseClasses.cpp:8761:Sip Call deleted: 0x8b17760