Однако...  

Перещли оба с провайдером на G711 и - ура! - исходящие заработали. Сейчас приступил к тщательной проверке всего-всего, потом (если кому интересно) выложу окончательный конфиг Ext SIP GW.

Апдейт: Пров поигрался у себя и после второго инвайта с авторизацией  ко мне приходит 403 Not Authorised с обьяснением Bearer Capability not authorized. Я как-то могу повлиять?

В ARS роуте выставлены и Voice, и Fax, и все, что возможно...

Последняя трасса - не совсем честный исходящий. Звоню я туда на номер, приходящий по аналоговым СО (АРА8) на аналоговый внутренний, у которого немедленная переадресация на 8495ххххххх. По-другому никак, клиент уже работает вовсю.

И все равно непонятно, почему каналов не хватает? Может, в кодеках дело? У меня в дефолтном IP домене выставлено Without compression.

Не знал. Зря паниковал.

Однако лед тронулся. Каким-то волшебством добился повторного Invite при исходящем звонке, где посылается поле Authorization. Теперь получаю 503 ошибку с руганью на отсутствие каналов.

1373356861 -> Tue Jul  9 14:01:01 2013 [ipc_thread] IPC Thread : Ipc reception 9369.
Tue Jul  9 14:01:01 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Tue Jul  9 14:01:01 2013 [exec_ipc] in 9368.
Tue Jul  9 14:01:01 2013 [display_ipc_in] ------------ Begin ---------------
Tue Jul  9 14:01:01 2013 neqt : 1152 Id : -1
Tue Jul  9 14:01:01 2013 INVITE
Tue Jul  9 14:01:01 2013 REQUEST URI : <> 84959332989@10.180.140.2:5060 ; user=phone
Tue Jul  9 14:01:01 2013 FROM : <Test> 550389@10.110.32.90:5060 ; user=phone
Tue Jul  9 14:01:01 2013 TO : <> 84959332989@10.180.140.2:5060 ; user=phone
Tue Jul  9 14:01:01 2013 CAC : 0
Tue Jul  9 14:01:01 2013 neqt CAC : -1
Tue Jul  9 14:01:01 2013 CAC-CSBU info : UNKNOWN
Tue Jul  9 14:01:01 2013 CLIR : 0
Tue Jul  9 14:01:01 2013 SDP :
Tue Jul  9 14:01:01 2013   ADDRESS : 10.110.32.9210.110.32.92 :32612
Tue Jul  9 14:01:01 2013   ALGOS :
Tue Jul  9 14:01:01 2013     PCMA
Tue Jul  9 14:01:01 2013     G723
Tue Jul  9 14:01:01 2013     97
Tue Jul  9 14:01:01 2013   DIRECTION : SEND & RECEIVE
Tue Jul  9 14:01:01 2013   crypto index : 0
Tue Jul  9 14:01:01 2013        N_GW_EXT : 10
Tue Jul  9 14:01:01 2013 [display_ipc_in] ------------- End ----------------
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] an event 10752 arrived on the eqt 1152 -1.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] New Call created.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::callFactory].
Tue Jul  9 14:01:01 2013 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R10.1.1 j2.603.20.i
1373356861 -> Tue Jul  9 14:01:01 2013 [CMotorCallManager::callFactory]=84e58d0.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::insertCallwithEqt] CMotorCall 1152 inserted.
Tue Jul  9 14:01:01 2013 inviteBuildFromAssertedId-->extGw=-1
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildAurlWithBelongingDomain] Reg_Id_for_user_URL_of_PAI =1
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 [quoteString] => "550389"
Tue Jul  9 14:01:01 2013 [isAddrInDico] user=84959332989 host=10.180.140.2
Tue Jul  9 14:01:01 2013 [isUserInDico] 84959332989@10.180.140.2
Tue Jul  9 14:01:01 2013 isUserInDico] NOT found in the dictionnary.
Tue Jul  9 14:01:01 2013 [isAddrInDico] other sip user
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildAurlWithBelongingDomain] P-Asserted-Identity: "550389" <sip:550389@10.180.140.2
>
Tue Jul  9 14:01:01 2013 [quoteString] => "Test"
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::setFilterUsedMode] To be traced = 0
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] state = INITIAL_STATE.
Tue Jul  9 14:01:01 2013 [onIncomingEvent] INVITE arrived.
Tue Jul  9 14:01:01 2013 [receiveInviteEvent] Call: eqt: 1152 INITIAL_STATE received an event.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitInviteMessage] begin. size=656 call_type: 0
Tue Jul  9 14:01:01 2013 [isAddrInDico] user=84959332989 host=10.180.140.2
Tue Jul  9 14:01:01 2013 [isUserInDico] 84959332989@10.180.140.2
1373356861 -> Tue Jul  9 14:01:01 2013 isUserInDico] NOT found in the dictionnary.
Tue Jul  9 14:01:01 2013 [isAddrInDico] other sip user
Tue Jul  9 14:01:01 2013 inviteBuildFromAssertedId-->extGw=10
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildAurlWithBelongingDomain] Reg_Id_for_user_URL_of_PAI =1
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 [quoteString] => "550389"
Tue Jul  9 14:01:01 2013 [isAddrInDico] user=84959332989 host=10.180.140.2
Tue Jul  9 14:01:01 2013 [isUserInDico] 84959332989@10.180.140.2
Tue Jul  9 14:01:01 2013 isUserInDico] NOT found in the dictionnary.
Tue Jul  9 14:01:01 2013 [isAddrInDico] other sip user
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildAurlWithBelongingDomain] P-Asserted-Identity: "550389" <sip:550389@10.180.140.2
>
Tue Jul  9 14:01:01 2013 [quoteString] => "Test"
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitInviteMessage] From: "Test" <sip:550389@10.180.140.2;user=phone>
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitInviteMessage] reqUri :sip:84959332989@10.180.140.2;user=phone
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitInviteMessage]-->SIP_INFO_allowed=0
Tue Jul  9 14:01:01 2013 1103[CMotorCall ISDN ExtGW
Tue Jul  9 14:01:01 2013 1103[CMotorCall ISDN ExtGW
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildSupportedHeader] Invite directed to external gw : 10
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
1373356861 -> Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitInviteMessage] To: <sip:84959332989@10.180.140.2;user=phone>
Tue Jul  9 14:01:01 2013  am_I_PCS SCSWorking : NO
Tue Jul  9 14:01:01 2013  check_PCSstate
Tue Jul  9 14:01:01 2013  am_I_PCS SCSWorking : NO
Tue Jul  9 14:01:01 2013  check_PCSstate stat of PCS  is : -1
Tue Jul  9 14:01:01 2013 [inviteBuildContact] trunk_number=102 extGw =10.
Tue Jul  9 14:01:01 2013 [137339-InviteBuildContact] userinfo : 550389
Tue Jul  9 14:01:01 2013 1103[CMotorCall::sipUriType] sip Uri.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::isTLSProtRequiredForExtGw] =0.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildContact] Contact: sip:550389@10.110.32.90
Tue Jul  9 14:01:01 2013 1103[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT manged with TLS and refresh REINVITE
Tue Jul  9 14:01:01 2013 1103[CMotorCall::inviteBuildSessionTimer] uacGatewayMode=1 uacRefresher=1.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeRequestSdp] Begin sdp.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::appendAudioAttributToMedia] Direction: 0.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::appendAudioAttributToMedia] format 97
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeRequestSdp] crypto index3=0 clearMediaLine=0.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeRequestSdp] appendMediaDescription ok.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeRequestSdp] Final sdp.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitInviteMessage] The sdp build.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::new_determineTargetsForTheRequest] is not Responsible For This URI.
1373356861 -> Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] target is not the local node.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] nb contacts=1.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] *pcszNameToFind : 84959332989
Tue Jul  9 14:01:01 2013 [isUserInDico] 84959332989@10.180.140.2
Tue Jul  9 14:01:01 2013 isUserInDico] NOT found in the dictionnary.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] contact : sip:84959332989@10.180.140.2;user=phone
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] nb available licenses=10 .
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0 and pSipAddSpec->getHost()=10.180.140.2
Tue Jul  9 14:01:01 2013 [CGWMngDat a::isMainServer] CPU is MAIN.
Tue Jul  9 14:01:01 2013 [CGWMngDat a::isMainServer] checkwith PCS = 0
Tue Jul  9 14:01:01 2013 1103[CMotorCall::isTLSProtRequiredForExtGw] =0.
Tue Jul  9 14:01:01 2013 1103 [CCall::makeGenericRequest] INVITE
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Confirmed Dialog is not found (ID =
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Initial Dialog Client not found
Tue Jul  9 14:01:01 2013 1502 [CDialog::createRequest]
Tue Jul  9 14:01:01 2013 1502 [CDialog::buildServicesForAllRequest]
Tue Jul  9 14:01:01 2013 1502 [CDialog::createInviteRequest]
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] STATE CHANGED TO INITIAL
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] notifying the parent dialog
1373356861 -> Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2102, previousState = Terminated, currentState = I
nitial, reason = None]
Tue Jul  9 14:01:01 2013 2 [CRequest::CRequest] Creation of a request
Tue Jul  9 14:01:01 2013 2 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Tue Jul  9 14:01:01 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 1002)
----------------------utf8-----------------------
INVITE sip:84959332989@10.180.140.2;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, SUBSCRIBE, OPTIONS, UPDATE
Supported: timer,path,100rel
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
Session-Expires: 1800;refresher=uac
Min-SE: 900
P-Asserted-Identity: "550389" <sip:550389@10.180.140.2>
Content-Type: application/sdp
To: <sip:84959332989@10.180.140.2;user=phone>
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
Contact: <sip:550389@10.110.32.90;transport=UDP>
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
CSeq: 1201037864 INVITE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK13de85af2fabb8be2dd23cb67677bb8d
Max-Forwards: 70
Content-Length: 265

v=0
o=OXE 1373356861 1373356861 IN IP4 10.110.32.90
s=abs
c=IN IP4 10.110.32.92
t=0 0
m=audio 32612 RTP/AVP 8 4 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:4 G723/8000
a=ptime:30
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
Tue Jul  9 14:01:01 2013 2 [CMessage::onSendSuccess]
1373356861 -> Tue Jul  9 14:01:01 2013 2102 [CTransaction::onSendSuccess] CMessage 2 send Success
Tue Jul  9 14:01:01 2013 1502 [CDialog::onSendSuccess]
Tue Jul  9 14:01:01 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Tue Jul  9 14:01:01 2013 [isIpAddressType] 10.180.140.2.
Tue Jul  9 14:01:01 2013 [isIpAddressType] YES.
Tue Jul  9 14:01:01 2013 2102 [CTransInitialState::createRequest] Transaction changes to Calling state
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] STATE CHANGED TO CALLING
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] notifying the parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2102, previousState = Initial, currentState = Calling, reason =
Request creation]
Tue Jul  9 14:01:01 2013 2102 [CTransaction::startTimer] Timer A is started (delay = 500 ms)
Tue Jul  9 14:01:01 2013 2102 [CTransaction::startTimer] Timer B is started (delay = 4000 ms)
Tue Jul  9 14:01:01 2013 1502 [CDialog::getTransactionByCSeq] CSeq = 1201037864
Tue Jul  9 14:01:01 2013 1502 [CDialog::addTransaction] added transaction 2102 with branch z9hG4bK13de85af2fabb8be2dd23cb67677bb8d,
with CSeq 1201037864
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Client, UA)
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateSupported] Request timer supported
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateMinSE] Min-SE updated : 900
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1373356861 -> Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Tue Jul  9 14:01:01 2013 [CForkedBranch::CForkedBranch] context = 0x84e5d7c.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::branchAllocation] pForkedBranch = 0x84e49f8 and the branch number is.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::makeInitialMotorRequest] reqUri duplication pForkedBranch = 0x84e49f8.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Tue Jul  9 14:01:01 2013 NOE-SIP : StandByCallCreation not sent to twin CS
Tue Jul  9 14:01:01 2013 [onIncomingEvent] CallID must be inserted.
Tue Jul  9 14:01:01 2013 [onIncomingEvent] CallID inserted.
Tue Jul  9 14:01:01 2013 [exec_ipc] in end 9368.
Tue Jul  9 14:01:01 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:84959332989@10.180.140.2;user=phone>
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
CSeq: 1201037864 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK13de85af2fabb8be2dd23cb67677bb8d

-------------------------------------------------

Tue Jul  9 14:01:01 2013 [CIOCom::receiveResponse] CResponse 2 ref=1
Tue Jul  9 14:01:01 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Tue Jul  9 14:01:01 2013  102 [CCallManager::onIncomingResponse]
Tue Jul  9 14:01:01 2013 1103 [CCall::receiveResponse] 100
1373356861 -> Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Confirmed Dialog is not found (ID = 76816edcc2f41fe921ba66b6edd81ba4;
)
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Returning Initial Dialog Client
Tue Jul  9 14:01:01 2013 1502 [CDialog::receiveResponse]
Tue Jul  9 14:01:01 2013 2102 [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] notifying the parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2102, previousState = Calling, currentState = Proceeding, reason
= 1xx response reception]
Tue Jul  9 14:01:01 2013 2102 [CTransaction::freeTimerToken] Timer A is freed
Tue Jul  9 14:01:01 2013 2102 [CTransaction::freeTimerToken] Timer B is freed
Tue Jul  9 14:01:01 2013 1103[CMotorCall::searchForkedBranch]pForkedBranch=0x84e49f8.
Tue Jul  9 14:01:01 2013 [receiveInformationalMessage] Call: a00a03e4296dd158a42d5970e13569d7@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Tue Jul  9 14:01:01 2013 [receiveInformationalMessage] is in the else part of SDP not present
Tue Jul  9 14:01:01 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 401 Unauthorized
To: <sip:84959332989@10.180.140.2;user=phone>;tag=SDmhp6299-s0nj9yipq7
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
CSeq: 1201037864 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK13de85af2fabb8be2dd23cb67677bb8d
WWW-Authenticate: Digest realm="10.67.144.34",nonce="51dbc39dcfec66ef786a43c7311c15af449e59a6",opaque="d115b45f7caffcf5cb8e2e76dedf8
be5",qop="auth"
Content-Length: 0

-------------------------------------------------

1373356861 -> Tue Jul  9 14:01:01 2013 [CIOCom::receiveResponse] CResponse 3 ref=1
Tue Jul  9 14:01:01 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Tue Jul  9 14:01:01 2013  102 [CCallManager::onIncomingResponse]
Tue Jul  9 14:01:01 2013 1103 [CCall::receiveResponse] 401
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Confirmed Dialog is not found (ID = 76816edcc2f41fe921ba66b6edd81ba4;SDmhp6299-s0nj
9yipq7)
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Returning Initial Dialog Client
Tue Jul  9 14:01:01 2013 1502 [CDialog::receiveResponse]
Tue Jul  9 14:01:01 2013 2 [~CResponse] resp(100) a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037864 INVITE
Tue Jul  9 14:01:01 2013 2102 [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] notifying the parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2102, previousState = Proceeding, currentState = Completed, reas
on = Final resp reception]
Tue Jul  9 14:01:01 2013 3 [CRequest::CRequest] Creation of a request
Tue Jul  9 14:01:01 2013 3 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Tue Jul  9 14:01:01 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 390)
----------------------utf8-----------------------
ACK sip:84959332989@10.180.140.2;user=phone SIP/2.0
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
To: <sip:84959332989@10.180.140.2;user=phone>;tag=SDmhp6299-s0nj9yipq7
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK13de85af2fabb8be2dd23cb67677bb8d
CSeq: 1201037864 ACK
Content-Length: 0

-------------------------------------------------
1373356861 -> Tue Jul  9 14:01:01 2013 3 [CMessage::onSendSuccess]
Tue Jul  9 14:01:01 2013 2102 [CTransaction::onSendSuccess] CMessage 3 send Success
Tue Jul  9 14:01:01 2013 1502 [CDialog::onSendSuccess]
Tue Jul  9 14:01:01 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Tue Jul  9 14:01:01 2013 [isIpAddressType] 10.180.140.2.
Tue Jul  9 14:01:01 2013 [isIpAddressType] YES.
Tue Jul  9 14:01:01 2013 2102 [CTransaction::startTimer] Timer D is started (delay = 32142 ms)
Tue Jul  9 14:01:01 2013 [unquoteString] "10.67.144.34" => 10.67.144.34
Tue Jul  9 14:01:01 2013 1103[CMotorCall::isKnownAuthenticate] Unquoted realm found : 10.67.144.34 ,Realm in the management : 10.67.
144.34.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::isKnownAuthenticate] matching realm : 10.67.144.34 in authenticate header.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::searchForkedBranch]pForkedBranch=0x84e49f8.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitAuthorizedRequest] Begin.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitAuthorizedRequest] authenticateHeader found => Login: 550389.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitAuthorizedRequest] AuthorizationService for qop : "auth" => cnounce : 1373356861.
Tue Jul  9 14:01:01 2013 1103 [CCall::makeGenericRequest] INVITE
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Confirmed Dialog is not found (ID = 76816edcc2f41fe921ba66b6edd81ba4;SDmhp6299-s0nj
9yipq7)
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Returning Initial Dialog Client
Tue Jul  9 14:01:01 2013 1502 [CDialog::createRequest]
1373356861 -> Tue Jul  9 14:01:01 2013 1502 [CDialog::buildServicesForAllRequest]
Tue Jul  9 14:01:01 2013 1502 [CDialog::createInviteRequest]
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] STATE CHANGED TO INITIAL
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] notifying the parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2103, previousState = Terminated, currentState = Initial, reason
= None]
Tue Jul  9 14:01:01 2013 4 [CRequest::CRequest] Creation of a request
Tue Jul  9 14:01:01 2013 4 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Tue Jul  9 14:01:01 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 1286)
----------------------utf8-----------------------
INVITE sip:84959332989@10.180.140.2;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, SUBSCRIBE, OPTIONS, UPDATE
Supported: timer,path,100rel
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
Session-Expires: 1800;refresher=uac
Min-SE: 900
P-Asserted-Identity: "550389" <sip:550389@10.180.140.2>
Content-Type: application/sdp
To: <sip:84959332989@10.180.140.2;user=phone>
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
Contact: <sip:550389@10.110.32.90;transport=UDP>
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
CSeq: 1201037865 INVITE
Max-Forwards: 70
Authorization: Digest username="550389",realm="10.67.144.34",nonce="51dbc39dcfec66ef786a43c7311c15af449e59a6",opaque="d115b45f7caffc
f5cb8e2e76dedf8be5",qop=auth,cnonce="1373356861",nc=00000001,uri="sip:84959332989@10.180.140.2;user=phone",response="db6d98302caa560
4a7cf1cb018ca0ea9"
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK646d4baa378df178134c85ea4d4b995e
Content-Length: 265

v=0
o=OXE 1373356861 1373356861 IN IP4 10.110.32.90
s=abs
c=IN IP4 10.110.32.92
t=0 0
m=audio 32612 RTP/AVP 8 4 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:4 G723/8000
a=ptime:30
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
1373356861 -> Tue Jul  9 14:01:01 2013 4 [CMessage::onSendSuccess]
Tue Jul  9 14:01:01 2013 2103 [CTransaction::onSendSuccess] CMessage 4 send Success
Tue Jul  9 14:01:01 2013 1502 [CDialog::onSendSuccess]
Tue Jul  9 14:01:01 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Tue Jul  9 14:01:01 2013 [isIpAddressType] 10.180.140.2.
Tue Jul  9 14:01:01 2013 [isIpAddressType] YES.
Tue Jul  9 14:01:01 2013 2103 [CTransInitialState::createRequest] Transaction changes to Calling state
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] STATE CHANGED TO CALLING
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] notifying the parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2103, previousState = Initial, currentState = Calling, reason =
Request creation]
Tue Jul  9 14:01:01 2013 2103 [CTransaction::startTimer] Timer A is started (delay = 500 ms)
Tue Jul  9 14:01:01 2013 2103 [CTransaction::startTimer] Timer B is started (delay = 4000 ms)
Tue Jul  9 14:01:01 2013 1502 [CDialog::getTransactionByCSeq] CSeq = 1201037865
Tue Jul  9 14:01:01 2013 1502 [CDialog::addTransaction] added transaction 2103 with branch z9hG4bK646d4baa378df178134c85ea4d4b995e,
with CSeq 1201037865
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateSupported] Request timer supported
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitAuthorizedRequest] ForkedBranch updated.
1373356861 -> Tue Jul  9 14:01:01 2013 [CForkedBranch::CForkedBranch] context = 0x84ee7dc.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::branchAllocation] pForkedBranch = 0x84e49f8 and the branch number is.
Tue Jul  9 14:01:01 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:84959332989@10.180.140.2;user=phone>
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
CSeq: 1201037865 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK646d4baa378df178134c85ea4d4b995e

-------------------------------------------------

Tue Jul  9 14:01:01 2013 [CIOCom::receiveResponse] CResponse 4 ref=1
Tue Jul  9 14:01:01 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Tue Jul  9 14:01:01 2013  102 [CCallManager::onIncomingResponse]
Tue Jul  9 14:01:01 2013 1103 [CCall::receiveResponse] 100
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Confirmed Dialog is not found (ID = 76816edcc2f41fe921ba66b6edd81ba4;)
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Returning Initial Dialog Client
Tue Jul  9 14:01:01 2013 1502 [CDialog::receiveResponse]
Tue Jul  9 14:01:01 2013 2103 [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] notifying the parent dialog
1373356861 -> Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2103, previousState = Calling, currentState = Proc
eeding, reason = 1xx response reception]
Tue Jul  9 14:01:01 2013 2103 [CTransaction::freeTimerToken] Timer A is freed
Tue Jul  9 14:01:01 2013 2103 [CTransaction::freeTimerToken] Timer B is freed
Tue Jul  9 14:01:01 2013 1103[CMotorCall::searchForkedBranch]pForkedBranch=0x84e49f8.
Tue Jul  9 14:01:01 2013 [receiveInformationalMessage] Call: a00a03e4296dd158a42d5970e13569d7@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Tue Jul  9 14:01:01 2013 [receiveInformationalMessage] is in the else part of SDP not present
Tue Jul  9 14:01:01 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 503 Service Unavailable
To: <sip:84959332989@10.180.140.2;user=phone>;tag=SDmhp6299-ooxn1qcknj
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
CSeq: 1201037865 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK646d4baa378df178134c85ea4d4b995e
Reason: Q.850;cause=34;text="No circuit/channel available"
Content-Length: 0

-------------------------------------------------

Tue Jul  9 14:01:01 2013 [CIOCom::receiveResponse] CResponse 5 ref=1
Tue Jul  9 14:01:01 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Tue Jul  9 14:01:01 2013  102 [CCallManager::onIncomingResponse]
Tue Jul  9 14:01:01 2013 1103 [CCall::receiveResponse] 503
1373356861 -> Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Confirmed Dialog is not found (ID = 76816edcc2f41fe921ba66b6edd81ba4;
SDmhp6299-ooxn1qcknj)
Tue Jul  9 14:01:01 2013 1103 [CCall::getDialog] Returning Initial Dialog Client
Tue Jul  9 14:01:01 2013 1502 [CDialog::receiveResponse]
Tue Jul  9 14:01:01 2013 4 [~CResponse] resp(100) a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037865 INVITE
Tue Jul  9 14:01:01 2013 2103 [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] notifying the parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2103, previousState = Proceeding, currentState = Completed, reas
on = Final resp reception]
Tue Jul  9 14:01:01 2013 5 [CRequest::CRequest] Creation of a request
Tue Jul  9 14:01:01 2013 5 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Tue Jul  9 14:01:01 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 390)
----------------------utf8-----------------------
ACK sip:84959332989@10.180.140.2;user=phone SIP/2.0
Call-ID: a00a03e4296dd158a42d5970e13569d7@10.110.32.90
From: "Test" <sip:550389@10.180.140.2;user=phone>;tag=76816edcc2f41fe921ba66b6edd81ba4
To: <sip:84959332989@10.180.140.2;user=phone>;tag=SDmhp6299-ooxn1qcknj
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK646d4baa378df178134c85ea4d4b995e
CSeq: 1201037865 ACK
Content-Length: 0

-------------------------------------------------
1373356861 -> Tue Jul  9 14:01:01 2013 5 [CMessage::onSendSuccess]
Tue Jul  9 14:01:01 2013 2103 [CTransaction::onSendSuccess] CMessage 5 send Success
Tue Jul  9 14:01:01 2013 1502 [CDialog::onSendSuccess]
Tue Jul  9 14:01:01 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Tue Jul  9 14:01:01 2013 [isIpAddressType] 10.180.140.2.
Tue Jul  9 14:01:01 2013 [isIpAddressType] YES.
Tue Jul  9 14:01:01 2013 2103 [CTransaction::startTimer] Timer D is started (delay = 32208 ms)
Tue Jul  9 14:01:01 2013 1103[CMotorCall::searchForkedBranch]pForkedBranch=0x84e49f8.
Tue Jul  9 14:01:01 2013         [CForkedBranch::setFinalResponse] response=503.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::responseToInviteOrCancel] no response to the CH m_cancelSent=0.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::responseToInviteOrCancel] all responses are received 1.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::chooseBestResponse] pForkedBranch=0x84e49f8 iResponseCode=2000.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::chooseBestResponse] last iResponseCode=503.
Tue Jul  9 14:01:01 2013         [CForkedBranch::setFinalResponse] pResponse=0x84f2380.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::chooseBestResponse] next branch.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
Tue Jul  9 14:01:01 2013 [receiveServerFailureMessage] Call: a00a03e4296dd158a42d5970e13569d7@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
1373356861 -> Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] CAC = 0 eqtCAC = -1
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] cacUsed=0 eqtCac=-1
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] displayIPCMessageOut
Tue Jul  9 14:01:01 2013 ** SIP OTHER ICE **
Tue Jul  9 14:01:01 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Tue Jul  9 14:01:01 2013 [ipc_thread] IPC Thread : Ipc reception 9369.
Tue Jul  9 14:01:01 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Tue Jul  9 14:01:01 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Tue Jul  9 14:01:01 2013 [display_ipc_out] ------------ Begin ---------------
Tue Jul  9 14:01:01 2013 Id : -1
Tue Jul  9 14:01:01 2013 SERVER FAILURE
Tue Jul  9 14:01:01 2013 xx :        3
Tue Jul  9 14:01:01 2013        RELATIVE REQUEST : INVITE
Tue Jul  9 14:01:01 2013 [display_ipc_out] ------------- End ----------------
Tue Jul  9 14:01:01 2013 1103[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Tue Jul  9 14:01:01 2013 1103[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
Tue Jul  9 14:01:01 2013 [exec_ipc] in 9368.
Tue Jul  9 14:01:01 2013 [display_ipc_in] ------------ Begin ---------------
Tue Jul  9 14:01:01 2013 neqt : 1152 Id : -1
Tue Jul  9 14:01:01 2013 SIP EQT RELEASED
Tue Jul  9 14:01:01 2013 [display_ipc_in] ------------- End ----------------
1373356861 -> Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 1152 -1.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] The call with eqt: 1152 has released its equipment.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel]1 T38 REINVITE TRUE
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] CAC = 0 eqtCAC = -1
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] cacUsed=0 eqtCac=-1
Tue Jul  9 14:01:01 2013 1103[emitEventToMonitel] displayIPCMessageOut
Tue Jul  9 14:01:01 2013 ** SIP OTHER ICE **
Tue Jul  9 14:01:01 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Tue Jul  9 14:01:01 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Tue Jul  9 14:01:01 2013 [display_ipc_out] ------------ Begin ---------------
Tue Jul  9 14:01:01 2013 Id : -1
Tue Jul  9 14:01:01 2013 SIP_EQT_RELEASE_ACK
Tue Jul  9 14:01:01 2013 [display_ipc_out] ------------- End ----------------
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Tue Jul  9 14:01:01 2013 1103[CMotorCall::unRegister] Remove eqt : 1152 diag : -1 from the map.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::eraseCallwithEqt] erase 1152 -1.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onIncomingEvent] killSession.
1373356861 ->  ascii.alarm.delay = 4h
1373356861 -> Tue Jul  9 14:01:01 2013 1103 [CCall::killSession]
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Tue Jul  9 14:01:01 2013 2102 [CTransaction::freeTimerToken] Timer D is freed
Tue Jul  9 14:01:01 2013 2102 [CTransaction::changeState] no transaction state, terminated reason : None
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Tue Jul  9 14:01:01 2013 2103 [CTransaction::freeTimerToken] Timer D is freed
Tue Jul  9 14:01:01 2013 2103 [CTransaction::changeState] no transaction state, terminated reason : None
Tue Jul  9 14:01:01 2013 1103 [CCall::killSession] notifying the call manager
Tue Jul  9 14:01:01 2013  102 [CCallManager::onCallClosed]
Tue Jul  9 14:01:01 2013  102 [CCallManager::onCallClosed()] Call 1103 closed. Removing call 139352272 from the maps
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onNotifyCallClosed] Call : a00a03e4296dd158a42d5970e13569d7@10.110.32.90 is closed.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onNotifyCallClosed] Call : a00a03e4296dd158a42d5970e13569d7@10.110.32.90 is closed.
Tue Jul  9 14:01:01 2013 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Tue Jul  9 14:01:01 2013 [exec_ipc] in end 9368.
Tue Jul  9 14:01:01 2013 [CTransaction::notifyDialog]
Tue Jul  9 14:01:01 2013 [CTransaction::notifyDialog] notify parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2102, previousState = null, currentState = Terminated, reason =
None]
1373356861 -> Tue Jul  9 14:01:01 2013 2102 [~CTransaction] transaction 1201037864 INVITE
Tue Jul  9 14:01:01 2013 3 [~CRequest] req a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037864 ACK
Tue Jul  9 14:01:01 2013 3 [~CResponse] resp(401) a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037864 INVITE
Tue Jul  9 14:01:01 2013 2 [~CRequest] req a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037864 INVITE
Tue Jul  9 14:01:01 2013 [CTransaction::notifyDialog]
Tue Jul  9 14:01:01 2013 [CTransaction::notifyDialog] notify parent dialog
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState(pTrans = 2103, previousState = null, currentState = Terminated, reason =
None]
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState] dialog is terminated
Tue Jul  9 14:01:01 2013 1502 [CDialog::onTransactionState] onDialogClosed
Tue Jul  9 14:01:01 2013 1103 [CCall::onDialogClosed]
Tue Jul  9 14:01:01 2013 1103 [CCall::onDialogClosed] only initial *********
Tue Jul  9 14:01:01 2013 1103 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Tue Jul  9 14:01:01 2013 2103 [~CTransaction] transaction 1201037865 INVITE
Tue Jul  9 14:01:01 2013 5 [~CRequest] req a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037865 ACK
Tue Jul  9 14:01:01 2013  102 [CCallManager::removeGarbage] at index i = 0
Tue Jul  9 14:01:01 2013 1103 [CMotorCall::clear_subscription] no subscription managed
Tue Jul  9 14:01:01 2013 1103[CMotorCall::~CMotorCall] Call : a00a03e4296dd158a42d5970e13569d7@10.110.32.90 is being destructed.
1373356865 -> Tue Jul  9 14:01:01 2013 1103[CMotorCall::~CMotorCall] License is released for this call.
Tue Jul  9 14:01:01 2013 1103[CMotorCall::~CMotorCall] number of available licenses are =10 .
Tue Jul  9 14:01:01 2013 5 [~CResponse] resp(503) a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037865 INVITE
Tue Jul  9 14:01:01 2013 1103 [CCall::~CCall]
Tue Jul  9 14:01:01 2013 1103 [CCall::removeGarbage]
Tue Jul  9 14:01:01 2013 1502 [CDialog::~CDialog]
Tue Jul  9 14:01:01 2013 [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
Tue Jul  9 14:01:01 2013 4 [~CRequest] req a00a03e4296dd158a42d5970e13569d7@10.110.32.90 1201037865 INVITE

Собрали совсем аналогичную схему у себя на стенде. С такой же циской с NAT, с такими же IP фдресами. Без SBC, правда. Вместо провайдерской SI3000 стоит Астериск. С ходу заработало в обе стороны.

НО! Выплыла странная штука - регистрация происходит в два этапа. Запрос --> 401 Unauthirised --> Запрос --> 200OK. Первый запрос идет без указания realm, второй с указанием. (И у клиента, и у нас на стенде картина одинаковая).

А не в этом ли косяк - регистрация вот так косо установилась, а при звонке в инвайте реалм не посылается, и пров меня не видит.

Вот трасса регистрации

1373288327 -> Mon Jul  8 18:58:47 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 469)
----------------------utf8-----------------------
REGISTER sip:10.180.140.2 SIP/2.0
Supported: 100rel,path
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
To: sip:550389@10.180.140.2
From: sip:550389@10.180.140.2;tag=f0155f89b95bf47da897b8918d6eaf95
Contact: <sip:550389@10.110.32.90;transport=UDP>;expires=600
Call-ID: 1a0692390be7787c61a3703c6b623889@10.110.32.90
CSeq: 953736919 REGISTER
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK64f547e2ede2793e7d95f7ec434d66b3
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
Mon Jul  8 18:58:47 2013 F [CMessage::onSendSuccess]
Mon Jul  8 18:58:47 2013 210e [CTransaction::onSendSuccess] CMessage F send Success
Mon Jul  8 18:58:47 2013 1508 [CDialog::onSendSuccess]
Mon Jul  8 18:58:47 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Mon Jul  8 18:58:47 2013 [isIpAddressType] 10.180.140.2.
Mon Jul  8 18:58:47 2013 [isIpAddressType] YES.
Mon Jul  8 18:58:47 2013 210e [CTransInitialState::createRequest] Transaction changes to Trying state
Mon Jul  8 18:58:47 2013 210e [CTransaction::changeState] STATE CHANGED TO TRYING
Mon Jul  8 18:58:47 2013 210e [CTransaction::changeState] notifying the parent dialog
Mon Jul  8 18:58:47 2013 1508 [CDialog::onTransactionState(pTrans = 210e, previousState = Initial, currentState = Trying, reason = R
equest creation]
Mon Jul  8 18:58:47 2013 210e [CTransTryingState::enterInState] Init timers E and F
1373288327 -> Mon Jul  8 18:58:47 2013 210e [CTransaction::startTimer] Timer E is started (delay = 500 ms)
Mon Jul  8 18:58:47 2013 210e [CTransaction::startTimer] Timer F is started (delay = 2000 ms)
Mon Jul  8 18:58:47 2013 1508 [CDialog::addTransaction] added transaction 210e with branch z9hG4bK64f547e2ede2793e7d95f7ec434d66b3,
with CSeq 953736919
Mon Jul  8 18:58:47 2013 [CForkedBranch::CForkedBranch] context = 0x84f07f0.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::branchAllocation] pForkedBranch = 0x84e82f0 and the branch number is.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::makeInitialMotorRequest] reqUri duplication pForkedBranch = 0x84e82f0.
Mon Jul  8 18:58:47 2013 [CInitialState::receiveRegisterEvent] emitRegisterMessage OK.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Mon Jul  8 18:58:47 2013 [onIncomingEvent] CallID must be inserted.
Mon Jul  8 18:58:47 2013 [onIncomingEvent] CallID inserted.
Mon Jul  8 18:58:47 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 401 Unauthorized
To: <sip:550389@10.180.140.2>;tag=SDshab899-10g75hp4dw
From: sip:550389@10.180.140.2;tag=f0155f89b95bf47da897b8918d6eaf95
Call-ID: 1a0692390be7787c61a3703c6b623889@10.110.32.90
CSeq: 953736919 REGISTER
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK64f547e2ede2793e7d95f7ec434d66b3
Contact: <sip:550389@10.180.140.2:5060;transport=udp>;expires=600
Expires: 600
WWW-Authenticate: Digest realm="10.67.144.34",nonce="51dab7e8cb268f1305113bd62e5d9fb5190015e6",opaque="115cff3b9285f8825fc3cd4407cc9
2bb",qop="auth"
Content-Length: 0

-------------------------------------------------

1373288327 -> Mon Jul  8 18:58:47 2013 [CIOCom::receiveResponse] CResponse F ref=1
Mon Jul  8 18:58:47 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Mon Jul  8 18:58:47 2013  104 [CCallManager::onIncomingResponse]
Mon Jul  8 18:58:47 2013 1114 [CCall::receiveResponse] 401
Mon Jul  8 18:58:47 2013 1114 [CCall::getDialog] Confirmed Dialog is not found (ID = f0155f89b95bf47da897b8918d6eaf95;SDshab899-10g7
5hp4dw)
Mon Jul  8 18:58:47 2013 1114 [CCall::getDialog] Initial Dialog Client not found
Mon Jul  8 18:58:47 2013 1114 [CRegistrarCall::onReceiveOutOfContextResponse] 401
Mon Jul  8 18:58:47 2013 1114 [CCall::onDialogClosed]
Mon Jul  8 18:58:47 2013 1114 [CCall::onDialogClosed] only initial *********
Mon Jul  8 18:58:47 2013 1114 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Mon Jul  8 18:58:47 2013 1114 [CCall] closed
Mon Jul  8 18:58:47 2013  104 [CCallManager::onCallClosed]
Mon Jul  8 18:58:47 2013  104 [CCallManager::onCallClosed()] Call 1114 closed. Removing call 139365888 from the maps
Mon Jul  8 18:58:47 2013  101 [CCallManager::onIncomingResponse]
Mon Jul  8 18:58:47 2013 1113 [CCall::receiveResponse] 401
Mon Jul  8 18:58:47 2013 1113 [CCall::getDialog] Confirmed Dialog is not found (ID = f0155f89b95bf47da897b8918d6eaf95;SDshab899-10g7
5hp4dw)
Mon Jul  8 18:58:47 2013 1113 [CCall::getDialog] Returning Initial Dialog Client
Mon Jul  8 18:58:47 2013 1508 [CDialog::receiveResponse]
Mon Jul  8 18:58:47 2013 210e [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
1373288327 -> Mon Jul  8 18:58:47 2013 210e [CTransaction::changeState] STATE CHANGED TO COMPLETED
Mon Jul  8 18:58:47 2013 210e [CTransaction::changeState] notifying the parent dialog
Mon Jul  8 18:58:47 2013 1508 [CDialog::onTransactionState(pTrans = 210e, previousState = Trying, currentState = Completed, reason =
Final resp reception]
Mon Jul  8 18:58:47 2013 210e [CTransaction::freeTimerToken] Timer E is freed
Mon Jul  8 18:58:47 2013 210e [CTransaction::freeTimerToken] Timer F is freed
Mon Jul  8 18:58:47 2013 210e [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
Mon Jul  8 18:58:47 2013 [unquoteString] "10.67.144.34" => 10.67.144.34
Mon Jul  8 18:58:47 2013 1113[CMotorCall::isKnownAuthenticate] Unquoted realm found : 10.67.144.34 ,Realm in the management : 10.67.
144.34.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::isKnownAuthenticate] matching realm : 10.67.144.34 in authenticate header.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::searchForkedBranch]pForkedBranch=0x84e82f0.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::emitAuthorizedRequest] Begin.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::emitAuthorizedRequest] authenticateHeader found => Login: 550389.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::emitAuthorizedRequest] AuthorizationService for qop : "auth" => cnounce : 1373288327.
Mon Jul  8 18:58:47 2013 1113 [CCall::makeGenericRequest] REGISTER
Mon Jul  8 18:58:47 2013 1113 [CCall::getDialog] Confirmed Dialog is not found (ID = f0155f89b95bf47da897b8918d6eaf95;SDshab899-10g7
5hp4dw)
1373288327 -> Mon Jul  8 18:58:47 2013 1113 [CCall::getDialog] Returning Initial Dialog Client
Mon Jul  8 18:58:47 2013 1508 [CDialog::createRequest]
Mon Jul  8 18:58:47 2013 1508 [CDialog::buildServicesForAllRequest]
Mon Jul  8 18:58:47 2013 1508 [CDialog::createBasicRequest]
Mon Jul  8 18:58:47 2013 210f [CTransaction::changeState] STATE CHANGED TO INITIAL
Mon Jul  8 18:58:47 2013 210f [CTransaction::changeState] notifying the parent dialog
Mon Jul  8 18:58:47 2013 1508 [CDialog::onTransactionState(pTrans = 210f, previousState = Terminated, currentState = Initial, reason
= None]
Mon Jul  8 18:58:47 2013 10 [CRequest::CRequest] Creation of a request
Mon Jul  8 18:58:47 2013 10 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Mon Jul  8 18:58:47 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 730)
----------------------utf8-----------------------
REGISTER sip:10.180.140.2 SIP/2.0
Supported: 100rel,path
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
To: sip:550389@10.180.140.2
From: sip:550389@10.180.140.2;tag=f0155f89b95bf47da897b8918d6eaf95
Contact: <sip:550389@10.110.32.90;transport=UDP>;expires=600
Call-ID: 1a0692390be7787c61a3703c6b623889@10.110.32.90
CSeq: 953736920 REGISTER
Max-Forwards: 70
Authorization: Digest username="550389",realm="10.67.144.34",nonce="51dab7e8cb268f1305113bd62e5d9fb5190015e6",opaque="115cff3b9285f8
825fc3cd4407cc92bb",qop=auth,cnonce="1373288327",nc=00000001,uri="sip:10.180.140.2",response="f8f5ae50e65d34f97824296e1318e6c5"
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK8f05bf7ea2045cd93c5e35fde0ea3dd6
Content-Length: 0

-------------------------------------------------
1373288327 -> Mon Jul  8 18:58:47 2013 10 [CMessage::onSendSuccess]
Mon Jul  8 18:58:47 2013 210f [CTransaction::onSendSuccess] CMessage 10 send Success
Mon Jul  8 18:58:47 2013 1508 [CDialog::onSendSuccess]
Mon Jul  8 18:58:47 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Mon Jul  8 18:58:47 2013 [isIpAddressType] 10.180.140.2.
Mon Jul  8 18:58:47 2013 [isIpAddressType] YES.
Mon Jul  8 18:58:47 2013 210f [CTransInitialState::createRequest] Transaction changes to Trying state
Mon Jul  8 18:58:47 2013 210f [CTransaction::changeState] STATE CHANGED TO TRYING
Mon Jul  8 18:58:47 2013 210f [CTransaction::changeState] notifying the parent dialog
Mon Jul  8 18:58:47 2013 1508 [CDialog::onTransactionState(pTrans = 210f, previousState = Initial, currentState = Trying, reason = R
equest creation]
Mon Jul  8 18:58:47 2013 210f [CTransTryingState::enterInState] Init timers E and F
Mon Jul  8 18:58:47 2013 210f [CTransaction::startTimer] Timer E is started (delay = 500 ms)
Mon Jul  8 18:58:47 2013 210f [CTransaction::startTimer] Timer F is started (delay = 16000 ms)
Mon Jul  8 18:58:47 2013 1508 [CDialog::addTransaction] added transaction 210f with branch z9hG4bK8f05bf7ea2045cd93c5e35fde0ea3dd6,
with CSeq 953736920
Mon Jul  8 18:58:47 2013 1113[CMotorCall::emitAuthorizedRequest] ForkedBranch updated.
Mon Jul  8 18:58:47 2013 [CForkedBranch::CForkedBranch] context = 0x84e89dc.
Mon Jul  8 18:58:47 2013 1113[CMotorCall::branchAllocation] pForkedBranch = 0x84e82f0 and the branch number is.
Mon Jul  8 18:58:47 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:550389@10.180.140.2>;tag=SDshab899-70g6xovjte
From: sip:550389@10.180.140.2;tag=f0155f89b95bf47da897b8918d6eaf95
Call-ID: 1a0692390be7787c61a3703c6b623889@10.110.32.90
CSeq: 953736920 REGISTER
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK8f05bf7ea2045cd93c5e35fde0ea3dd6
Contact: <sip:550389@10.110.32.90:5060;transport=UDP>;expires=600
Content-Length: 0

-------------------------------------------------

1373288327 -> Mon Jul  8 18:58:47 2013 [CIOCom::receiveResponse] CResponse 10 ref=1
Mon Jul  8 18:58:47 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Mon Jul  8 18:58:47 2013  104 [CCallManager::onIncomingResponse]
Mon Jul  8 18:58:47 2013 1115 [CCall::receiveResponse] 200
Mon Jul  8 18:58:47 2013 1115 [CCall::getDialog] Confirmed Dialog is not found (ID = f0155f89b95bf47da897b8918d6eaf95;SDshab899-70g6
xovjte)
Mon Jul  8 18:58:47 2013 1115 [CCall::getDialog] Initial Dialog Client not found
Mon Jul  8 18:58:47 2013 1115 [CRegistrarCall::onReceiveOutOfContextResponse] 200
Mon Jul  8 18:58:47 2013 1115 [CCall::onDialogClosed]
Mon Jul  8 18:58:47 2013 1115 [CCall::onDialogClosed] only initial *********
Mon Jul  8 18:58:47 2013 1115 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Mon Jul  8 18:58:47 2013 1115 [CCall] closed
Mon Jul  8 18:58:47 2013  104 [CCallManager::onCallClosed]
Mon Jul  8 18:58:47 2013  104 [CCallManager::onCallClosed()] Call 1115 closed. Removing call 139351480 from the maps
Mon Jul  8 18:58:47 2013  101 [CCallManager::onIncomingResponse]
Mon Jul  8 18:58:47 2013 1113 [CCall::receiveResponse] 200
Mon Jul  8 18:58:47 2013 1113 [CCall::getDialog] Confirmed Dialog is not found (ID = f0155f89b95bf47da897b8918d6eaf95;SDshab899-70g6
xovjte)
Mon Jul  8 18:58:47 2013 1113 [CCall::getDialog] Returning Initial Dialog Client
Mon Jul  8 18:58:47 2013 1508 [CDialog::receiveResponse]
Mon Jul  8 18:58:47 2013 210f [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
1373288327 -> Mon Jul  8 18:58:47 2013 210f [CTransaction::changeState] STATE CHANGED TO COMPLETED
Mon Jul  8 18:58:47 2013 210f [CTransaction::changeState] notifying the parent dialog
Mon Jul  8 18:58:47 2013 1508 [CDialog::onTransactionState(pTrans = 210f, previousState = Trying, currentState = Completed, reason =
Final resp reception]
Mon Jul  8 18:58:47 2013 210f [CTransaction::freeTimerToken] Timer E is freed
Mon Jul  8 18:58:47 2013 210f [CTransaction::freeTimerToken] Timer F is freed
Mon Jul  8 18:58:47 2013 210f [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
Mon Jul  8 18:58:47 2013 1113[CMotorCall::onReceiveResponse] Update2 the Other context.
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] Call: 1a0692390be7787c61a3703c6b623889@10.110.32.90 eqt: -1 REGISTER_STATE recei
ved a message.
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] gw 10.
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] getExpires =0.
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] Servcie Count 0
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] Clearing index for already allocated gateway
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] contact getExpires =600.
Mon Jul  8 18:58:47 2013 [buidRegisterContact] Contact: sip:550389@10.110.32.90
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] nego =600.
Mon Jul  8 18:58:47 2013 [CMotorRegisterTimerContext::start] delay =480000.
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] Call: 1a0692390be7787c61a3703c6b623889@10.110.32.90 eqt: -1 REGISTER_STATE timer
=480000.
1373288331 -> Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] Gw=10 Supervision timer = 600
Mon Jul  8 18:58:47 2013 [receiveSuccessfulMessage] Supervision timer managed
Mon Jul  8 18:58:47 2013 [sip_motor_put_gateway_in_service] trunk 102 gw 10.
Mon Jul  8 18:58:47 2013 [sip_motor_start gateway] gwNb:10 sip_extgw[gwNb]:1401303316 sip_extgw[gwNb]->trunk_state:1
Mon Jul  8 18:58:47 2013 [sip_motor_put_gateway_in_service] external gateway 10 in service.
Mon Jul  8 18:58:50 2013  104 [CCallManager::removeGarbage] at index i = 1
Mon Jul  8 18:58:50 2013 1115 [CCall::~CCall]
Mon Jul  8 18:58:50 2013 1115 [CCall::removeGarbage]
Mon Jul  8 18:58:50 2013  104 [CCallManager::removeGarbage] at index i = 0
Mon Jul  8 18:58:50 2013 1114 [CCall::~CCall]
Mon Jul  8 18:58:50 2013 1114 [CCall::removeGarbage]

1373288333 -> Mon Jul  8 18:58:52 2013 210e [CTransCompletedState::timerFires] Timer K fires
Mon Jul  8 18:58:52 2013 210e [CTransCompletedState::timerFires] Timer K : Transaction changes to Terminated state
Mon Jul  8 18:58:52 2013 210e [CTransaction::changeState] STATE CHANGED TO TERMINATED
Mon Jul  8 18:58:52 2013 210e [CTransaction::changeState] no transaction state, terminated reason : Timer K fires
Mon Jul  8 18:58:52 2013 210f [CTransCompletedState::timerFires] Timer K fires
Mon Jul  8 18:58:52 2013 210f [CTransCompletedState::timerFires] Timer K : Transaction changes to Terminated state
Mon Jul  8 18:58:52 2013 210f [CTransaction::changeState] STATE CHANGED TO TERMINATED
Mon Jul  8 18:58:52 2013 210f [CTransaction::changeState] no transaction state, terminated reason : Timer K fires
Mon Jul  8 18:58:53 2013 [CTransaction::notifyDialog]
Mon Jul  8 18:58:53 2013 [CTransaction::notifyDialog] notify parent dialog
Mon Jul  8 18:58:53 2013 1508 [CDialog::onTransactionState(pTrans = 210e, previousState = null, currentState = Terminated, reason =
Timer K fires]
Mon Jul  8 18:58:53 2013 210E [~CTransaction] transaction 953736919 REGISTER
Mon Jul  8 18:58:53 2013 F [~CResponse] resp(401) 1a0692390be7787c61a3703c6b623889@10.110.32.90 953736919 REGISTER
Mon Jul  8 18:58:53 2013 F [~CRequest] req 1a0692390be7787c61a3703c6b623889@10.110.32.90 953736919 REGISTER
Mon Jul  8 18:58:53 2013 [CTransaction::notifyDialog]
Mon Jul  8 18:58:53 2013 [CTransaction::notifyDialog] notify parent dialog
Mon Jul  8 18:58:53 2013 1508 [CDialog::onTransactionState(pTrans = 210f, previousState = null, currentState = Terminated, reason =
Timer K fires]
1373288333 -> Mon Jul  8 18:58:53 2013 1508 [CDialog::onTransactionState] dialog is terminated
Mon Jul  8 18:58:53 2013 1508 [CDialog::onTransactionState] onDialogClosed
Mon Jul  8 18:58:53 2013 1113 [CCall::onDialogClosed]
Mon Jul  8 18:58:53 2013 1113 [CCall::onDialogClosed] only initial *********
Mon Jul  8 18:58:53 2013 1113 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Mon Jul  8 18:58:53 2013 1113 [CCall] closed
Mon Jul  8 18:58:53 2013  101 [CCallManager::onCallClosed]
Mon Jul  8 18:58:53 2013  101 [CCallManager::onCallClosed()] Call 1113 closed. Removing call 139395864 from the maps
Mon Jul  8 18:58:53 2013 [CMotorCallManager::onNotifyCallClosed] Call : 1a0692390be7787c61a3703c6b623889@10.110.32.90 is closed.
Mon Jul  8 18:58:53 2013 [CMotorCallManager::onNotifyCallClosed] Call : 1a0692390be7787c61a3703c6b623889@10.110.32.90 is closed.
Mon Jul  8 18:58:53 2013 [CMotorCallManager::onNotifyCallClosed] call processResponse.
Mon Jul  8 18:58:53 2013 1113[CMotorCall::chooseBestResponse] pForkedBranch=0x84e82f0 iResponseCode=2000.
Mon Jul  8 18:58:53 2013 1113[CMotorCall::chooseBestResponse] next branch.
Mon Jul  8 18:58:53 2013 1113[CMotorCall::processResponse] no response found.
Mon Jul  8 18:58:53 2013 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Mon Jul  8 18:58:53 2013 210F [~CTransaction] transaction 953736920 REGISTER
Mon Jul  8 18:58:53 2013 10 [~CResponse] resp(200) 1a0692390be7787c61a3703c6b623889@10.110.32.90 953736920 REGISTER
Mon Jul  8 18:58:53 2013  101 [CCallManager::removeGarbage] at index i = 0
1373288337 -> Mon Jul  8 18:58:53 2013 1113 [CMotorCall::clear_subscription] no subscription managed
Mon Jul  8 18:58:53 2013 1113[CMotorCall::~CMotorCall] Call : 1a0692390be7787c61a3703c6b623889@10.110.32.90 is being destructed.
Mon Jul  8 18:58:53 2013 1113 [CCall::~CCall]
Mon Jul  8 18:58:53 2013 1113 [CCall::removeGarbage]
Mon Jul  8 18:58:53 2013 1508 [CDialog::~CDialog]
Mon Jul  8 18:58:53 2013 10 [~CRequest] req 1a0692390be7787c61a3703c6b623889@10.110.32.90 953736920 REGISTER

Ка знать, может быть, и нет. Ведь то, что я приве, это трасса со станции. Это Я вижу то, что отправляется к прову. Доходит это до того места, где ловит он - большой вопрос.

А убежать от прова нет возможности - это наша же контора, только иногородний филиал.  
Мы обречены бороться вечно...

А вот и нет   . Я ж потом написал, что звук в обе стороны пошел.

А с исходящей пока бьюсь. Регистрация транка имееся, а вот даже инвайта при звонке провайдер не видит. Я впадаю в отчаяние.

Рано обрадовался. Входящая связь односторонняя. При звонке на IP телефон голоса от станции не слышно. Если звонить на аналог, слышимость в обе стороны. Адреса на IPфоны раздаются станцией же по DHCP, адрес GW пробовали и как адрес CS и как адрес циски c NAT.

Стоп. Назад. С входящей все ОК. Забыл применить параметр DHCP.  

А исходящий звонок не проходит. Вот трасса.

** UNIX-trace-daemon started ... (static user group No 1) **

traced started ...
1372927773 ->  main.trace.timer = 480mn
1372927777 -> Thu Jul  4 14:49:37 2013 [ipc_thread] IPC Thread : Ipc reception 27712.
Thu Jul  4 14:49:37 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Thu Jul  4 14:49:37 2013 [exec_ipc] in 27711.
Thu Jul  4 14:49:37 2013 [display_ipc_in] ------------ Begin ---------------
Thu Jul  4 14:49:37 2013 neqt : 1152 Id : -1
Thu Jul  4 14:49:37 2013 INVITE
Thu Jul  4 14:49:37 2013 REQUEST URI : <> 482284@10.180.140.2:5060 ; user=phone
Thu Jul  4 14:49:37 2013 FROM : <Stanislav Akulic> 550380@10.110.32.90:5060 ; user=phone
Thu Jul  4 14:49:37 2013 TO : <> 482284@10.180.140.2:5060 ; user=phone
Thu Jul  4 14:49:37 2013 CAC : 0
Thu Jul  4 14:49:37 2013 neqt CAC : -1
Thu Jul  4 14:49:37 2013 CAC-CSBU info : UNKNOWN
Thu Jul  4 14:49:37 2013 CLIR : 0
Thu Jul  4 14:49:37 2013 SDP :
Thu Jul  4 14:49:37 2013   ADDRESS : 10.110.32.11010.110.32.110 :32514
Thu Jul  4 14:49:37 2013   ALGOS :
Thu Jul  4 14:49:37 2013     PCMA
Thu Jul  4 14:49:37 2013     G723
Thu Jul  4 14:49:37 2013     97
Thu Jul  4 14:49:37 2013   DIRECTION : SEND & RECEIVE
Thu Jul  4 14:49:37 2013   crypto index : 0
Thu Jul  4 14:49:37 2013        N_GW_EXT : 1
Thu Jul  4 14:49:37 2013 [display_ipc_in] ------------- End ----------------
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] an event 10752 arrived on the eqt 1152 -1.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] New Call created.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::callFactory].
Thu Jul  4 14:49:37 2013 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R10.1.1 j2.603.20.i
1372927777 -> Thu Jul  4 14:49:37 2013 [CMotorCallManager::callFactory]=84e3d78.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::insertCallwithEqt] CMotorCall 1152 inserted.
Thu Jul  4 14:49:37 2013 inviteBuildFromAssertedId-->extGw=-1
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildAurlWithBelongingDomain] extGw=1
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 [quoteString] => "550380"
Thu Jul  4 14:49:37 2013 [isAddrInDico] user=482284 host=10.180.140.2
Thu Jul  4 14:49:37 2013 [isUserInDico] 482284@10.180.140.2
Thu Jul  4 14:49:37 2013 isUserInDico] NOT found in the dictionnary.
Thu Jul  4 14:49:37 2013 [isAddrInDico] other sip user
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildAurlWithoutBelongingDomain] P-Asserted-Identity: "550380" <sip:550380@10.110.32
.90>
Thu Jul  4 14:49:37 2013 [quoteString] => "Stanislav Akulic"
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::setFilterUsedMode] To be traced = 0
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] state = INITIAL_STATE.
Thu Jul  4 14:49:37 2013 [onIncomingEvent] INVITE arrived.
Thu Jul  4 14:49:37 2013 [receiveInviteEvent] Call: eqt: 1152 INITIAL_STATE received an event.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitInviteMessage] begin. size=656 call_type: 0
Thu Jul  4 14:49:37 2013 [isAddrInDico] user=482284 host=10.180.140.2
Thu Jul  4 14:49:37 2013 [isUserInDico] 482284@10.180.140.2
1372927777 -> Thu Jul  4 14:49:37 2013 isUserInDico] NOT found in the dictionnary.
Thu Jul  4 14:49:37 2013 [isAddrInDico] other sip user
Thu Jul  4 14:49:37 2013 inviteBuildFromAssertedId-->extGw=1
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildAurlWithBelongingDomain] extGw=1
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 [quoteString] => "550380"
Thu Jul  4 14:49:37 2013 [isAddrInDico] user=482284 host=10.180.140.2
Thu Jul  4 14:49:37 2013 [isUserInDico] 482284@10.180.140.2
Thu Jul  4 14:49:37 2013 isUserInDico] NOT found in the dictionnary.
Thu Jul  4 14:49:37 2013 [isAddrInDico] other sip user
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildAurlWithoutBelongingDomain] P-Asserted-Identity: "550380" <sip:550380@10.110.32
.90>
Thu Jul  4 14:49:37 2013 [quoteString] => "Stanislav Akulic"
Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitInviteMessage] From: "Stanislav Akulic" <sip:550380@10.110.32.90;user=phone>
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitInviteMessage] reqUri :sip:482284@10.180.140.2;user=phone
Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitInviteMessage]-->SIP_INFO_allowed=0
Thu Jul  4 14:49:37 2013 113c[CMotorCall ISDN ExtGW
Thu Jul  4 14:49:37 2013 113c[CMotorCall ISDN ExtGW
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildSupportedHeader] Invite directed to external gw : 1
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
1372927777 -> Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitInviteMessage] To: <sip:482284@10.180.140.2;user=phone>
Thu Jul  4 14:49:37 2013  am_I_PCS SCSWorking : NO
Thu Jul  4 14:49:37 2013  check_PCSstate
Thu Jul  4 14:49:37 2013  am_I_PCS SCSWorking : NO
Thu Jul  4 14:49:37 2013  check_PCSstate stat of PCS  is : -1
Thu Jul  4 14:49:37 2013 [inviteBuildContact] trunk_number=102 extGw =1.
Thu Jul  4 14:49:37 2013 [137339-InviteBuildContact] userinfo : 550380
Thu Jul  4 14:49:37 2013 113c[CMotorCall::sipUriType] sip Uri.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::isTLSProtRequiredForExtGw] =0.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildContact] Contact: sip:550380@10.110.32.90
Thu Jul  4 14:49:37 2013 113c[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT manged with TLS and refresh REINVITE
Thu Jul  4 14:49:37 2013 113c[CMotorCall::inviteBuildSessionTimer] uacGatewayMode=1 uacRefresher=1.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeRequestSdp] Begin sdp.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::appendAudioAttributToMedia] Direction: 0.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::appendAudioAttributToMedia] format 97
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeRequestSdp] crypto index3=0 clearMediaLine=0.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeRequestSdp] appendMediaDescription ok.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeRequestSdp] Final sdp.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitInviteMessage] The sdp build.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::new_determineTargetsForTheRequest] is not Responsible For This URI.
1372927777 -> Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] target is not the local node.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] nb contacts=1.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] *pcszNameToFind : 482284
Thu Jul  4 14:49:37 2013 [isUserInDico] 482284@10.180.140.2
Thu Jul  4 14:49:37 2013 isUserInDico] NOT found in the dictionnary.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] contact : sip:482284@10.180.140.2;user=phone
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] nb available licenses=10 .
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0 and pSipAddSpec->getHost()=10.180.140.2
Thu Jul  4 14:49:37 2013 [CGWMngDat a::isMainServer] CPU is MAIN.
Thu Jul  4 14:49:37 2013 [CGWMngDat a::isMainServer] checkwith PCS = 0
Thu Jul  4 14:49:37 2013 113c[CMotorCall::isTLSProtRequiredForExtGw] =0.
Thu Jul  4 14:49:37 2013 113c [CCall::makeGenericRequest] INVITE
Thu Jul  4 14:49:37 2013 113c [CCall::getDialog] Confirmed Dialog is not found (ID =
Thu Jul  4 14:49:37 2013 113c [CCall::getDialog] Initial Dialog Client not found
Thu Jul  4 14:49:37 2013 152e [CDialog::createRequest]
Thu Jul  4 14:49:37 2013 152e [CDialog::buildServicesForAllRequest]
Thu Jul  4 14:49:37 2013 152e [CDialog::createInviteRequest]
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] STATE CHANGED TO INITIAL
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] notifying the parent dialog
1372927777 -> Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState(pTrans = 2144, previousState = Terminated, currentState = I
nitial, reason = None]
Thu Jul  4 14:49:37 2013 52 [CRequest::CRequest] Creation of a request
Thu Jul  4 14:49:37 2013 52 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Thu Jul  4 14:49:37 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 1003)
----------------------utf8-----------------------
INVITE sip:482284@10.180.140.2;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, SUBSCRIBE, OPTIONS, UPDATE
Supported: timer,path,100rel
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
Session-Expires: 1800;refresher=uac
Min-SE: 900
P-Asserted-Identity: "550380" <sip:550380@10.110.32.90>
Content-Type: application/sdp
To: <sip:482284@10.180.140.2;user=phone>
From: "Stanislav Akulic" <sip:550380@10.110.32.90;user=phone>;tag=13dd6160616eea9891f322297be7e3d7
Contact: <sip:550380@10.110.32.90;transport=UDP>
Call-ID: 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90
CSeq: 24197852 INVITE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bKff1b6c454a4be45ff5997f2d8ba43afb
Max-Forwards: 70
Content-Length: 266

v=0
o=OXE 1372927777 1372927777 IN IP4 10.110.32.90
s=abs
c=IN IP4 10.110.32.110
t=0 0
m=audio 32514 RTP/AVP 8 4 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:4 G723/8000
a=ptime:30
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
Thu Jul  4 14:49:37 2013 52 [CMessage::onSendSuccess]
1372927777 -> Thu Jul  4 14:49:37 2013 2144 [CTransaction::onSendSuccess] CMessage 52 send Success
Thu Jul  4 14:49:37 2013 152e [CDialog::onSendSuccess]
Thu Jul  4 14:49:37 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Thu Jul  4 14:49:37 2013 [isIpAddressType] 10.180.140.2.
Thu Jul  4 14:49:37 2013 [isIpAddressType] YES.
Thu Jul  4 14:49:37 2013 2144 [CTransInitialState::createRequest] Transaction changes to Calling state
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] STATE CHANGED TO CALLING
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] notifying the parent dialog
Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState(pTrans = 2144, previousState = Initial, currentState = Calling, reason =
Request creation]
Thu Jul  4 14:49:37 2013 2144 [CTransaction::startTimer] Timer A is started (delay = 500 ms)
Thu Jul  4 14:49:37 2013 2144 [CTransaction::startTimer] Timer B is started (delay = 4000 ms)
Thu Jul  4 14:49:37 2013 152e [CDialog::getTransactionByCSeq] CSeq = 24197852
Thu Jul  4 14:49:37 2013 152e [CDialog::addTransaction] added transaction 2144 with branch z9hG4bKff1b6c454a4be45ff5997f2d8ba43afb,
with CSeq 24197852
Thu Jul  4 14:49:37 2013 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Client, UA)
Thu Jul  4 14:49:37 2013 [CSessionTimerContext::updateSupported] Request timer supported
Thu Jul  4 14:49:37 2013 [CSessionTimerContext::updateMinSE] Min-SE updated : 900
Thu Jul  4 14:49:37 2013 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1372927777 -> Thu Jul  4 14:49:37 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Thu Jul  4 14:49:37 2013 [CForkedBranch::CForkedBranch] context = 0x84e4224.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::branchAllocation] pForkedBranch = 0x84e5de0 and the branch number is.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::makeInitialMotorRequest] reqUri duplication pForkedBranch = 0x84e5de0.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Thu Jul  4 14:49:37 2013 NOE-SIP : StandByCallCreation not sent to twin CS
Thu Jul  4 14:49:37 2013 [onIncomingEvent] CallID must be inserted.
Thu Jul  4 14:49:37 2013 [onIncomingEvent] CallID inserted.
Thu Jul  4 14:49:37 2013 [exec_ipc] in end 27711.
Thu Jul  4 14:49:37 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:482284@10.180.140.2;user=phone>
From: "Stanislav Akulic" <sip:550380@10.110.32.90;user=phone>;tag=13dd6160616eea9891f322297be7e3d7
Call-ID: 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90
CSeq: 24197852 INVITE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bKff1b6c454a4be45ff5997f2d8ba43afb

-------------------------------------------------

Thu Jul  4 14:49:37 2013 [CIOCom::receiveResponse] CResponse 5A ref=1
Thu Jul  4 14:49:37 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Thu Jul  4 14:49:37 2013  102 [CCallManager::onIncomingResponse]
Thu Jul  4 14:49:37 2013 113c [CCall::receiveResponse] 100
1372927777 -> Thu Jul  4 14:49:37 2013 113c [CCall::getDialog] Confirmed Dialog is not found (ID = 13dd6160616eea9891f322297be7e3d7;
)
Thu Jul  4 14:49:37 2013 113c [CCall::getDialog] Returning Initial Dialog Client
Thu Jul  4 14:49:37 2013 152e [CDialog::receiveResponse]
Thu Jul  4 14:49:37 2013 2144 [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] notifying the parent dialog
Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState(pTrans = 2144, previousState = Calling, currentState = Proceeding, reason
= 1xx response reception]
Thu Jul  4 14:49:37 2013 2144 [CTransaction::freeTimerToken] Timer A is freed
Thu Jul  4 14:49:37 2013 2144 [CTransaction::freeTimerToken] Timer B is freed
Thu Jul  4 14:49:37 2013 113c[CMotorCall::searchForkedBranch]pForkedBranch=0x84e5de0.
Thu Jul  4 14:49:37 2013 [receiveInformationalMessage] Call: 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Thu Jul  4 14:49:37 2013 [receiveInformationalMessage] is in the else part of SDP not present
Thu Jul  4 14:49:37 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bKff1b6c454a4be45ff5997f2d8ba43afb
To: <sip:482284@10.180.140.2;user=phone>;tag=aprqngfrt-5snkko70hjeod
From: "Stanislav Akulic" <sip:550380@10.110.32.90;user=phone>;tag=13dd6160616eea9891f322297be7e3d7
Call-ID: 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90
CSeq: 24197852 INVITE

-------------------------------------------------

1372927777 -> Thu Jul  4 14:49:37 2013 [CIOCom::receiveResponse] CResponse 5B ref=1
Thu Jul  4 14:49:37 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Thu Jul  4 14:49:37 2013  102 [CCallManager::onIncomingResponse]
Thu Jul  4 14:49:37 2013 113c [CCall::receiveResponse] 403
Thu Jul  4 14:49:37 2013 113c [CCall::getDialog] Confirmed Dialog is not found (ID = 13dd6160616eea9891f322297be7e3d7;aprqngfrt-5snk
ko70hjeod)
Thu Jul  4 14:49:37 2013 113c [CCall::getDialog] Returning Initial Dialog Client
Thu Jul  4 14:49:37 2013 152e [CDialog::receiveResponse]
Thu Jul  4 14:49:37 2013 5A [~CResponse] resp(100) 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 24197852 INVITE
Thu Jul  4 14:49:37 2013 2144 [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] notifying the parent dialog
Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState(pTrans = 2144, previousState = Proceeding, currentState = Completed, reas
on = Final resp reception]
Thu Jul  4 14:49:37 2013 53 [CRequest::CRequest] Creation of a request
Thu Jul  4 14:49:37 2013 53 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Thu Jul  4 14:49:37 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 393)
----------------------utf8-----------------------
ACK sip:482284@10.180.140.2;user=phone SIP/2.0
Call-ID: 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90
From: "Stanislav Akulic" <sip:550380@10.110.32.90;user=phone>;tag=13dd6160616eea9891f322297be7e3d7
To: <sip:482284@10.180.140.2;user=phone>;tag=aprqngfrt-5snkko70hjeod
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bKff1b6c454a4be45ff5997f2d8ba43afb
CSeq: 24197852 ACK
Content-Length: 0

-------------------------------------------------
1372927777 -> Thu Jul  4 14:49:37 2013 53 [CMessage::onSendSuccess]
Thu Jul  4 14:49:37 2013 2144 [CTransaction::onSendSuccess] CMessage 53 send Success
Thu Jul  4 14:49:37 2013 152e [CDialog::onSendSuccess]
Thu Jul  4 14:49:37 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Thu Jul  4 14:49:37 2013 [isIpAddressType] 10.180.140.2.
Thu Jul  4 14:49:37 2013 [isIpAddressType] YES.
Thu Jul  4 14:49:37 2013 2144 [CTransaction::startTimer] Timer D is started (delay = 32332 ms)
Thu Jul  4 14:49:37 2013 113c[CMotorCall::searchForkedBranch]pForkedBranch=0x84e5de0.
Thu Jul  4 14:49:37 2013         [CForkedBranch::setFinalResponse] response=403.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::responseToInviteOrCancel] no response to the CH m_cancelSent=0.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::responseToInviteOrCancel] all responses are received 1.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::chooseBestResponse] pForkedBranch=0x84e5de0 iResponseCode=2000.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::chooseBestResponse] last iResponseCode=403.
Thu Jul  4 14:49:37 2013         [CForkedBranch::setFinalResponse] pResponse=0x84f0e40.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::chooseBestResponse] next branch.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
Thu Jul  4 14:49:37 2013 [receiveRequestFailureMessage] Call: 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 eqt: 1152 PROCEEDING_STA
TE received a message.
1372927777 -> Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] CAC = 0 eqtCAC = -1
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] cacUsed=0 eqtCac=-1
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] displayIPCMessageOut
Thu Jul  4 14:49:37 2013 ** SIP OTHER ICE **
Thu Jul  4 14:49:37 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Thu Jul  4 14:49:37 2013 [ipc_thread] IPC Thread : Ipc reception 27712.
Thu Jul  4 14:49:37 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Thu Jul  4 14:49:37 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Thu Jul  4 14:49:37 2013 [display_ipc_out] ------------ Begin ---------------
Thu Jul  4 14:49:37 2013 Id : -1
Thu Jul  4 14:49:37 2013 REQUEST FAILURE
Thu Jul  4 14:49:37 2013 xx :        3
Thu Jul  4 14:49:37 2013        RELATIVE REQUEST : INVITE
Thu Jul  4 14:49:37 2013 [display_ipc_out] ------------- End ----------------
Thu Jul  4 14:49:37 2013 113c[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Thu Jul  4 14:49:37 2013 113c[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
Thu Jul  4 14:49:37 2013 [exec_ipc] in 27711.
Thu Jul  4 14:49:37 2013 [display_ipc_in] ------------ Begin ---------------
Thu Jul  4 14:49:37 2013 neqt : 1152 Id : -1
Thu Jul  4 14:49:37 2013 SIP EQT RELEASED
Thu Jul  4 14:49:37 2013 [display_ipc_in] ------------- End ----------------
1372927777 -> Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 1152 -1.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] The call with eqt: 1152 has released its equipment.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel]1 T38 REINVITE TRUE
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] CAC = 0 eqtCAC = -1
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] cacUsed=0 eqtCac=-1
Thu Jul  4 14:49:37 2013 113c[emitEventToMonitel] displayIPCMessageOut
Thu Jul  4 14:49:37 2013 ** SIP OTHER ICE **
Thu Jul  4 14:49:37 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Thu Jul  4 14:49:37 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Thu Jul  4 14:49:37 2013 [display_ipc_out] ------------ Begin ---------------
Thu Jul  4 14:49:37 2013 Id : -1
Thu Jul  4 14:49:37 2013 SIP_EQT_RELEASE_ACK
Thu Jul  4 14:49:37 2013 [display_ipc_out] ------------- End ----------------
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
Thu Jul  4 14:49:37 2013 113c[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Thu Jul  4 14:49:37 2013 113c[CMotorCall::unRegister] Remove eqt : 1152 diag : -1 from the map.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::eraseCallwithEqt] erase 1152 -1.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onIncomingEvent] killSession.
1372927777 -> Thu Jul  4 14:49:37 2013 113c [CCall::killSession]
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Thu Jul  4 14:49:37 2013 2144 [CTransaction::freeTimerToken] Timer D is freed
Thu Jul  4 14:49:37 2013 2144 [CTransaction::changeState] no transaction state, terminated reason : None
Thu Jul  4 14:49:37 2013 113c [CCall::killSession] notifying the call manager
Thu Jul  4 14:49:37 2013  102 [CCallManager::onCallClosed]
Thu Jul  4 14:49:37 2013  102 [CCallManager::onCallClosed()] Call 113c closed. Removing call 139345272 from the maps
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onNotifyCallClosed] Call : 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 is closed.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onNotifyCallClosed] Call : 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 is closed.
Thu Jul  4 14:49:37 2013 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Thu Jul  4 14:49:37 2013 [exec_ipc] in end 27711.
Thu Jul  4 14:49:37 2013 [CTransaction::notifyDialog]
Thu Jul  4 14:49:37 2013 [CTransaction::notifyDialog] notify parent dialog
Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState(pTrans = 2144, previousState = null, currentState = Terminated, reason =
None]
Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState] dialog is terminated
Thu Jul  4 14:49:37 2013 152e [CDialog::onTransactionState] onDialogClosed
Thu Jul  4 14:49:37 2013 113c [CCall::onDialogClosed]
Thu Jul  4 14:49:37 2013 113c [CCall::onDialogClosed] only initial *********
1372927781 -> Thu Jul  4 14:49:37 2013 113c [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Thu Jul  4 14:49:37 2013 2144 [~CTransaction] transaction 24197852 INVITE
Thu Jul  4 14:49:37 2013 53 [~CRequest] req 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 24197852 ACK
Thu Jul  4 14:49:38 2013  102 [CCallManager::removeGarbage] at index i = 0
Thu Jul  4 14:49:38 2013 113c [CMotorCall::clear_subscription] no subscription managed
Thu Jul  4 14:49:38 2013 113c[CMotorCall::~CMotorCall] Call : 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 is being destructed.
Thu Jul  4 14:49:38 2013 113c[CMotorCall::~CMotorCall] License is released for this call.
Thu Jul  4 14:49:38 2013 113c[CMotorCall::~CMotorCall] number of available licenses are =10 .
Thu Jul  4 14:49:38 2013 5B [~CResponse] resp(403) 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 24197852 INVITE
Thu Jul  4 14:49:38 2013 113c [CCall::~CCall]
Thu Jul  4 14:49:38 2013 113c [CCall::removeGarbage]
Thu Jul  4 14:49:38 2013 152e [CDialog::~CDialog]
Thu Jul  4 14:49:38 2013 [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
Thu Jul  4 14:49:38 2013 52 [~CRequest] req 6321a3c0b7c66d89291c566a4ed0115a@10.110.32.90 24197852 INVITE

При попытке выставить в true ругается, что для SIP транк групп это запрещено.

Но лед тронулся. После того, как я в поле Outgoing Realm прописал подсмотренный в трассе неудачной регистрации адрес 10.67.х.х, у меня Ext SIP GW встал в сервис и пошли входящие звонки (голос в обе стороны). Провайдер сказал, что это адрес одной из его железок, и знать его я вообще не должен. Чудеса да и только...

С исходящими пока бьюсь.

Пробовал так же. Все варианты уже перепробовал. Не регистрируется. Пока читаю доку и думаю.

Кстати, как насчет моего вопроса про ABCF?

Итак, по порядку
В поле SIP Gateway адрес 10.180.140.2
В поле Outbound Proxy 10.180.140.1 (то, что провайдер назвал SBC)
И в proxy, и в GW метод стоит Digest.
Registration Timer = 1800 (где-то подсмотрел, не помню)
Registration ID = 550380 (один из номеров, под которым пров сказал регистриться).
Далее исходящий логин (550380) и пароль.

To Андрей: в звонилке прописывал адрес внешнего GW (10.180.140.2)

To Error: насчет факсов пока не выяснял, самому страшно.

А идеология такова - провайдер дает мне 10 номеров, каждый со своей регистрацией. Каждый номер 55038Х - это входящий городской. Это один город, 50 абонентов. А в другом городе у клиента есть еще одна ОХЕ, которую он впоследствии хочет вязать ABCFом с этой станцией, используя этот же SIP канал (потока нет). И меня очень интересует вопрос - при существующем методе регистрации (если его удастся наладить), не хлебну ли я проблем с ABCF?

Да, IP телефоны имеются.
И SIP звонилка регистрится сразу, и голос в обе стороны.
А что есть в этом случае SBC?  Мне провайдер сказал, что адрес 140.1 - это и есть SBC.

Логин-пароль, ясно, прописали.
А 10.110.32.90 - это адрес процессора (станция за NAT)

Пинги со станции на 140.1 и 140.2 идут.

Все еще хуже, чем думал.
Оказывается, регистрация не идет.
Провайдер мне выдал следующее:
адрес SIP Gateway 10.180.140.2
адрес SIP шлюза (это SBC ?) 10.180.140.1
адрес для АТС 10.180.140.141.
Вопрос - в параметрах External SIP GW  что куда расставить?
Особенно интересуют поля Belonging Domain и Outgoing Realm.

Проблема у меня довольно частая. Таймер регистрации. Если равен 0, транк группа в сервисе, но после моего 100 Trying получаю 403 Forbidden. Вот трасса.

traced started ...
1372249725 -> Wed Jun 26 18:28:45 2013 [display_ipc_in] ------------ Begin ---------------
Wed Jun 26 18:28:45 2013 neqt : 1157 Id : -1
Wed Jun 26 18:28:45 2013 INVITE
Wed Jun 26 18:28:45 2013 REQUEST URI : <> 89036117511@10.180.140.2:5060 ; user=phone
Wed Jun 26 18:28:45 2013 FROM : < Lan Driv> 4143@10.110.32.90:5060 ; user=phone
Wed Jun 26 18:28:45 2013 TO : <> 89036117511@10.180.140.2:5060 ; user=phone
Wed Jun 26 18:28:45 2013 CAC : 0
Wed Jun 26 18:28:45 2013 neqt CAC : -1
Wed Jun 26 18:28:45 2013 CAC-CSBU info : UNKNOWN
Wed Jun 26 18:28:45 2013 CLIR : 0
Wed Jun 26 18:28:45 2013 SDP :
Wed Jun 26 18:28:45 2013   ADDRESS : 10.110.32.10010.110.32.100 :32514
Wed Jun 26 18:28:45 2013   ALGOS :
Wed Jun 26 18:28:45 2013     G723
Wed Jun 26 18:28:45 2013     PCMA
Wed Jun 26 18:28:45 2013     97
Wed Jun 26 18:28:45 2013   DIRECTION : SEND & RECEIVE
Wed Jun 26 18:28:45 2013   crypto index : 0
Wed Jun 26 18:28:45 2013        N_GW_EXT : 1
Wed Jun 26 18:28:45 2013 [display_ipc_in] ------------- End ----------------
Wed Jun 26 18:28:45 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 1015)
----------------------utf8-----------------------
INVITE sip:89036117511@10.180.140.2;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, SUBSCRIBE, OPTIONS, UPDATE
Supported: timer,path,100rel
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
Session-Expires: 1800;refresher=uac
Min-SE: 900
P-Asserted-Identity: " Lan Driv" <sip:4143@10.110.32.90;user=phone>
Content-Type: application/sdp
To: <sip:89036117511@10.180.140.2;user=phone>
From: " Lan Driv" <sip:4143@10.110.32.90;user=phone>;tag=6444a79b95ac4c990130ddcc10daf11a
Contact: <sip:4143@10.110.32.90;transport=UDP>
Call-ID: afc582f3a1f8158d01d562f11ce0e524@10.110.32.90
CSeq: 942310080 INVITE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK54b85378370aa5a404b67655a5fd5bf4
Max-Forwards: 70
Content-Length: 266

v=0
o=OXE 1372249725 1372249725 IN IP4 10.110.32.90
s=abs
c=IN IP4 10.110.32.100
t=0 0
m=audio 32514 RTP/AVP 4 8 97
a=sendrecv
a=rtpmap:4 G723/8000
a=ptime:30
a=maxptime:30
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
1372249725 -> Wed Jun 26 18:28:45 2013 1109[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Wed Jun 26 18:28:45 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:89036117511@10.180.140.2;user=phone>
From: " Lan Driv" <sip:4143@10.110.32.90;user=phone>;tag=6444a79b95ac4c990130ddcc10daf11a
Call-ID: afc582f3a1f8158d01d562f11ce0e524@10.110.32.90
CSeq: 942310080 INVITE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK54b85378370aa5a404b67655a5fd5bf4

-------------------------------------------------

Wed Jun 26 18:28:45 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK54b85378370aa5a404b67655a5fd5bf4
To: <sip:89036117511@10.180.140.2;user=phone>;tag=aprqngfrt-p97kri37ah01c
From: " Lan Driv" <sip:4143@10.110.32.90;user=phone>;tag=6444a79b95ac4c990130ddcc10daf11a
Call-ID: afc582f3a1f8158d01d562f11ce0e524@10.110.32.90
CSeq: 942310080 INVITE

-------------------------------------------------

Wed Jun 26 18:28:45 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 395)
----------------------utf8-----------------------
ACK sip:89036117511@10.180.140.2;user=phone SIP/2.0
Call-ID: afc582f3a1f8158d01d562f11ce0e524@10.110.32.90
From: " Lan Driv" <sip:4143@10.110.32.90;user=phone>;tag=6444a79b95ac4c990130ddcc10daf11a
To: <sip:89036117511@10.180.140.2;user=phone>;tag=aprqngfrt-p97kri37ah01c
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK54b85378370aa5a404b67655a5fd5bf4
CSeq: 942310080 ACK
Content-Length: 0

-------------------------------------------------
1372249729 -> Wed Jun 26 18:28:45 2013 [display_ipc_out] ------------ Begin ---------------
Wed Jun 26 18:28:45 2013 Id : -1
Wed Jun 26 18:28:45 2013 REQUEST FAILURE
Wed Jun 26 18:28:45 2013 xx :        3
Wed Jun 26 18:28:45 2013        RELATIVE REQUEST : INVITE
Wed Jun 26 18:28:45 2013 [display_ipc_out] ------------- End ----------------
Wed Jun 26 18:28:45 2013 1109[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Wed Jun 26 18:28:45 2013 [display_ipc_in] ------------ Begin ---------------
Wed Jun 26 18:28:45 2013 neqt : 1157 Id : -1
Wed Jun 26 18:28:45 2013 SIP EQT RELEASED
Wed Jun 26 18:28:45 2013 [display_ipc_in] ------------- End ----------------
Wed Jun 26 18:28:45 2013 [display_ipc_out] ------------ Begin ---------------
Wed Jun 26 18:28:45 2013 Id : -1
Wed Jun 26 18:28:45 2013 SIP_EQT_RELEASE_ACK
Wed Jun 26 18:28:45 2013 [display_ipc_out] ------------- End ----------------
Wed Jun 26 18:28:45 2013 1109[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS

Если таймер не равен 0, то тайм-слоты транк группы все hs.