SIP Error on 4135 Conference phone

[DRaGoN_KNigHT]

Hello guys,

We were trying to setup a 4135 Phone to communicate an OT Conference bridge. The 4135 phone is located in Australia and the OT Conference bridge is located in Singapore. But I am not sure why the calls are failing. I have attached the SIP traces for your reference. Any assistance is appreciated.

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

traced started ...
1523941530 -> Tue Apr 17 13:05:30 2018 RECEIVE MESSAGE FROM NETWORK (10.67.23.219:5060 [UDP])
----------------------utf8-----------------------
OPTIONS sip:10.93.9.13;transport=udp SIP/2.0
Via: SIP/2.0/UDP 10.67.23.219:5060;rport;branch=z9hG4bKPjYpfXvLmt3-pg0yoCjiuS4rNRhSEFdN3R
Max-Forwards: 70
From: <sip:10.67.23.219>;tag=Zl1qcod.E8O8S5UVkamDv4TvJJ8EN0CP
To: <sip:10.93.9.13>
Call-ID: qWQ-ykIYUyhjaw4bANDoCzIC6iKsr23y
CSeq: 57689 OPTIONS
Content-Length: 0

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

Tue Apr 17 13:05:30 2018 [CIOCom::receiveRequest] optimisation value 1
Tue Apr 17 13:05:30 2018 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => 10.93.9.13 sgsinsuoxn01p
Tue Apr 17 13:05:30 2018 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Tue Apr 17 13:05:30 2018 2CC26 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
Tue Apr 17 13:05:30 2018 [CIOCom::receiveRequest] Received CRequest 2CC26 ref=1
Tue Apr 17 13:05:30 2018 [CIOCom::receiveRequest] rport1 empty
Tue Apr 17 13:05:30 2018 [CIOCom::receiveRequest] Set received param on first Via header : 10.67.23.219
Tue Apr 17 13:05:30 2018 [CDispatcher::onIncomingRequest()]
Tue Apr 17 13:05:30 2018 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Tue Apr 17 13:05:30 2018 [CDispatcher::processRequestFromManagerIndex] Call does not exist or manager changed: Find the new manager to handle
Tue Apr 17 13:05:30 2018 102 [CCallManager::onIncomingRequest()]
Tue Apr 17 13:05:30 2018 [CMotorCallManager::callFactory] For call : qWQ-ykIYUyhjaw4bANDoCzIC6iKsr23y.
1523941530 -> Tue Apr 17 13:05:30 2018 1108 [CCall::CCall] resources number: 12

Tue Apr 17 13:05:30 2018 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R12.1 m2.300.19
Tue Apr 17 13:05:30 2018 [CMotorCallManager::callFactory]=858e478.
Tue Apr 17 13:05:30 2018 110f [CCall::receiveRequest] OPTIONS
Tue Apr 17 13:05:30 2018 110f [CCall::getDialog] Confirmed Dialog is not found (ID = ;Zl1qcod.E8O8S5UVkamDv4TvJJ8EN0CP)
Tue Apr 17 13:05:30 2018 110f [CCall::getDialog] Initial Dialog Server not found
Tue Apr 17 13:05:30 2018 1552 [CDialog::receiveRequest]
Tue Apr 17 13:05:30 2018 1552 [CDialog::receiveBasicRequest]
Tue Apr 17 13:05:30 2018 217c [CTransaction::changeState] STATE CHANGED TO INITIAL
Tue Apr 17 13:05:30 2018 217c [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:30 2018 1552 [CDialog::onTransactionState(pTrans = 217c, previousState = Terminated, currentState = Initial, reason = None]
Tue Apr 17 13:05:30 2018 217c [CTransInitialState::receiveRequest] Transaction changes to Trying state
Tue Apr 17 13:05:30 2018 217c [CTransaction::changeState] STATE CHANGED TO TRYING
Tue Apr 17 13:05:30 2018 217c [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:30 2018 1552 [CDialog::onTransactionState(pTrans = 217c, previousState = Initial, currentState = Trying, reason = Request reception]
Tue Apr 17 13:05:30 2018 1552 [CDialog::addTransaction] added transaction 217c with branch z9hG4bKPjYpfXvLmt3-pg0yoCjiuS4rNRhSEFdN3R, with CSeq 57689
1523941530 -> Tue Apr 17 13:05:30 2018 110f [CCall::receiveRequest] iErrorCode=488.
Tue Apr 17 13:05:30 2018 110f [CCall::checkAuthentication] OPTIONS
Tue Apr 17 13:05:30 2018 110f[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
Tue Apr 17 13:05:30 2018 110f[CMotorCall::controlAuthentication] ---*--- END-03 ---*--- Control authentication
Tue Apr 17 13:05:30 2018 110f [CCall::controlAuthentication] need auth =0
Tue Apr 17 13:05:30 2018 110f [CCall::checkAuthentication] AUTHENT=0
Tue Apr 17 13:05:30 2018 110f [CCall::checkAuthentication] iRetValue=0
Tue Apr 17 13:05:30 2018 110f [CCall::receiveRequest] extGw=-1.
Tue Apr 17 13:05:30 2018 110f [CCall::receiveRequest] External Authentication by WS is in progress ...
Tue Apr 17 13:05:30 2018 110f[CMotorCall::onReceiveRequest] request received.
Tue Apr 17 13:05:30 2018 110f[CMotorCall::setFilterUsedMode] To be traced = 0
Tue Apr 17 13:05:30 2018 [getFromHeader] look at the From.
Tue Apr 17 13:05:30 2018 [getFromHeader] displayName=.
Tue Apr 17 13:05:30 2018 [convertCSipURLIntoSipuri] uri = sip:10.67.23.219.
Tue Apr 17 13:05:30 2018 [getFromHeader] =@10.67.23.219.
Tue Apr 17 13:05:30 2018 [getFromHeader] clirPresent=0.
Tue Apr 17 13:05:30 2018 [getReqUriHeader] look at the requri.
Tue Apr 17 13:05:30 2018 [convertCSipURLIntoSipuri] uri = sip:10.93.9.13;transport=udp.
Tue Apr 17 13:05:30 2018 110f[CMotorCall::getUserType] extGw=-1.
Tue Apr 17 13:05:30 2018 [CMotorCall::analyseRouting] TEL uri=0.
Tue Apr 17 13:05:30 2018 [CMotorCall::analyseRouting] @10.67.23.219 NOT found in the dictionnary.
1523941530 -> Tue Apr 17 13:05:30 2018 [isDomainFromExtGw] Host from request is : 10.67.23.219.
Tue Apr 17 13:05:30 2018 [isDomainFromExtGw] User from request is :
Tue Apr 17 13:05:30 2018 Routing using Via Header
Tue Apr 17 13:05:30 2018 [getExtGWusingViaHeader]GwNumber =1, IPADDRESS inbansuotm01p.dc.ale-international.com
Tue Apr 17 13:05:30 2018 [getExtGWusingViaHeader]GwNumber =9, IPADDRESS 10.108.255.218
Tue Apr 17 13:05:30 2018 [getExtGWusingViaHeader]GwNumber =10, IPADDRESS 10.108.255.210
Tue Apr 17 13:05:30 2018 [getExtGWusingViaHeader]VIA(0) Via: SIP/2.0/UDP 10.67.23.219:5060;received=10.67.23.219;branch=z9hG4bKPjYpfXvLmt3-pg0yoCjiuS4rNRhSEFdN3R;rport=5060
Tue Apr 17 13:05:30 2018 Found=-1
Tue Apr 17 13:05:30 2018 [CMotorCall::analyseRouting] @10.67.23.219 is not authenticable.
Tue Apr 17 13:05:30 2018 isUserInDico] NOT found in the dictionnary.
Tue Apr 17 13:05:30 2018 [isAddrInDico] other sip user
Tue Apr 17 13:05:30 2018 110f[CMotorCall::getUserType] extGw=-1.
Tue Apr 17 13:05:30 2018 110f[CMotorCall::initOfUserType] m_other_calling=1 extgw=-1
Tue Apr 17 13:05:30 2018 110f[CMotorCall::onReceiveRequest] accepte? m_other_calling=1 gw=-1.
Tue Apr 17 13:05:30 2018 isNotInTrustedIpAddressList
Tue Apr 17 13:05:30 2018 110f[CMotorCall::onReceiveRequest] system option=0 extGw=-1.
Tue Apr 17 13:05:30 2018 110f[CMotorCall::onReceiveRequest] release the call 403.
Tue Apr 17 13:05:30 2018 110f[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Tue Apr 17 13:05:30 2018 1552 [CCall::findFirstServerTrans]
1523941530 -> Tue Apr 17 13:05:30 2018 1552 [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
Tue Apr 17 13:05:30 2018 110f [CCall::makeGenericResponse] 403
Tue Apr 17 13:05:30 2018 110f [CCall::getDialog] Confirmed Dialog is not found (ID = ;Zl1qcod.E8O8S5UVkamDv4TvJJ8EN0CP)
Tue Apr 17 13:05:30 2018 110f [CCall::getDialog] Returning Initial Dialog Server
Tue Apr 17 13:05:30 2018 1552 [CDialog::createResponse] 403
Tue Apr 17 13:05:30 2018 217c [CTransTryingState::createResponse] CResponse 2CAC9 ref=1
Tue Apr 17 13:05:30 2018 [DBG: CResponse::freeAttributes]
Tue Apr 17 13:05:30 2018 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Tue Apr 17 13:05:30 2018 [DBG: CResponse::freeAttributes] Ends
Tue Apr 17 13:05:30 2018 2CAC9 [CMessage::send] sip_sendMessage (10.67.23.219:5060)
Tue Apr 17 13:05:30 2018 SEND MESSAGE TO NETWORK (10.67.23.219:5060 [UDP]) (BUFF LEN = 479)
----------------------utf8-----------------------
SIP/2.0 403 Forbidden
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
User-Agent: OmniPCX Enterprise R12.1 m2.300.19
To: <sip:10.93.9.13>;tag=4041b10445f8da0c485b481b4254656b
From: <sip:10.67.23.219>;tag=Zl1qcod.E8O8S5UVkamDv4TvJJ8EN0CP
Call-ID: qWQ-ykIYUyhjaw4bANDoCzIC6iKsr23y
CSeq: 57689 OPTIONS
Via: SIP/2.0/UDP 10.67.23.219:5060;received=10.67.23.219;rport=5060;branch=z9hG4bKPjYpfXvLmt3-pg0yoCjiuS4rNRhSEFdN3R
Content-Length: 0

-------------------------------------------------
Tue Apr 17 13:05:30 2018 2CAC9 [CMessage::onSendSuccess]
1523941532 -> Tue Apr 17 13:05:30 2018 217c [CTransaction::onSendSuccess] CMessage 2CAC9 send Success
Tue Apr 17 13:05:30 2018 1552 [CDialog::onSendSuccess]
Tue Apr 17 13:05:30 2018 217c [CTransTryingState::createResponse] Final : Transaction changes to Completed state
Tue Apr 17 13:05:30 2018 217c [CTransaction::changeState] STATE CHANGED TO COMPLETED
Tue Apr 17 13:05:30 2018 217c [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:30 2018 1552 [CDialog::onTransactionState(pTrans = 217c, previousState = Trying, currentState = Completed, reason = Final resp creation]
Tue Apr 17 13:05:30 2018 217c [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
Tue Apr 17 13:05:30 2018 1552 [CDialog::updateRouteSet] there are 0 record-route headers
Tue Apr 17 13:05:32 2018 2176 [CTransCompletedState::timerFires] Timer J fires
Tue Apr 17 13:05:32 2018 2176 [CTransCompletedState::timerFires] Timer J : Transaction changes to Terminated state
Tue Apr 17 13:05:32 2018 2176 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Tue Apr 17 13:05:32 2018 2176 [CTransaction::changeState] no transaction state, terminated reason : Timer J fires
Tue Apr 17 13:05:32 2018 [CTransaction::notifyDialog]
Tue Apr 17 13:05:32 2018 [CTransaction::notifyDialog] notify parent dialog
Tue Apr 17 13:05:32 2018 154c [CDialog::onTransactionState(pTrans = 2176, previousState = null, currentState = Terminated, reason = Timer J fires]
Tue Apr 17 13:05:32 2018 154c [CDialog::onTransactionState] dialog is terminated
1523941532 -> Tue Apr 17 13:05:32 2018 154c [CDialog::onTransactionState] onDialogClosed
Tue Apr 17 13:05:32 2018 1109 [CCall::onDialogClosed]
Tue Apr 17 13:05:32 2018 1109 [CCall::onDialogClosed] only initial *********
Tue Apr 17 13:05:32 2018 1109 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Tue Apr 17 13:05:32 2018 1109 [CCall] closed
Tue Apr 17 13:05:32 2018 102 [CCallManager::onCallClosed]
Tue Apr 17 13:05:32 2018 102 [CCallManager::onCallClosed()] Call 1109 closed. Removing call 140483656 from the maps
Tue Apr 17 13:05:32 2018 [CMotorCallManager::onNotifyCallClosed] Call : 52088rTxZUeKDkhmK6lrW2Ub1CeqYbEC is closed.
Tue Apr 17 13:05:32 2018 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Tue Apr 17 13:05:32 2018 102 [CCallManager::onCallClosed] pCall added in the Garbage List
Tue Apr 17 13:05:32 2018 2176 [~CTransaction] transaction 13387 OPTIONS

1523941535 -> Tue Apr 17 13:05:33 2018 102 [CCallManager::removeGarbage] at index i = 0
Tue Apr 17 13:05:33 2018 1109 [CMotorCall::clear_subscription] no subscription managed
Tue Apr 17 13:05:33 2018 1109[CMotorCall::~CMotorCall] Call : 52088rTxZUeKDkhmK6lrW2Ub1CeqYbEC is being destructed.
Tue Apr 17 13:05:33 2018 [DBG: CSipSdpMessage::Destructor]
Tue Apr 17 13:05:33 2018 [DBG: CSipSdpMessage::Destructor] Ends
Tue Apr 17 13:05:33 2018 [DBG: CSipSdpMessage::Destructor]
Tue Apr 17 13:05:33 2018 [DBG: CSipSdpMessage::Destructor] Ends
Tue Apr 17 13:05:33 2018 [CCall::~CCall]
Tue Apr 17 13:05:33 2018 1109 [CCall::TestDegradedModeEnd] nb resources=10
Tue Apr 17 13:05:33 2018 1109 [CCall::~CCall]
Tue Apr 17 13:05:33 2018 1109 [CCall::removeGarbage]
Tue Apr 17 13:05:33 2018 154c [CDialog::~CDialog]
Tue Apr 17 13:05:33 2018 [CResponse::~CResponse]
Tue Apr 17 13:05:33 2018 2CAC3 [~CResponse] resp(403) 52088rTxZUeKDkhmK6lrW2Ub1CeqYbEC 13387 OPTIONS
Tue Apr 17 13:05:33 2018 [CRequest::~CRequest]
Tue Apr 17 13:05:33 2018 2CC20 [~CRequest] req 52088rTxZUeKDkhmK6lrW2Ub1CeqYbEC 13387 OPTIONS
Tue Apr 17 13:05:33 2018 [CRequest::~CRequest] Ends
Tue Apr 17 13:05:33 2018 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Tue Apr 17 13:05:33 2018 [CMessage::~CMessage Ends]
Tue Apr 17 13:05:33 2018 [CResponse::~CResponse Ends]
Tue Apr 17 13:05:33 2018 [CMessage::~CMessage Ends]
Tue Apr 17 13:05:33 2018 [CCall::~CCall] Ends
Tue Apr 17 13:05:35 2018 RECEIVE MESSAGE FROM NETWORK (10.92.131.207:5060 [UDP])
----------------------utf8-----------------------
OPTIONS sip:10.93.9.13;transport=udp SIP/2.0
Via: SIP/2.0/UDP 10.92.131.207:5060;rport;branch=z9hG4bKPjzwH6o.9PUHMOhlxctzZA7yXbX24HSMEx
Max-Forwards: 70
From: <sip:10.92.131.207>;tag=QOuDt.JYk5buiEZpcW5VBFNQCQ8dYWzK
To: <sip:10.93.9.13>
Call-ID: wGHVuwvBTEanQqT3oHj98Y4rdMFpAWYA
CSeq: 51321 OPTIONS
Content-Length: 0

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

1523941535 -> Tue Apr 17 13:05:35 2018 [CIOCom::receiveRequest] optimisation value 1
Tue Apr 17 13:05:35 2018 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => 10.93.9.13 sgsinsuoxn01p
Tue Apr 17 13:05:35 2018 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Tue Apr 17 13:05:35 2018 2CC27 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
Tue Apr 17 13:05:35 2018 [CIOCom::receiveRequest] Received CRequest 2CC27 ref=1
Tue Apr 17 13:05:35 2018 [CIOCom::receiveRequest] rport1 empty
Tue Apr 17 13:05:35 2018 [CIOCom::receiveRequest] Set received param on first Via header : 10.92.131.207
Tue Apr 17 13:05:35 2018 [CDispatcher::onIncomingRequest()]
Tue Apr 17 13:05:35 2018 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Tue Apr 17 13:05:35 2018 [CDispatcher::processRequestFromManagerIndex] Call does not exist or manager changed: Find the new manager to handle
Tue Apr 17 13:05:35 2018 102 [CCallManager::onIncomingRequest()]
Tue Apr 17 13:05:35 2018 [CMotorCallManager::callFactory] For call : wGHVuwvBTEanQqT3oHj98Y4rdMFpAWYA.
Tue Apr 17 13:05:35 2018 1109 [CCall::CCall] resources number: 12

Tue Apr 17 13:05:35 2018 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R12.1 m2.300.19
Tue Apr 17 13:05:35 2018 [CMotorCallManager::callFactory]=85f9c48.
Tue Apr 17 13:05:35 2018 1110 [CCall::receiveRequest] OPTIONS
Tue Apr 17 13:05:35 2018 1110 [CCall::getDialog] Confirmed Dialog is not found (ID = ;QOuDt.JYk5buiEZpcW5VBFNQCQ8dYWzK)
Tue Apr 17 13:05:35 2018 1110 [CCall::getDialog] Initial Dialog Server not found
1523941535 -> Tue Apr 17 13:05:35 2018 1553 [CDialog::receiveRequest]
Tue Apr 17 13:05:35 2018 1553 [CDialog::receiveBasicRequest]
Tue Apr 17 13:05:35 2018 217d [CTransaction::changeState] STATE CHANGED TO INITIAL
Tue Apr 17 13:05:35 2018 217d [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:35 2018 1553 [CDialog::onTransactionState(pTrans = 217d, previousState = Terminated, currentState = Initial, reason = None]
Tue Apr 17 13:05:35 2018 217d [CTransInitialState::receiveRequest] Transaction changes to Trying state
Tue Apr 17 13:05:35 2018 217d [CTransaction::changeState] STATE CHANGED TO TRYING
Tue Apr 17 13:05:35 2018 217d [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:35 2018 1553 [CDialog::onTransactionState(pTrans = 217d, previousState = Initial, currentState = Trying, reason = Request reception]
Tue Apr 17 13:05:35 2018 1553 [CDialog::addTransaction] added transaction 217d with branch z9hG4bKPjzwH6o.9PUHMOhlxctzZA7yXbX24HSMEx, with CSeq 51321
Tue Apr 17 13:05:35 2018 1110 [CCall::receiveRequest] iErrorCode=488.
Tue Apr 17 13:05:35 2018 1110 [CCall::checkAuthentication] OPTIONS
Tue Apr 17 13:05:35 2018 1110[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
Tue Apr 17 13:05:35 2018 1110[CMotorCall::controlAuthentication] ---*--- END-03 ---*--- Control authentication
Tue Apr 17 13:05:35 2018 1110 [CCall::controlAuthentication] need auth =0
Tue Apr 17 13:05:35 2018 1110 [CCall::checkAuthentication] AUTHENT=0
Tue Apr 17 13:05:35 2018 1110 [CCall::checkAuthentication] iRetValue=0
1523941535 -> Tue Apr 17 13:05:35 2018 1110 [CCall::receiveRequest] extGw=-1.
Tue Apr 17 13:05:35 2018 1110 [CCall::receiveRequest] External Authentication by WS is in progress ...
Tue Apr 17 13:05:35 2018 1110[CMotorCall::onReceiveRequest] request received.
Tue Apr 17 13:05:35 2018 1110[CMotorCall::setFilterUsedMode] To be traced = 0
Tue Apr 17 13:05:35 2018 [getFromHeader] look at the From.
Tue Apr 17 13:05:35 2018 [getFromHeader] displayName=.
Tue Apr 17 13:05:35 2018 [convertCSipURLIntoSipuri] uri = sip:10.92.131.207.
Tue Apr 17 13:05:35 2018 [getFromHeader] =@10.92.131.207.
Tue Apr 17 13:05:35 2018 [getFromHeader] clirPresent=0.
Tue Apr 17 13:05:35 2018 [getReqUriHeader] look at the requri.
Tue Apr 17 13:05:35 2018 [convertCSipURLIntoSipuri] uri = sip:10.93.9.13;transport=udp.
Tue Apr 17 13:05:35 2018 1110[CMotorCall::getUserType] extGw=-1.
Tue Apr 17 13:05:35 2018 [CMotorCall::analyseRouting] TEL uri=0.
Tue Apr 17 13:05:35 2018 [CMotorCall::analyseRouting] @10.92.131.207 NOT found in the dictionnary.
Tue Apr 17 13:05:35 2018 [isDomainFromExtGw] Host from request is : 10.92.131.207.
Tue Apr 17 13:05:35 2018 [isDomainFromExtGw] User from request is :
Tue Apr 17 13:05:35 2018 Routing using Via Header
Tue Apr 17 13:05:35 2018 [getExtGWusingViaHeader]GwNumber =1, IPADDRESS inbansuotm01p.dc.ale-international.com
Tue Apr 17 13:05:35 2018 [getExtGWusingViaHeader]GwNumber =9, IPADDRESS 10.108.255.218
Tue Apr 17 13:05:35 2018 [getExtGWusingViaHeader]GwNumber =10, IPADDRESS 10.108.255.210
Tue Apr 17 13:05:35 2018 [getExtGWusingViaHeader]VIA(0) Via: SIP/2.0/UDP 10.92.131.207:5060;received=10.92.131.207;branch=z9hG4bKPjzwH6o.9PUHMOhlxctzZA7yXbX24HSMEx;rport=5060
1523941535 -> Tue Apr 17 13:05:35 2018 Found=-1
Tue Apr 17 13:05:35 2018 [CMotorCall::analyseRouting] @10.92.131.207 is not authenticable.
Tue Apr 17 13:05:35 2018 isUserInDico] NOT found in the dictionnary.
Tue Apr 17 13:05:35 2018 [isAddrInDico] other sip user
Tue Apr 17 13:05:35 2018 1110[CMotorCall::getUserType] extGw=-1.
Tue Apr 17 13:05:35 2018 1110[CMotorCall::initOfUserType] m_other_calling=1 extgw=-1
Tue Apr 17 13:05:35 2018 1110[CMotorCall::onReceiveRequest] accepte? m_other_calling=1 gw=-1.
Tue Apr 17 13:05:35 2018 isNotInTrustedIpAddressList
Tue Apr 17 13:05:35 2018 1110[CMotorCall::onReceiveRequest] system option=0 extGw=-1.
Tue Apr 17 13:05:35 2018 1110[CMotorCall::onReceiveRequest] release the call 403.
Tue Apr 17 13:05:35 2018 1110[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Tue Apr 17 13:05:35 2018 1553 [CCall::findFirstServerTrans]
Tue Apr 17 13:05:35 2018 1553 [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
Tue Apr 17 13:05:35 2018 1110 [CCall::makeGenericResponse] 403
Tue Apr 17 13:05:35 2018 1110 [CCall::getDialog] Confirmed Dialog is not found (ID = ;QOuDt.JYk5buiEZpcW5VBFNQCQ8dYWzK)
Tue Apr 17 13:05:35 2018 1110 [CCall::getDialog] Returning Initial Dialog Server
Tue Apr 17 13:05:35 2018 1553 [CDialog::createResponse] 403
Tue Apr 17 13:05:35 2018 217d [CTransTryingState::createResponse] CResponse 2CACA ref=1
Tue Apr 17 13:05:35 2018 [DBG: CResponse::freeAttributes]
Tue Apr 17 13:05:35 2018 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
1523941535 -> Tue Apr 17 13:05:35 2018 [DBG: CResponse::freeAttributes] Ends
Tue Apr 17 13:05:35 2018 2CACA [CMessage::send] sip_sendMessage (10.92.131.207:5060)
Tue Apr 17 13:05:35 2018 SEND MESSAGE TO NETWORK (10.92.131.207:5060 [UDP]) (BUFF LEN = 482)
----------------------utf8-----------------------
SIP/2.0 403 Forbidden
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
User-Agent: OmniPCX Enterprise R12.1 m2.300.19
To: <sip:10.93.9.13>;tag=d706caffdc47d161e0e0080e80d0b163
From: <sip:10.92.131.207>;tag=QOuDt.JYk5buiEZpcW5VBFNQCQ8dYWzK
Call-ID: wGHVuwvBTEanQqT3oHj98Y4rdMFpAWYA
CSeq: 51321 OPTIONS
Via: SIP/2.0/UDP 10.92.131.207:5060;received=10.92.131.207;rport=5060;branch=z9hG4bKPjzwH6o.9PUHMOhlxctzZA7yXbX24HSMEx
Content-Length: 0

-------------------------------------------------
Tue Apr 17 13:05:35 2018 2CACA [CMessage::onSendSuccess]
Tue Apr 17 13:05:35 2018 217d [CTransaction::onSendSuccess] CMessage 2CACA send Success
Tue Apr 17 13:05:35 2018 1553 [CDialog::onSendSuccess]
Tue Apr 17 13:05:35 2018 217d [CTransTryingState::createResponse] Final : Transaction changes to Completed state
Tue Apr 17 13:05:35 2018 217d [CTransaction::changeState] STATE CHANGED TO COMPLETED
Tue Apr 17 13:05:35 2018 217d [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:35 2018 1553 [CDialog::onTransactionState(pTrans = 217d, previousState = Trying, currentState = Completed, reason = Final resp creation]
Tue Apr 17 13:05:35 2018 217d [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
1523941536 -> Tue Apr 17 13:05:35 2018 1553 [CDialog::updateRouteSet] there are 0 record-route headers

1523941537 -> Tue Apr 17 13:05:37 2018 2178 [CTransCompletedState::timerFires] Timer J fires
Tue Apr 17 13:05:37 2018 2178 [CTransCompletedState::timerFires] Timer J : Transaction changes to Terminated state
Tue Apr 17 13:05:37 2018 2178 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Tue Apr 17 13:05:37 2018 2178 [CTransaction::changeState] no transaction state, terminated reason : Timer J fires
Tue Apr 17 13:05:37 2018 [CTransaction::notifyDialog]
Tue Apr 17 13:05:37 2018 [CTransaction::notifyDialog] notify parent dialog
Tue Apr 17 13:05:37 2018 154e [CDialog::onTransactionState(pTrans = 2178, previousState = null, currentState = Terminated, reason = Timer J fires]
Tue Apr 17 13:05:37 2018 154e [CDialog::onTransactionState] dialog is terminated
Tue Apr 17 13:05:37 2018 154e [CDialog::onTransactionState] onDialogClosed
Tue Apr 17 13:05:37 2018 110b [CCall::onDialogClosed]
Tue Apr 17 13:05:37 2018 110b [CCall::onDialogClosed] only initial *********
Tue Apr 17 13:05:37 2018 110b [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Tue Apr 17 13:05:37 2018 110b [CCall] closed
Tue Apr 17 13:05:37 2018 102 [CCallManager::onCallClosed]
Tue Apr 17 13:05:37 2018 102 [CCallManager::onCallClosed()] Call 110b closed. Removing call 140307208 from the maps
Tue Apr 17 13:05:37 2018 [CMotorCallManager::onNotifyCallClosed] Call : VvPxWBNNPUuEQvIUZhkm25qmCRgUawYY is closed.
Tue Apr 17 13:05:37 2018 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Tue Apr 17 13:05:37 2018 102 [CCallManager::onCallClosed] pCall added in the Garbage List
1523941539 -> Tue Apr 17 13:05:37 2018 2178 [~CTransaction] transaction 22156 OPTIONS
Tue Apr 17 13:05:39 2018 102 [CCallManager::removeGarbage] at index i = 0
Tue Apr 17 13:05:39 2018 110b [CMotorCall::clear_subscription] no subscription managed
Tue Apr 17 13:05:39 2018 110b[CMotorCall::~CMotorCall] Call : VvPxWBNNPUuEQvIUZhkm25qmCRgUawYY is being destructed.
Tue Apr 17 13:05:39 2018 [DBG: CSipSdpMessage::Destructor]
Tue Apr 17 13:05:39 2018 [DBG: CSipSdpMessage::Destructor] Ends
Tue Apr 17 13:05:39 2018 [DBG: CSipSdpMessage::Destructor]
Tue Apr 17 13:05:39 2018 [DBG: CSipSdpMessage::Destructor] Ends
Tue Apr 17 13:05:39 2018 [CCall::~CCall]
Tue Apr 17 13:05:39 2018 110b [CCall::TestDegradedModeEnd] nb resources=10
Tue Apr 17 13:05:39 2018 110b [CCall::~CCall]
Tue Apr 17 13:05:39 2018 110b [CCall::removeGarbage]
Tue Apr 17 13:05:39 2018 154e [CDialog::~CDialog]
Tue Apr 17 13:05:39 2018 [CResponse::~CResponse]
Tue Apr 17 13:05:39 2018 2CAC5 [~CResponse] resp(403) VvPxWBNNPUuEQvIUZhkm25qmCRgUawYY 22156 OPTIONS
Tue Apr 17 13:05:39 2018 [CRequest::~CRequest]
Tue Apr 17 13:05:39 2018 2CC22 [~CRequest] req VvPxWBNNPUuEQvIUZhkm25qmCRgUawYY 22156 OPTIONS
Tue Apr 17 13:05:39 2018 [CRequest::~CRequest] Ends
Tue Apr 17 13:05:39 2018 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Tue Apr 17 13:05:39 2018 [CMessage::~CMessage Ends]
Tue Apr 17 13:05:39 2018 [CResponse::~CResponse Ends]
Tue Apr 17 13:05:39 2018 [CMessage::~CMessage Ends]
Tue Apr 17 13:05:39 2018 [CCall::~CCall] Ends
1523941539 -> Tue Apr 17 13:05:39 2018 2179 [CTransCompletedState::timerFires] Timer J fires
Tue Apr 17 13:05:39 2018 2179 [CTransCompletedState::timerFires] Timer J : Transaction changes to Terminated state
Tue Apr 17 13:05:39 2018 2179 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Tue Apr 17 13:05:39 2018 2179 [CTransaction::changeState] no transaction state, terminated reason : Timer J fires
Tue Apr 17 13:05:39 2018 [CTransaction::notifyDialog]
Tue Apr 17 13:05:39 2018 [CTransaction::notifyDialog] notify parent dialog
Tue Apr 17 13:05:39 2018 154f [CDialog::onTransactionState(pTrans = 2179, previousState = null, currentState = Terminated, reason = Timer J fires]
Tue Apr 17 13:05:39 2018 154f [CDialog::onTransactionState] dialog is terminated
Tue Apr 17 13:05:39 2018 154f [CDialog::onTransactionState] onDialogClosed
Tue Apr 17 13:05:39 2018 110c [CCall::onDialogClosed]
Tue Apr 17 13:05:39 2018 110c [CCall::onDialogClosed] only initial *********
Tue Apr 17 13:05:39 2018 110c [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Tue Apr 17 13:05:39 2018 110c [CCall] closed
Tue Apr 17 13:05:39 2018 102 [CCallManager::onCallClosed]
Tue Apr 17 13:05:39 2018 102 [CCallManager::onCallClosed()] Call 110c closed. Removing call 140331560 from the maps
Tue Apr 17 13:05:39 2018 [CMotorCallManager::onNotifyCallClosed] Call : 0d141279e6bd5a40fb39193a34ca0103@10.93.8.211 is closed.
Tue Apr 17 13:05:39 2018 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Tue Apr 17 13:05:39 2018 102 [CCallManager::onCallClosed] pCall added in the Garbage List
1523941540 -> Tue Apr 17 13:05:39 2018 2179 [~CTransaction] transaction 17056 OPTIONS

1523941544 -> Tue Apr 17 13:05:42 2018 102 [CCallManager::removeGarbage] at index i = 0
Tue Apr 17 13:05:42 2018 110c [CMotorCall::clear_subscription] no subscription managed
Tue Apr 17 13:05:42 2018 110c[CMotorCall::~CMotorCall] Call : 0d141279e6bd5a40fb39193a34ca0103@10.93.8.211 is being destructed.
Tue Apr 17 13:05:42 2018 [DBG: CSipSdpMessage::Destructor]
Tue Apr 17 13:05:42 2018 [DBG: CSipSdpMessage::Destructor] Ends
Tue Apr 17 13:05:42 2018 [DBG: CSipSdpMessage::Destructor]
Tue Apr 17 13:05:42 2018 [DBG: CSipSdpMessage::Destructor] Ends
Tue Apr 17 13:05:42 2018 [CCall::~CCall]
Tue Apr 17 13:05:42 2018 110c [CCall::TestDegradedModeEnd] nb resources=9
Tue Apr 17 13:05:42 2018 110c [CCall::~CCall]
Tue Apr 17 13:05:42 2018 110c [CCall::removeGarbage]
Tue Apr 17 13:05:42 2018 154f [CDialog::~CDialog]
Tue Apr 17 13:05:42 2018 [CResponse::~CResponse]
Tue Apr 17 13:05:42 2018 2CAC6 [~CResponse] resp(200) 0d141279e6bd5a40fb39193a34ca0103@10.93.8.211 17056 OPTIONS
Tue Apr 17 13:05:42 2018 [CRequest::~CRequest]
Tue Apr 17 13:05:42 2018 2CC23 [~CRequest] req 0d141279e6bd5a40fb39193a34ca0103@10.93.8.211 17056 OPTIONS
Tue Apr 17 13:05:42 2018 [CRequest::~CRequest] Ends
Tue Apr 17 13:05:42 2018 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Tue Apr 17 13:05:42 2018 [CMessage::~CMessage Ends]
Tue Apr 17 13:05:42 2018 [CResponse::~CResponse Ends]
Tue Apr 17 13:05:42 2018 [CMessage::~CMessage Ends]
Tue Apr 17 13:05:42 2018 [CCall::~CCall] Ends

1523941546 -> Tue Apr 17 13:05:46 2018 RECEIVE MESSAGE FROM NETWORK (10.23.80.43:5060 [UDP])
----------------------utf8-----------------------
OPTIONS sip:sgsinsuoxn01p.dc.ale-international.com;transport=udp SIP/2.0
Via: SIP/2.0/UDP 10.23.80.43:5060;rport;branch=z9hG4bKPj3KemC3-RmJM8wV6PC9on15j6aHd7GSCh
Max-Forwards: 70
From: <sip:10.23.80.43>;tag=XHYlOvXT2LYBdYf5x8nAr1SSyjbZMVC2
To: <sip:sgsinsuoxn01p.dc.ale-international.com>
Call-ID: Yp5-tTQgzRhPNuoVIGJxeu0UKGD1IQhT
CSeq: 36001 OPTIONS
Content-Length: 0

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

Tue Apr 17 13:05:46 2018 [CIOCom::receiveRequest] optimisation value 1
Tue Apr 17 13:05:46 2018 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => sgsinsuoxn01p.dc.ale-international.com sgsinsuoxn01p
Tue Apr 17 13:05:46 2018 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Tue Apr 17 13:05:46 2018 2CC28 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
Tue Apr 17 13:05:46 2018 [CIOCom::receiveRequest] Received CRequest 2CC28 ref=1
Tue Apr 17 13:05:46 2018 [CIOCom::receiveRequest] rport1 empty
Tue Apr 17 13:05:46 2018 [CIOCom::receiveRequest] Set received param on first Via header : 10.23.80.43
Tue Apr 17 13:05:46 2018 [CDispatcher::onIncomingRequest()]
Tue Apr 17 13:05:46 2018 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Tue Apr 17 13:05:46 2018 [CDispatcher::processRequestFromManagerIndex] Call does not exist or manager changed: Find the new manager to handle
Tue Apr 17 13:05:46 2018 102 [CCallManager::onIncomingRequest()]
1523941546 -> Tue Apr 17 13:05:46 2018 [CMotorCallManager::callFactory] For call : Yp5-tTQgzRhPNuoVIGJxeu0UKGD1IQhT.
Tue Apr 17 13:05:46 2018 110b [CCall::CCall] resources number: 11

Tue Apr 17 13:05:46 2018 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R12.1 m2.300.19
Tue Apr 17 13:05:46 2018 [CMotorCallManager::callFactory]=85ceb08.
Tue Apr 17 13:05:46 2018 1111 [CCall::receiveRequest] OPTIONS
Tue Apr 17 13:05:46 2018 1111 [CCall::getDialog] Confirmed Dialog is not found (ID = ;XHYlOvXT2LYBdYf5x8nAr1SSyjbZMVC2)
Tue Apr 17 13:05:46 2018 1111 [CCall::getDialog] Initial Dialog Server not found
Tue Apr 17 13:05:46 2018 1554 [CDialog::receiveRequest]
Tue Apr 17 13:05:46 2018 1554 [CDialog::receiveBasicRequest]
Tue Apr 17 13:05:46 2018 217e [CTransaction::changeState] STATE CHANGED TO INITIAL
Tue Apr 17 13:05:46 2018 217e [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:46 2018 1554 [CDialog::onTransactionState(pTrans = 217e, previousState = Terminated, currentState = Initial, reason = None]
Tue Apr 17 13:05:46 2018 217e [CTransInitialState::receiveRequest] Transaction changes to Trying state
Tue Apr 17 13:05:46 2018 217e [CTransaction::changeState] STATE CHANGED TO TRYING
Tue Apr 17 13:05:46 2018 217e [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:46 2018 1554 [CDialog::onTransactionState(pTrans = 217e, previousState = Initial, currentState = Trying, reason = Request reception]
Tue Apr 17 13:05:46 2018 1554 [CDialog::addTransaction] added transaction 217e with branch z9hG4bKPj3KemC3-RmJM8wV6PC9on15j6aHd7GSCh, with CSeq 36001
1523941546 -> Tue Apr 17 13:05:46 2018 1111 [CCall::receiveRequest] iErrorCode=488.
Tue Apr 17 13:05:46 2018 1111 [CCall::checkAuthentication] OPTIONS
Tue Apr 17 13:05:46 2018 1111[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
Tue Apr 17 13:05:46 2018 1111[CMotorCall::controlAuthentication] ---*--- END-03 ---*--- Control authentication
Tue Apr 17 13:05:46 2018 1111 [CCall::controlAuthentication] need auth =0
Tue Apr 17 13:05:46 2018 1111 [CCall::checkAuthentication] AUTHENT=0
Tue Apr 17 13:05:46 2018 1111 [CCall::checkAuthentication] iRetValue=0
Tue Apr 17 13:05:46 2018 1111 [CCall::receiveRequest] extGw=-1.
Tue Apr 17 13:05:46 2018 1111 [CCall::receiveRequest] External Authentication by WS is in progress ...
Tue Apr 17 13:05:46 2018 1111[CMotorCall::onReceiveRequest] request received.
Tue Apr 17 13:05:46 2018 1111[CMotorCall::setFilterUsedMode] To be traced = 0
Tue Apr 17 13:05:46 2018 [getFromHeader] look at the From.
Tue Apr 17 13:05:46 2018 [getFromHeader] displayName=.
Tue Apr 17 13:05:46 2018 [convertCSipURLIntoSipuri] uri = sip:10.23.80.43.
Tue Apr 17 13:05:46 2018 [getFromHeader] =@10.23.80.43.
Tue Apr 17 13:05:46 2018 [getFromHeader] clirPresent=0.
Tue Apr 17 13:05:46 2018 [getReqUriHeader] look at the requri.
Tue Apr 17 13:05:46 2018 [convertCSipURLIntoSipuri] uri = sip:sgsinsuoxn01p.dc.ale-international.com;transport=udp.
Tue Apr 17 13:05:46 2018 1111[CMotorCall::getUserType] extGw=-1.
Tue Apr 17 13:05:46 2018 [CMotorCall::analyseRouting] TEL uri=0.
1523941546 -> Tue Apr 17 13:05:46 2018 [CMotorCall::analyseRouting] @10.23.80.43 NOT found in the dictionnary.
Tue Apr 17 13:05:46 2018 [isDomainFromExtGw] Host from request is : 10.23.80.43.
Tue Apr 17 13:05:46 2018 [isDomainFromExtGw] User from request is :
Tue Apr 17 13:05:46 2018 Routing using Via Header
Tue Apr 17 13:05:46 2018 [getExtGWusingViaHeader]GwNumber =1, IPADDRESS inbansuotm01p.dc.ale-international.com
Tue Apr 17 13:05:46 2018 [getExtGWusingViaHeader]GwNumber =9, IPADDRESS 10.108.255.218
Tue Apr 17 13:05:46 2018 [getExtGWusingViaHeader]GwNumber =10, IPADDRESS 10.108.255.210
Tue Apr 17 13:05:46 2018 [getExtGWusingViaHeader]VIA(0) Via: SIP/2.0/UDP 10.23.80.43:5060;received=10.23.80.43;branch=z9hG4bKPj3KemC3-RmJM8wV6PC9on15j6aHd7GSCh;rport=5060
Tue Apr 17 13:05:46 2018 Found=-1
Tue Apr 17 13:05:46 2018 [CMotorCall::analyseRouting] @10.23.80.43 is not authenticable.
Tue Apr 17 13:05:46 2018 isUserInDico] NOT found in the dictionnary.
Tue Apr 17 13:05:46 2018 [isAddrInDico] other sip user
Tue Apr 17 13:05:46 2018 1111[CMotorCall::getUserType] extGw=-1.
Tue Apr 17 13:05:46 2018 1111[CMotorCall::initOfUserType] m_other_calling=1 extgw=-1
Tue Apr 17 13:05:46 2018 1111[CMotorCall::onReceiveRequest] accepte? m_other_calling=1 gw=-1.
Tue Apr 17 13:05:46 2018 isNotInTrustedIpAddressList
Tue Apr 17 13:05:46 2018 1111[CMotorCall::onReceiveRequest] system option=0 extGw=-1.
Tue Apr 17 13:05:46 2018 1111[CMotorCall::onReceiveRequest] release the call 403.
Tue Apr 17 13:05:46 2018 1111[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
1523941546 -> Tue Apr 17 13:05:46 2018 1554 [CCall::findFirstServerTrans]
Tue Apr 17 13:05:46 2018 1554 [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
Tue Apr 17 13:05:46 2018 1111 [CCall::makeGenericResponse] 403
Tue Apr 17 13:05:46 2018 1111 [CCall::getDialog] Confirmed Dialog is not found (ID = ;XHYlOvXT2LYBdYf5x8nAr1SSyjbZMVC2)
Tue Apr 17 13:05:46 2018 1111 [CCall::getDialog] Returning Initial Dialog Server
Tue Apr 17 13:05:46 2018 1554 [CDialog::createResponse] 403
Tue Apr 17 13:05:46 2018 217e [CTransTryingState::createResponse] CResponse 2CACB ref=1
Tue Apr 17 13:05:46 2018 [DBG: CResponse::freeAttributes]
Tue Apr 17 13:05:46 2018 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Tue Apr 17 13:05:46 2018 [DBG: CResponse::freeAttributes] Ends
Tue Apr 17 13:05:46 2018 2CACB [CMessage::send] sip_sendMessage (10.23.80.43:5060)
Tue Apr 17 13:05:46 2018 SEND MESSAGE TO NETWORK (10.23.80.43:5060 [UDP]) (BUFF LEN = 504)
----------------------utf8-----------------------
SIP/2.0 403 Forbidden
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
User-Agent: OmniPCX Enterprise R12.1 m2.300.19
To: <sip:sgsinsuoxn01p.dc.ale-international.com>;tag=37c07f1d52c54e606240ad31f2d60795
From: <sip:10.23.80.43>;tag=XHYlOvXT2LYBdYf5x8nAr1SSyjbZMVC2
Call-ID: Yp5-tTQgzRhPNuoVIGJxeu0UKGD1IQhT
CSeq: 36001 OPTIONS
Via: SIP/2.0/UDP 10.23.80.43:5060;received=10.23.80.43;rport=5060;branch=z9hG4bKPj3KemC3-RmJM8wV6PC9on15j6aHd7GSCh
Content-Length: 0

-------------------------------------------------
1523941547 -> Tue Apr 17 13:05:46 2018 2CACB [CMessage::onSendSuccess]
Tue Apr 17 13:05:46 2018 217e [CTransaction::onSendSuccess] CMessage 2CACB send Success
Tue Apr 17 13:05:46 2018 1554 [CDialog::onSendSuccess]
Tue Apr 17 13:05:46 2018 217e [CTransTryingState::createResponse] Final : Transaction changes to Completed state
Tue Apr 17 13:05:46 2018 217e [CTransaction::changeState] STATE CHANGED TO COMPLETED
Tue Apr 17 13:05:46 2018 217e [CTransaction::changeState] notifying the parent dialog
Tue Apr 17 13:05:46 2018 1554 [CDialog::onTransactionState(pTrans = 217e, previousState = Trying, currentState = Completed, reason = Final resp creation]
Tue Apr 17 13:05:46 2018 217e [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
Tue Apr 17 13:05:46 2018 1554 [CDialog::updateRouteSet] there are 0 record-route headers
Tue Apr 17 13:05:47 2018 RECEIVE MESSAGE FROM NETWORK (10.93.8.211:5160 [UDP])

[DRaGoN_KNigHT]

Awww... Guys it was an issue related to user dialing... That boy was dialing using DID number instead of short code... Thanks for all your support !!

[alex]

Tue Apr 17 13:05:30 2018 isNotInTrustedIpAddressList