error,
а уж как мне интересно... сегодня вечером патчить буду, по итогам отпишусь.
20.02.2014 09:25:17, ahvel.]]>
====quote====
Dmitry Ryzhakov пишет:
ну так покажите ему эту картинку - куда уж нагляднее - стрелка влево, стрелка вправо
=============
ага...бага влево...бага вправо...- это невесомый аргумент
просто интересно чем все закончится
19.02.2014 15:39:09, error.]]>
ну так покажите ему эту картинку - куда уж нагляднее - стрелка влево, стрелка вправо
19.02.2014 11:13:35, Dmitry Ryzhakov.]]>
Dmitry Ryzhakov,
сетевик, как и всегда
, говорит что всё открыто и нарядно... что то доказать можно только ткнув носом
19.02.2014 10:10:21, ahvel.]]>
по моему вам надо плотнее посмотреть роутинг между сетями и в частности - содержимое пакетов на 24.132 и далее... до этого обмена у вас медиа потоки с адреса 127.27.2.17 просто не поднимались и соответственного голоса небыло.
19.02.2014 09:22:26, Dmitry Ryzhakov.]]>
Dmitry Ryzhakov, после обновления прошивки шлюза, голос стал появляться так же и при нажатии *, т е перехода в режим посылки DTMF....
-набрал номер
-после 2 секунд поднял трубку
-5 секунд нажал (*)
-10 секунд разговора и положил трубку со стороны ОХЕ
смущает что только после нажатия *, от станции приходит номер порта RTP
PS: надеюсь патч поможет...
18.02.2014 22:55:10, ahvel.]]>
довольно наглядно с "недокрутами" разбираться в wireshark - Telephony > VoIP calls > graph - схема прохождения медиа потоков там наглядная и все адреса-порты видно. читать разлапистую трассировку алкатель имеет смысл если есть подозрение в ошибочной работе СИП после первичного анализа Ваершарком
18.02.2014 14:43:53, Dmitry Ryzhakov.]]>
error,
спасибо, попробую патч накатить. Сомневался, может чего недокрутил.
18.02.2014 14:39:36, ahvel.]]>
====quote====
ahvel пишет:
при поднятии трубки тишина. если звонок поставить на ожидание и потом опять взять, голос появляется и всё работает нормально.
=============
у вас одна дорога - ставить последний патч, от i1.605.12 до i1.605.41 много чего было в sip-е
18.02.2014 09:59:11, error.]]>
-------------------------------------------------
1392649145 -> [CIOCom::receiveResponse] CResponse 65 ref=1
1392649145 -> [CDispatcher::onIncomingResponse]
1392649145 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1392649145 -> 102 [CCallManager::onIncomingResponse]
1392649145 -> 1139 [CCall::receiveResponse] 200
1392649145 -> 1139 [CCall::receiveResponse]Trying to find the right dialog
1392649145 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649145 -> 1139 [CCall::receiveResponse]One dialog found
1392649145 -> 1540 [CDialog::receiveResponse]
1392649145 -> 2154 [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
1392649145 -> 2154 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1392649145 -> 2154 [CTransaction::changeState] notifying the parent dialog
1392649145 -> 1540 [CDialog::onTransactionState(pTrans = 2154, previousState = Trying, currentState = Completed, reason = Final resp reception]
1392649145 -> 2154 [CTransaction::freeTimerToken] Timer E is freed
1392649145 -> 2154 [CTransaction::freeTimerToken] Timer F is freed
1392649145 -> 2154 [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
1392649145 -> 1139[CMotorCall::onReceiveResponse] Update2 the Other context.
1392649145 -> [receiveSuccessfulMessage] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 TERMINATED_STATE received a message.
1392649145 -> 1139[emitEventToMonitel] content size (lginfo): 656
1392649145 -> 1139[emitEventToMonitel] CAC = 0 eqtCAC = -1
1392649145 -> 1139[emitEventToMonitel] CAC = 0
1392649145 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649145 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649145 -> [sendLgEvtSip] Event sent on eqt : 1718 Id :-1
1392649145 -> [display_ipc_out] ------------ Begin ---------------
1392649145 -> Id : -1
1392649145 -> SUCCESSFUL
1392649145 -> xx : 0
1392649145 -> RELATIVE REQUEST : BYE
1392649145 -> CLIR : 0
1392649145 -> COLP : 0
1392649145 -> [display_ipc_out] ------------- End ----------------
1392649145 -> [exec_ipc] in 28289.
1392649145 -> [display_ipc_in] ------------ Begin ---------------
1392649145 -> neqt : 1718 Id : -1
1392649145 -> SIP EQT RELEASED
1392649145 -> [display_ipc_in] ------------- End ----------------
1392649145 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 1718--1.
1392649145 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 1718 has released its equipment.
1392649145 -> 1139[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
1392649145 -> 1139[emitEventToMonitel] content size (lginfo): 656
1392649145 -> 1139[emitEventToMonitel] CAC = 0 eqtCAC = -1
1392649145 -> 1139[emitEventToMonitel] CAC = 0
1392649145 -> [sendLgEvtSip] Event sent on eqt : 1718 Id :-1
1392649145 -> [display_ipc_out] ------------ Begin ---------------
1392649145 -> Id : -1
1392649145 -> UNKNOWN MESSAGE
1392649145 -> [display_ipc_out] ------------- End ----------------
1392649145 -> 1139[CMotorCall::unRegister] Remove eqt : 1718 diag : -1 from the map.
1392649145 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 1718 erased.
1392649145 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1392649145 -> [CMotorCallManager::onIncomingEvent] killSession.
1392649145 -> 1139 [CCall::killSession]
1392649145 -> 2150 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1392649145 -> 2150 [CTransaction::changeState] no transaction state, terminated reason : None
1392649145 -> 2154 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1392649145 -> 2154 [CTransaction::freeTimerToken] Timer K is freed
1392649145 -> 2154 [CTransaction::changeState] no transaction state, terminated reason : None
1392649145 -> 1139 [CCall::killSession] notifying the call manager
1392649145 -> 102 [CCallManager::onCallClosed]
1392649145 -> 102 [CCallManager::onCallClosed()] Call 1139 closed. Removing call 139961680 from the maps
1392649145 -> [CMotorCallManager::onNotifyCallClosed] Call : 7c1eb3fe026d-7-11143b19 is closed.
1392649145 -> [CMotorCallManager::onNotifyCallClosed] Call : 7c1eb3fe026d-7-11143b19 is closed.
1392649145 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1392649145 -> [exec_ipc] in end 28289.
1392649145 -> [CTransaction::notifyDialog]
1392649145 -> [CTransaction::notifyDialog] notify parent dialog
1392649145 -> 153f [CDialog::onTransactionState(pTrans = 2150, previousState = null, currentState = Terminated, reason = None]
1392649145 -> 153f [CDialog::onTransactionState] dialog is terminated
1392649145 -> 153f [CDialog::onTransactionState] onDialogClosed
1392649145 -> 1139 [CCall::onDialogClosed]
1392649145 -> 1139 [CCall::onDialogClosed] not only initial *********
1392649145 -> 1139 [CCall::onDialogClosed]: the dialog 1540 is NOT closed
1392649145 -> 2150 [~CTransaction] transaction 11 INVITE
1392649145 -> 61 [~CResponse] resp(180) 7c1eb3fe026d-7-11143b19 11 INVITE
1392649145 -> [CTransaction::notifyDialog]
1392649145 -> [CTransaction::notifyDialog] notify parent dialog
1392649145 -> 1540 [CDialog::onTransactionState(pTrans = 2154, previousState = null, currentState = Terminated, reason = None]
1392649145 -> 1139 [CCall::onDialogClosed]
1392649145 -> 1139 [CCall::onDialogClosed] not only initial *********
1392649145 -> 1139 [CCall::onDialogClosed]: the dialog 1540 is closed
1392649145 -> 1139 [CCall::onDialogClosed] All the dialogs in the Call are closed
1392649145 -> 2154 [~CTransaction] transaction 1439058299 BYE
1392649145 -> 65 [~CResponse] resp(200) 7c1eb3fe026d-7-11143b19 1439058299 BYE
1392649145 -> 102 [CCallManager::removeGarbage] at index i = 0
1392649145 -> 1139[CMotorCall::~CMotorCall] Call : 7c1eb3fe026d-7-11143b19 is being destructed.
1392649145 -> 1139 [CCall::~CCall]
1392649145 -> 1139 [CCall::removeGarbage]
1392649145 -> 1540 [CDialog::~CDialog]
1392649145 -> 1540 [~CDialog] delete ack request # 0
1392649145 -> 5E [~CRequest] req 7c1eb3fe026d-7-11143b19 1439058297 ACK
1392649145 -> 63 [~CResponse] resp(200) 7c1eb3fe026d-7-11143b19 1439058297 INVITE
1392649145 -> 5D [~CRequest] req 7c1eb3fe026d-7-11143b19 1439058297 INVITE
1392649145 -> 1540 [~CDialog] delete ack request # 1
1392649145 -> 60 [~CRequest] req 7c1eb3fe026d-7-11143b19 1439058298 ACK
1392649145 -> 64 [~CResponse] resp(200) 7c1eb3fe026d-7-11143b19 1439058298 INVITE
1392649145 -> 5F [~CRequest] req 7c1eb3fe026d-7-11143b19 1439058298 INVITE
1392649145 -> 153f [CDialog::~CDialog]
1392649145 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1392649145 -> 61 [~CRequest] req 7c1eb3fe026d-7-11143b19 1439058299 BYE
1392649145 -> 62 [~CResponse] resp(200) 7c1eb3fe026d-7-11143b19 11 INVITE
1392649145 -> 5B [~CRequest] req 7c1eb3fe026d-7-11143b19 11 INVITE
17.02.2014 22:58:43, ahvel.]]>
собственно сам трейс описанного звонка
1392649124 -> RECEIVE MESSAGE FROM NETWORK (172.27.2.16:5060 [UDP])
----------------------utf8-----------------------
INVITE sip:1111@172.27.3.14:5060 SIP/2.0
Max-Forwards: 70
Via: SIP/2.0/UDP 172.27.2.16:5060;branch=z9hG4bK-11286538521
From: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
To: <sip:1111@172.27.3.14:5060>
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 11 INVITE
Contact: <sip:77019290234@172.27.2.16:5060>
User-Agent: 2N VoiceBlueNext 1.5.1.7.2
Allow: INVITE,BYE,ACK,CANCEL,OPTIONS,REFER,NOTIFY
Content-Type: application/sdp
Content-Length: 242
v=0
o=VoiceBlueNext 44079 16056 IN IP4 172.27.3.1
s=GSM Call
c=IN IP4 172.27.3.1
t=0 0
a=sendrecv
m=audio 10270 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:102 telephone-event/8000
a=fmtp:102 0-11
a=sendrecv
-------------------------------------------------
1392649124 -> 5B [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1392649124 -> [CIOCom::receiveRequest] Received CRequest 5B ref=1
1392649124 -> [CIOCom::checkHostInBlackList] host=172.27.2.16
1392649124 -> [CIOCom::checkHostInBlackList] host=172.27.2.16
1392649124 -> [CIOCom::receiveRequest] rport1 not empty
1392649124 -> [CDispatcher::onIncomingRequest()]
1392649124 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1392649124 -> 102 [CCallManager::onIncomingRequest()]
1392649124 -> [CMotorCallManager::callFactory] For call : 7c1eb3fe026d-7-11143b19.
1392649124 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.12
1392649124 -> [CMotorCallManager::callFactory]=857a550.
1392649124 -> 1139 [CCall::receiveRequest] INVITE
1392649124 -> 1139 [CCall::getDialog] Confirmed Dialog is not found (ID = ;7c1eb3fe026d-10-11143b19)
1392649124 -> 1139 [CCall::getDialog] Initial Dialog Server not found
1392649124 -> 153f [CDialog::receiveRequest]
1392649124 -> 153f [CDialog::receiveInviteRequest]
1392649124 -> 2150 [CTransaction::changeState] STATE CHANGED TO INITIAL
1392649124 -> 2150 [CTransaction::changeState] notifying the parent dialog
1392649124 -> 153f [CDialog::onTransactionState(pTrans = 2150, previousState = Terminated, currentState = Initial, reason = None]
1392649124 -> 2150 [CTransInitialState::receiveRequest] Transaction changes to Proceeding state
1392649124 -> 2150 [CTransaction::changeState] STATE CHANGED TO PROCEEDING
1392649124 -> 2150 [CTransaction::changeState] notifying the parent dialog
1392649124 -> 153f [CDialog::onTransactionState(pTrans = 2150, previousState = Initial, currentState = Proceeding, reason = Request reception]
1392649124 -> 2150 [CTransProceedingState::createResponse] CResponse 60 ref=1
1392649124 -> 60 [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649124 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 258)
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:1111@172.27.3.14:5060>
From: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 11 INVITE
Via: SIP/2.0/UDP 172.27.2.16:5060;branch=z9hG4bK-11286538521
Content-Length: 0
-------------------------------------------------
1392649124 -> 153f [CDialog::receiveInviteRequest] a new Server INVITE transaction is in progress
1392649124 -> [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Server, UA)
1392649124 -> [CSessionTimerContext::updateAfterRefreshReception] Update CSessionTimerContext (refresh reception)
1392649124 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 0
1392649124 -> [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=INVITE
1392649124 -> 153f [CDialog::addTransaction] added transaction 2150 with branch z9hG4bK-11286538521, with CSeq 11
1392649124 -> 1139 [CCall::checkAuthentication] INVITE
1392649124 -> 1139[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1392649124 -> [CGwMngDat a::isAuthenticationRequiredForThisClient] 172.27.3.14 .
1392649124 -> [isDomainFromGwExt] Host from request is : 172.27.3.14.
1392649124 -> [isDomainFromGwExt] User from request is : 77019290234
1392649124 -> [domain not from an External Gateway.
1392649124 -> 1139[CMotorCall::setFilterUsedMode] To be traced = 0
1392649124 -> [getFromHeader].
1392649124 -> [isUserDeclared] 77019290234@172.27.3.14
1392649124 -> isUserDeclared] NOT found in the dictionnary.
1392649124 -> [isSeplosStation] other station
1392649124 -> 1139[CMotorCall::toGatewayOrProxy] request for proxydomain=172.27.3.14.
1392649124 -> [isUserRegistred] getRegistration=1111.
1392649124 -> [isUserRegistred] result=-1.
1392649124 -> 1139[CMotorCall::onReceiveRequest] request for gateway.
1392649124 -> 1139[CMotorCall::onReceiveRequest] state = INITIAL_STATE.
1392649124 -> 1139[CMotorCall::methodInviteReceived] nb available licenses=10 .
1392649124 -> [isUserDeclared] 77019290234@172.27.3.14
1392649124 -> isUserDeclared] NOT found in the dictionnary.
1392649124 -> 1139[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
1392649124 -> 1139[CMotorCall::methodInviteReceived] Invite => update the inviteContext.
1392649124 -> [CForkedBranch::CForkedBranch] context = 0x857a980.
1392649124 -> 1139[CMotorCall::methodInviteReceived] reqUri stored: sip:77019290234@172.27.2.16:5060
1392649124 -> [CForkedBranch::reqUriDuplication] reqUri :sip:77019290234@172.27.2.16:5060
1392649124 -> 1139[CMotorCall::methodInviteReceived] CAC = 0
1392649124 -> [receiveInviteMessage] Call: 7c1eb3fe026d-7-11143b19 eqt: -1 INITIAL_STATE received a message.
1392649124 -> [decodeInviteCLIR].
1392649124 -> [isDomainFromGwExt] Host from request is : 172.27.3.14.
1392649124 -> [isDomainFromGwExt] User from request is : 77019290234
1392649124 -> am_I_PCS SCSWorking : NO
1392649124 -> check_PCSstate
1392649124 -> am_I_PCS SCSWorking : NO
1392649124 -> OXE contains PCS configuration
1392649124 -> check_PCSstate get the address of the user
1392649124 -> 1139[CMotorCall::addrToMediaInit] cac case.
1392649124 -> [isUserRegistred] getRegistration=77019290234.
1392649124 -> [isUserRegistred] try with alias.
1392649124 -> [getUrlByAlias] user=77019290234 domain=172.27.3.14.
1392649124 -> [getUrlByAlias] NOK
1392649124 -> [isUserRegistred] result=-1.
1392649124 -> [convertIPStrIntoTuipv] 172.27.3.14 => 172.27.3.14
1392649124 -> [isIpAddressType] .¬.
1392649124 -> 1139[CMotorCall::addrToMediaInit] S_OK.
1392649124 -> check_PCSstate we have found the ip if user
1392649124 -> check_PCSstate toAddress [0]= 172
1392649124 -> check_PCSstate toAddress [1]= 27
1392649124 -> check_PCSstate toAddress [2]= 3
1392649124 -> check_PCSstate toAddress [3]= 14
1392649124 -> check_PCSstate toAddress [172.27.3.14]
1392649124 -> check_PCSstate user IP is Found ? = YES
1392649124 -> The recevied host 172.27.3.14
1392649124 -> Trying to find the ip address in domain list
1392649124 -> The entry dom : 1 add_type=1
1392649124 -> The entry dom ip low :172.27.2.15
1392649124 -> The entry ipaddress from low :172.27.3.14
1392649124 -> The entry compare :-1
1392649124 -> The entry compare 2 :0
1392649124 -> iplink_is_good_range_for_reg
1392649124 -> The user is ipadd not in any Domain range return state as -1
1392649124 -> check_PCSstate stat of PCS is : -1
1392649124 -> [isSessionTimerTooSmall].
1392649124 -> 1139[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=0 uacRefresher=0.
1392649124 -> [decodeInviteSDP].
1392649124 -> [checkSdpValidity] Sdp contains 1 media description(s).
1392649124 -> [checkSdpValidity] Media 0 type 1 contains 2 formats.
1392649124 -> [checkSdpValidity] Format : 18.
1392649124 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1392649124 -> [convertSdpIntoTsdp] No Direction in the session part.
1392649124 -> [convertSdpIntoTsdp] Check the direction in Session part - result:0.
1392649124 -> [convertSdpIntoTsdp] The audio media contains 2 format(s).
1392649124 -> [convertSdpIntoTsdp] Format 0 is 18.
1392649124 -> [convertSdpIntoTsdp] Format 1 is 102.
1392649124 -> [convertSdpIntoTsdp] Get the direction.
1392649124 -> [convertSdpIntoTsdp] Direction is sendrecv.
1392649124 -> [convertSdpIntoTsdp] The connection is at session level.
1392649124 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 172.27.3.1.
1392649124 -> [convertIPStrIntoTuipv] 172.27.3.1 => 172.27.3.1
1392649124 -> [receiveInviteMessage] NO 100rel REQUIRED for this call.
1392649124 -> [isCACWithInvalidMediaAddr].
1392649124 -> [decodeInviteTo].
1392649124 -> [decodeInviteReferredBy].
1392649124 -> [decodeInviteACSBU].
1392649124 -> 1139[CMotorCall::setFilterUsedMode] To be traced = 0
1392649124 -> 1139[emitEventToMonitel] content size (lginfo): 656
1392649124 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649124 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649124 -> [CMotorCallManager::insertCallwithEqt] CMotorCall 1718 inserted.
1392649124 -> 1139[sendLgEvtSipCreate] Event sent on eqt : 1718
1392649124 -> [exec_ipc] in 28289.
1392649124 -> [display_ipc_in] ------------ Begin ---------------
1392649124 -> neqt : 1718 Id : -1
1392649124 -> INFORMATIONAL
1392649124 -> xx : 80
1392649124 -> RELATIVE REQUEST : INVITE
1392649124 -> SDP :
1392649124 -> ADDRESS : 172.27.2.17 :32568
1392649124 -> ALGOS :
1392649124 -> G729
1392649124 -> 102
1392649124 -> DIRECTION : SEND & RECEIVE
1392649124 -> [display_ipc_in] ------------- End ----------------
1392649124 -> [CMotorCallManager::onIncomingEvent] an event 10764 arrived on the eqt 1718--1.
1392649124 -> [CMotorCallManager::onIncomingEvent] state = PROCEEDING_STATE.
1392649124 -> [onIncomingEvent] INFORMATIONAL arrived.
1392649124 -> [receiveInformationalEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 PROCEEDING_STATE received an event.
1392649124 -> 1139[CMotorCall::inviteBuildContact] Contact: sip:172.27.3.14
1392649124 -> 1139[CMotorCall::makeResponseSdp] Begin sdp : v=0
o=OXE 1392649124 1392649124 IN IP4 172.27.3.14
s=-
c=IN IP4 0.0.0.0
t=0 0
.
1392649124 -> 1139[CMotorCall::makeResponseSdp] Audio media.
1392649124 -> 1139[CMotorCall::makeResponseSdp] format 102
1392649124 -> 1139[CMotorCall::makeResponseSdp] fromSdp.getMediaDesciprionCount :1
1392649124 -> 1139[CMotorCall::makeResponseSdp] Media accepted 0 : v=0
o=OXE 1392649124 1392649124 IN IP4 172.27.3.14
s=-
c=IN IP4 0.0.0.0
t=0 0
.
1392649124 -> 1139[CMotorCall::makeResponseSdp] Final Sdp: v=0
o=OXE 1392649124 1392649124 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
.
1392649124 -> 1139[CMotorCall::emitInformationalMessage] Answer sdp: v=0
o=OXE 1392649124 1392649124 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
1392649124 -> 1139 [CCall::makeGenericResponse] 180
1392649124 -> 1139 [CCall::getDialog] Confirmed Dialog is not found (ID = ;7c1eb3fe026d-10-11143b19)
1392649124 -> 1139 [CCall::getDialog] Returning Initial Dialog Server
1392649124 -> 153f [CDialog::createResponse] 180
1392649124 -> 2150 [CTransProceedingState::createResponse] CResponse 61 ref=1
1392649124 -> 61 [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649124 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 715)
----------------------utf8-----------------------
SIP/2.0 180 Ringing
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Contact: sip:172.27.3.14
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
Content-Type: application/sdp
To: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
From: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 11 INVITE
Via: SIP/2.0/UDP 172.27.2.16:5060;branch=z9hG4bK-11286538521
Content-Length: 237
v=0
o=OXE 1392649124 1392649124 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
-------------------------------------------------
1392649124 -> 60 [~CResponse] resp(100) 7c1eb3fe026d-7-11143b19 11 INVITE
1392649124 -> 153f [CDialog::updateRouteSet] there are 0 record-route headers
1392649124 -> [exec_ipc] in end 28289.
1392649126 -> main.trace.timer = 480mn
1392649129 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649129 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649129 -> [exec_ipc] in 28289.
1392649129 -> [display_ipc_in] ------------ Begin ---------------
1392649129 -> neqt : 1718 Id : -1
1392649129 -> SUCCESSFUL
1392649129 -> xx : 0
1392649129 -> RELATIVE REQUEST : INVITE
1392649129 -> CLIR : 0
1392649129 -> COLP : 1
1392649129 -> SDP :
1392649129 -> ADDRESS : 172.27.2.17 :32568
1392649129 -> ALGOS :
1392649129 -> G729
1392649129 -> 102
1392649129 -> DIRECTION : SEND & RECEIVE
1392649129 -> [display_ipc_in] ------------- End ----------------
1392649129 -> [CMotorCallManager::onIncomingEvent] an event 10765 arrived on the eqt 1718--1.
1392649129 -> [CMotorCallManager::onIncomingEvent] state = PROCEEDING_STATE.
1392649129 -> [onIncomingEvent] SUCCESSFUL arrived.
1392649129 -> [onIncomingEvent] relative_request = 10752
1392649129 -> [CProceedingState::receiveSuccessfulEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 PROCEEDING_STATE received an event.
1392649129 -> [quoteString] => "Viktor Dooll"
1392649129 -> 1139[CMotorCall::emitSuccessfulMessage] P-Asserted-Identity: "Viktor Dooll" <sip:1111@172.27.3.14;user=phone>
1392649129 -> 1139[CMotorCall::inviteBuildContact] Contact: sip:172.27.3.14
1392649129 -> 1139[CMotorCall::emitSuccessfullMessage] uacGatewayMode=0 uacRefresher=0.
1392649129 -> 1139[CMotorCall::makeResponseSdp] Begin sdp : v=0
o=OXE 1392649124 1392649125 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
.
1392649129 -> 1139[CMotorCall::makeResponseSdp] Audio media.
1392649129 -> 1139[CMotorCall::makeResponseSdp] format 102
1392649129 -> 1139[CMotorCall::makeResponseSdp] fromSdp.getMediaDesciprionCount :1
1392649129 -> 1139[CMotorCall::makeResponseSdp] Media accepted 0 : v=0
o=OXE 1392649124 1392649125 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
.
1392649129 -> 1139[CMotorCall::makeResponseSdp] Final Sdp: v=0
o=OXE 1392649124 1392649125 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
.
1392649129 -> 1139[CMotorCall::emitSuccesfulMessage] Answer sdp: v=0
o=OXE 1392649124 1392649125 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
1392649129 -> 1139 [CCall::makeGenericResponse] 200
1392649129 -> 1139 [CCall::getDialog] Confirmed Dialog is not found (ID = 25daee7629453dc0f488d19759b53801;7c1eb3fe026d-10-11143b19)
1392649129 -> 1139 [CCall::getDialog] Returning Initial Dialog Server
1392649129 -> 153f [CDialog::createResponse] 200
1392649129 -> 153f [CDialog::createResponse] create a CONFIRMED dialog
1392649129 -> 1540 [CDialog::CDialog] look for the transaction #0, transaction key = z9hG4bK-11286538521
1392649129 -> 1540 [CDialog::CDialog] copy the transaction #0, transaction key = z9hG4bK-11286538521
1392649129 -> 2151 [CTransaction::CTransaction] Transaction is cloned in 4 state
1392649129 -> 1540 [CDialog::addTransaction] added transaction 2151 with branch z9hG4bK-11286538521, with CSeq 11
1392649129 -> 1540 [CDialog::startDialogTTL]
1392649129 -> 1540 [CDialog::createResponse] 200
1392649129 -> 2151 [CTransProceedingState::createResponse] CResponse 62 ref=1
1392649129 -> 62 [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649129 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 852)
----------------------utf8-----------------------
SIP/2.0 200 OK
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Contact: sip:172.27.3.14
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
Session-Expires: 1800;refresher=uas
P-Asserted-Identity: "Viktor Dooll" <sip:1111@172.27.3.14;user=phone>
Content-Type: application/sdp
To: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
From: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 11 INVITE
Via: SIP/2.0/UDP 172.27.2.16:5060;branch=z9hG4bK-11286538521
Content-Length: 237
v=0
o=OXE 1392649124 1392649125 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
-------------------------------------------------
1392649129 -> 2151 [CTransProceedingState::createResponse] Final : Transaction changes to Completed state
1392649129 -> 2151 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1392649129 -> 2151 [CTransaction::changeState] notifying the parent dialog
1392649129 -> 1540 [CDialog::onTransactionState(pTrans = 2151, previousState = Proceeding, currentState = Completed, reason = Final resp creation]
1392649129 -> 2151 [CTransaction::startTimer] Timer G is started (delay = 500 ms)
1392649129 -> 2151 [CTransaction::startTimer] Timer H is started (delay = 32000 ms)
1392649129 -> 1540 [CDialog::updateRouteSet] there are 0 record-route headers
1392649129 -> [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from response (Server, UA)
1392649129 -> [CSessionTimerContext::updateAfterRefreshReception] Update CSessionTimerContext (refresh reception)
1392649129 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 0
1392649129 -> [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=INVITE
1392649129 -> [CSessionTimerContext::updateAfterResponseRefreshCreation] Update CSessionTimerContext (response refresh creation)
1392649129 -> [CSessionTimerContext::updateSessionExpires] header value : 1800
1392649129 -> [CSessionTimerContext::updateSessionExpires] updated
1392649129 -> [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1392649129 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1392649129 -> [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
1392649129 -> [CSessionTimerContext::startTimers] Start session timer will expires : 900000
1392649129 -> 1139 [CCall::insertInDialogMap] added dialog #1540 with the key 25daee7629453dc0f488d19759b53801;7c1eb3fe026d-10-11143b19
1392649129 -> 153f [CDialog::updateRouteSet] there are 0 record-route headers
1392649129 -> [CProceedingState::receiveSuccessfulEvent] emitSuccessfulMessage OK.
1392649129 -> [exec_ipc] in end 28289.
1392649129 -> RECEIVE MESSAGE FROM NETWORK (172.27.2.16:5060 [UDP])
----------------------utf8-----------------------
ACK sip:1111@172.27.3.14:5060 SIP/2.0
Max-Forwards: 70
Via: SIP/2.0/UDP 172.27.2.16:5060;branch=z9hG4bK-11286538521
From: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
To: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 11 ACK
Contact: <sip:77019290234@172.27.2.16:5060>
User-Agent: 2N VoiceBlueNext 1.5.1.7.2
Allow: INVITE,BYE,ACK,CANCEL,OPTIONS,REFER,NOTIFY
Content-Length: 0
-------------------------------------------------
1392649129 -> 5C [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1392649129 -> [CIOCom::receiveRequest] Received CRequest 5C ref=1
1392649129 -> [CIOCom::checkHostInBlackList] host=172.27.2.16
1392649129 -> [CIOCom::checkHostInBlackList] host=172.27.2.16
1392649129 -> [CIOCom::receiveRequest] rport1 not empty
1392649129 -> [CDispatcher::onIncomingRequest()]
1392649129 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1392649129 -> 102 [CCallManager::onIncomingRequest()]
1392649129 -> 1139 [CCall::receiveRequest] ACK
1392649129 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649129 -> 1540 [CDialog::receiveRequest]
1392649129 -> 1540 [CDialog::receiveAckRequest]
1392649129 -> 2151 [CTransCompletedState::receiveRequest] ACK(UDP) : Transaction changes to Confirmed state
1392649129 -> 2151 [CTransaction::changeState] STATE CHANGED TO CONFIRMED
1392649129 -> 2151 [CTransaction::changeState] notifying the parent dialog
1392649129 -> 1540 [CDialog::onTransactionState(pTrans = 2151, previousState = Completed, currentState = Confirmed, reason = Request reception]
1392649129 -> 2151 [CTransaction::freeTimerToken] Timer G is freed
1392649129 -> 2151 [CTransaction::freeTimerToken] Timer H is freed
1392649129 -> 2151 [CTransaction::startTimer] Timer I is started (delay = 5000 ms)
1392649129 -> 1540 [CDialog::receiveAckRequest] receiving an ACK with the same branch as the accepted INVITE
1392649129 -> 1139 [CCall::checkAuthentication] ACK
1392649129 -> 1139[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1392649129 -> 1139[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
1392649129 -> [getFromHeader].
1392649129 -> [isUserDeclared] 77019290234@172.27.3.14
1392649129 -> isUserDeclared] NOT found in the dictionnary.
1392649129 -> [isSeplosStation] other station
1392649129 -> 1139[CMotorCall::toGatewayOrProxy] request for proxydomain=172.27.3.14.
1392649129 -> [isUserRegistred] getRegistration=1111.
1392649129 -> [isUserRegistred] result=-1.
1392649129 -> 1139[CMotorCall::onReceiveRequest] request for gateway.
1392649129 -> 1139[CMotorCall::onReceiveRequest] state = ACCEPTED_STATE.
1392649129 -> 1139[CMotorCall::compareDialogFromContext] same Dialog
1392649129 -> 1139[CMotorCall::methodAckReceived] Ack => update the inviteContext.
1392649129 -> [receiveAckMessage] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 ACCEPTED_STATE received a message.
1392649129 -> [receiveAckMessage] g711u: 255 g711A: 255 g723: 255 g729: 255.
1392649129 -> 1139[emitEventToMonitel] content size (lginfo): 656
1392649129 -> 1139[emitEventToMonitel] CAC = 0 eqtCAC = -1
1392649129 -> 1139[emitEventToMonitel] CAC = 0
1392649129 -> [sendLgEvtSip] Event sent on eqt : 1718 Id :-1
1392649129 -> [display_ipc_out] ------------ Begin ---------------
1392649129 -> Id : -1
1392649129 -> ACK
1392649129 -> [display_ipc_out] ------------- End ----------------
1392649129 -> 1139 [CCall::getCallDuplicationData]
1392649129 -> 1139 [CCall::getCallDuplicationData] : Request URI = , Call ID = 7c1eb3fe026d-7-11143b19, Local URI = sip:1111@172.27.3.14:5060, Local Tag = 25daee7629453dc0f488d19759b53801, Remote URI = sip:77019290234@172.27.3.14:5060, Remote Tag = 7c1eb3fe026d-10-11143b19, Local CSeq = 1439058296, Remote CSeq = 11
1392649129 -> [CViaSetSerializer::serialize] Serialized via set :
1392649129 -> [CRouteSet::serialize] Serialized route set : Contact=sip:77019290234@172.27.2.16:5060
1392649134 -> 2151 [CTransConfirmedState::timerFires] Timer I fires
1392649134 -> 2151 [CTransConfirmedState::timerFires] TimerI : Transaction changes to Terminated state
1392649134 -> 2151 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1392649134 -> 2151 [CTransaction::changeState] no transaction state, terminated reason : Timer I fires
1392649134 -> [CTransaction::notifyDialog]
1392649134 -> [CTransaction::notifyDialog] notify parent dialog
1392649134 -> 1540 [CDialog::onTransactionState(pTrans = 2151, previousState = null, currentState = Terminated, reason = Timer I fires]
1392649134 -> 2151 [~CTransaction] transaction 11 INVITE
1392649134 -> 5C [~CRequest] req 7c1eb3fe026d-7-11143b19 11 ACK
1392649136 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649136 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649136 -> [exec_ipc] in 28289.
1392649136 -> [display_ipc_in] ------------ Begin ---------------
1392649136 -> neqt : 1718 Id : -1
1392649136 -> RE_INVITE
1392649136 -> SDP :
1392649136 -> ADDRESS : 172.27.3.15 :32624
1392649136 -> ALGOS :
1392649136 -> G729
1392649136 -> 102
1392649136 -> DIRECTION : SEND ONLY
1392649136 -> [display_ipc_in] ------------- End ----------------
1392649136 -> [CMotorCallManager::onIncomingEvent] an event 10753 arrived on the eqt 1718--1.
1392649136 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1392649136 -> [onIncomingEvent] RE_INVITE arrived.
1392649136 -> [receiveReInviteEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 COMPLETED_STATE received an event.
1392649136 -> 1139[emitReInviteMessage]-->SIP_INFO_allowed=0
1392649136 -> 1139[CMotorCall::emitReInviteMessage] uacGatewayMode=1 uacRefresher=1.
1392649136 -> 1139[CMotorCall::inviteBuildContact] Contact: sip:172.27.3.14
1392649136 -> 1139[CMotorCall::makeRequestSdp] Begin sdp : v=0
o=OXE 1392649124 1392649126 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32568 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
a=sendrecv
.
1392649136 -> 1139[CMotorCall::makeRequestSdp] Direction: 1.
1392649136 -> 1139[CMotorCall::makeResponseSdp] format 102
1392649136 -> 1139[CMotorCall::makeRequestSdp] Final sdp: v=0
o=OXE 1392649124 1392649126 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.3.15
t=0 0
m=audio 32624 RTP/AVP 18 102
a=sendonly
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
.
1392649136 -> 1139[CMotorCall::emitReInviteMessage] The sdp build: .
1392649136 -> 1139[CMotorCall::searchForkedBranch]pForkedBranch=0x857e718.
1392649136 -> 1139[CMotorCall::emitReInviteMessage] reqUri got :sip:77019290234@172.27.2.16:5060
1392649136 -> 1139[CMotorCall::emitReInviteMessage] continue.
1392649136 -> 1139 [CCall::makeGenericRequest] INVITE
1392649136 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649136 -> 1540 [CDialog::createRequest]
1392649136 -> 1540 [CDialog::buildServicesForAllRequest]
1392649136 -> 1540 [CDialog::createInviteRequest]
1392649136 -> 2152 [CTransaction::changeState] STATE CHANGED TO INITIAL
1392649136 -> 2152 [CTransaction::changeState] notifying the parent dialog
1392649136 -> 1540 [CDialog::onTransactionState(pTrans = 2152, previousState = Terminated, currentState = Initial, reason = None]
1392649136 -> 5D [CRequest::CRequest] Creation of a request
1392649136 -> 5D [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649136 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 864)
----------------------utf8-----------------------
INVITE sip:77019290234@172.27.2.16:5060 SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Contact: sip:172.27.3.14
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
Session-Expires: 1800;refresher=uac
Min-SE: 900
Content-Type: application/sdp
To: sip:77019290234@172.27.3.14:5060;tag=7c1eb3fe026d-10-11143b19
From: sip:1111@172.27.3.14:5060;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058297 INVITE
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bK31a71e527429b303fd535fe488bf45d6
Max-Forwards: 70
Content-Length: 237
v=0
o=OXE 1392649124 1392649126 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.3.15
t=0 0
m=audio 32624 RTP/AVP 18 102
a=sendonly
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
-------------------------------------------------
1392649136 -> 2152 [CTransInitialState::createRequest] Transaction changes to Calling state
1392649136 -> 2152 [CTransaction::changeState] STATE CHANGED TO CALLING
1392649136 -> 2152 [CTransaction::changeState] notifying the parent dialog
1392649136 -> 1540 [CDialog::onTransactionState(pTrans = 2152, previousState = Initial, currentState = Calling, reason = Request creation]
1392649136 -> 2152 [CTransaction::startTimer] Timer A is started (delay = 500 ms)
1392649136 -> 2152 [CTransaction::startTimer] Timer B is started (delay = 8000 ms)
1392649136 -> 1540 [CDialog::addTransaction] added transaction 2152 with branch z9hG4bK31a71e527429b303fd535fe488bf45d6, with CSeq 1439058297
1392649136 -> [CSessionTimerContext::updateAfterRefreshCreation] Update CSessionTimerContext (refresh creation)
1392649136 -> [CSessionTimerContext::updateSupported] Request timer supported
1392649136 -> [CSessionTimerContext::updateMinSE] Min-SE updated : 900
1392649136 -> [CSessionTimerContext::updateSessionExpires] header value : 1800
1392649136 -> [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1392649136 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1392649136 -> [CForkedBranch::CForkedBranch] context = 0x857a980.
1392649136 -> 1139[CMotorCall::emitReInviteMessage]Request built branch=1.
1392649136 -> [CForkedBranch::reqUriDuplication] reqUri :sip:77019290234@172.27.2.16:5060
1392649136 -> [exec_ipc] in end 28289.
1392649136 -> RECEIVE MESSAGE FROM NETWORK (172.27.2.16:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Max-Forwards: 70
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bK31a71e527429b303fd535fe488bf45d6
From: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
To: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058297 INVITE
Contact: <sip:77019290234@172.27.2.16:5060>
User-Agent: 2N VoiceBlueNext 1.5.1.7.2
Allow: INVITE,BYE,ACK,CANCEL,OPTIONS,REFER,NOTIFY
Content-Type: application/sdp
Content-Length: 242
v=0
o=VoiceBlueNext 44079 16056 IN IP4 172.27.3.1
s=GSM Call
c=IN IP4 172.27.3.1
t=0 0
a=sendrecv
m=audio 10272 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:102 telephone-event/8000
a=fmtp:102 0-11
a=recvonly
-------------------------------------------------
1392649136 -> [CIOCom::receiveResponse] CResponse 63 ref=1
1392649136 -> [CDispatcher::onIncomingResponse]
1392649136 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1392649136 -> 102 [CCallManager::onIncomingResponse]
1392649136 -> 1139 [CCall::receiveResponse] 200
1392649136 -> 1139 [CCall::receiveResponse]Trying to find the right dialog
1392649136 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649136 -> 1139 [CCall::receiveResponse]One dialog found
1392649136 -> 1540 [CDialog::receiveResponse]
1392649136 -> 2152 [CTransCallingState::receiveResponse] Final : Transaction changes to Completed state
1392649136 -> 2152 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1392649136 -> 2152 [CTransaction::changeState] notifying the parent dialog
1392649136 -> 1540 [CDialog::onTransactionState(pTrans = 2152, previousState = Calling, currentState = Completed, reason = Final resp reception]
1392649136 -> 2152 [CTransaction::freeTimerToken] Timer A is freed
1392649136 -> 2152 [CTransaction::freeTimerToken] Timer B is freed
1392649136 -> 2152 [CTransaction::startTimer] Timer D is started (delay = 32064 ms)
1392649136 -> [CSessionTimerContext::updateAfterResponseRefreshReception] Update CSessionTimerContext (response refresh reception)
1392649136 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1392649136 -> [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
1392649136 -> [CSessionTimerContext::startTimers] Start session timer will expires : 900000
1392649136 -> 1540 [CDialog::updateRouteSet] there are 0 record-route headers
1392649136 -> 1139[CMotorCall::searchForkedBranch]pForkedBranch=0x857ea70.
1392649136 -> [CForkedBranch::setFinalResponse] pResponse=0x857e7d8.
1392649136 -> [CForkedBranch::setFinalResponse] response=200.
1392649136 -> 1139[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
1392649136 -> 1139[CMotorCall::chooseBestResponse] pForkedBranch=0x857ea70 iResponseCode=2000.
1392649136 -> [CForkedBranch::getResponseCode] response=200.
1392649136 -> [CForkedBranch::getResponseCode] response=200.
1392649136 -> 1139[CMotorCall::chooseBestResponse] last iResponseCode=200.
1392649136 -> [CForkedBranch::setFinalResponse] pResponse=0x857e7d8.
1392649136 -> 1139[CMotorCall::chooseBestResponse] next branch.
1392649136 -> 1139[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
1392649136 -> [receiveSuccessfulMessage] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 MODIFICATION_PROCEEDING_STATE received a message.
1392649136 -> 1139[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=1 uacRefresher=1.
1392649136 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1392649136 -> [convertSdpIntoTsdp] default T38 config.
1392649136 -> [convertSdpIntoTsdp] No Direction in the session part.
1392649136 -> [convertSdpIntoTsdp] Check the direction in Session part - result:0.
1392649136 -> [convertSdpIntoTsdp] The audio media contains 2 format(s).
1392649136 -> [convertSdpIntoTsdp] Format 0 is 18.
1392649136 -> [convertSdpIntoTsdp] Format 1 is 102.
1392649136 -> [convertSdpIntoTsdp] Get the direction.
1392649136 -> [convertSdpIntoTsdp] Direction is recvonly.
1392649136 -> [convertSdpIntoTsdp] The connection is at session level.
1392649136 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 172.27.3.1.
1392649136 -> [convertIPStrIntoTuipv] 172.27.3.1 => 172.27.3.1
1392649136 -> [receiveSuccessfulMessage] T38 = 0.
1392649136 -> [methodAllowedByDistant] INFO not allowed by distant !!
1392649136 -> 1139[emitEventToMonitel] content size (lginfo): 656
1392649136 -> 1139[emitEventToMonitel] CAC = 0 eqtCAC = -1
1392649136 -> 1139[emitEventToMonitel] CAC = 0
1392649136 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649136 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649136 -> [sendLgEvtSip] Event sent on eqt : 1718 Id :-1
1392649136 -> [display_ipc_out] ------------ Begin ---------------
1392649136 -> Id : -1
1392649136 -> SUCCESSFUL
1392649136 -> xx : 0
1392649136 -> RELATIVE REQUEST : RE_INVITE
1392649136 -> CLIR : 0
1392649136 -> COLP : 0
1392649136 -> SDP :
1392649136 -> ADDRESS : 172.27.3.1 :10272
1392649136 -> ALGOS :
1392649136 -> G729
1392649136 -> 102
1392649136 -> DIRECTION : RECEIVE ONLY
1392649136 -> [display_ipc_out] ------------- End ----------------
1392649136 -> 1139[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
1392649136 -> 1139[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
1392649136 -> [CForkedBranch::getResponseCode] response=200.
1392649136 -> [CForkedBranch::getResponseCode] response=200.
1392649136 -> [exec_ipc] in 28289.
1392649136 -> [display_ipc_in] ------------ Begin ---------------
1392649136 -> neqt : 1718 Id : -1
1392649136 -> ACK
1392649136 -> [display_ipc_in] ------------- End ----------------
1392649136 -> [CMotorCallManager::onIncomingEvent] an event 10754 arrived on the eqt 1718--1.
1392649136 -> [CMotorCallManager::onIncomingEvent] state = MODIFICATION_PROCEEDING_STATE.
1392649136 -> [onIncomingEvent] ACK arrived.
1392649136 -> [receiveAckEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 MODIFICATION_PROCEEDING_STATE received an event.
1392649136 -> 1139[CMotorCall::inviteBuildContact] Contact: sip:172.27.3.14
1392649136 -> 1139[CMotorCall::emitAckMessage] begin.
1392649136 -> 1139[CMotorCall::emitAckMessage] SDP ok.
1392649136 -> 1139 [CCall::makeGenericRequest] ACK
1392649136 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649136 -> 1540 [CDialog::createRequest]
1392649136 -> 1540 [CDialog::buildServicesForAllRequest]
1392649136 -> 1540 [CDialog::createAckRequest]
1392649136 -> 1540 [CDialog::createAckRequest], previous trans 2152 is found
1392649136 -> 1540 [CDialog::createAckRequest], previous trans 2152 is client
1392649136 -> 5E [CRequest::CRequest] Creation of a request
1392649136 -> 1540 [CDialog::buildServicesForAck]
1392649136 -> 5E [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649136 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 432)
----------------------utf8-----------------------
ACK sip:77019290234@172.27.2.16:5060 SIP/2.0
Contact: sip:172.27.3.14
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
To: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
From: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058297 ACK
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bKc97b9ef5186607c0b1ef0623f64f1c20
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1392649136 -> 2152 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1392649136 -> 2152 [CTransaction::freeTimerToken] Timer D is freed
1392649136 -> 2152 [CTransaction::changeState] no transaction state, terminated reason : Request creation
1392649136 -> 1540 [CDialog::createAckRequest] successful INVITE is terminated after the ACK is sent
1392649136 -> 1139 [CCall::getCallDuplicationData]
1392649136 -> 1139 [CCall::getCallDuplicationData] : Request URI = , Call ID = 7c1eb3fe026d-7-11143b19, Local URI = sip:1111@172.27.3.14:5060, Local Tag = 25daee7629453dc0f488d19759b53801, Remote URI = sip:77019290234@172.27.3.14:5060, Remote Tag = 7c1eb3fe026d-10-11143b19, Local CSeq = 1439058297, Remote CSeq = 11
1392649136 -> [CViaSetSerializer::serialize] Serialized via set :
1392649136 -> [CRouteSet::serialize] Serialized route set : Contact=sip:77019290234@172.27.2.16:5060
1392649136 -> [exec_ipc] in end 28289.
1392649136 -> [CTransaction::notifyDialog]
1392649136 -> [CTransaction::notifyDialog] notify parent dialog
1392649136 -> 1540 [CDialog::onTransactionState(pTrans = 2152, previousState = null, currentState = Terminated, reason = Request creation]
1392649136 -> 2152 [~CTransaction] transaction 1439058297 INVITE
1392649137 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649137 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649137 -> [exec_ipc] in 28289.
1392649137 -> [display_ipc_in] ------------ Begin ---------------
1392649137 -> neqt : 1718 Id : -1
1392649137 -> RE_INVITE
1392649137 -> SDP :
1392649137 -> ADDRESS : 172.27.2.17 :32592
1392649137 -> ALGOS :
1392649137 -> G729
1392649137 -> 102
1392649137 -> DIRECTION : SEND & RECEIVE
1392649137 -> [display_ipc_in] ------------- End ----------------
1392649137 -> [CMotorCallManager::onIncomingEvent] an event 10753 arrived on the eqt 1718--1.
1392649137 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1392649137 -> [onIncomingEvent] RE_INVITE arrived.
1392649137 -> [receiveReInviteEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 COMPLETED_STATE received an event.
1392649137 -> 1139[emitReInviteMessage]-->SIP_INFO_allowed=0
1392649137 -> 1139[CMotorCall::emitReInviteMessage] uacGatewayMode=1 uacRefresher=1.
1392649137 -> 1139[CMotorCall::inviteBuildContact] Contact: sip:172.27.3.14
1392649137 -> 1139[CMotorCall::makeRequestSdp] Begin sdp : v=0
o=OXE 1392649124 1392649127 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.3.15
t=0 0
m=audio 32624 RTP/AVP 18 102
a=sendonly
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
.
1392649137 -> 1139[CMotorCall::makeRequestSdp] Direction: 0.
1392649137 -> 1139[CMotorCall::makeResponseSdp] format 102
1392649137 -> 1139[CMotorCall::makeRequestSdp] Final sdp: v=0
o=OXE 1392649124 1392649127 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32592 RTP/AVP 18 102
a=sendrecv
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
.
1392649137 -> 1139[CMotorCall::emitReInviteMessage] The sdp build: .
1392649137 -> 1139[CMotorCall::searchForkedBranch]pForkedBranch=0x857ea70.
1392649137 -> 1139[CMotorCall::emitReInviteMessage] reqUri got :sip:77019290234@172.27.2.16:5060
1392649137 -> 1139[CMotorCall::emitReInviteMessage] continue.
1392649137 -> 1139 [CCall::makeGenericRequest] INVITE
1392649137 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649137 -> 1540 [CDialog::createRequest]
1392649137 -> 1540 [CDialog::buildServicesForAllRequest]
1392649137 -> 1540 [CDialog::createInviteRequest]
1392649137 -> 2153 [CTransaction::changeState] STATE CHANGED TO INITIAL
1392649137 -> 2153 [CTransaction::changeState] notifying the parent dialog
1392649137 -> 1540 [CDialog::onTransactionState(pTrans = 2153, previousState = Terminated, currentState = Initial, reason = None]
1392649137 -> 5F [CRequest::CRequest] Creation of a request
1392649137 -> 5F [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649137 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 864)
----------------------utf8-----------------------
INVITE sip:77019290234@172.27.2.16:5060 SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Contact: sip:172.27.3.14
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
Session-Expires: 1800;refresher=uac
Min-SE: 900
Content-Type: application/sdp
To: sip:77019290234@172.27.3.14:5060;tag=7c1eb3fe026d-10-11143b19
From: sip:1111@172.27.3.14:5060;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058298 INVITE
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bK065baa20795ecd5048a6157e1f87a62c
Max-Forwards: 70
Content-Length: 237
v=0
o=OXE 1392649124 1392649127 IN IP4 172.27.3.14
s=abs
c=IN IP4 172.27.2.17
t=0 0
m=audio 32592 RTP/AVP 18 102
a=sendrecv
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:102 telephone-event/8000
-------------------------------------------------
1392649137 -> 2153 [CTransInitialState::createRequest] Transaction changes to Calling state
1392649137 -> 2153 [CTransaction::changeState] STATE CHANGED TO CALLING
1392649137 -> 2153 [CTransaction::changeState] notifying the parent dialog
1392649137 -> 1540 [CDialog::onTransactionState(pTrans = 2153, previousState = Initial, currentState = Calling, reason = Request creation]
1392649137 -> 2153 [CTransaction::startTimer] Timer A is started (delay = 500 ms)
1392649137 -> 2153 [CTransaction::startTimer] Timer B is started (delay = 8000 ms)
1392649137 -> 1540 [CDialog::addTransaction] added transaction 2153 with branch z9hG4bK065baa20795ecd5048a6157e1f87a62c, with CSeq 1439058298
1392649137 -> [CSessionTimerContext::updateAfterRefreshCreation] Update CSessionTimerContext (refresh creation)
1392649137 -> [CSessionTimerContext::updateSupported] Request timer supported
1392649137 -> [CSessionTimerContext::updateSessionExpires] header value : 1800
1392649137 -> [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1392649137 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1392649137 -> [CForkedBranch::CForkedBranch] context = 0x857a980.
1392649137 -> 1139[CMotorCall::emitReInviteMessage]Request built branch=1.
1392649137 -> [CForkedBranch::reqUriDuplication] reqUri :sip:77019290234@172.27.2.16:5060
1392649137 -> [exec_ipc] in end 28289.
1392649137 -> RECEIVE MESSAGE FROM NETWORK (172.27.2.16:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Max-Forwards: 70
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bK065baa20795ecd5048a6157e1f87a62c
From: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
To: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058298 INVITE
Contact: <sip:77019290234@172.27.2.16:5060>
User-Agent: 2N VoiceBlueNext 1.5.1.7.2
Allow: INVITE,BYE,ACK,CANCEL,OPTIONS,REFER,NOTIFY
Content-Type: application/sdp
Content-Length: 244
v=0
o=VoiceBlueNext 44079 16056 IN IP4 172.27.2.16
s=GSM Call
c=IN IP4 172.27.2.16
t=0 0
a=sendrecv
m=audio 32698 RTP/AVP 18 102
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:102 telephone-event/8000
a=fmtp:102 0-11
a=sendrecv
-------------------------------------------------
1392649137 -> [CIOCom::receiveResponse] CResponse 64 ref=1
1392649137 -> [CDispatcher::onIncomingResponse]
1392649137 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1392649137 -> 102 [CCallManager::onIncomingResponse]
1392649137 -> 1139 [CCall::receiveResponse] 200
1392649137 -> 1139 [CCall::receiveResponse]Trying to find the right dialog
1392649137 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649137 -> 1139 [CCall::receiveResponse]One dialog found
1392649137 -> 1540 [CDialog::receiveResponse]
1392649137 -> 2153 [CTransCallingState::receiveResponse] Final : Transaction changes to Completed state
1392649137 -> 2153 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1392649137 -> 2153 [CTransaction::changeState] notifying the parent dialog
1392649137 -> 1540 [CDialog::onTransactionState(pTrans = 2153, previousState = Calling, currentState = Completed, reason = Final resp reception]
1392649137 -> 2153 [CTransaction::freeTimerToken] Timer A is freed
1392649137 -> 2153 [CTransaction::freeTimerToken] Timer B is freed
1392649137 -> 2153 [CTransaction::startTimer] Timer D is started (delay = 32460 ms)
1392649137 -> [CSessionTimerContext::updateAfterResponseRefreshReception] Update CSessionTimerContext (response refresh reception)
1392649137 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1392649137 -> [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
1392649137 -> [CSessionTimerContext::startTimers] Start session timer will expires : 900000
1392649137 -> 1540 [CDialog::updateRouteSet] there are 0 record-route headers
1392649137 -> 1139[CMotorCall::searchForkedBranch]pForkedBranch=0x857ea70.
1392649137 -> [CForkedBranch::setFinalResponse] pResponse=0x8589438.
1392649137 -> [CForkedBranch::setFinalResponse] response=200.
1392649137 -> 1139[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
1392649137 -> 1139[CMotorCall::chooseBestResponse] pForkedBranch=0x857ea70 iResponseCode=2000.
1392649137 -> [CForkedBranch::getResponseCode] response=200.
1392649137 -> [CForkedBranch::getResponseCode] response=200.
1392649137 -> 1139[CMotorCall::chooseBestResponse] last iResponseCode=200.
1392649137 -> [CForkedBranch::setFinalResponse] pResponse=0x8589438.
1392649137 -> 1139[CMotorCall::chooseBestResponse] next branch.
1392649137 -> 1139[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
1392649137 -> [receiveSuccessfulMessage] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 MODIFICATION_PROCEEDING_STATE received a message.
1392649137 -> 1139[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=1 uacRefresher=1.
1392649137 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1392649137 -> [convertSdpIntoTsdp] default T38 config.
1392649137 -> [convertSdpIntoTsdp] No Direction in the session part.
1392649137 -> [convertSdpIntoTsdp] Check the direction in Session part - result:0.
1392649137 -> [convertSdpIntoTsdp] The audio media contains 2 format(s).
1392649137 -> [convertSdpIntoTsdp] Format 0 is 18.
1392649137 -> [convertSdpIntoTsdp] Format 1 is 102.
1392649137 -> [convertSdpIntoTsdp] Get the direction.
1392649137 -> [convertSdpIntoTsdp] Direction is sendrecv.
1392649137 -> [convertSdpIntoTsdp] The connection is at session level.
1392649137 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 172.27.2.16.
1392649137 -> [convertIPStrIntoTuipv] 172.27.2.16 => 172.27.2.16
1392649137 -> [receiveSuccessfulMessage] T38 = 0.
1392649137 -> [methodAllowedByDistant] INFO not allowed by distant !!
1392649137 -> 1139[emitEventToMonitel] content size (lginfo): 656
1392649137 -> 1139[emitEventToMonitel] CAC = 0 eqtCAC = -1
1392649137 -> 1139[emitEventToMonitel] CAC = 0
1392649137 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649137 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649137 -> [sendLgEvtSip] Event sent on eqt : 1718 Id :-1
1392649137 -> [display_ipc_out] ------------ Begin ---------------
1392649137 -> Id : -1
1392649137 -> SUCCESSFUL
1392649137 -> xx : 0
1392649137 -> RELATIVE REQUEST : RE_INVITE
1392649137 -> CLIR : 0
1392649137 -> COLP : 0
1392649137 -> SDP :
1392649137 -> ADDRESS : 172.27.2.16 :32698
1392649137 -> ALGOS :
1392649137 -> G729
1392649137 -> 102
1392649137 -> DIRECTION : SEND & RECEIVE
1392649137 -> [display_ipc_out] ------------- End ----------------
1392649137 -> 1139[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
1392649137 -> 1139[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
1392649137 -> [CForkedBranch::getResponseCode] response=200.
1392649137 -> [CForkedBranch::getResponseCode] response=200.
1392649137 -> [exec_ipc] in 28289.
1392649137 -> [display_ipc_in] ------------ Begin ---------------
1392649137 -> neqt : 1718 Id : -1
1392649137 -> ACK
1392649137 -> [display_ipc_in] ------------- End ----------------
1392649137 -> [CMotorCallManager::onIncomingEvent] an event 10754 arrived on the eqt 1718--1.
1392649137 -> [CMotorCallManager::onIncomingEvent] state = MODIFICATION_PROCEEDING_STATE.
1392649137 -> [onIncomingEvent] ACK arrived.
1392649137 -> [receiveAckEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 MODIFICATION_PROCEEDING_STATE received an event.
1392649137 -> 1139[CMotorCall::inviteBuildContact] Contact: sip:172.27.3.14
1392649137 -> 1139[CMotorCall::emitAckMessage] begin.
1392649137 -> 1139[CMotorCall::emitAckMessage] SDP ok.
1392649137 -> 1139 [CCall::makeGenericRequest] ACK
1392649137 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649137 -> 1540 [CDialog::createRequest]
1392649137 -> 1540 [CDialog::buildServicesForAllRequest]
1392649137 -> 1540 [CDialog::createAckRequest]
1392649137 -> 1540 [CDialog::createAckRequest], previous trans 2153 is found
1392649137 -> 1540 [CDialog::createAckRequest], previous trans 2153 is client
1392649137 -> 60 [CRequest::CRequest] Creation of a request
1392649137 -> 1540 [CDialog::buildServicesForAck]
1392649137 -> 60 [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649137 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 432)
----------------------utf8-----------------------
ACK sip:77019290234@172.27.2.16:5060 SIP/2.0
Contact: sip:172.27.3.14
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
To: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
From: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058298 ACK
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bK7a42c76db1fe68683f5259ec4d66edb6
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1392649137 -> 2153 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1392649137 -> 2153 [CTransaction::freeTimerToken] Timer D is freed
1392649137 -> 2153 [CTransaction::changeState] no transaction state, terminated reason : Request creation
1392649137 -> 1540 [CDialog::createAckRequest] successful INVITE is terminated after the ACK is sent
1392649137 -> 1139 [CCall::getCallDuplicationData]
1392649137 -> 1139 [CCall::getCallDuplicationData] : Request URI = , Call ID = 7c1eb3fe026d-7-11143b19, Local URI = sip:1111@172.27.3.14:5060, Local Tag = 25daee7629453dc0f488d19759b53801, Remote URI = sip:77019290234@172.27.3.14:5060, Remote Tag = 7c1eb3fe026d-10-11143b19, Local CSeq = 1439058298, Remote CSeq = 11
1392649137 -> [CViaSetSerializer::serialize] Serialized via set :
1392649137 -> [CRouteSet::serialize] Serialized route set : Contact=sip:77019290234@172.27.2.16:5060
1392649137 -> [exec_ipc] in end 28289.
1392649137 -> [CTransaction::notifyDialog]
1392649137 -> [CTransaction::notifyDialog] notify parent dialog
1392649137 -> 1540 [CDialog::onTransactionState(pTrans = 2153, previousState = null, currentState = Terminated, reason = Request creation]
1392649137 -> 2153 [~CTransaction] transaction 1439058298 INVITE
1392649143 -> [ipc_thread] IPC Thread : Ipc reception 28290.
1392649143 -> [ipc_thread] IPC Thread : TCL thread signaled.
1392649143 -> [exec_ipc] in 28289.
1392649143 -> [display_ipc_in] ------------ Begin ---------------
1392649143 -> neqt : 1718 Id : -1
1392649143 -> BYE
1392649143 -> [display_ipc_in] ------------- End ----------------
1392649143 -> [CMotorCallManager::onIncomingEvent] an event 10755 arrived on the eqt 1718--1.
1392649143 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1392649143 -> [onIncomingEvent] BYE arrived.
1392649143 -> [receiveByeEvent] Call: 7c1eb3fe026d-7-11143b19 eqt: 1718 COMPLETED_STATE received an event.
1392649143 -> 1139 [CCall::makeGenericRequest] BYE
1392649143 -> 1139 [CCall::getDialog] Confirmed Dialog found
1392649143 -> 1540 [CDialog::createRequest]
1392649143 -> 1540 [CDialog::buildServicesForAllRequest]
1392649143 -> 1540 [CDialog::createByeRequest]
1392649143 -> 2154 [CTransaction::changeState] STATE CHANGED TO INITIAL
1392649143 -> 2154 [CTransaction::changeState] notifying the parent dialog
1392649143 -> 1540 [CDialog::onTransactionState(pTrans = 2154, previousState = Terminated, currentState = Initial, reason = None]
1392649143 -> 61 [CRequest::CRequest] Creation of a request
1392649143 -> 61 [CMessage::send] sip_sendMessage (172.27.2.16:5060)
1392649143 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 436)
----------------------utf8-----------------------
BYE sip:77019290234@172.27.2.16:5060 SIP/2.0
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
To: sip:77019290234@172.27.3.14:5060;tag=7c1eb3fe026d-10-11143b19
From: sip:1111@172.27.3.14:5060;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058299 BYE
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bKf9516feb680c85b66b70fbc536114a90
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1392649143 -> 2154 [CTransInitialState::createRequest] Transaction changes to Trying state
1392649143 -> 2154 [CTransaction::changeState] STATE CHANGED TO TRYING
1392649143 -> 2154 [CTransaction::changeState] notifying the parent dialog
1392649143 -> 1540 [CDialog::onTransactionState(pTrans = 2154, previousState = Initial, currentState = Trying, reason = Request creation]
1392649143 -> 2154 [CTransTryingState::enterInState] Init timers E and F
1392649143 -> 2154 [CTransaction::startTimer] Timer E is started (delay = 500 ms)
1392649143 -> 2154 [CTransaction::startTimer] Timer F is started (delay = 32000 ms)
1392649143 -> 1540 [CDialog::addTransaction] added transaction 2154 with branch z9hG4bKf9516feb680c85b66b70fbc536114a90, with CSeq 1439058299
1392649143 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1392649143 -> [exec_ipc] in end 28289.
1392649144 -> 2154 [CTransTryingState::timerFires] Timer E fires
1392649144 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 436)
----------------------utf8-----------------------
BYE sip:77019290234@172.27.2.16:5060 SIP/2.0
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
To: sip:77019290234@172.27.3.14:5060;tag=7c1eb3fe026d-10-11143b19
From: sip:1111@172.27.3.14:5060;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058299 BYE
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bKf9516feb680c85b66b70fbc536114a90
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1392649144 -> 2154 [CTransaction::startTimer] Timer E is started (delay = 1000 ms)
1392649145 -> 2154 [CTransTryingState::timerFires] Timer E fires
1392649145 -> SEND MESSAGE TO NETWORK (172.27.2.16:5060 [UDP]) (BUFF LEN = 436)
----------------------utf8-----------------------
BYE sip:77019290234@172.27.2.16:5060 SIP/2.0
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.12
To: sip:77019290234@172.27.3.14:5060;tag=7c1eb3fe026d-10-11143b19
From: sip:1111@172.27.3.14:5060;tag=25daee7629453dc0f488d19759b53801
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058299 BYE
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bKf9516feb680c85b66b70fbc536114a90
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1392649145 -> 2154 [CTransaction::startTimer] Timer E is started (delay = 2000 ms)
1392649145 -> RECEIVE MESSAGE FROM NETWORK (172.27.2.16:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Max-Forwards: 70
Via: SIP/2.0/UDP 172.27.3.14;branch=z9hG4bKf9516feb680c85b66b70fbc536114a90
From: <sip:1111@172.27.3.14:5060>;tag=25daee7629453dc0f488d19759b53801
To: <sip:77019290234@172.27.3.14:5060>;tag=7c1eb3fe026d-10-11143b19
Call-ID: 7c1eb3fe026d-7-11143b19
CSeq: 1439058299 BYE
Contact: <sip:77019290234@172.27.2.16:5060>
User-Agent: 2N VoiceBlueNext 1.5.1.7.2
Allow: INVITE,BYE,ACK,CANCEL,OPTIONS,REFER,NOTIFY
Content-Length: 0
17.02.2014 22:58:15, ahvel.]]>
Всем здравствуйте и всего доброго.
Подключил GSM шлюз по SIP как External Gateway.
Исходящие вызовы уходят без проблем, а вот с входящими интересная ситуация.
При входящем звонке, шлюз посылает внутренний номер 1111, телефон звонит, при поднятии трубки тишина. если звонок поставить на ожидание и потом опять взять, голос появляется и всё работает нормально.
Почитав форум и маны, пришёл к выводу что дело в RTP. Пробовал на шлюзе менять диапазон портов, для чистоты эксперимента оставлял диапозон в 10 портов начиная с 32696 по 32706.
в трассировке видно что вначале почему то выбирается порт не из диапазона, после постановки на ожидание и возврат звонка, видно RE-INVITE и порт меняется на один из указанного диапозона.
OXE MG R9.1-i1.605-12-ru-c82
шлюз находится рядом с выносом с PCSом, сам проц в другом городе и соответственно в другой подсети (хз но может важно).
17.02.2014 22:49:03, ahvel.]]>