Уважаемые дамы и господа! Для вас сохранен старый форум по адресу http://forum.intersyst.ru

Поиск  Правила  Войти
Форум » Seller_V
Выбрать дату в календаре…Выбрать дату в календаре

Страницы: Пред. 1 ... 14 15 16 17 18 19 20 21 22 23 24 ... 31 След.
SIP trunk group: неправильный АОН
 
#
10.07.2013 22:13:49
Цитата
vad пишет:
Цитата
Seller_V пишет:

Эге, это значит, надо 10 дискриминаторов делать? Однако...

а у вас чего - абонентам звонят с 10-ти разных гейтвеев? Офигеть.
Ну... В общем, да...
Я в начале ветки описывал схему: у прова 10 номеров (каждый = городскому 6-значному номеру, каждый со своей регистрацией). Соответственно, под каждый заточен свой внешний SIP GW. Номера эти (для меня входящие) разруливаются через DDI транслятор.
 
Перейти    
SIP trunk group: неправильный АОН
 
#
10.07.2013 18:22:43
Эге, это значит, надо 10 дискриминаторов делать? Однако...
 
Перейти    
SIP trunk group: неправильный АОН
 
#
10.07.2013 16:25:49
Скажите пожалуйста, а реально ли сделать так, чтобы при исходящем звонке абонент пользовался именно тем GW, с которого на него приходит входящий городской?
 
Перейти    
SIP trunk group: неправильный АОН
 
#
10.07.2013 15:47:23
Пожалуйста, вот трейс успешного исходящего звонка:

1373447514 -> Wed Jul 10 15:11:54 2013 [ipc_thread] IPC Thread : Ipc reception 9282.
Wed Jul 10 15:11:54 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Wed Jul 10 15:11:54 2013 [exec_ipc] in 9281.
Wed Jul 10 15:11:54 2013 [display_ipc_in] ------------ Begin ---------------
Wed Jul 10 15:11:54 2013 neqt : 1152 Id : -1
Wed Jul 10 15:11:54 2013 INVITE
Wed Jul 10 15:11:54 2013 REQUEST URI : <> 89036117511@10.180.140.2:5060 ; user=phone
Wed Jul 10 15:11:54 2013 FROM : <M. Azanova DECT> 550389@10.110.32.90:5060 ; user=phone
Wed Jul 10 15:11:54 2013 TO : <> 89036117511@10.180.140.2:5060 ; user=phone
Wed Jul 10 15:11:54 2013 CAC : 0
Wed Jul 10 15:11:54 2013 neqt CAC : -1
Wed Jul 10 15:11:54 2013 CAC-CSBU info : UNKNOWN
Wed Jul 10 15:11:54 2013 CLIR : 0
Wed Jul 10 15:11:54 2013 SDP :
Wed Jul 10 15:11:54 2013   ADDRESS : 10.110.32.9210.110.32.92 :32600
Wed Jul 10 15:11:54 2013   ALGOS :
Wed Jul 10 15:11:54 2013     PCMA
Wed Jul 10 15:11:54 2013     97
Wed Jul 10 15:11:54 2013   DIRECTION : SEND & RECEIVE
Wed Jul 10 15:11:54 2013   crypto index : 0
Wed Jul 10 15:11:54 2013        N_GW_EXT : 10
Wed Jul 10 15:11:54 2013 [display_ipc_in] ------------- End ----------------
Wed Jul 10 15:11:54 2013 [CMotorCallManager::onIncomingEvent] an event 10752 arrived on the eqt 1152 -1.
Wed Jul 10 15:11:54 2013 [CMotorCallManager::onIncomingEvent] New Call created.
Wed Jul 10 15:11:54 2013 [CMotorCallManager::callFactory].
Wed Jul 10 15:11:54 2013 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R10.1.1 j2.603.20.i
1373447514 -> Wed Jul 10 15:11:54 2013 [CMotorCallManager::callFactory]=84f9778.
Wed Jul 10 15:11:54 2013 [CMotorCallManager::insertCallwithEqt] CMotorCall 1152 inserted.
Wed Jul 10 15:11:54 2013 inviteBuildFromAssertedId-->extGw=-1
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildAurlWithBelongingDomain] Reg_Id_for_user_URL_of_PAI =1
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 [quoteString] => "550389"
Wed Jul 10 15:11:54 2013 [isAddrInDico] user=89036117511 host=10.180.140.2
Wed Jul 10 15:11:54 2013 [isUserInDico] 89036117511@10.180.140.2
Wed Jul 10 15:11:54 2013 isUserInDico] NOT found in the dictionnary.
Wed Jul 10 15:11:54 2013 [isAddrInDico] other sip user
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildAurlWithBelongingDomain] P-Asserted-Identity: "550389" <sip:550389@10.180.140.2
>
Wed Jul 10 15:11:54 2013 [quoteString] => "M. Azanova DECT"
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::setFilterUsedMode] To be traced = 0
Wed Jul 10 15:11:54 2013 [CMotorCallManager::onIncomingEvent] state = INITIAL_STATE.
Wed Jul 10 15:11:54 2013 [onIncomingEvent] INVITE arrived.
Wed Jul 10 15:11:54 2013 [receiveInviteEvent] Call: eqt: 1152 INITIAL_STATE received an event.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitInviteMessage] begin. size=656 call_type: 0
Wed Jul 10 15:11:54 2013 [isAddrInDico] user=89036117511 host=10.180.140.2
1373447514 -> Wed Jul 10 15:11:54 2013 [isUserInDico] 89036117511@10.180.140.2
Wed Jul 10 15:11:54 2013 isUserInDico] NOT found in the dictionnary.
Wed Jul 10 15:11:54 2013 [isAddrInDico] other sip user
Wed Jul 10 15:11:54 2013 inviteBuildFromAssertedId-->extGw=10
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildAurlWithBelongingDomain] Reg_Id_for_user_URL_of_PAI =1
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 [quoteString] => "550389"
Wed Jul 10 15:11:54 2013 [isAddrInDico] user=89036117511 host=10.180.140.2
Wed Jul 10 15:11:54 2013 [isUserInDico] 89036117511@10.180.140.2
Wed Jul 10 15:11:54 2013 isUserInDico] NOT found in the dictionnary.
Wed Jul 10 15:11:54 2013 [isAddrInDico] other sip user
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildAurlWithBelongingDomain] P-Asserted-Identity: "550389" <sip:550389@10.180.140.2
>
Wed Jul 10 15:11:54 2013 [quoteString] => "M. Azanova DECT"
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitInviteMessage] From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitInviteMessage] reqUri :sip:89036117511@10.180.140.2;user=phone
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitInviteMessage]-->SIP_INFO_allowed=0
Wed Jul 10 15:11:54 2013 113a[CMotorCall ISDN ExtGW
Wed Jul 10 15:11:54 2013 113a[CMotorCall ISDN ExtGW
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildSupportedHeader] Invite directed to external gw : 10
1373447514 -> Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitInviteMessage] To: <sip:89036117511@10.180.140.2;user=phone>
Wed Jul 10 15:11:54 2013  am_I_PCS SCSWorking : NO
Wed Jul 10 15:11:54 2013  check_PCSstate
Wed Jul 10 15:11:54 2013  am_I_PCS SCSWorking : NO
Wed Jul 10 15:11:54 2013  check_PCSstate stat of PCS  is : -1
Wed Jul 10 15:11:54 2013 [inviteBuildContact] trunk_number=102 extGw =10.
Wed Jul 10 15:11:54 2013 [137339-InviteBuildContact] userinfo : 550389
Wed Jul 10 15:11:54 2013 113a[CMotorCall::sipUriType] sip Uri.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::isTLSProtRequiredForExtGw] =0.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildContact] Contact: sip:550389@10.110.32.90
Wed Jul 10 15:11:54 2013 113a[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT manged with TLS and refresh REINVITE
Wed Jul 10 15:11:54 2013 113a[CMotorCall::inviteBuildSessionTimer] uacGatewayMode=1 uacRefresher=1.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeRequestSdp] Begin sdp.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::appendAudioAttributToMedia] Direction: 0.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::appendAudioAttributToMedia] format 97
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeRequestSdp] crypto index3=0 clearMediaLine=0.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeRequestSdp] appendMediaDescription ok.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeRequestSdp] Final sdp.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitInviteMessage] The sdp build.
1373447514 -> Wed Jul 10 15:11:54 2013 113a[CMotorCall::new_determineTargetsForTheRequest] is not Responsible For This URI.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] target is not the local node.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] nb contacts=1.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] *pcszNameToFind : 89036117511
Wed Jul 10 15:11:54 2013 [isUserInDico] 89036117511@10.180.140.2
Wed Jul 10 15:11:54 2013 isUserInDico] NOT found in the dictionnary.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] contact : sip:89036117511@10.180.140.2;user=phone
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] nb available licenses=9 .
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0 and pSipAddSpec->getHost()=10.180.140.2
Wed Jul 10 15:11:54 2013 [CGWMngDat a::isMainServer] CPU is MAIN.
Wed Jul 10 15:11:54 2013 [CGWMngDat a::isMainServer] checkwith PCS = 0
Wed Jul 10 15:11:54 2013 113a[CMotorCall::isTLSProtRequiredForExtGw] =0.
Wed Jul 10 15:11:54 2013 113a [CCall::makeGenericRequest] INVITE
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = ;)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Initial Dialog Client not found
Wed Jul 10 15:11:54 2013 151d [CDialog::createRequest]
Wed Jul 10 15:11:54 2013 151d [CDialog::buildServicesForAllRequest]
Wed Jul 10 15:11:54 2013 151d [CDialog::createInviteRequest]
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] STATE CHANGED TO INITIAL
1373447514 -> Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212e, previousState = Terminated, currentState = Initial, reason
= None]
Wed Jul 10 15:11:54 2013 34 [CRequest::CRequest] Creation of a request
Wed Jul 10 15:11:54 2013 34 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:11:54 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 961)
----------------------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: "550389" <sip:550389@10.180.140.2>
Content-Type: application/sdp
To: <sip:89036117511@10.180.140.2;user=phone>
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Contact: <sip:550389@10.110.32.90;transport=UDP>
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397262 INVITE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK0165a8e887d3d407fc7297d0184292e0
Max-Forwards: 70
Content-Length: 214

v=0
o=OXE 1373447514 1373447514 IN IP4 10.110.32.90
s=abs
c=IN IP4 10.110.32.92
t=0 0
m=audio 32600 RTP/AVP 8 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
1373447514 -> Wed Jul 10 15:11:54 2013 34 [CMessage::onSendSuccess]
Wed Jul 10 15:11:54 2013 212e [CTransaction::onSendSuccess] CMessage 34 send Success
Wed Jul 10 15:11:54 2013 151d [CDialog::onSendSuccess]
Wed Jul 10 15:11:54 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:11:54 2013 [isIpAddressType] 10.180.140.2.
Wed Jul 10 15:11:54 2013 [isIpAddressType] YES.
Wed Jul 10 15:11:54 2013 212e [CTransInitialState::createRequest] Transaction changes to Calling state
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] STATE CHANGED TO CALLING
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212e, previousState = Initial, currentState = Calling, reason =
Request creation]
Wed Jul 10 15:11:54 2013 212e [CTransaction::startTimer] Timer A is started (delay = 500 ms)
Wed Jul 10 15:11:54 2013 212e [CTransaction::startTimer] Timer B is started (delay = 4000 ms)
Wed Jul 10 15:11:54 2013 151d [CDialog::getTransactionByCSeq] CSeq = 519397262
Wed Jul 10 15:11:54 2013 151d [CDialog::addTransaction] added transaction 212e with branch z9hG4bK0165a8e887d3d407fc7297d0184292e0,
with CSeq 519397262
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Client, UA)
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateSupported] Request timer supported
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateMinSE] Min-SE updated : 900
1373447514 -> Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Wed Jul 10 15:11:54 2013 [CForkedBranch::CForkedBranch] context = 0x84f9c24.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::branchAllocation] pForkedBranch = 0x84fe458 and the branch number is.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::makeInitialMotorRequest] reqUri duplication pForkedBranch = 0x84fe458.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Wed Jul 10 15:11:54 2013 NOE-SIP : StandByCallCreation not sent to twin CS
Wed Jul 10 15:11:54 2013 [onIncomingEvent] CallID must be inserted.
Wed Jul 10 15:11:54 2013 [onIncomingEvent] CallID inserted.
Wed Jul 10 15:11:54 2013 [exec_ipc] in end 9281.
Wed Jul 10 15:11:54 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: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397262 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK0165a8e887d3d407fc7297d0184292e0

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

Wed Jul 10 15:11:54 2013 [CIOCom::receiveResponse] CResponse 38 ref=1
Wed Jul 10 15:11:54 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
1373447514 -> Wed Jul 10 15:11:54 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:11:54 2013 113a [CCall::receiveResponse] 100
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:54 2013 212e [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212e, previousState = Calling, currentState = Proceeding, reason
= 1xx response reception]
Wed Jul 10 15:11:54 2013 212e [CTransaction::freeTimerToken] Timer A is freed
Wed Jul 10 15:11:54 2013 212e [CTransaction::freeTimerToken] Timer B is freed
Wed Jul 10 15:11:54 2013 113a[CMotorCall::searchForkedBranch]pForkedBranch=0x84fe458.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] is in the else part of SDP not present
Wed Jul 10 15:11:54 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 401 Unauthorized
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-90w76txmo0
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397262 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK0165a8e887d3d407fc7297d0184292e0
WWW-Authenticate: Digest realm="10.67.144.34",nonce="51dd25ba0af64f534b1f9441b2ba9038df3dae25",opaque="58e0f3eb7d01b5095d2396886ba08
b1e",qop="auth"
Content-Length: 0

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

1373447514 -> Wed Jul 10 15:11:54 2013 [CIOCom::receiveResponse] CResponse 39 ref=1
Wed Jul 10 15:11:54 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:11:54 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:11:54 2013 113a [CCall::receiveResponse] 401
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-90w7
6txmo0)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:54 2013 38 [~CResponse] resp(100) ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 519397262 INVITE
Wed Jul 10 15:11:54 2013 212e [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] STATE CHANGED TO COMPLETED
Wed Jul 10 15:11:54 2013 212e [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212e, previousState = Proceeding, currentState = Completed, reas
on = Final resp reception]
Wed Jul 10 15:11:54 2013 35 [CRequest::CRequest] Creation of a request
Wed Jul 10 15:11:54 2013 35 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:11:54 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 400)
----------------------utf8-----------------------
ACK sip:89036117511@10.180.140.2;user=phone SIP/2.0
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-90w76txmo0
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK0165a8e887d3d407fc7297d0184292e0
CSeq: 519397262 ACK
Content-Length: 0

-------------------------------------------------
1373447514 -> Wed Jul 10 15:11:54 2013 35 [CMessage::onSendSuccess]
Wed Jul 10 15:11:54 2013 212e [CTransaction::onSendSuccess] CMessage 35 send Success
Wed Jul 10 15:11:54 2013 151d [CDialog::onSendSuccess]
Wed Jul 10 15:11:54 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:11:54 2013 [isIpAddressType] 10.180.140.2.
Wed Jul 10 15:11:54 2013 [isIpAddressType] YES.
Wed Jul 10 15:11:54 2013 212e [CTransaction::startTimer] Timer D is started (delay = 32403 ms)
Wed Jul 10 15:11:54 2013 [unquoteString] "10.67.144.34" => 10.67.144.34
Wed Jul 10 15:11:54 2013 113a[CMotorCall::isKnownAuthenticate] Unquoted realm found : 10.67.144.34 ,Realm in the management : 10.67.
144.34.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::isKnownAuthenticate] matching realm : 10.67.144.34 in authenticate header.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::searchForkedBranch]pForkedBranch=0x84fe458.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitAuthorizedRequest] Begin.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitAuthorizedRequest] authenticateHeader found => Login: 550389.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitAuthorizedRequest] AuthorizationService for qop : "auth" => cnounce : 1373447514.
Wed Jul 10 15:11:54 2013 113a [CCall::makeGenericRequest] INVITE
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-90w7
6txmo0)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::createRequest]
1373447514 -> Wed Jul 10 15:11:54 2013 151d [CDialog::buildServicesForAllRequest]
Wed Jul 10 15:11:54 2013 151d [CDialog::createInviteRequest]
Wed Jul 10 15:11:54 2013 212f [CTransaction::changeState] STATE CHANGED TO INITIAL
Wed Jul 10 15:11:54 2013 212f [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212f, previousState = Terminated, currentState = Initial, reason
= None]
Wed Jul 10 15:11:54 2013 36 [CRequest::CRequest] Creation of a request
Wed Jul 10 15:11:54 2013 36 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:11:54 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 1245)
----------------------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: "550389" <sip:550389@10.180.140.2>
Content-Type: application/sdp
To: <sip:89036117511@10.180.140.2;user=phone>
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Contact: <sip:550389@10.110.32.90;transport=UDP>
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397263 INVITE
Max-Forwards: 70
Authorization: Digest username="550389",realm="10.67.144.34",nonce="51dd25ba0af64f534b1f9441b2ba9038df3dae25",opaque="58e0f3eb7d01b5
095d2396886ba08b1e",qop=auth,cnonce="1373447514",nc=00000001,uri="sip:89036117511@10.180.140.2;user=phone",response="185bb34740cea87
5e9f9ecfca23d2221"
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55
Content-Length: 214

v=0
o=OXE 1373447514 1373447514 IN IP4 10.110.32.90
s=abs
c=IN IP4 10.110.32.92
t=0 0
m=audio 32600 RTP/AVP 8 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
1373447514 -> Wed Jul 10 15:11:54 2013 36 [CMessage::onSendSuccess]
Wed Jul 10 15:11:54 2013 212f [CTransaction::onSendSuccess] CMessage 36 send Success
Wed Jul 10 15:11:54 2013 151d [CDialog::onSendSuccess]
Wed Jul 10 15:11:54 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:11:54 2013 [isIpAddressType] 10.180.140.2.
Wed Jul 10 15:11:54 2013 [isIpAddressType] YES.
Wed Jul 10 15:11:54 2013 212f [CTransInitialState::createRequest] Transaction changes to Calling state
Wed Jul 10 15:11:54 2013 212f [CTransaction::changeState] STATE CHANGED TO CALLING
Wed Jul 10 15:11:54 2013 212f [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212f, previousState = Initial, currentState = Calling, reason =
Request creation]
Wed Jul 10 15:11:54 2013 212f [CTransaction::startTimer] Timer A is started (delay = 500 ms)
Wed Jul 10 15:11:54 2013 212f [CTransaction::startTimer] Timer B is started (delay = 4000 ms)
Wed Jul 10 15:11:54 2013 151d [CDialog::getTransactionByCSeq] CSeq = 519397263
Wed Jul 10 15:11:54 2013 151d [CDialog::addTransaction] added transaction 212f with branch z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55,
with CSeq 519397263
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateSupported] Request timer supported
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
Wed Jul 10 15:11:54 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitAuthorizedRequest] ForkedBranch updated.
1373447514 -> Wed Jul 10 15:11:54 2013 [CForkedBranch::CForkedBranch] context = 0x84fe8ec.
Wed Jul 10 15:11:54 2013 113a[CMotorCall::branchAllocation] pForkedBranch = 0x84ffed0 and the branch number is.
Wed Jul 10 15:11:54 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: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397263 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55

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

Wed Jul 10 15:11:54 2013 [CIOCom::receiveResponse] CResponse 3A ref=1
Wed Jul 10 15:11:54 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:11:54 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:11:54 2013 113a [CCall::receiveResponse] 100
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:54 2013 212f [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
Wed Jul 10 15:11:54 2013 212f [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Wed Jul 10 15:11:54 2013 212f [CTransaction::changeState] notifying the parent dialog
1373447514 -> Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 212f, previousState = Calling, currentState = Proc
eeding, reason = 1xx response reception]
Wed Jul 10 15:11:54 2013 212f [CTransaction::freeTimerToken] Timer A is freed
Wed Jul 10 15:11:54 2013 212f [CTransaction::freeTimerToken] Timer B is freed
Wed Jul 10 15:11:54 2013 113a[CMotorCall::searchForkedBranch]pForkedBranch=0x84ffed0.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] is in the else part of SDP not present
Wed Jul 10 15:11:54 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 183 Session Progress
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397263 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55
Allow: INVITE,ACK,CANCEL,INFO,PRACK,UPDATE,OPTIONS,REGISTER,REFER,SUBSCRIBE
Contact: <sip:89036117511@10.180.140.2:5060;user=phone;transport=udp>
Require: 100rel
RSeq: 1
Content-Length: 161
Content-Type: application/sdp
Content-Disposition: session;handling=required

v=0
o=- 6336865 8144681 IN IP4 10.180.140.2
s=-
c=IN IP4 10.180.140.2
b=AS:64
t=0 0
m=audio 20098 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=ptime:20
a=sendrecv
-------------------------------------------------

1373447514 -> Wed Jul 10 15:11:54 2013 [CIOCom::receiveResponse] CResponse 3B ref=1
Wed Jul 10 15:11:54 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:11:54 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:11:54 2013 113a [CCall::receiveResponse] 183
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:54 2013 3A [~CResponse] resp(100) ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 519397263 INVITE
Wed Jul 10 15:11:54 2013 151d [CDialog::updateRouteSet] there are 0 record-route headers
Wed Jul 10 15:11:54 2013 113a[CMotorCall::prackToSend] Reliable response received.
Wed Jul 10 15:11:54 2013 113a[CMotorCall ISDN ExtGW
Wed Jul 10 15:11:54 2013 113a[CMotorCall::emitPrackMessage] response context is used.
Wed Jul 10 15:11:54 2013 113a [CCall::makeGenericRequest] PRACK
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::createRequest]
Wed Jul 10 15:11:54 2013 151d [CDialog::buildServicesForAllRequest]
Wed Jul 10 15:11:54 2013 151d [CDialog::createBasicRequest]
Wed Jul 10 15:11:54 2013 2130 [CTransaction::changeState] STATE CHANGED TO INITIAL
1373447514 -> Wed Jul 10 15:11:54 2013 2130 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 2130, previousState = Terminated, currentState = Initial, reason
= None]
Wed Jul 10 15:11:54 2013 37 [CRequest::CRequest] Creation of a request
Wed Jul 10 15:11:54 2013 6801 [CPrackService::applyToMessage] there are 0 route headers in the request
Wed Jul 10 15:11:54 2013 37 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:11:54 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 524)
----------------------utf8-----------------------
PRACK sip:89036117511@10.180.140.2:5060;user=phone;transport=udp SIP/2.0
Supported: timer,path
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
RAck: 1 519397263 INVITE
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397264 PRACK
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bKe0aef8b382aa2f93731ed15c73dd4110
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
Wed Jul 10 15:11:54 2013 37 [CMessage::onSendSuccess]
Wed Jul 10 15:11:54 2013 2130 [CTransaction::onSendSuccess] CMessage 37 send Success
Wed Jul 10 15:11:54 2013 151d [CDialog::onSendSuccess]
Wed Jul 10 15:11:54 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:11:54 2013 [isIpAddressType] 10.180.140.2.
1373447514 -> Wed Jul 10 15:11:54 2013 [isIpAddressType] YES.
Wed Jul 10 15:11:54 2013 2130 [CTransInitialState::createRequest] Transaction changes to Trying state
Wed Jul 10 15:11:54 2013 2130 [CTransaction::changeState] STATE CHANGED TO TRYING
Wed Jul 10 15:11:54 2013 2130 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 2130, previousState = Initial, currentState = Trying, reason = R
equest creation]
Wed Jul 10 15:11:54 2013 2130 [CTransTryingState::enterInState] Init timers E and F
Wed Jul 10 15:11:54 2013 2130 [CTransaction::startTimer] Timer E is started (delay = 500 ms)
Wed Jul 10 15:11:54 2013 2130 [CTransaction::startTimer] Timer F is started (delay = 16000 ms)
Wed Jul 10 15:11:54 2013 151d [CDialog::addTransaction] added transaction 2130 with branch z9hG4bKe0aef8b382aa2f93731ed15c73dd4110,
with CSeq 519397264
Wed Jul 10 15:11:54 2013 113a[CMotorCall::searchForkedBranch]pForkedBranch=0x84ffed0.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] is in the first IF of SDP present
Wed Jul 10 15:11:54 2013 [checkSdpValidity] Media 0 type 1 contains 1 formats.
Wed Jul 10 15:11:54 2013 [checkSdpValidity] Format : 8.
Wed Jul 10 15:11:54 2013 [receiveInformationalMessage] is in the else part of SDP present
Wed Jul 10 15:11:54 2013 [convertSdpIntoTsdp] No Direction in the session part.
1373447514 -> Wed Jul 10 15:11:54 2013 [convertSdpIntoTsdp] Check the direction in Session part - result:0.
Wed Jul 10 15:11:54 2013 [convertSdpIntoTsdp] media AUDIO detected (previous crypto=0).
Wed Jul 10 15:11:54 2013 [convertCryptoInfoInFile] clearMediaLine2: 0.
Wed Jul 10 15:11:54 2013 [convertAudioMedia] The audio media contains 1 format(s).
Wed Jul 10 15:11:54 2013 [convertAudioMedia] Format 0 is 8.
Wed Jul 10 15:11:54 2013 [convertAudioMedia] Direction is sendrecv.
Wed Jul 10 15:11:54 2013 [convertAudioMedia] Connection address retrieved in sdp: 10.180.140.2.
Wed Jul 10 15:11:54 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:11:54 2013 [convertSdpIntoTsdp] sdp index=0.
Wed Jul 10 15:11:54 2013 [display_sdp] address =10.180.140.2
Wed Jul 10 15:11:54 2013 [display_sdp] codecs =0.
Wed Jul 10 15:11:54 2013 [display_sdp] codecs =255.
Wed Jul 10 15:11:54 2013 [display_sdp] codecs =255.
Wed Jul 10 15:11:54 2013 [display_sdp] codecs =255.
Wed Jul 10 15:11:54 2013 [display_sdp] codecs =255.
Wed Jul 10 15:11:54 2013 [display_sdp] direction=0.
Wed Jul 10 15:11:54 2013 [convertSdpIntoTsdp] only one media taken into account xxx crypto_index=0 clear media=1
Wed Jul 10 15:11:54 2013 [convertSdpIntoTsdp] crypto_index=0 clear media=1.
Wed Jul 10 15:11:54 2013 [methodAllowedByDistant] UPDATE allowed by distant.
Wed Jul 10 15:11:54 2013 113a[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Wed Jul 10 15:11:54 2013 113a[emitEventToMonitel]1 T38 REINVITE TRUE
Wed Jul 10 15:11:54 2013 113a[emitEventToMonitel] CAC = 0 eqtCAC = -1
1373447514 -> Wed Jul 10 15:11:54 2013 113a[emitEventToMonitel] cacUsed=0 eqtCac=-1
Wed Jul 10 15:11:54 2013 113a[emitEventToMonitel] displayIPCMessageOut
Wed Jul 10 15:11:54 2013 ** SIP TRUNKING **
Wed Jul 10 15:11:54 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Wed Jul 10 15:11:54 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Wed Jul 10 15:11:54 2013 [display_ipc_out] ------------ Begin ---------------
Wed Jul 10 15:11:54 2013 Id : -1
Wed Jul 10 15:11:54 2013 INFORMATIONAL
Wed Jul 10 15:11:54 2013 xx :       83
Wed Jul 10 15:11:54 2013        RELATIVE REQUEST : INVITE
Wed Jul 10 15:11:54 2013 Allow Update : 1
Wed Jul 10 15:11:54 2013 SDP :
Wed Jul 10 15:11:54 2013   ADDRESS : 10.180.140.210.180.140.2 :20098
Wed Jul 10 15:11:54 2013   ALGOS :
Wed Jul 10 15:11:54 2013     PCMA
Wed Jul 10 15:11:54 2013   DIRECTION : SEND & RECEIVE
Wed Jul 10 15:11:54 2013   crypto index : 0
Wed Jul 10 15:11:54 2013 [display_ipc_out] ------------- End ----------------
Wed Jul 10 15:11:54 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397264 PRACK
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bKe0aef8b382aa2f93731ed15c73dd4110
Content-Length: 0

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

Wed Jul 10 15:11:54 2013 [CIOCom::receiveResponse] CResponse 3C ref=1
1373447517 -> Wed Jul 10 15:11:54 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:11:54 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:11:54 2013 113a [CCall::receiveResponse] 200
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:11:54 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:54 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:54 2013 2130 [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
Wed Jul 10 15:11:54 2013 2130 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Wed Jul 10 15:11:54 2013 2130 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:54 2013 151d [CDialog::onTransactionState(pTrans = 2130, previousState = Trying, currentState = Completed, reason =
Final resp reception]
Wed Jul 10 15:11:54 2013 2130 [CTransaction::freeTimerToken] Timer E is freed
Wed Jul 10 15:11:54 2013 2130 [CTransaction::freeTimerToken] Timer F is freed
Wed Jul 10 15:11:54 2013 2130 [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
Wed Jul 10 15:11:54 2013 113a[CMotorCall::onReceiveResponse] Response to PRACK accepted.
Wed Jul 10 15:11:57 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 180 Ringing
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397263 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55
Allow: INVITE,ACK,CANCEL,INFO,PRACK,UPDATE,OPTIONS,REGISTER,REFER,SUBSCRIBE
Contact: <sip:89036117511@10.180.140.2:5060;user=phone;transport=udp>
Require: 100rel
RSeq: 2
Content-Length: 0

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

1373447517 -> Wed Jul 10 15:11:57 2013 [CIOCom::receiveResponse] CResponse 3D ref=1
Wed Jul 10 15:11:57 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:11:57 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:11:57 2013 113a [CCall::receiveResponse] 180
Wed Jul 10 15:11:57 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:11:57 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:57 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:57 2013 3B [~CResponse] resp(183) ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 519397263 INVITE
Wed Jul 10 15:11:57 2013 151d [CDialog::updateRouteSet] there are 0 record-route headers
Wed Jul 10 15:11:57 2013 113a[CMotorCall::prackToSend] Reliable response received.
Wed Jul 10 15:11:57 2013 113a[CMotorCall ISDN ExtGW
Wed Jul 10 15:11:57 2013 113a[CMotorCall::emitPrackMessage] response context is used.
Wed Jul 10 15:11:57 2013 113a [CCall::makeGenericRequest] PRACK
Wed Jul 10 15:11:57 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:11:57 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:57 2013 151d [CDialog::createRequest]
Wed Jul 10 15:11:57 2013 151d [CDialog::buildServicesForAllRequest]
Wed Jul 10 15:11:57 2013 151d [CDialog::createBasicRequest]
Wed Jul 10 15:11:57 2013 2131 [CTransaction::changeState] STATE CHANGED TO INITIAL
1373447517 -> Wed Jul 10 15:11:57 2013 2131 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:57 2013 151d [CDialog::onTransactionState(pTrans = 2131, previousState = Terminated, currentState = Initial, reason
= None]
Wed Jul 10 15:11:57 2013 38 [CRequest::CRequest] Creation of a request
Wed Jul 10 15:11:57 2013 6802 [CPrackService::applyToMessage] there are 0 route headers in the request
Wed Jul 10 15:11:57 2013 38 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:11:57 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 524)
----------------------utf8-----------------------
PRACK sip:89036117511@10.180.140.2:5060;user=phone;transport=udp SIP/2.0
Supported: timer,path
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
RAck: 2 519397263 INVITE
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397265 PRACK
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK676a9474974c700872eba6e33d4ddac6
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
Wed Jul 10 15:11:57 2013 38 [CMessage::onSendSuccess]
Wed Jul 10 15:11:57 2013 2131 [CTransaction::onSendSuccess] CMessage 38 send Success
Wed Jul 10 15:11:57 2013 151d [CDialog::onSendSuccess]
Wed Jul 10 15:11:57 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:11:57 2013 [isIpAddressType] 10.180.140.2.
1373447517 -> Wed Jul 10 15:11:57 2013 [isIpAddressType] YES.
Wed Jul 10 15:11:57 2013 2131 [CTransInitialState::createRequest] Transaction changes to Trying state
Wed Jul 10 15:11:57 2013 2131 [CTransaction::changeState] STATE CHANGED TO TRYING
Wed Jul 10 15:11:57 2013 2131 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:57 2013 151d [CDialog::onTransactionState(pTrans = 2131, previousState = Initial, currentState = Trying, reason = R
equest creation]
Wed Jul 10 15:11:57 2013 2131 [CTransTryingState::enterInState] Init timers E and F
Wed Jul 10 15:11:57 2013 2131 [CTransaction::startTimer] Timer E is started (delay = 500 ms)
Wed Jul 10 15:11:57 2013 2131 [CTransaction::startTimer] Timer F is started (delay = 16000 ms)
Wed Jul 10 15:11:57 2013 151d [CDialog::addTransaction] added transaction 2131 with branch z9hG4bK676a9474974c700872eba6e33d4ddac6,
with CSeq 519397265
Wed Jul 10 15:11:57 2013 113a[CMotorCall::searchForkedBranch]pForkedBranch=0x84ffed0.
Wed Jul 10 15:11:57 2013 [receiveInformationalMessage] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 PROCEEDING_STAT
E received a message.
Wed Jul 10 15:11:57 2013 [receiveInformationalMessage] is in the else part of SDP not present
Wed Jul 10 15:11:57 2013 [methodAllowedByDistant] INFO allowed by distant.
Wed Jul 10 15:11:57 2013 [methodAllowedByDistant] UPDATE allowed by distant.
Wed Jul 10 15:11:57 2013 113a[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Wed Jul 10 15:11:57 2013 113a[emitEventToMonitel]1 T38 REINVITE TRUE
1373447517 -> Wed Jul 10 15:11:57 2013 113a[emitEventToMonitel] CAC = 0 eqtCAC = -1
Wed Jul 10 15:11:57 2013 113a[emitEventToMonitel] cacUsed=0 eqtCac=-1
Wed Jul 10 15:11:57 2013 113a[emitEventToMonitel] displayIPCMessageOut
Wed Jul 10 15:11:57 2013 ** SIP TRUNKING **
Wed Jul 10 15:11:57 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Wed Jul 10 15:11:57 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Wed Jul 10 15:11:57 2013 [display_ipc_out] ------------ Begin ---------------
Wed Jul 10 15:11:57 2013 Id : -1
Wed Jul 10 15:11:57 2013 INFORMATIONAL
Wed Jul 10 15:11:57 2013 xx :       80
Wed Jul 10 15:11:57 2013        RELATIVE REQUEST : INVITE
Wed Jul 10 15:11:57 2013 Allow Update : 1
Wed Jul 10 15:11:57 2013 [display_ipc_out] ------------- End ----------------
Wed Jul 10 15:11:57 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397265 PRACK
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK676a9474974c700872eba6e33d4ddac6
Content-Length: 0

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

Wed Jul 10 15:11:57 2013 [CIOCom::receiveResponse] CResponse 3E ref=1
Wed Jul 10 15:11:57 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:11:57 2013  102 [CCallManager::onIncomingResponse]
1373447519 -> Wed Jul 10 15:11:57 2013 113a [CCall::receiveResponse] 200
Wed Jul 10 15:11:57 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:11:57 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:11:57 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:11:57 2013 2131 [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
Wed Jul 10 15:11:57 2013 2131 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Wed Jul 10 15:11:57 2013 2131 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:11:57 2013 151d [CDialog::onTransactionState(pTrans = 2131, previousState = Trying, currentState = Completed, reason =
Final resp reception]
Wed Jul 10 15:11:57 2013 2131 [CTransaction::freeTimerToken] Timer E is freed
Wed Jul 10 15:11:57 2013 2131 [CTransaction::freeTimerToken] Timer F is freed
Wed Jul 10 15:11:57 2013 2131 [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
Wed Jul 10 15:11:57 2013 113a[CMotorCall::onReceiveResponse] Response to PRACK accepted.
Wed Jul 10 15:11:59 2013 2130 [CTransCompletedState::timerFires] Timer K fires
Wed Jul 10 15:11:59 2013 2130 [CTransCompletedState::timerFires] Timer K : Transaction changes to Terminated state
Wed Jul 10 15:11:59 2013 2130 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Wed Jul 10 15:11:59 2013 2130 [CTransaction::changeState] no transaction state, terminated reason : Timer K fires
1373447523 -> Wed Jul 10 15:11:59 2013 [CTransaction::notifyDialog]
Wed Jul 10 15:11:59 2013 [CTransaction::notifyDialog] notify parent dialog
Wed Jul 10 15:11:59 2013 151d [CDialog::onTransactionState(pTrans = 2130, previousState = null, currentState = Terminated, reason =
Timer K fires]
Wed Jul 10 15:11:59 2013 2130 [~CTransaction] transaction 519397264 PRACK
Wed Jul 10 15:11:59 2013 3C [~CResponse] resp(200) ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 519397264 PRACK
Wed Jul 10 15:11:59 2013 37 [~CRequest] req ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 519397264 PRACK
Wed Jul 10 15:12:02 2013 2131 [CTransCompletedState::timerFires] Timer K fires
Wed Jul 10 15:12:02 2013 2131 [CTransCompletedState::timerFires] Timer K : Transaction changes to Terminated state
Wed Jul 10 15:12:02 2013 2131 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Wed Jul 10 15:12:02 2013 2131 [CTransaction::changeState] no transaction state, terminated reason : Timer K fires
Wed Jul 10 15:12:02 2013 [CTransaction::notifyDialog]
Wed Jul 10 15:12:02 2013 [CTransaction::notifyDialog] notify parent dialog
Wed Jul 10 15:12:02 2013 151d [CDialog::onTransactionState(pTrans = 2131, previousState = null, currentState = Terminated, reason =
Timer K fires]
Wed Jul 10 15:12:02 2013 2131 [~CTransaction] transaction 519397265 PRACK
Wed Jul 10 15:12:02 2013 3E [~CResponse] resp(200) ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 519397265 PRACK

1373447523 -> Wed Jul 10 15:12:03 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397263 INVITE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55
Accept: application/sdp
Allow: INVITE,ACK,CANCEL,BYE,INFO,PRACK,OPTIONS,REGISTER,REFER,SUBSCRIBE
Contact: "89036117511" <sip:89036117511@10.180.140.2:5060;user=phone;transport=udp>
Supported: 100rel
Content-Length: 0

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

Wed Jul 10 15:12:03 2013 [CIOCom::receiveResponse] CResponse 3F ref=1
Wed Jul 10 15:12:03 2013 [CDispatcher::processResponseFromManagerIndex] start at index 0
Wed Jul 10 15:12:03 2013  102 [CCallManager::onIncomingResponse]
Wed Jul 10 15:12:03 2013 113a [CCall::receiveResponse] 200
Wed Jul 10 15:12:03 2013 113a [CCall::getDialog] Confirmed Dialog is not found (ID = b481d8231ee2a3c186df22142cbf468e;SDsnbge99-cvp3
ymdyjk)
Wed Jul 10 15:12:03 2013 113a [CCall::getDialog] Returning Initial Dialog Client
Wed Jul 10 15:12:03 2013 151d [CDialog::receiveResponse]
Wed Jul 10 15:12:03 2013 151d [CDialog::receiveResponse] create a CONFIRMED dialog
Wed Jul 10 15:12:03 2013 151e [CDialog::CDialog] look for the transaction #0, transaction key = z9hG4bK29f4c92a3d7a17198b8434cfad3b0
e55
1373447523 -> Wed Jul 10 15:12:03 2013 151e [CDialog::CDialog] copy the transaction #0, transaction key = z9hG4bK29f4c92a3d7a17198b8
434cfad3b0e55
Wed Jul 10 15:12:03 2013 2132 [CTransaction::CTransaction] Transaction is cloned in 4 state
Wed Jul 10 15:12:03 2013 151e [CDialog::addTransaction] added transaction 2132 with branch z9hG4bK29f4c92a3d7a17198b8434cfad3b0e55,
with CSeq 519397263
Wed Jul 10 15:12:03 2013 151e [CDialog::startDialogTTL]
Wed Jul 10 15:12:03 2013 151e [CDialog::receiveResponse]
Wed Jul 10 15:12:03 2013 2132 [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
Wed Jul 10 15:12:03 2013 2132 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Wed Jul 10 15:12:03 2013 2132 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:12:03 2013 151e [CDialog::onTransactionState(pTrans = 2132, previousState = Proceeding, currentState = Completed, reas
on = Final resp reception]
Wed Jul 10 15:12:03 2013 2132 [CTransaction::startTimer] Timer D is started (delay = 32196 ms)
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from response (Client, UA)
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::updateSupported] Request timer supported
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::updateMinSE] Min-SE updated : 900
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1373447523 -> Wed Jul 10 15:12:03 2013 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::startTimers] Start session timer will expires : 900000
Wed Jul 10 15:12:03 2013 [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=INVITE
Wed Jul 10 15:12:03 2013 151e [CDialog::updateRouteSet] there are 0 record-route headers
Wed Jul 10 15:12:03 2013 113a [CCall::insertInDialogMap] added dialog #151e with the key b481d8231ee2a3c186df22142cbf468e;SDsnbge99-
cvp3ymdyjk

Wed Jul 10 15:12:03 2013 151d [CDialog::getTransactionByCSeq] CSeq = 519397264
Wed Jul 10 15:12:03 2013 151d [CDialog::updateRouteSet] there are 0 record-route headers
Wed Jul 10 15:12:03 2013 113a[CMotorCall::searchForkedBranch]pForkedBranch=0x84ffed0.
Wed Jul 10 15:12:03 2013         [CForkedBranch::setFinalResponse] response=200.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::chooseBestResponse] pForkedBranch=0x84ffed0 iResponseCode=2000.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::chooseBestResponse] last iResponseCode=200.
Wed Jul 10 15:12:03 2013         [CForkedBranch::setFinalResponse] pResponse=0x84f8d50.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::chooseBestResponse] next branch.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
1373447523 -> Wed Jul 10 15:12:03 2013 [receiveSuccessfulMessage] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 PROC
EEDING_STATE received a message.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT manged with TLS and refresh REINVITE
Wed Jul 10 15:12:03 2013 113a[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=1 uacRefresher=1.
Wed Jul 10 15:12:03 2013 [decodeACACALU] no header.
Wed Jul 10 15:12:03 2013 113a[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Wed Jul 10 15:12:03 2013 113a[emitEventToMonitel] CAC = 0 eqtCAC = -1
Wed Jul 10 15:12:03 2013 113a[emitEventToMonitel] cacUsed=0 eqtCac=-1
Wed Jul 10 15:12:03 2013 113a[emitEventToMonitel] displayIPCMessageOut
Wed Jul 10 15:12:03 2013 ** SIP TRUNKING **
Wed Jul 10 15:12:03 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Wed Jul 10 15:12:03 2013 [ipc_thread] IPC Thread : Ipc reception 9282.
Wed Jul 10 15:12:03 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Wed Jul 10 15:12:03 2013 [sendLgEvtSip] Event sent on eqt : 1152 Id :-1
Wed Jul 10 15:12:03 2013 [display_ipc_out] ------------ Begin ---------------
Wed Jul 10 15:12:03 2013 Id : -1
Wed Jul 10 15:12:03 2013 SUCCESSFUL
Wed Jul 10 15:12:03 2013 xx :        0
Wed Jul 10 15:12:03 2013        RELATIVE REQUEST : INVITE
Wed Jul 10 15:12:03 2013 CAC-CSBU info : UNKNOWN
Wed Jul 10 15:12:03 2013 CLIR : 0
Wed Jul 10 15:12:03 2013 COLP : 0
Wed Jul 10 15:12:03 2013 [display_ipc_out] ------------- End ----------------
Wed Jul 10 15:12:03 2013 113a[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
1373447523 -> Wed Jul 10 15:12:03 2013 113a[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
Wed Jul 10 15:12:03 2013 [exec_ipc] in 9281.
Wed Jul 10 15:12:03 2013 [display_ipc_in] ------------ Begin ---------------
Wed Jul 10 15:12:03 2013 neqt : 1152 Id : -1
Wed Jul 10 15:12:03 2013 ACK
Wed Jul 10 15:12:03 2013 [display_ipc_in] ------------- End ----------------
Wed Jul 10 15:12:03 2013 [CMotorCallManager::onIncomingEvent] an event 10754 arrived on the eqt 1152 -1.
Wed Jul 10 15:12:03 2013 [CMotorCallManager::onIncomingEvent] state = ACCEPTED_STATE.
Wed Jul 10 15:12:03 2013 [onIncomingEvent] authorizationAttempt set to false.
Wed Jul 10 15:12:03 2013 [onIncomingEvent] ACK arrived.
Wed Jul 10 15:12:03 2013 [receiveAckEvent] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 ACCEPTED_STATE received an
event.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::emitAckMessage] begin.
Wed Jul 10 15:12:03 2013 113a[CMotorCall::emitAckMessage] SDP ok.
Wed Jul 10 15:12:03 2013 113a [CCall::makeGenericRequest] ACK
Wed Jul 10 15:12:03 2013 113a [CCall::getDialog] Confirmed Dialog found
Wed Jul 10 15:12:03 2013 151e [CDialog::createRequest]
Wed Jul 10 15:12:03 2013 151e [CDialog::buildServicesForAllRequest]
Wed Jul 10 15:12:03 2013 151e [CDialog::createAckRequest]
Wed Jul 10 15:12:03 2013 151e [CDialog::createAckRequest], previous trans 2132 is found
Wed Jul 10 15:12:03 2013 151e [CDialog::createAckRequest], previous trans 2132 is client
1373447523 -> Wed Jul 10 15:12:03 2013 39 [CRequest::CRequest] Creation of a request
Wed Jul 10 15:12:03 2013 151e [CDialog::buildServicesForAck]
Wed Jul 10 15:12:03 2013 [CGwMngDat a::getStackAuthRealm] lg Realm=14
Wed Jul 10 15:12:03 2013 [CGwMngDat a::getStackAuthRealm] Realm : AlcatelOmniPcx
Wed Jul 10 15:12:03 2013 39 [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:12:03 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 807)
----------------------utf8-----------------------
ACK sip:89036117511@10.180.140.2:5060;user=phone;transport=udp SIP/2.0
Contact: sip:550389@10.110.32.90
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
Authorization: Digest username="550389",realm="10.67.144.34",nonce="51dd25ba0af64f534b1f9441b2ba9038df3dae25",opaque="58e0f3eb7d01b5
095d2396886ba08b1e",qop=auth,cnonce="1373447514",nc=00000001,uri="sip:89036117511@10.180.140.2;user=phone",response="185bb34740cea87
5e9f9ecfca23d2221"
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: "M. Azanova DECT" <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397263 ACK
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK036c14e98f03ea0f2413ad7bed582ca2
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
Wed Jul 10 15:12:03 2013 39 [CMessage::onSendSuccess]
Wed Jul 10 15:12:03 2013 151e [CDialog::onSendSuccess]
Wed Jul 10 15:12:03 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
1373447527 -> Wed Jul 10 15:12:03 2013 [isIpAddressType] 10.180.140.2.
Wed Jul 10 15:12:03 2013 [isIpAddressType] YES.
Wed Jul 10 15:12:03 2013 2132 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Wed Jul 10 15:12:03 2013 2132 [CTransaction::freeTimerToken] Timer D is freed
Wed Jul 10 15:12:03 2013 2132 [CTransaction::changeState] no transaction state, terminated reason : Request creation
Wed Jul 10 15:12:03 2013 151e [CDialog::createAckRequest] successful INVITE is terminated after the ACK is sent
Wed Jul 10 15:12:03 2013 113a[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Wed Jul 10 15:12:03 2013 [receiveAckEvent] continue with session Timer
Wed Jul 10 15:12:03 2013 [exec_ipc] in end 9281.
Wed Jul 10 15:12:03 2013 [CTransaction::notifyDialog]
Wed Jul 10 15:12:03 2013 [CTransaction::notifyDialog] notify parent dialog
Wed Jul 10 15:12:03 2013 151e [CDialog::onTransactionState(pTrans = 2132, previousState = null, currentState = Terminated, reason =
Request creation]
Wed Jul 10 15:12:03 2013 2132 [~CTransaction] transaction 519397263 INVITE

1373447534 -> Wed Jul 10 15:12:14 2013 [ipc_thread] IPC Thread : Ipc reception 9282.
Wed Jul 10 15:12:14 2013 [ipc_thread] IPC Thread : TCL thread signaled.
Wed Jul 10 15:12:14 2013 [exec_ipc] in 9281.
Wed Jul 10 15:12:14 2013 [display_ipc_in] ------------ Begin ---------------
Wed Jul 10 15:12:14 2013 neqt : 1152 Id : -1
Wed Jul 10 15:12:14 2013 BYE
Wed Jul 10 15:12:14 2013 [display_ipc_in] ------------- End ----------------
Wed Jul 10 15:12:14 2013 [CMotorCallManager::onIncomingEvent] an event 10755 arrived on the eqt 1152 -1.
Wed Jul 10 15:12:14 2013 [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
Wed Jul 10 15:12:14 2013 [onIncomingEvent] BYE arrived.
Wed Jul 10 15:12:14 2013 [receiveByeEvent] Call: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90 eqt: 1152 COMPLETED_STATE received an
event.
Wed Jul 10 15:12:14 2013 113a[CMotorCall ISDN ExtGW
Wed Jul 10 15:12:14 2013 113a [CCall::makeGenericRequest] BYE
Wed Jul 10 15:12:14 2013 113a [CCall::getDialog] Confirmed Dialog found
Wed Jul 10 15:12:14 2013 151e [CDialog::createRequest]
Wed Jul 10 15:12:14 2013 151e [CDialog::buildServicesForAllRequest]
Wed Jul 10 15:12:14 2013 151e [CDialog::createByeRequest]
Wed Jul 10 15:12:14 2013 2133 [CTransaction::changeState] STATE CHANGED TO INITIAL
Wed Jul 10 15:12:14 2013 2133 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:12:14 2013 151e [CDialog::onTransactionState(pTrans = 2133, previousState = Terminated, currentState = Initial, reason
= None]
Wed Jul 10 15:12:14 2013 3A [CRequest::CRequest] Creation of a request
1373447534 -> Wed Jul 10 15:12:14 2013 3A [CMessage::send] sip_sendMessage (10.180.140.2:5060)
Wed Jul 10 15:12:14 2013 SEND MESSAGE TO NETWORK (10.180.140.2:5060 [UDP]) (BUFF LEN = 501)
----------------------utf8-----------------------
BYE sip:89036117511@10.180.140.2:5060;user=phone;transport=udp SIP/2.0
Supported: timer,path,100rel
User-Agent: OmniPCX Enterprise R10.1.1 j2.603.20.i
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397266 BYE
Via: SIP/2.0/UDP 10.110.32.90;branch=z9hG4bK85e22922ee6a4547a2cc45af1a100122
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
Wed Jul 10 15:12:14 2013 3A [CMessage::onSendSuccess]
Wed Jul 10 15:12:14 2013 2133 [CTransaction::onSendSuccess] CMessage 3A send Success
Wed Jul 10 15:12:14 2013 151e [CDialog::onSendSuccess]
Wed Jul 10 15:12:14 2013 [convertIPStrIntoTuipv] 10.180.140.2 => 10.180.140.2
Wed Jul 10 15:12:14 2013 [isIpAddressType] 10.180.140.2.
Wed Jul 10 15:12:14 2013 [isIpAddressType] YES.
Wed Jul 10 15:12:14 2013 2133 [CTransInitialState::createRequest] Transaction changes to Trying state
Wed Jul 10 15:12:14 2013 2133 [CTransaction::changeState] STATE CHANGED TO TRYING
Wed Jul 10 15:12:14 2013 2133 [CTransaction::changeState] notifying the parent dialog
Wed Jul 10 15:12:14 2013 151e [CDialog::onTransactionState(pTrans = 2133, previousState = Initial, currentState = Trying, reason = R
equest creation]
1373447534 -> Wed Jul 10 15:12:14 2013 2133 [CTransTryingState::enterInState] Init timers E and F
Wed Jul 10 15:12:14 2013 2133 [CTransaction::startTimer] Timer E is started (delay = 500 ms)
Wed Jul 10 15:12:14 2013 2133 [CTransaction::startTimer] Timer F is started (delay = 16000 ms)
Wed Jul 10 15:12:14 2013 151e [CDialog::addTransaction] added transaction 2133 with branch z9hG4bK85e22922ee6a4547a2cc45af1a100122,
with CSeq 519397266
Wed Jul 10 15:12:14 2013 [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
Wed Jul 10 15:12:14 2013 113a[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Wed Jul 10 15:12:14 2013 [exec_ipc] in end 9281.
Wed Jul 10 15:12:14 2013 RECEIVE MESSAGE FROM NETWORK (10.180.140.2:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:89036117511@10.180.140.2;user=phone>;tag=SDsnbge99-cvp3ymdyjk
From: <sip:550389@10.180.140.2;user=phone>;tag=b481d8231ee2a3c186df22142cbf468e
Call-ID: ab1fb399c2f99fda17c2e260dcc13e4f@10.110.32.90
CSeq: 519397266 BYE
Via: SIP/2.0/UDP 10.110.32.90:5060;branch=z9hG4bK85e22922ee6a4547a2cc45af1a100122
Content-Length: 0
 
Перейти    
SIP trunk group: неправильный АОН
 
#
10.07.2013 14:17:01
Однако...  :)

Перещли оба с провайдером на G711 и - ура! - исходящие заработали. Сейчас приступил к тщательной проверке всего-всего, потом (если кому интересно) выложу окончательный конфиг Ext SIP GW.
Изменено: Seller_V - 10.07.2013 14:17:19
 
Перейти    
SIP trunk group: неправильный АОН
 
#
09.07.2013 17:39:33
Апдейт: Пров поигрался у себя и после второго инвайта с авторизацией  ко мне приходит 403 Not Authorised с обьяснением Bearer Capability not authorized. Я как-то могу повлиять?

В ARS роуте выставлены и Voice, и Fax, и все, что возможно...
 
Перейти    
SIP trunk group: неправильный АОН
 
#
09.07.2013 16:28:35
Последняя трасса - не совсем честный исходящий. Звоню я туда на номер, приходящий по аналоговым СО (АРА8) на аналоговый внутренний, у которого немедленная переадресация на 8495ххххххх. По-другому никак, клиент уже работает вовсю.

И все равно непонятно, почему каналов не хватает? Может, в кодеках дело? У меня в дефолтном IP домене выставлено Without compression.
 
Перейти    
SIP trunk group: неправильный АОН
 
#
09.07.2013 15:31:39
Цитата
TMC пишет:
Цитата    
Seller_V пишет:
Выплыла странная штука - регистрация происходит в два этапа. Запрос --> 401 Unauthirised --> Запрос --> 200OK.
Так и должно быть.

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

Однако лед тронулся. Каким-то волшебством добился повторного 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
 
Перейти    
SIP trunk group: неправильный АОН
 
#
08.07.2013 19:15:22
Собрали совсем аналогичную схему у себя на стенде. С такой же циской с 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
 
Перейти    
SIP trunk group: неправильный АОН
 
#
05.07.2013 18:36:13
Цитата
error пишет:
нда уж, ваш пров в глаза "играется"
Ка знать, может быть, и нет. Ведь то, что я приве, это трасса со станции. Это Я вижу то, что отправляется к прову. Доходит это до того места, где ловит он - большой вопрос.

А убежать от прова нет возможности - это наша же контора, только иногородний филиал.  :D
Мы обречены бороться вечно...
 
Перейти    
SIP trunk group: неправильный АОН
 
#
05.07.2013 16:36:24
Цитата
error пишет:
вот дошли и до IP-phone
звука в обе стороны и не будет

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

А с исходящей пока бьюсь. Регистрация транка имееся, а вот даже инвайта при звонке провайдер не видит. Я впадаю в отчаяние.
 
Перейти    
SIP trunk group: неправильный АОН
 
#
04.07.2013 14:34:49
Рано обрадовался. Входящая связь односторонняя. При звонке на IP телефон голоса от станции не слышно. Если звонить на аналог, слышимость в обе стороны. Адреса на IPфоны раздаются станцией же по DHCP, адрес GW пробовали и как адрес CS и как адрес циски c NAT.

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

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

** 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
Изменено: Seller_V - 04.07.2013 15:08:34
 
Перейти    
SIP trunk group: неправильный АОН
 
#
02.07.2013 19:23:07
Цитата
vad пишет:
А в SIP TG - пункт Supervised by routing имеется (под рукой нет TG)? Без него все как-то плохо должно быть.

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

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

С исходящими пока бьюсь.
 
Перейти    
SIP trunk group: неправильный АОН
 
#
02.07.2013 14:51:17
Пробовал так же. Все варианты уже перепробовал. Не регистрируется. Пока читаю доку и думаю.

Кстати, как насчет моего вопроса про ABCF?
 
Перейти    
SIP trunk group: неправильный АОН
 
#
28.06.2013 22:21:09
Цитата
error пишет:
стоит у Вас External SIP GW - Minimal authentication method + SIP Digest

думаю что еще нужно Registration timer  ставить не 0



SBC - Session Board Controller - по русски это sip-proxy или же softswitch class4



вы так и не сказали каким макаром идет регистрация по каждому номеру или пачкой

если по каждому то надо еще использовать Registration ID

Итак, по порядку
В поле 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?
 
Перейти    
Страницы: Пред. 1 ... 14 15 16 17 18 19 20 21 22 23 24 ... 31 След.