Hi
We have a problem at a client where certain numbers cannot be dialed over the sip trunk.
We have an UX2000 NET Gateway integrating Lync and Polycom and PABX (OXE) with SIP Trunk.
Any number can be dialed from the pabx so there is no barring issue. But if people use their Lync extension to dial out (VIA PABX) some numbers do not work. These numbers all fall in area 4 on my pabx but other numbers in the same area work perfectly so its also not barring problem there but seems like specific numbers only.
We had the guys from the gateway at the client over the weekend and after they upgraded their firmware one of the numbers which previously did not work suddenly started working but the other ones are still not which makes me suspect the Gateway is the problem but I need to prove it.
I have attached 3 traces. 087 cannot be dialed but 041 can be dialed. Please can someone assist me in analyzing these traces as I cannot see why I am getting the error 488?
Pabx is 196.5.234.252 xm
196.5.234.250 xa
UX gateway 196.5.234.253
thank you
Martin
Problem dialing from Lync
Problem dialing from Lync
You do not have the required permissions to view the files attached to this post.
Re: Problem dialing from Lync
Does nobody have any idea?
Re: Problem dialing from Lync
try to get logs with "motortrace 7".
If it looks like a duck, swims like a duck, and quacks like a duck, then it probably is a duck.
Re: Problem dialing from Lync
Ok Alex I will do and post it. Thank you
Re: Problem dialing from Lync
I did motortrace 6. Hope this helps?
(101)xa001001> motortrace 6
motortrace (v5.2.0) verbosity = 0037b524
sipmotor trace-level set 6 (All traces + TRANSPORT + ADNS).
(101)xa001001> traced
** UNIX-trace-daemon started ... (static user group No 1) **
traced started ...
1433920552 -> [CTransaction::notifyDialog]
1433920552 -> [CTransaction::notifyDialog] notify parent dialog
1433920552 -> 157f [CDialog::onTransactionState(pTrans = 2108, previousState = null, currentState = Terminated, reason = None]
1433920552 -> 157f [CDialog::onTransactionState] dialog is terminated
1433920552 -> 157f [CDialog::onTransactionState] onDialogClosed
1433920552 -> 11f3 [CCall::onDialogClosed]
1433920552 -> 11f3 [CCall::onDialogClosed] only initial *********
1433920552 -> 11f3 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920552 -> 2108 [~CTransaction] transaction 1 REGISTER
1433920552 -> [CTransaction::notifyDialog]
1433920552 -> [CTransaction::notifyDialog] notify parent dialog
1433920552 -> 1580 [CDialog::onTransactionState(pTrans = 2109, previousState = null, currentState = Terminated, reason = None]
1433920552 -> 1580 [CDialog::onTransactionState] dialog is terminated
1433920552 -> 1580 [CDialog::onTransactionState] onDialogClosed
1433920552 -> 11f4 [CCall::onDialogClosed]
1433920552 -> 11f4 [CCall::onDialogClosed] only initial *********
1433920552 -> 11f4 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920552 -> 2109 [~CTransaction] transaction 1 REGISTER
1433920552 -> 485D7 [~CRequest] req 17e3a14d-23590116-afde72e3@10.51.82.55 1 REGISTER
1433920552 -> info [CServRegistrar::writeLocateFile]
1433920552 -> 102 [CCallManager::removeGarbage] at index i = 2
1433920552 -> 11f4[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920552 -> 11f4 [CCall::~CCall]
1433920552 -> 11f4 [CCall::removeGarbage]
1433920552 -> 1580 [CDialog::~CDialog]
1433920552 -> 102 [CCallManager::removeGarbage] at index i = 1
1433920552 -> 11f2[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920552 -> 11f2 [CCall::~CCall]
1433920552 -> 11f2 [CCall::removeGarbage]
1433920552 -> 157e [CDialog::~CDialog]
1433920552 -> 102 [CCallManager::removeGarbage] at index i = 0
1433920552 -> 11ef[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920552 -> 11ef [CCall::~CCall]
1433920552 -> 11ef [CCall::removeGarbage]
1433920552 -> 157a [CDialog::~CDialog]
1433920552 -> 104 [CCallManager::removeGarbage] at index i = 2
1433920552 -> 11f3 [CCall::~CCall]
1433920552 -> 11f3 [CCall::removeGarbage]
1433920552 -> 157f [CDialog::~CDialog]
1433920552 -> 104 [CCallManager::removeGarbage] at index i = 1
1433920552 -> 11f1 [CCall::~CCall]
1433920552 -> 11f1 [CCall::removeGarbage]
1433920552 -> 157d [CDialog::~CDialog]
1433920552 -> 104 [CCallManager::removeGarbage] at index i = 0
1433920552 -> 11ee [CCall::~CCall]
1433920552 -> 11ee [CCall::removeGarbage]
1433920552 -> 1579 [CDialog::~CDialog]
1433920554 -> 2105 [CTransTryingState::timerFires] Timer E fires
1433920554 -> SEND MESSAGE TO NETWORK (196.5.234.93:5060 [UDP]) (BUFF LEN = 645)
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920554 -> [CTransport::findConnection] pConnection = f048
1433920554 -> [CTransport::getConnection] RemoteHost=(196.5.234.93 5060) already exist, using connection f048
1433920554 -> udp_send fd:3
1433920554 -> udp_send fd:3 port 5060 iBytesSend:645 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
1433920554 -> f048 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920554 -> 2105 [CTransaction::startTimer] Timer E is started (delay = 4000 ms)
1433920554 -> udp_recv fd:3
1433920554 -> udp_recv fd:3 iBytesRead:534 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
1433920554 -> UdpInputProc iSock:3 iBytesRead:534 Host:10.51.82.55 Port:5060
1433920554 -> [CTransportUdp::receiveMessage] from 10.51.82.55:5060 rc:534
1433920554 -> [CTransport::findConnection] pConnection = f047
1433920554 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) MaxNbMsgByPeriod:25 Period:3
1433920554 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) NbMsg:3 < seuil
1433920554 -> f047 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920554 -> RECEIVE MESSAGE FROM NETWORK (10.51.82.55:5060 [UDP])
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920554 -> 485D8 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920554 -> [CIOCom::receiveRequest] Received CRequest 485D8 ref=1
1433920554 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920554 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920554 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920554 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920554 -> [CIOCom::receiveRequest] rport1 not empty
1433920554 -> [CDispatcher::onIncomingRequest()]
1433920554 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920554 -> 104 [CCallManager::onIncomingRequest()]
1433920554 -> 11f5 [CCall::receiveRequest] REGISTER
1433920554 -> 11f5 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920554 -> 11f5 [CCall::getDialog] Initial Dialog Server not found
1433920554 -> 1581 [CDialog::receiveRequest]
1433920554 -> 1581 [CDialog::receiveBasicRequest]
1433920554 -> 210a [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920554 -> 210a [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1581 [CDialog::onTransactionState(pTrans = 210a, previousState = Terminated, currentState = Initial, reason = None]
1433920554 -> 210a [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920554 -> 210a [CTransaction::changeState] STATE CHANGED TO TRYING
1433920554 -> 210a [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1581 [CDialog::onTransactionState(pTrans = 210a, previousState = Initial, currentState = Trying, reason = Request reception]
1433920554 -> 1581 [CDialog::addTransaction] added transaction 210a with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920554 -> 11f5 [CCall::checkAuthentication] REGISTER
1433920554 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920554 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920554 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920554 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920554 -> [CGWMngData::isMainServer ] check the request for PCS
1433920554 -> check_PCS_ACTIVE start
1433920554 -> check_PCS_ACTIVE get the PCS state
1433920554 -> check_PCSstate
1433920554 -> am_I_PCS SCSWorking : NO
1433920554 -> OXE contains PCS configuration
1433920554 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920554 -> check_PCSstate ipadd 10.51.82.55
1433920554 -> check_PCSstate user IP is Found ? = YES
1433920554 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920554 -> [isDomainFromGwExt] no User from request.
1433920554 -> check_PCS_ACTIVE extgwid -1
1433920554 -> The recevied host 10.51.82.55
1433920554 -> Trying to find the ip address in domain list
1433920554 -> The entry dom : 1 add_type=2
1433920554 -> The entry dom ip low :196.9.33.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The entry dom : 2 add_type=2
1433920554 -> The entry dom ip low :196.9.69.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The user is ipadd not in any Domain range return state as -1
1433920554 -> check_PCSstate stat of PCS is : -1
1433920554 -> check_PCS_ACTIVE the PCS state -1
1433920554 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920554 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920554 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920554 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920554 -> [isDomainFromGwExt] no User from request.
1433920554 -> [domain not from an External Gateway.
1433920554 -> 11f5 [CRegistrarCall::onReceiveRequest] REGISTER
1433920554 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920554 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920554 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920554 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920554 -> [CGWMngData::isMainServer ] check the request for PCS
1433920554 -> check_PCS_ACTIVE start
1433920554 -> check_PCS_ACTIVE get the PCS state
1433920554 -> check_PCSstate
1433920554 -> am_I_PCS SCSWorking : NO
1433920554 -> OXE contains PCS configuration
1433920554 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920554 -> check_PCSstate ipadd 10.51.82.55
1433920554 -> check_PCSstate user IP is Found ? = YES
1433920554 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920554 -> [isDomainFromGwExt] no User from request.
1433920554 -> check_PCS_ACTIVE extgwid -1
1433920554 -> The recevied host 10.51.82.55
1433920554 -> Trying to find the ip address in domain list
1433920554 -> The entry dom : 1 add_type=2
1433920554 -> The entry dom ip low :196.9.33.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The entry dom : 2 add_type=2
1433920554 -> The entry dom ip low :196.9.69.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The user is ipadd not in any Domain range return state as -1
1433920554 -> check_PCSstate stat of PCS is : -1
1433920554 -> check_PCS_ACTIVE the PCS state -1
1433920554 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920554 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920554 -> [CServRegistrar::processRegister]
1433920554 -> 11f5 [CRegistrarCall::onReceiveRequest], user not found => kill session
1433920554 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920554 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f5
1433920554 -> 11f5 [CCall::killSession]
1433920554 -> 210a [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920554 -> 210a [CTransaction::changeState] no transaction state, terminated reason : None
1433920554 -> 11f5 [CCall::onKill Session Call manager close is called]
1433920554 -> 11f5 [CCall::killSession] notifying the call manager
1433920554 -> 104 [CCallManager::onCallClosed]
1433920554 -> 104 [CCallManager::onCallClosed()] Call 11f5 closed. Removing call 495251872 from the maps
1433920554 -> [CCall::onKill] set callmanager to null
1433920554 -> 102 [CCallManager::onIncomingRequest()]
1433920554 -> [CMotorCallManager::callFactory] For call : 17e3a14d-23590116-afde72e3@10.51.82.55.
1433920554 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.21
1433920554 -> [CMotorCallManager::callFactory]=1d95d0b0.
1433920554 -> 11f6 [CCall::receiveRequest] REGISTER
1433920554 -> 11f6 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920554 -> 11f6 [CCall::getDialog] Initial Dialog Server not found
1433920554 -> 1582 [CDialog::receiveRequest]
1433920554 -> 1582 [CDialog::receiveBasicRequest]
1433920554 -> 210b [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920554 -> 210b [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1582 [CDialog::onTransactionState(pTrans = 210b, previousState = Terminated, currentState = Initial, reason = None]
1433920554 -> 210b [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920554 -> 210b [CTransaction::changeState] STATE CHANGED TO TRYING
1433920554 -> 210b [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1582 [CDialog::onTransactionState(pTrans = 210b, previousState = Initial, currentState = Trying, reason = Request reception]
1433920554 -> 1582 [CDialog::addTransaction] added transaction 210b with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920554 -> 11f6 [CCall::checkAuthentication] REGISTER
1433920554 -> 11f6[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920554 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920554 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920554 -> [isDomainFromGwExt] User from request is : 7672
1433920554 -> [domain not from an External Gateway.
1433920554 -> [getFromHeader].
1433920554 -> [isUserDeclared] 7672@196.5.234.93
1433920554 -> isUserDeclared] NOT found in the dictionnary.
1433920554 -> [isSeplosStation] other station
1433920554 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920554 -> [isDomainFromGwExt] User from request is : 7672
1433920554 -> 11f6[CMotorCall::toGatewayOrProxy] request for proxydomain=196.5.234.93.
1433920554 -> 11f6[CMotorCall::toGatewayOrProxy] request for proxy (ReqUri domain unknown).
1433920554 -> 11f6[CMotorCall::toGatewayOrProxy] rout to proxy.
1433920554 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920554 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f6
1433920554 -> 11f6 [CCall::killSession]
1433920554 -> 210b [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920554 -> 210b [CTransaction::changeState] no transaction state, terminated reason : None
1433920554 -> 11f6 [CCall::onKill Session Call manager close is called]
1433920554 -> 11f6 [CCall::killSession] notifying the call manager
1433920554 -> 102 [CCallManager::onCallClosed]
1433920554 -> 102 [CCallManager::onCallClosed()] Call 11f6 closed. Removing call 496357552 from the maps
1433920554 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920554 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920554 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1433920554 -> [CCall::onKill] set callmanager to null
1433920554 -> 103 [CCallManager::onIncomingRequest()]
1433920554 -> 11f0 [CCall::receiveRequest] REGISTER
1433920554 -> 11f0 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920554 -> 11f0 [CCall::getDialog] Returning Initial Dialog Server
1433920554 -> 157b [CDialog::receiveRequest]
1433920554 -> 157b [CDialog::receiveBasicRequest]
1433920554 -> 157b [CDialog::receiveBasicRequest] A basic server transaction is found with the same branch
1433920554 -> [CTransaction::notifyDialog]
1433920554 -> [CTransaction::notifyDialog] notify parent dialog
1433920554 -> 1581 [CDialog::onTransactionState(pTrans = 210a, previousState = null, currentState = Terminated, reason = None]
1433920554 -> 1581 [CDialog::onTransactionState] dialog is terminated
1433920554 -> 1581 [CDialog::onTransactionState] onDialogClosed
1433920554 -> 11f5 [CCall::onDialogClosed]
1433920554 -> 11f5 [CCall::onDialogClosed] only initial *********
1433920554 -> 11f5 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920554 -> 210A [~CTransaction] transaction 1 REGISTER
1433920554 -> [CTransaction::notifyDialog]
1433920554 -> [CTransaction::notifyDialog] notify parent dialog
1433920554 -> 1582 [CDialog::onTransactionState(pTrans = 210b, previousState = null, currentState = Terminated, reason = None]
1433920554 -> 1582 [CDialog::onTransactionState] dialog is terminated
1433920554 -> 1582 [CDialog::onTransactionState] onDialogClosed
1433920554 -> 11f6 [CCall::onDialogClosed]
1433920554 -> 11f6 [CCall::onDialogClosed] only initial *********
1433920554 -> 11f6 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920554 -> 210B [~CTransaction] transaction 1 REGISTER
1433920554 -> 485D8 [~CRequest] req 17e3a14d-23590116-afde72e3@10.51.82.55 1 REGISTER
1433920555 -> EAu: Block Memory Size: 1086060
1433920555 -> EAu: Dupli window: 0/1 (max: 1)
1433920555 -> 102 [CCallManager::removeGarbage] at index i = 0
1433920555 -> 11f6[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920555 -> 11f6 [CCall::~CCall]
1433920555 -> 11f6 [CCall::removeGarbage]
1433920555 -> 1582 [CDialog::~CDialog]
1433920555 -> 104 [CCallManager::removeGarbage] at index i = 0
1433920555 -> 11f5 [CCall::~CCall]
1433920555 -> 11f5 [CCall::removeGarbage]
1433920555 -> 1581 [CDialog::~CDialog]
1433920556 -> [CTransport::AcceptConnection] Remote=(196.5.234.253 25102) OK
1433920556 -> [CTransport::findConnection] pConnection = 0
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> [CTransportTcp::acceptConnection] new connection = f09b
1433920556 -> [CTransport::setChannelOptions] channel=496846848 iResult=0 iTosset for this channel is 184
1433920556 -> [CTransport::setChannelOptions] channel=496846848 iResult=0 VLanpriority set for this channelis 5
1433920556 -> [CTransport::setChannelOptions] channel=496846848 iResult=0
1433920556 -> [CTransport::addConnection] Insert connection f09b with key = 196.5.234.253|25102
1433920556 -> [CTransportTcp::acceptConnection] Remote=(196.5.234.253 25102) CNX created OK
1433920556 -> [CTransport::AcceptConnection] Remote=(196.5.234.253 25102) OK
1433920556 -> f09b [CConnectionTcp::receiveMsg] Receiveing message, rc = 931
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) MaxNbMsgByPeriod:25 Period:3
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) NbMsg:1 < seuil
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> RECEIVE MESSAGE FROM NETWORK (196.5.234.253:25102 [TCP])
----------------------utf8-----------------------
INVITE sip:50877405000@196.5.234.252:5060;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, OPTIONS, REFER, REGISTER, INFO, UPDATE, PRACK
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
Contact: <sip:+27102216592@196.5.234.253:5060;transport=TCP>
Content-Length: 239
Content-Type: application/sdp
CSeq: 2 INVITE
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Max-Forwards: 69
Min-SE: 500
Session-Expires: 3600
Supported: replaces,update,timer,100rel
To: <sip:50877405000@196.5.234.252:5060;user=phone>
User-Agent: SONUS SBC2000 4.1.1v377 UX
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
v=0
o=SBC 1410 1001 IN IP4 196.5.234.253
s=VoipCall
c=IN IP4 196.5.234.253
t=0 0
m=audio 17038 RTP/AVP 8 101
c=IN IP4 196.5.234.253
a=rtpmap:8 PCMA/8000/1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=sendrecv
-------------------------------------------------
1433920556 -> 485D9 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920556 -> [CIOCom::receiveRequest] Received CRequest 485D9 ref=1
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CDispatcher::onIncomingRequest()]
1433920556 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920556 -> 102 [CCallManager::onIncomingRequest()]
1433920556 -> [CMotorCallManager::callFactory] For call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253.
1433920556 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.21
1433920556 -> [CMotorCallManager::callFactory]=1da542b8.
1433920556 -> 11f7 [CCall::receiveRequest] INVITE
1433920556 -> 11f7 [CCall::getDialog] Confirmed Dialog is not found (ID = ;c405eafd-c989)
1433920556 -> 11f7 [CCall::getDialog] Initial Dialog Server not found
1433920556 -> 1583 [CDialog::receiveRequest]
1433920556 -> 1583 [CDialog::receiveInviteRequest]
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Terminated, currentState = Initial, reason = None]
1433920556 -> 210c [CTransInitialState::receiveRequest] Transaction changes to Proceeding state
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO PROCEEDING
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Initial, currentState = Proceeding, reason = Request reception]
1433920556 -> 210c [CTransProceedingState::createResponse] CResponse 29E93 ref=1
1433920556 -> 29E93 [CMessage::send] sip_sendMessage (196.5.234.253:5060)
1433920556 -> SEND MESSAGE TO NETWORK (196.5.234.253:25102 [TCP]) (BUFF LEN = 331)
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:50877405000@196.5.234.252:5060;user=phone>
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
CSeq: 2 INVITE
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
Content-Length: 0
-------------------------------------------------
1433920556 -> [CTransport::findConnection] pConnection = f09b
1433920556 -> [CTransport::getConnection] RemoteHost=(196.5.234.253 25102) already exist, using connection f09b
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> 1583 [CDialog::receiveInviteRequest] a new Server INVITE transaction is in progress
1433920556 -> [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Server, UA)
1433920556 -> [CSessionTimerContext::updateAfterRefreshReception] Update CSessionTimerContext (refresh reception)
1433920556 -> [CSessionTimerContext::updateSupported] Request timer supported
1433920556 -> [CSessionTimerContext::updateMinSE] Min-SE updated : 500
1433920556 -> [CSessionTimerContext::updateSessionExpires] header value : 3600
1433920556 -> [CSessionTimerContext::updateSessionExpires] updated
1433920556 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 3600
1433920556 -> [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=UPDATE
1433920556 -> 1583 [CDialog::addTransaction] added transaction 210c with branch z9hG4bK-UX-c405-eafd-22f0, with CSeq 2
1433920556 -> 11f7 [CCall::checkAuthentication] INVITE
1433920556 -> 11f7[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920556 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.253 .
1433920556 -> [isDomainFromGwExt] Host from request is : 196.5.234.253.
1433920556 -> [isDomainFromGwExt] User from request is : +27102216592
1433920556 -> isDomainFromGwExt--> GwExt=1
1433920556 -> domain from External Gateway 1.
1433920556 -> 11f7[CMotorCall::setFilterUsedMode] To be traced = 0
1433920556 -> [getFromHeader].
1433920556 -> [isUserDeclared] +27102216592@196.5.234.253
1433920556 -> isUserDeclared] NOT found in the dictionnary.
1433920556 -> [isSeplosStation] other station
1433920556 -> [isDomainFromGwExt] Host from request is : 196.5.234.253.
1433920556 -> [isDomainFromGwExt] User from request is : +27102216592
1433920556 -> isDomainFromGwExt--> GwExt=1
1433920556 -> 11f7[CMotorCall::toGatewayOrProxy] request for proxydomain=196.5.234.252.
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> 11f7[CMotorCall ABCF ExtGW
1433920556 -> [isUserRegistred] getRegistration=50877405000.
1433920556 -> [isUserRegistred] result=-1.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] request for gateway.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] state = INITIAL_STATE.
1433920556 -> 11f7[CMotorCall::methodInviteReceived] nb available licenses=3 .
1433920556 -> [isUserDeclared] +27102216592@196.5.234.253
1433920556 -> isUserDeclared] NOT found in the dictionnary.
1433920556 -> 11f7[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
1433920556 -> 11f7[CMotorCall::methodInviteReceived] Invite => update the inviteContext.
1433920556 -> [CForkedBranch::CForkedBranch] context = 0x1da546ec.
1433920556 -> 11f7[CMotorCall::methodInviteReceived] reqUri stored: sip:+27102216592@196.5.234.253:5060;transport=TCP
1433920556 -> 11f7[CMotorCall::methodInviteReceived] CAC = 0
1433920556 -> [receiveInviteMessage] Call: call-8C366E0B-0000-0010-150E-54C@196.5.234.253 eqt: -1 INITIAL_STATE received a message.
1433920556 -> [decodeInviteCLIR].
1433920556 -> [receiveInviteMessage] INFO present in Allow header
1433920556 -> [receiveInviteMessage] UPDATE present in Allow header
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> am_I_PCS SCSWorking : NO
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> check_extgw_PCSstate EXTGW is : 1
1433920556 -> The check_extgw_PCSstate extgwid : 1
1433920556 -> The state of PCS which rescued the extgw is : -1
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> [isSessionTimerTooSmall].
1433920556 -> 11f7[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=0 uacRefresher=0.
1433920556 -> [decodeInviteSDP].
1433920556 -> [checkSdpValidity] Sdp contains 1 media description(s).
1433920556 -> [checkSdpValidity] Media 0 type 1 contains 2 formats.
1433920556 -> [checkSdpValidity] Format : 8.
1433920556 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1433920556 -> [convertSdpIntoTsdp] No Direction in the session part.
1433920556 -> [convertSdpIntoTsdp] Check the direction in Session part - result:0.
1433920556 -> [convertSdpIntoTsdp] The audio media contains 2 format(s).
1433920556 -> [convertSdpIntoTsdp] Format 0 is 8.
1433920556 -> [convertSdpIntoTsdp] Format 1 is 101.
1433920556 -> [convertSdpIntoTsdp] Get the direction.
1433920556 -> [convertSdpIntoTsdp] Direction is sendrecv.
1433920556 -> [convertSdpIntoTsdp] The connection is at media level.
1433920556 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 196.5.234.253.
1433920556 -> [convertIPStrIntoTuipv] 196.5.234.253 => 196.5.234.253
1433920556 -> [receiveInviteMessage] NO 100rel REQUIRED for this call.
1433920556 -> [isCACWithInvalidMediaAddr].
1433920556 -> [decodeInviteTo].
1433920556 -> [decodeInviteReferredBy].
1433920556 -> [decodeInviteACSBU].
1433920556 -> 11f7[CMotorCall::setFilterUsedMode] To be traced = 0
1433920556 -> 11f7[emitEventToMonitel] content size (lginfo): 656
1433920556 -> [ipc_thread] IPC Thread : Ipc reception 2325.
1433920556 -> [ipc_thread] IPC Thread : TCL thread signaled.
1433920556 -> [CMotorCallManager::insertCallwithEqt] CMotorCall 5216 inserted.
1433920556 -> 11f7[sendLgEvtSipCreate] Event sent on eqt : 5216
1433920556 -> 11f7[CMotorCall::getOutgoingCall] outgoingCall:0
1433920556 -> 11f7 [CCall::getCallDuplicationData]
1433920556 -> [CViaSetSerializer::copy] Added via 7cb6 at index 0
1433920556 -> 11f7 [CCall::getCallDuplicationData] : Request URI = sip:50877405000@196.5.234.252:5060;user=phone, Call ID = call-8C366E0B-0000-0010-150E-54C@196.5.234.253, Local URI = sip:50877405000@196.5.234.252:5060;user=phone, Local Tag = , Remote URI = sip:+27102216592@196.5.234.253:5060;user=phone, Remote Tag = c405eafd-c989, Local CSeq = 329690144, Remote CSeq = 2
1433920556 -> [CViaSetSerializer::serialize] Serialized via set : ViaSerialize=Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [receiveInviteMessage] send RemoteSdp to the StandBy.
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [exec_ipc] in 2324.
1433920556 -> [display_ipc_in] ------------ Begin ---------------
1433920556 -> neqt : 5216 Id : -1
1433920556 -> REQUEST FAILURE
1433920556 -> xx : 88
1433920556 -> RELATIVE REQUEST : INVITE
1433920556 -> [display_ipc_in] ------------- End ----------------
1433920556 -> [CMotorCallManager::onIncomingEvent] an event 10767 arrived on the eqt 5216--1.
1433920556 -> [CMotorCallManager::onIncomingEvent] state = PROCEEDING_STATE.
1433920556 -> [onIncomingEvent] REQUEST FAILURE arrived.
1433920556 -> [receiveRequestFailureEvent] Call: call-8C366E0B-0000-0010-150E-54C@196.5.234.253 eqt: 5216 PROCEEDING_STATE received an event.
1433920556 -> 11f7[CMotorCall::getOutgoingCall] outgoingCall:0
1433920556 -> [receiveRequestFailureEvent] incoming call.
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> 11f7[CMotorCall ABCF ExtGW
1433920556 -> 11f7 [CCall::makeGenericResponse] 488
1433920556 -> 11f7 [CCall::getDialog] Confirmed Dialog is not found (ID = ;c405eafd-c989)
1433920556 -> 11f7 [CCall::getDialog] Returning Initial Dialog Server
1433920556 -> 1583 [CDialog::createResponse] 488
1433920556 -> 210c [CTransProceedingState::createResponse] CResponse 29E94 ref=1
1433920556 -> 29E94 [CMessage::send] sip_sendMessage (196.5.234.253:5060)
1433920556 -> SEND MESSAGE TO NETWORK (196.5.234.253:25102 [TCP]) (BUFF LEN = 511)
----------------------utf8-----------------------
SIP/2.0 488 Not Acceptable Here
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
User-Agent: OmniPCX Enterprise R9.1 i1.605.21
To: <sip:50877405000@196.5.234.252:5060;user=phone>;tag=4dbabf30cb5213bef17c1cd2589fc442
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
CSeq: 2 INVITE
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
Content-Length: 0
-------------------------------------------------
1433920556 -> [CTransport::findConnection] pConnection = f09b
1433920556 -> [CTransport::getConnection] RemoteHost=(196.5.234.253 25102) already exist, using connection f09b
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> 29E93 [~CResponse] resp(100) call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 INVITE
1433920556 -> 210c [CTransProceedingState::createResponse] Final : Transaction changes to Completed state
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO COMPLETED
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Proceeding, currentState = Completed, reason = Final resp creation]
1433920556 -> 210c [CTransaction::startTimer] Timer H is started (delay = 32000 ms)
1433920556 -> 1583 [CDialog::updateRouteSet] there are 0 record-route headers
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [exec_ipc] in end 2324.
1433920556 -> f09b [CConnectionTcp::receiveMsg] Receiveing message, rc = 613
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) MaxNbMsgByPeriod:25 Period:3
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) NbMsg:2 < seuil
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> RECEIVE MESSAGE FROM NETWORK (196.5.234.253:25102 [TCP])
----------------------utf8-----------------------
ACK sip:50877405000@196.5.234.252:5060;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, OPTIONS, REFER, REGISTER, INFO, UPDATE, PRACK
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
Contact: <sip:+27102216592@196.5.234.253:5060;transport=TCP>
Content-Length: 0
CSeq: 2 ACK
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Max-Forwards: 69
To: <sip:50877405000@196.5.234.252:5060;user=phone>;tag=4dbabf30cb5213bef17c1cd2589fc442
User-Agent: SONUS SBC2000 4.1.1v377 UX
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
-------------------------------------------------
1433920556 -> 485DA [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920556 -> [CIOCom::receiveRequest] Received CRequest 485DA ref=1
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CDispatcher::onIncomingRequest()]
1433920556 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920556 -> 102 [CCallManager::onIncomingRequest()]
1433920556 -> 11f7 [CCall::receiveRequest] ACK
1433920556 -> 11f7 [CCall::getDialog] Confirmed Dialog is not found (ID = 4dbabf30cb5213bef17c1cd2589fc442;c405eafd-c989)
1433920556 -> 11f7 [CCall::getDialog] Returning Initial Dialog Server
1433920556 -> 1583 [CDialog::receiveRequest]
1433920556 -> 1583 [CDialog::receiveAckRequest]
1433920556 -> 210c [CTransCompletedState::receiveRequest] ACK(UDP) : Transaction changes to Confirmed state
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO CONFIRMED
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Completed, currentState = Confirmed, reason = Request reception]
1433920556 -> 210c [CTransaction::freeTimerToken] Timer H is freed
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920556 -> 210c [CTransaction::changeState] no transaction state, terminated reason : Timer I fires
1433920556 -> 1583 [CDialog::receiveAckRequest] receiving an ACK on a previously rejected INVITE
1433920556 -> 11f7 [CCall::checkAuthentication] ACK
1433920556 -> 11f7[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920556 -> 11f7[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
1433920556 -> 0[CMotorCall::onReceiveRequest] route already analyzed.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] request for gateway.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] state = TERMINATED_STATE.
1433920556 -> 11f7[CMotorCall::compareDialogFromContext] same Dialog
1433920556 -> 11f7[CMotorCall::methodAckReceived] Ack => update the inviteContext.
1433920556 -> [receiveAckMessage] Call: call-8C366E0B-0000-0010-150E-54C@196.5.234.253 eqt: 5216 TERMINATED_STATE received a message.
1433920556 -> 11f7[emitEventToMonitel] content size (lginfo): 656
1433920556 -> 11f7[emitEventToMonitel] CAC = 0 eqtCAC = -1
1433920556 -> 11f7[emitEventToMonitel] CAC = 0
1433920556 -> [ipc_thread] IPC Thread : Ipc reception 2325.
1433920556 -> [ipc_thread] IPC Thread : TCL thread signaled.
1433920556 -> [sendLgEvtSip] Event sent on eqt : 5216 Id :-1
1433920556 -> [display_ipc_out] ------------ Begin ---------------
1433920556 -> Id : -1
1433920556 -> ACK
1433920556 -> [display_ipc_out] ------------- End ----------------
1433920556 -> [exec_ipc] in 2324.
1433920556 -> [display_ipc_in] ------------ Begin ---------------
1433920556 -> neqt : 5216 Id : -1
1433920556 -> SIP EQT RELEASED
1433920556 -> [display_ipc_in] ------------- End ----------------
1433920556 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 5216--1.
1433920556 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 5216 has released its equipment.
1433920556 -> 11f7[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
1433920556 -> 11f7[emitEventToMonitel] content size (lginfo): 656
1433920556 -> 11f7[emitEventToMonitel] CAC = 0 eqtCAC = -1
1433920556 -> 11f7[emitEventToMonitel] CAC = 0
1433920556 -> [sendLgEvtSip] Event sent on eqt : 5216 Id :-1
1433920556 -> [display_ipc_out] ------------ Begin ---------------
1433920556 -> Id : -1
1433920556 -> UNKNOWN MESSAGE
1433920556 -> [display_ipc_out] ------------- End ----------------
1433920556 -> 11f7[CMotorCall::unRegister] Remove eqt : 5216 diag : -1 from the map.
1433920556 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 5216 erased.
1433920556 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [CMotorCallManager::onIncomingEvent] killSession.
1433920556 -> 11f7 [CCall::killSession]
1433920556 -> 11f7 [CCall::onKill Session Call manager close is called]
1433920556 -> 11f7 [CCall::killSession] notifying the call manager
1433920556 -> 102 [CCallManager::onCallClosed]
1433920556 -> 102 [CCallManager::onCallClosed()] Call 11f7 closed. Removing call 497369784 from the maps
1433920556 -> [CMotorCallManager::onNotifyCallClosed] Call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253 is closed.
1433920556 -> [CMotorCallManager::onNotifyCallClosed] Call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253 is closed.
1433920556 -> [CMotorCallManager::onNotifyCallClosed] call processResponse.
1433920556 -> 11f7[CMotorCall::processResponse] call chooseBestResponse.
1433920556 -> 11f7[CMotorCall::chooseBestResponse] pForkedBranch=0x1dab78f8 iResponseCode=2000.
1433920556 -> [CForkedBranch::getResponseCode] response=2000.
1433920556 -> 11f7[CMotorCall::chooseBestResponse] next branch.
1433920556 -> 11f7[CMotorCall::processResponse] no response found.
1433920556 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1433920556 -> [CCall::onKill] set callmanager to null
1433920556 -> [exec_ipc] in end 2324.
1433920557 -> [CTransaction::notifyDialog]
1433920557 -> [CTransaction::notifyDialog] notify parent dialog
1433920557 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = null, currentState = Terminated, reason = Timer I fires]
1433920557 -> 1583 [CDialog::onTransactionState] dialog is terminated
1433920557 -> 1583 [CDialog::onTransactionState] onDialogClosed
1433920557 -> 11f7 [CCall::onDialogClosed]
1433920557 -> 11f7 [CCall::onDialogClosed] only initial *********
1433920557 -> 11f7 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920557 -> 210C [~CTransaction] transaction 2 INVITE
1433920557 -> 485DA [~CRequest] req call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 ACK
1433920558 -> 2105 [CTransTryingState::timerFires] Timer E fires
1433920558 -> SEND MESSAGE TO NETWORK (196.5.234.93:5060 [UDP]) (BUFF LEN = 645)
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920558 -> [CTransport::findConnection] pConnection = f048
1433920558 -> [CTransport::getConnection] RemoteHost=(196.5.234.93 5060) already exist, using connection f048
1433920558 -> udp_send fd:3
1433920558 -> udp_send fd:3 port 5060 iBytesSend:645 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
1433920558 -> f048 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920558 -> 2105 [CTransaction::startTimer] Timer E is started (delay = 4000 ms)
1433920558 -> udp_recv fd:3
1433920558 -> udp_recv fd:3 iBytesRead:534 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
1433920558 -> UdpInputProc iSock:3 iBytesRead:534 Host:10.51.82.55 Port:5060
1433920558 -> [CTransportUdp::receiveMessage] from 10.51.82.55:5060 rc:534
1433920558 -> [CTransport::findConnection] pConnection = f047
1433920558 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) MaxNbMsgByPeriod:25 Period:3
1433920558 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) NbMsg:4 < seuil
1433920558 -> f047 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920558 -> RECEIVE MESSAGE FROM NETWORK (10.51.82.55:5060 [UDP])
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920558 -> 485DB [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920558 -> [CIOCom::receiveRequest] Received CRequest 485DB ref=1
1433920558 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920558 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920558 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920558 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920558 -> [CIOCom::receiveRequest] rport1 not empty
1433920558 -> [CDispatcher::onIncomingRequest()]
1433920558 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920558 -> 104 [CCallManager::onIncomingRequest()]
1433920558 -> 11f8 [CCall::receiveRequest] REGISTER
1433920558 -> 11f8 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920558 -> 11f8 [CCall::getDialog] Initial Dialog Server not found
1433920558 -> 1584 [CDialog::receiveRequest]
1433920558 -> 1584 [CDialog::receiveBasicRequest]
1433920558 -> 210d [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920558 -> 210d [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1584 [CDialog::onTransactionState(pTrans = 210d, previousState = Terminated, currentState = Initial, reason = None]
1433920558 -> 210d [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920558 -> 210d [CTransaction::changeState] STATE CHANGED TO TRYING
1433920558 -> 210d [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1584 [CDialog::onTransactionState(pTrans = 210d, previousState = Initial, currentState = Trying, reason = Request reception]
1433920558 -> 1584 [CDialog::addTransaction] added transaction 210d with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920558 -> 11f8 [CCall::checkAuthentication] REGISTER
1433920558 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920558 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920558 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920558 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920558 -> [CGWMngData::isMainServer ] check the request for PCS
1433920558 -> check_PCS_ACTIVE start
1433920558 -> check_PCS_ACTIVE get the PCS state
1433920558 -> check_PCSstate
1433920558 -> am_I_PCS SCSWorking : NO
1433920558 -> OXE contains PCS configuration
1433920558 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920558 -> check_PCSstate ipadd 10.51.82.55
1433920558 -> check_PCSstate user IP is Found ? = YES
1433920558 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920558 -> [isDomainFromGwExt] no User from request.
1433920558 -> check_PCS_ACTIVE extgwid -1
1433920558 -> The recevied host 10.51.82.55
1433920558 -> Trying to find the ip address in domain list
1433920558 -> The entry dom : 1 add_type=2
1433920558 -> The entry dom ip low :196.9.33.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The entry dom : 2 add_type=2
1433920558 -> The entry dom ip low :196.9.69.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The user is ipadd not in any Domain range return state as -1
1433920558 -> check_PCSstate stat of PCS is : -1
1433920558 -> check_PCS_ACTIVE the PCS state -1
1433920558 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920558 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920558 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920558 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920558 -> [isDomainFromGwExt] no User from request.
1433920558 -> [domain not from an External Gateway.
1433920558 -> 11f8 [CRegistrarCall::onReceiveRequest] REGISTER
1433920558 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920558 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920558 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920558 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920558 -> [CGWMngData::isMainServer ] check the request for PCS
1433920558 -> check_PCS_ACTIVE start
1433920558 -> check_PCS_ACTIVE get the PCS state
1433920558 -> check_PCSstate
1433920558 -> am_I_PCS SCSWorking : NO
1433920558 -> OXE contains PCS configuration
1433920558 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920558 -> check_PCSstate ipadd 10.51.82.55
1433920558 -> check_PCSstate user IP is Found ? = YES
1433920558 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920558 -> [isDomainFromGwExt] no User from request.
1433920558 -> check_PCS_ACTIVE extgwid -1
1433920558 -> The recevied host 10.51.82.55
1433920558 -> Trying to find the ip address in domain list
1433920558 -> The entry dom : 1 add_type=2
1433920558 -> The entry dom ip low :196.9.33.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The entry dom : 2 add_type=2
1433920558 -> The entry dom ip low :196.9.69.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The user is ipadd not in any Domain range return state as -1
1433920558 -> check_PCSstate stat of PCS is : -1
1433920558 -> check_PCS_ACTIVE the PCS state -1
1433920558 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920558 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920558 -> [CServRegistrar::processRegister]
1433920558 -> 11f8 [CRegistrarCall::onReceiveRequest], user not found => kill session
1433920558 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920558 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f8
1433920558 -> 11f8 [CCall::killSession]
1433920558 -> 210d [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920558 -> 210d [CTransaction::changeState] no transaction state, terminated reason : None
1433920558 -> 11f8 [CCall::onKill Session Call manager close is called]
1433920558 -> 11f8 [CCall::killSession] notifying the call manager
1433920558 -> 104 [CCallManager::onCallClosed]
1433920558 -> 104 [CCallManager::onCallClosed()] Call 11f8 closed. Removing call 497776784 from the maps
1433920558 -> [CCall::onKill] set callmanager to null
1433920558 -> 102 [CCallManager::onIncomingRequest()]
1433920558 -> [CMotorCallManager::callFactory] For call : 17e3a14d-23590116-afde72e3@10.51.82.55.
1433920558 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.21
1433920558 -> [CMotorCallManager::callFactory]=1da35fb8.
1433920558 -> 11f9 [CCall::receiveRequest] REGISTER
1433920558 -> 11f9 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920558 -> 11f9 [CCall::getDialog] Initial Dialog Server not found
1433920558 -> 1585 [CDialog::receiveRequest]
1433920558 -> 1585 [CDialog::receiveBasicRequest]
1433920558 -> 210e [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920558 -> 210e [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1585 [CDialog::onTransactionState(pTrans = 210e, previousState = Terminated, currentState = Initial, reason = None]
1433920558 -> 210e [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920558 -> 210e [CTransaction::changeState] STATE CHANGED TO TRYING
1433920558 -> 210e [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1585 [CDialog::onTransactionState(pTrans = 210e, previousState = Initial, currentState = Trying, reason = Request reception]
1433920558 -> 1585 [CDialog::addTransaction] added transaction 210e with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920558 -> 11f9 [CCall::checkAuthentication] REGISTER
1433920558 -> 11f9[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920558 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920558 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920558 -> [isDomainFromGwExt] User from request is : 7672
1433920558 -> [domain not from an External Gateway.
1433920558 -> [getFromHeader].
1433920558 -> [isUserDeclared] 7672@196.5.234.93
1433920558 -> isUserDeclared] NOT found in the dictionnary.
1433920558 -> [isSeplosStation] other station
1433920558 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920558 -> [isDomainFromGwExt] User from request is : 7672
1433920558 -> 11f9[CMotorCall::toGatewayOrProxy] request for proxydomain=196.5.234.93.
1433920558 -> 11f9[CMotorCall::toGatewayOrProxy] request for proxy (ReqUri domain unknown).
1433920558 -> 11f9[CMotorCall::toGatewayOrProxy] rout to proxy.
1433920558 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920558 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f9
1433920558 -> 11f9 [CCall::killSession]
1433920558 -> 210e [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920558 -> 210e [CTransaction::changeState] no transaction state, terminated reason : None
1433920558 -> 11f9 [CCall::onKill Session Call manager close is called]
1433920558 -> 11f9 [CCall::killSession] notifying the call manager
1433920558 -> 102 [CCallManager::onCallClosed]
1433920558 -> 102 [CCallManager::onCallClosed()] Call 11f9 closed. Removing call 497246136 from the maps
1433920558 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920558 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920558 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1433920558 -> [CCall::onKill] set callmanager to null
1433920558 -> 103 [CCallManager::onIncomingRequest()]
1433920558 -> 11f0 [CCall::receiveRequest] REGISTER
1433920558 -> 11f0 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920558 -> 11f0 [CCall::getDialog] Returning Initial Dialog Server
1433920558 -> 157b [CDialog::receiveRequest]
1433920558 -> 157b [CDialog::receiveBasicRequest]
1433920558 -> 157b [CDialog::receiveBasicRequest] A basic server transaction is found with the same branch
1433920558 -> [CTransaction::notifyDialog]
1433920558 -> [CTransaction::notifyDialog] notify parent dialog
1433920558 -> 1584 [CDialog::onTransactionState(pTrans = 210d, previousState = null, currentState = Terminated, reason = None]
1433920558 -> 1584 [CDialog::onTransactionState] dialog is terminated
1433920558 -> 1584 [CDialog::onTransactionState] onDialogClosed
1433920558 -> 11f8 [CCall::onDialogClosed]
1433920558 -> 11f8 [CCall::onDialogClosed] only initial *********
1433920558 -> 11f8 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920558 -> 210D [~CTransaction] transaction 1 REGISTER
1433920558 -> [CTransaction::notifyDialog]
1433920558 -> [CTransaction::notifyDialog] notify parent dialog
1433920558 -> 1585 [CDialog::onTransactionState(pTrans = 210e, previousState = null, currentState = Terminated, reason = None]
1433920558 -> 1585 [CDialog::onTransactionState] dialog is terminated
1433920558 -> 1585 [CDialog::onTransactionState] onDialogClosed
1433920558 -> 11f9 [CCall::onDialogClosed]
1433920558 -> 11f9 [CCall::onDialogClosed] only initial *********
1433920558 -> 11f9 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920558 -> 210E [~CTransaction] transaction 1 REGISTER
1433920558 -> 485DB [~CRequest] req 17e3a14d-23590116-afde72e3@10.51.82.55 1 REGISTER
1433920558 -> 102 [CCallManager::removeGarbage] at index i = 1
1433920558 -> 11f9[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920558 -> 11f9 [CCall::~CCall]
1433920558 -> 11f9 [CCall::removeGarbage]
1433920558 -> 1585 [CDialog::~CDialog]
1433920558 -> 102 [CCallManager::removeGarbage] at index i = 0
1433920558 -> 11f7[CMotorCall::~CMotorCall] Call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253 is being destructed.
1433920558 -> 11f7 [CCall::~CCall]
1433920558 -> 11f7 [CCall::removeGarbage]
1433920558 -> 1583 [CDialog::~CDialog]
1433920558 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1433920558 -> 29E94 [~CResponse] resp(488) call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 INVITE
1433920558 -> 485D9 [~CRequest] req call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 INVITE
1433920558 -> 104 [CCallManager::removeGarbage] at index i = 0
1433920558 -> 11f8 [CCall::~CCall]
1433920558 -> 11f8 [CCall::removeGarbage]
1433920558 -> 1584 [CDialog::~CDialog]
(101)xa001001> motortrace 6
motortrace (v5.2.0) verbosity = 0037b524
sipmotor trace-level set 6 (All traces + TRANSPORT + ADNS).
(101)xa001001> traced
** UNIX-trace-daemon started ... (static user group No 1) **
traced started ...
1433920552 -> [CTransaction::notifyDialog]
1433920552 -> [CTransaction::notifyDialog] notify parent dialog
1433920552 -> 157f [CDialog::onTransactionState(pTrans = 2108, previousState = null, currentState = Terminated, reason = None]
1433920552 -> 157f [CDialog::onTransactionState] dialog is terminated
1433920552 -> 157f [CDialog::onTransactionState] onDialogClosed
1433920552 -> 11f3 [CCall::onDialogClosed]
1433920552 -> 11f3 [CCall::onDialogClosed] only initial *********
1433920552 -> 11f3 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920552 -> 2108 [~CTransaction] transaction 1 REGISTER
1433920552 -> [CTransaction::notifyDialog]
1433920552 -> [CTransaction::notifyDialog] notify parent dialog
1433920552 -> 1580 [CDialog::onTransactionState(pTrans = 2109, previousState = null, currentState = Terminated, reason = None]
1433920552 -> 1580 [CDialog::onTransactionState] dialog is terminated
1433920552 -> 1580 [CDialog::onTransactionState] onDialogClosed
1433920552 -> 11f4 [CCall::onDialogClosed]
1433920552 -> 11f4 [CCall::onDialogClosed] only initial *********
1433920552 -> 11f4 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920552 -> 2109 [~CTransaction] transaction 1 REGISTER
1433920552 -> 485D7 [~CRequest] req 17e3a14d-23590116-afde72e3@10.51.82.55 1 REGISTER
1433920552 -> info [CServRegistrar::writeLocateFile]
1433920552 -> 102 [CCallManager::removeGarbage] at index i = 2
1433920552 -> 11f4[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920552 -> 11f4 [CCall::~CCall]
1433920552 -> 11f4 [CCall::removeGarbage]
1433920552 -> 1580 [CDialog::~CDialog]
1433920552 -> 102 [CCallManager::removeGarbage] at index i = 1
1433920552 -> 11f2[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920552 -> 11f2 [CCall::~CCall]
1433920552 -> 11f2 [CCall::removeGarbage]
1433920552 -> 157e [CDialog::~CDialog]
1433920552 -> 102 [CCallManager::removeGarbage] at index i = 0
1433920552 -> 11ef[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920552 -> 11ef [CCall::~CCall]
1433920552 -> 11ef [CCall::removeGarbage]
1433920552 -> 157a [CDialog::~CDialog]
1433920552 -> 104 [CCallManager::removeGarbage] at index i = 2
1433920552 -> 11f3 [CCall::~CCall]
1433920552 -> 11f3 [CCall::removeGarbage]
1433920552 -> 157f [CDialog::~CDialog]
1433920552 -> 104 [CCallManager::removeGarbage] at index i = 1
1433920552 -> 11f1 [CCall::~CCall]
1433920552 -> 11f1 [CCall::removeGarbage]
1433920552 -> 157d [CDialog::~CDialog]
1433920552 -> 104 [CCallManager::removeGarbage] at index i = 0
1433920552 -> 11ee [CCall::~CCall]
1433920552 -> 11ee [CCall::removeGarbage]
1433920552 -> 1579 [CDialog::~CDialog]
1433920554 -> 2105 [CTransTryingState::timerFires] Timer E fires
1433920554 -> SEND MESSAGE TO NETWORK (196.5.234.93:5060 [UDP]) (BUFF LEN = 645)
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920554 -> [CTransport::findConnection] pConnection = f048
1433920554 -> [CTransport::getConnection] RemoteHost=(196.5.234.93 5060) already exist, using connection f048
1433920554 -> udp_send fd:3
1433920554 -> udp_send fd:3 port 5060 iBytesSend:645 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
1433920554 -> f048 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920554 -> 2105 [CTransaction::startTimer] Timer E is started (delay = 4000 ms)
1433920554 -> udp_recv fd:3
1433920554 -> udp_recv fd:3 iBytesRead:534 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
1433920554 -> UdpInputProc iSock:3 iBytesRead:534 Host:10.51.82.55 Port:5060
1433920554 -> [CTransportUdp::receiveMessage] from 10.51.82.55:5060 rc:534
1433920554 -> [CTransport::findConnection] pConnection = f047
1433920554 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) MaxNbMsgByPeriod:25 Period:3
1433920554 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) NbMsg:3 < seuil
1433920554 -> f047 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920554 -> RECEIVE MESSAGE FROM NETWORK (10.51.82.55:5060 [UDP])
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920554 -> 485D8 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920554 -> [CIOCom::receiveRequest] Received CRequest 485D8 ref=1
1433920554 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920554 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920554 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920554 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920554 -> [CIOCom::receiveRequest] rport1 not empty
1433920554 -> [CDispatcher::onIncomingRequest()]
1433920554 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920554 -> 104 [CCallManager::onIncomingRequest()]
1433920554 -> 11f5 [CCall::receiveRequest] REGISTER
1433920554 -> 11f5 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920554 -> 11f5 [CCall::getDialog] Initial Dialog Server not found
1433920554 -> 1581 [CDialog::receiveRequest]
1433920554 -> 1581 [CDialog::receiveBasicRequest]
1433920554 -> 210a [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920554 -> 210a [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1581 [CDialog::onTransactionState(pTrans = 210a, previousState = Terminated, currentState = Initial, reason = None]
1433920554 -> 210a [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920554 -> 210a [CTransaction::changeState] STATE CHANGED TO TRYING
1433920554 -> 210a [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1581 [CDialog::onTransactionState(pTrans = 210a, previousState = Initial, currentState = Trying, reason = Request reception]
1433920554 -> 1581 [CDialog::addTransaction] added transaction 210a with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920554 -> 11f5 [CCall::checkAuthentication] REGISTER
1433920554 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920554 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920554 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920554 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920554 -> [CGWMngData::isMainServer ] check the request for PCS
1433920554 -> check_PCS_ACTIVE start
1433920554 -> check_PCS_ACTIVE get the PCS state
1433920554 -> check_PCSstate
1433920554 -> am_I_PCS SCSWorking : NO
1433920554 -> OXE contains PCS configuration
1433920554 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920554 -> check_PCSstate ipadd 10.51.82.55
1433920554 -> check_PCSstate user IP is Found ? = YES
1433920554 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920554 -> [isDomainFromGwExt] no User from request.
1433920554 -> check_PCS_ACTIVE extgwid -1
1433920554 -> The recevied host 10.51.82.55
1433920554 -> Trying to find the ip address in domain list
1433920554 -> The entry dom : 1 add_type=2
1433920554 -> The entry dom ip low :196.9.33.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The entry dom : 2 add_type=2
1433920554 -> The entry dom ip low :196.9.69.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The user is ipadd not in any Domain range return state as -1
1433920554 -> check_PCSstate stat of PCS is : -1
1433920554 -> check_PCS_ACTIVE the PCS state -1
1433920554 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920554 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920554 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920554 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920554 -> [isDomainFromGwExt] no User from request.
1433920554 -> [domain not from an External Gateway.
1433920554 -> 11f5 [CRegistrarCall::onReceiveRequest] REGISTER
1433920554 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920554 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920554 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920554 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920554 -> [CGWMngData::isMainServer ] check the request for PCS
1433920554 -> check_PCS_ACTIVE start
1433920554 -> check_PCS_ACTIVE get the PCS state
1433920554 -> check_PCSstate
1433920554 -> am_I_PCS SCSWorking : NO
1433920554 -> OXE contains PCS configuration
1433920554 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920554 -> check_PCSstate ipadd 10.51.82.55
1433920554 -> check_PCSstate user IP is Found ? = YES
1433920554 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920554 -> [isDomainFromGwExt] no User from request.
1433920554 -> check_PCS_ACTIVE extgwid -1
1433920554 -> The recevied host 10.51.82.55
1433920554 -> Trying to find the ip address in domain list
1433920554 -> The entry dom : 1 add_type=2
1433920554 -> The entry dom ip low :196.9.33.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The entry dom : 2 add_type=2
1433920554 -> The entry dom ip low :196.9.69.0
1433920554 -> The entry ipaddress from low :10.51.82.55
1433920554 -> The entry compare :1
1433920554 -> The entry compare 2 :0
1433920554 -> The user is ipadd not in any Domain range return state as -1
1433920554 -> check_PCSstate stat of PCS is : -1
1433920554 -> check_PCS_ACTIVE the PCS state -1
1433920554 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920554 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920554 -> [CServRegistrar::processRegister]
1433920554 -> 11f5 [CRegistrarCall::onReceiveRequest], user not found => kill session
1433920554 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920554 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f5
1433920554 -> 11f5 [CCall::killSession]
1433920554 -> 210a [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920554 -> 210a [CTransaction::changeState] no transaction state, terminated reason : None
1433920554 -> 11f5 [CCall::onKill Session Call manager close is called]
1433920554 -> 11f5 [CCall::killSession] notifying the call manager
1433920554 -> 104 [CCallManager::onCallClosed]
1433920554 -> 104 [CCallManager::onCallClosed()] Call 11f5 closed. Removing call 495251872 from the maps
1433920554 -> [CCall::onKill] set callmanager to null
1433920554 -> 102 [CCallManager::onIncomingRequest()]
1433920554 -> [CMotorCallManager::callFactory] For call : 17e3a14d-23590116-afde72e3@10.51.82.55.
1433920554 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.21
1433920554 -> [CMotorCallManager::callFactory]=1d95d0b0.
1433920554 -> 11f6 [CCall::receiveRequest] REGISTER
1433920554 -> 11f6 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920554 -> 11f6 [CCall::getDialog] Initial Dialog Server not found
1433920554 -> 1582 [CDialog::receiveRequest]
1433920554 -> 1582 [CDialog::receiveBasicRequest]
1433920554 -> 210b [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920554 -> 210b [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1582 [CDialog::onTransactionState(pTrans = 210b, previousState = Terminated, currentState = Initial, reason = None]
1433920554 -> 210b [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920554 -> 210b [CTransaction::changeState] STATE CHANGED TO TRYING
1433920554 -> 210b [CTransaction::changeState] notifying the parent dialog
1433920554 -> 1582 [CDialog::onTransactionState(pTrans = 210b, previousState = Initial, currentState = Trying, reason = Request reception]
1433920554 -> 1582 [CDialog::addTransaction] added transaction 210b with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920554 -> 11f6 [CCall::checkAuthentication] REGISTER
1433920554 -> 11f6[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920554 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920554 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920554 -> [isDomainFromGwExt] User from request is : 7672
1433920554 -> [domain not from an External Gateway.
1433920554 -> [getFromHeader].
1433920554 -> [isUserDeclared] 7672@196.5.234.93
1433920554 -> isUserDeclared] NOT found in the dictionnary.
1433920554 -> [isSeplosStation] other station
1433920554 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920554 -> [isDomainFromGwExt] User from request is : 7672
1433920554 -> 11f6[CMotorCall::toGatewayOrProxy] request for proxydomain=196.5.234.93.
1433920554 -> 11f6[CMotorCall::toGatewayOrProxy] request for proxy (ReqUri domain unknown).
1433920554 -> 11f6[CMotorCall::toGatewayOrProxy] rout to proxy.
1433920554 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920554 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f6
1433920554 -> 11f6 [CCall::killSession]
1433920554 -> 210b [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920554 -> 210b [CTransaction::changeState] no transaction state, terminated reason : None
1433920554 -> 11f6 [CCall::onKill Session Call manager close is called]
1433920554 -> 11f6 [CCall::killSession] notifying the call manager
1433920554 -> 102 [CCallManager::onCallClosed]
1433920554 -> 102 [CCallManager::onCallClosed()] Call 11f6 closed. Removing call 496357552 from the maps
1433920554 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920554 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920554 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1433920554 -> [CCall::onKill] set callmanager to null
1433920554 -> 103 [CCallManager::onIncomingRequest()]
1433920554 -> 11f0 [CCall::receiveRequest] REGISTER
1433920554 -> 11f0 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920554 -> 11f0 [CCall::getDialog] Returning Initial Dialog Server
1433920554 -> 157b [CDialog::receiveRequest]
1433920554 -> 157b [CDialog::receiveBasicRequest]
1433920554 -> 157b [CDialog::receiveBasicRequest] A basic server transaction is found with the same branch
1433920554 -> [CTransaction::notifyDialog]
1433920554 -> [CTransaction::notifyDialog] notify parent dialog
1433920554 -> 1581 [CDialog::onTransactionState(pTrans = 210a, previousState = null, currentState = Terminated, reason = None]
1433920554 -> 1581 [CDialog::onTransactionState] dialog is terminated
1433920554 -> 1581 [CDialog::onTransactionState] onDialogClosed
1433920554 -> 11f5 [CCall::onDialogClosed]
1433920554 -> 11f5 [CCall::onDialogClosed] only initial *********
1433920554 -> 11f5 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920554 -> 210A [~CTransaction] transaction 1 REGISTER
1433920554 -> [CTransaction::notifyDialog]
1433920554 -> [CTransaction::notifyDialog] notify parent dialog
1433920554 -> 1582 [CDialog::onTransactionState(pTrans = 210b, previousState = null, currentState = Terminated, reason = None]
1433920554 -> 1582 [CDialog::onTransactionState] dialog is terminated
1433920554 -> 1582 [CDialog::onTransactionState] onDialogClosed
1433920554 -> 11f6 [CCall::onDialogClosed]
1433920554 -> 11f6 [CCall::onDialogClosed] only initial *********
1433920554 -> 11f6 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920554 -> 210B [~CTransaction] transaction 1 REGISTER
1433920554 -> 485D8 [~CRequest] req 17e3a14d-23590116-afde72e3@10.51.82.55 1 REGISTER
1433920555 -> EAu: Block Memory Size: 1086060
1433920555 -> EAu: Dupli window: 0/1 (max: 1)
1433920555 -> 102 [CCallManager::removeGarbage] at index i = 0
1433920555 -> 11f6[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920555 -> 11f6 [CCall::~CCall]
1433920555 -> 11f6 [CCall::removeGarbage]
1433920555 -> 1582 [CDialog::~CDialog]
1433920555 -> 104 [CCallManager::removeGarbage] at index i = 0
1433920555 -> 11f5 [CCall::~CCall]
1433920555 -> 11f5 [CCall::removeGarbage]
1433920555 -> 1581 [CDialog::~CDialog]
1433920556 -> [CTransport::AcceptConnection] Remote=(196.5.234.253 25102) OK
1433920556 -> [CTransport::findConnection] pConnection = 0
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> [CTransportTcp::acceptConnection] new connection = f09b
1433920556 -> [CTransport::setChannelOptions] channel=496846848 iResult=0 iTosset for this channel is 184
1433920556 -> [CTransport::setChannelOptions] channel=496846848 iResult=0 VLanpriority set for this channelis 5
1433920556 -> [CTransport::setChannelOptions] channel=496846848 iResult=0
1433920556 -> [CTransport::addConnection] Insert connection f09b with key = 196.5.234.253|25102
1433920556 -> [CTransportTcp::acceptConnection] Remote=(196.5.234.253 25102) CNX created OK
1433920556 -> [CTransport::AcceptConnection] Remote=(196.5.234.253 25102) OK
1433920556 -> f09b [CConnectionTcp::receiveMsg] Receiveing message, rc = 931
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) MaxNbMsgByPeriod:25 Period:3
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) NbMsg:1 < seuil
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> RECEIVE MESSAGE FROM NETWORK (196.5.234.253:25102 [TCP])
----------------------utf8-----------------------
INVITE sip:50877405000@196.5.234.252:5060;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, OPTIONS, REFER, REGISTER, INFO, UPDATE, PRACK
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
Contact: <sip:+27102216592@196.5.234.253:5060;transport=TCP>
Content-Length: 239
Content-Type: application/sdp
CSeq: 2 INVITE
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Max-Forwards: 69
Min-SE: 500
Session-Expires: 3600
Supported: replaces,update,timer,100rel
To: <sip:50877405000@196.5.234.252:5060;user=phone>
User-Agent: SONUS SBC2000 4.1.1v377 UX
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
v=0
o=SBC 1410 1001 IN IP4 196.5.234.253
s=VoipCall
c=IN IP4 196.5.234.253
t=0 0
m=audio 17038 RTP/AVP 8 101
c=IN IP4 196.5.234.253
a=rtpmap:8 PCMA/8000/1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
a=sendrecv
-------------------------------------------------
1433920556 -> 485D9 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920556 -> [CIOCom::receiveRequest] Received CRequest 485D9 ref=1
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CDispatcher::onIncomingRequest()]
1433920556 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920556 -> 102 [CCallManager::onIncomingRequest()]
1433920556 -> [CMotorCallManager::callFactory] For call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253.
1433920556 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.21
1433920556 -> [CMotorCallManager::callFactory]=1da542b8.
1433920556 -> 11f7 [CCall::receiveRequest] INVITE
1433920556 -> 11f7 [CCall::getDialog] Confirmed Dialog is not found (ID = ;c405eafd-c989)
1433920556 -> 11f7 [CCall::getDialog] Initial Dialog Server not found
1433920556 -> 1583 [CDialog::receiveRequest]
1433920556 -> 1583 [CDialog::receiveInviteRequest]
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Terminated, currentState = Initial, reason = None]
1433920556 -> 210c [CTransInitialState::receiveRequest] Transaction changes to Proceeding state
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO PROCEEDING
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Initial, currentState = Proceeding, reason = Request reception]
1433920556 -> 210c [CTransProceedingState::createResponse] CResponse 29E93 ref=1
1433920556 -> 29E93 [CMessage::send] sip_sendMessage (196.5.234.253:5060)
1433920556 -> SEND MESSAGE TO NETWORK (196.5.234.253:25102 [TCP]) (BUFF LEN = 331)
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:50877405000@196.5.234.252:5060;user=phone>
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
CSeq: 2 INVITE
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
Content-Length: 0
-------------------------------------------------
1433920556 -> [CTransport::findConnection] pConnection = f09b
1433920556 -> [CTransport::getConnection] RemoteHost=(196.5.234.253 25102) already exist, using connection f09b
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> 1583 [CDialog::receiveInviteRequest] a new Server INVITE transaction is in progress
1433920556 -> [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Server, UA)
1433920556 -> [CSessionTimerContext::updateAfterRefreshReception] Update CSessionTimerContext (refresh reception)
1433920556 -> [CSessionTimerContext::updateSupported] Request timer supported
1433920556 -> [CSessionTimerContext::updateMinSE] Min-SE updated : 500
1433920556 -> [CSessionTimerContext::updateSessionExpires] header value : 3600
1433920556 -> [CSessionTimerContext::updateSessionExpires] updated
1433920556 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 3600
1433920556 -> [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=UPDATE
1433920556 -> 1583 [CDialog::addTransaction] added transaction 210c with branch z9hG4bK-UX-c405-eafd-22f0, with CSeq 2
1433920556 -> 11f7 [CCall::checkAuthentication] INVITE
1433920556 -> 11f7[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920556 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.253 .
1433920556 -> [isDomainFromGwExt] Host from request is : 196.5.234.253.
1433920556 -> [isDomainFromGwExt] User from request is : +27102216592
1433920556 -> isDomainFromGwExt--> GwExt=1
1433920556 -> domain from External Gateway 1.
1433920556 -> 11f7[CMotorCall::setFilterUsedMode] To be traced = 0
1433920556 -> [getFromHeader].
1433920556 -> [isUserDeclared] +27102216592@196.5.234.253
1433920556 -> isUserDeclared] NOT found in the dictionnary.
1433920556 -> [isSeplosStation] other station
1433920556 -> [isDomainFromGwExt] Host from request is : 196.5.234.253.
1433920556 -> [isDomainFromGwExt] User from request is : +27102216592
1433920556 -> isDomainFromGwExt--> GwExt=1
1433920556 -> 11f7[CMotorCall::toGatewayOrProxy] request for proxydomain=196.5.234.252.
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> 11f7[CMotorCall ABCF ExtGW
1433920556 -> [isUserRegistred] getRegistration=50877405000.
1433920556 -> [isUserRegistred] result=-1.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] request for gateway.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] state = INITIAL_STATE.
1433920556 -> 11f7[CMotorCall::methodInviteReceived] nb available licenses=3 .
1433920556 -> [isUserDeclared] +27102216592@196.5.234.253
1433920556 -> isUserDeclared] NOT found in the dictionnary.
1433920556 -> 11f7[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
1433920556 -> 11f7[CMotorCall::methodInviteReceived] Invite => update the inviteContext.
1433920556 -> [CForkedBranch::CForkedBranch] context = 0x1da546ec.
1433920556 -> 11f7[CMotorCall::methodInviteReceived] reqUri stored: sip:+27102216592@196.5.234.253:5060;transport=TCP
1433920556 -> 11f7[CMotorCall::methodInviteReceived] CAC = 0
1433920556 -> [receiveInviteMessage] Call: call-8C366E0B-0000-0010-150E-54C@196.5.234.253 eqt: -1 INITIAL_STATE received a message.
1433920556 -> [decodeInviteCLIR].
1433920556 -> [receiveInviteMessage] INFO present in Allow header
1433920556 -> [receiveInviteMessage] UPDATE present in Allow header
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> am_I_PCS SCSWorking : NO
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> check_extgw_PCSstate EXTGW is : 1
1433920556 -> The check_extgw_PCSstate extgwid : 1
1433920556 -> The state of PCS which rescued the extgw is : -1
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> [isSessionTimerTooSmall].
1433920556 -> 11f7[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=0 uacRefresher=0.
1433920556 -> [decodeInviteSDP].
1433920556 -> [checkSdpValidity] Sdp contains 1 media description(s).
1433920556 -> [checkSdpValidity] Media 0 type 1 contains 2 formats.
1433920556 -> [checkSdpValidity] Format : 8.
1433920556 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1433920556 -> [convertSdpIntoTsdp] No Direction in the session part.
1433920556 -> [convertSdpIntoTsdp] Check the direction in Session part - result:0.
1433920556 -> [convertSdpIntoTsdp] The audio media contains 2 format(s).
1433920556 -> [convertSdpIntoTsdp] Format 0 is 8.
1433920556 -> [convertSdpIntoTsdp] Format 1 is 101.
1433920556 -> [convertSdpIntoTsdp] Get the direction.
1433920556 -> [convertSdpIntoTsdp] Direction is sendrecv.
1433920556 -> [convertSdpIntoTsdp] The connection is at media level.
1433920556 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 196.5.234.253.
1433920556 -> [convertIPStrIntoTuipv] 196.5.234.253 => 196.5.234.253
1433920556 -> [receiveInviteMessage] NO 100rel REQUIRED for this call.
1433920556 -> [isCACWithInvalidMediaAddr].
1433920556 -> [decodeInviteTo].
1433920556 -> [decodeInviteReferredBy].
1433920556 -> [decodeInviteACSBU].
1433920556 -> 11f7[CMotorCall::setFilterUsedMode] To be traced = 0
1433920556 -> 11f7[emitEventToMonitel] content size (lginfo): 656
1433920556 -> [ipc_thread] IPC Thread : Ipc reception 2325.
1433920556 -> [ipc_thread] IPC Thread : TCL thread signaled.
1433920556 -> [CMotorCallManager::insertCallwithEqt] CMotorCall 5216 inserted.
1433920556 -> 11f7[sendLgEvtSipCreate] Event sent on eqt : 5216
1433920556 -> 11f7[CMotorCall::getOutgoingCall] outgoingCall:0
1433920556 -> 11f7 [CCall::getCallDuplicationData]
1433920556 -> [CViaSetSerializer::copy] Added via 7cb6 at index 0
1433920556 -> 11f7 [CCall::getCallDuplicationData] : Request URI = sip:50877405000@196.5.234.252:5060;user=phone, Call ID = call-8C366E0B-0000-0010-150E-54C@196.5.234.253, Local URI = sip:50877405000@196.5.234.252:5060;user=phone, Local Tag = , Remote URI = sip:+27102216592@196.5.234.253:5060;user=phone, Remote Tag = c405eafd-c989, Local CSeq = 329690144, Remote CSeq = 2
1433920556 -> [CViaSetSerializer::serialize] Serialized via set : ViaSerialize=Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [receiveInviteMessage] send RemoteSdp to the StandBy.
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [exec_ipc] in 2324.
1433920556 -> [display_ipc_in] ------------ Begin ---------------
1433920556 -> neqt : 5216 Id : -1
1433920556 -> REQUEST FAILURE
1433920556 -> xx : 88
1433920556 -> RELATIVE REQUEST : INVITE
1433920556 -> [display_ipc_in] ------------- End ----------------
1433920556 -> [CMotorCallManager::onIncomingEvent] an event 10767 arrived on the eqt 5216--1.
1433920556 -> [CMotorCallManager::onIncomingEvent] state = PROCEEDING_STATE.
1433920556 -> [onIncomingEvent] REQUEST FAILURE arrived.
1433920556 -> [receiveRequestFailureEvent] Call: call-8C366E0B-0000-0010-150E-54C@196.5.234.253 eqt: 5216 PROCEEDING_STATE received an event.
1433920556 -> 11f7[CMotorCall::getOutgoingCall] outgoingCall:0
1433920556 -> [receiveRequestFailureEvent] incoming call.
1433920556 -> [isValidGwExt] ext gw 1 is valid
1433920556 -> 11f7[CMotorCall ABCF ExtGW
1433920556 -> 11f7 [CCall::makeGenericResponse] 488
1433920556 -> 11f7 [CCall::getDialog] Confirmed Dialog is not found (ID = ;c405eafd-c989)
1433920556 -> 11f7 [CCall::getDialog] Returning Initial Dialog Server
1433920556 -> 1583 [CDialog::createResponse] 488
1433920556 -> 210c [CTransProceedingState::createResponse] CResponse 29E94 ref=1
1433920556 -> 29E94 [CMessage::send] sip_sendMessage (196.5.234.253:5060)
1433920556 -> SEND MESSAGE TO NETWORK (196.5.234.253:25102 [TCP]) (BUFF LEN = 511)
----------------------utf8-----------------------
SIP/2.0 488 Not Acceptable Here
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
User-Agent: OmniPCX Enterprise R9.1 i1.605.21
To: <sip:50877405000@196.5.234.252:5060;user=phone>;tag=4dbabf30cb5213bef17c1cd2589fc442
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
CSeq: 2 INVITE
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
Content-Length: 0
-------------------------------------------------
1433920556 -> [CTransport::findConnection] pConnection = f09b
1433920556 -> [CTransport::getConnection] RemoteHost=(196.5.234.253 25102) already exist, using connection f09b
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> 29E93 [~CResponse] resp(100) call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 INVITE
1433920556 -> 210c [CTransProceedingState::createResponse] Final : Transaction changes to Completed state
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO COMPLETED
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Proceeding, currentState = Completed, reason = Final resp creation]
1433920556 -> 210c [CTransaction::startTimer] Timer H is started (delay = 32000 ms)
1433920556 -> 1583 [CDialog::updateRouteSet] there are 0 record-route headers
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [exec_ipc] in end 2324.
1433920556 -> f09b [CConnectionTcp::receiveMsg] Receiveing message, rc = 613
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) MaxNbMsgByPeriod:25 Period:3
1433920556 -> f09b [CConnection::dOSTest](196.5.234.253,25102,1) NbMsg:2 < seuil
1433920556 -> f09b [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920556 -> RECEIVE MESSAGE FROM NETWORK (196.5.234.253:25102 [TCP])
----------------------utf8-----------------------
ACK sip:50877405000@196.5.234.252:5060;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, OPTIONS, REFER, REGISTER, INFO, UPDATE, PRACK
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
Contact: <sip:+27102216592@196.5.234.253:5060;transport=TCP>
Content-Length: 0
CSeq: 2 ACK
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Max-Forwards: 69
To: <sip:50877405000@196.5.234.252:5060;user=phone>;tag=4dbabf30cb5213bef17c1cd2589fc442
User-Agent: SONUS SBC2000 4.1.1v377 UX
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
-------------------------------------------------
1433920556 -> 485DA [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920556 -> [CIOCom::receiveRequest] Received CRequest 485DA ref=1
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CIOCom::checkHostInBlackList] host=196.5.234.253
1433920556 -> [CAdnsMngt::checkHostInBlackList] host=196.5.234.253 alcResult= 0
1433920556 -> [CDispatcher::onIncomingRequest()]
1433920556 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920556 -> 102 [CCallManager::onIncomingRequest()]
1433920556 -> 11f7 [CCall::receiveRequest] ACK
1433920556 -> 11f7 [CCall::getDialog] Confirmed Dialog is not found (ID = 4dbabf30cb5213bef17c1cd2589fc442;c405eafd-c989)
1433920556 -> 11f7 [CCall::getDialog] Returning Initial Dialog Server
1433920556 -> 1583 [CDialog::receiveRequest]
1433920556 -> 1583 [CDialog::receiveAckRequest]
1433920556 -> 210c [CTransCompletedState::receiveRequest] ACK(UDP) : Transaction changes to Confirmed state
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO CONFIRMED
1433920556 -> 210c [CTransaction::changeState] notifying the parent dialog
1433920556 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = Completed, currentState = Confirmed, reason = Request reception]
1433920556 -> 210c [CTransaction::freeTimerToken] Timer H is freed
1433920556 -> 210c [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920556 -> 210c [CTransaction::changeState] no transaction state, terminated reason : Timer I fires
1433920556 -> 1583 [CDialog::receiveAckRequest] receiving an ACK on a previously rejected INVITE
1433920556 -> 11f7 [CCall::checkAuthentication] ACK
1433920556 -> 11f7[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920556 -> 11f7[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
1433920556 -> 0[CMotorCall::onReceiveRequest] route already analyzed.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] request for gateway.
1433920556 -> 11f7[CMotorCall::onReceiveRequest] state = TERMINATED_STATE.
1433920556 -> 11f7[CMotorCall::compareDialogFromContext] same Dialog
1433920556 -> 11f7[CMotorCall::methodAckReceived] Ack => update the inviteContext.
1433920556 -> [receiveAckMessage] Call: call-8C366E0B-0000-0010-150E-54C@196.5.234.253 eqt: 5216 TERMINATED_STATE received a message.
1433920556 -> 11f7[emitEventToMonitel] content size (lginfo): 656
1433920556 -> 11f7[emitEventToMonitel] CAC = 0 eqtCAC = -1
1433920556 -> 11f7[emitEventToMonitel] CAC = 0
1433920556 -> [ipc_thread] IPC Thread : Ipc reception 2325.
1433920556 -> [ipc_thread] IPC Thread : TCL thread signaled.
1433920556 -> [sendLgEvtSip] Event sent on eqt : 5216 Id :-1
1433920556 -> [display_ipc_out] ------------ Begin ---------------
1433920556 -> Id : -1
1433920556 -> ACK
1433920556 -> [display_ipc_out] ------------- End ----------------
1433920556 -> [exec_ipc] in 2324.
1433920556 -> [display_ipc_in] ------------ Begin ---------------
1433920556 -> neqt : 5216 Id : -1
1433920556 -> SIP EQT RELEASED
1433920556 -> [display_ipc_in] ------------- End ----------------
1433920556 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 5216--1.
1433920556 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 5216 has released its equipment.
1433920556 -> 11f7[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
1433920556 -> 11f7[emitEventToMonitel] content size (lginfo): 656
1433920556 -> 11f7[emitEventToMonitel] CAC = 0 eqtCAC = -1
1433920556 -> 11f7[emitEventToMonitel] CAC = 0
1433920556 -> [sendLgEvtSip] Event sent on eqt : 5216 Id :-1
1433920556 -> [display_ipc_out] ------------ Begin ---------------
1433920556 -> Id : -1
1433920556 -> UNKNOWN MESSAGE
1433920556 -> [display_ipc_out] ------------- End ----------------
1433920556 -> 11f7[CMotorCall::unRegister] Remove eqt : 5216 diag : -1 from the map.
1433920556 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 5216 erased.
1433920556 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1433920556 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1433920556 -> [CMotorCallManager::onIncomingEvent] killSession.
1433920556 -> 11f7 [CCall::killSession]
1433920556 -> 11f7 [CCall::onKill Session Call manager close is called]
1433920556 -> 11f7 [CCall::killSession] notifying the call manager
1433920556 -> 102 [CCallManager::onCallClosed]
1433920556 -> 102 [CCallManager::onCallClosed()] Call 11f7 closed. Removing call 497369784 from the maps
1433920556 -> [CMotorCallManager::onNotifyCallClosed] Call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253 is closed.
1433920556 -> [CMotorCallManager::onNotifyCallClosed] Call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253 is closed.
1433920556 -> [CMotorCallManager::onNotifyCallClosed] call processResponse.
1433920556 -> 11f7[CMotorCall::processResponse] call chooseBestResponse.
1433920556 -> 11f7[CMotorCall::chooseBestResponse] pForkedBranch=0x1dab78f8 iResponseCode=2000.
1433920556 -> [CForkedBranch::getResponseCode] response=2000.
1433920556 -> 11f7[CMotorCall::chooseBestResponse] next branch.
1433920556 -> 11f7[CMotorCall::processResponse] no response found.
1433920556 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1433920556 -> [CCall::onKill] set callmanager to null
1433920556 -> [exec_ipc] in end 2324.
1433920557 -> [CTransaction::notifyDialog]
1433920557 -> [CTransaction::notifyDialog] notify parent dialog
1433920557 -> 1583 [CDialog::onTransactionState(pTrans = 210c, previousState = null, currentState = Terminated, reason = Timer I fires]
1433920557 -> 1583 [CDialog::onTransactionState] dialog is terminated
1433920557 -> 1583 [CDialog::onTransactionState] onDialogClosed
1433920557 -> 11f7 [CCall::onDialogClosed]
1433920557 -> 11f7 [CCall::onDialogClosed] only initial *********
1433920557 -> 11f7 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920557 -> 210C [~CTransaction] transaction 2 INVITE
1433920557 -> 485DA [~CRequest] req call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 ACK
1433920558 -> 2105 [CTransTryingState::timerFires] Timer E fires
1433920558 -> SEND MESSAGE TO NETWORK (196.5.234.93:5060 [UDP]) (BUFF LEN = 645)
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920558 -> [CTransport::findConnection] pConnection = f048
1433920558 -> [CTransport::getConnection] RemoteHost=(196.5.234.93 5060) already exist, using connection f048
1433920558 -> udp_send fd:3
1433920558 -> udp_send fd:3 port 5060 iBytesSend:645 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 196.5.234.252;branch=z9hG4bK37ac6fec4abd0a5200ba5c6ee5cd40fb2ab5757a22a8819b7e690392a53a464b
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 69
Expires: 3600
Content-Length: 0
1433920558 -> f048 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920558 -> 2105 [CTransaction::startTimer] Timer E is started (delay = 4000 ms)
1433920558 -> udp_recv fd:3
1433920558 -> udp_recv fd:3 iBytesRead:534 message:REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
1433920558 -> UdpInputProc iSock:3 iBytesRead:534 Host:10.51.82.55 Port:5060
1433920558 -> [CTransportUdp::receiveMessage] from 10.51.82.55:5060 rc:534
1433920558 -> [CTransport::findConnection] pConnection = f047
1433920558 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) MaxNbMsgByPeriod:25 Period:3
1433920558 -> f047 [CConnection::dOSTest](10.51.82.55,5060,0) NbMsg:4 < seuil
1433920558 -> f047 [CConnection::resetKeepAliveTimer] Creating the keep alive timer
1433920558 -> RECEIVE MESSAGE FROM NETWORK (10.51.82.55:5060 [UDP])
----------------------utf8-----------------------
REGISTER sip:196.5.234.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.51.82.55:5060;branch=z9hG4bK8590fcc79A295338
From: "7672" <sip:7672@196.5.234.93>;tag=B6310B6C-5B7C23D1
To: <sip:7672@196.5.234.93>
CSeq: 1 REGISTER
Call-ID: 17e3a14d-23590116-afde72e3@10.51.82.55
Contact: <sip:7672@10.51.82.55:5060>;methods="INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER"
User-Agent: PolycomSoundStationIP-SSIP_5000-UA/3.2.3.1734
Accept-Language: en
Max-Forwards: 70
Expires: 3600
Content-Length: 0
-------------------------------------------------
1433920558 -> 485DB [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1433920558 -> [CIOCom::receiveRequest] Received CRequest 485DB ref=1
1433920558 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920558 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920558 -> [CIOCom::checkHostInBlackList] host=10.51.82.55
1433920558 -> [CAdnsMngt::checkHostInBlackList] host=10.51.82.55 alcResult= 0
1433920558 -> [CIOCom::receiveRequest] rport1 not empty
1433920558 -> [CDispatcher::onIncomingRequest()]
1433920558 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1433920558 -> 104 [CCallManager::onIncomingRequest()]
1433920558 -> 11f8 [CCall::receiveRequest] REGISTER
1433920558 -> 11f8 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920558 -> 11f8 [CCall::getDialog] Initial Dialog Server not found
1433920558 -> 1584 [CDialog::receiveRequest]
1433920558 -> 1584 [CDialog::receiveBasicRequest]
1433920558 -> 210d [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920558 -> 210d [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1584 [CDialog::onTransactionState(pTrans = 210d, previousState = Terminated, currentState = Initial, reason = None]
1433920558 -> 210d [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920558 -> 210d [CTransaction::changeState] STATE CHANGED TO TRYING
1433920558 -> 210d [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1584 [CDialog::onTransactionState(pTrans = 210d, previousState = Initial, currentState = Trying, reason = Request reception]
1433920558 -> 1584 [CDialog::addTransaction] added transaction 210d with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920558 -> 11f8 [CCall::checkAuthentication] REGISTER
1433920558 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920558 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920558 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920558 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920558 -> [CGWMngData::isMainServer ] check the request for PCS
1433920558 -> check_PCS_ACTIVE start
1433920558 -> check_PCS_ACTIVE get the PCS state
1433920558 -> check_PCSstate
1433920558 -> am_I_PCS SCSWorking : NO
1433920558 -> OXE contains PCS configuration
1433920558 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920558 -> check_PCSstate ipadd 10.51.82.55
1433920558 -> check_PCSstate user IP is Found ? = YES
1433920558 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920558 -> [isDomainFromGwExt] no User from request.
1433920558 -> check_PCS_ACTIVE extgwid -1
1433920558 -> The recevied host 10.51.82.55
1433920558 -> Trying to find the ip address in domain list
1433920558 -> The entry dom : 1 add_type=2
1433920558 -> The entry dom ip low :196.9.33.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The entry dom : 2 add_type=2
1433920558 -> The entry dom ip low :196.9.69.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The user is ipadd not in any Domain range return state as -1
1433920558 -> check_PCSstate stat of PCS is : -1
1433920558 -> check_PCS_ACTIVE the PCS state -1
1433920558 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920558 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920558 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920558 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920558 -> [isDomainFromGwExt] no User from request.
1433920558 -> [domain not from an External Gateway.
1433920558 -> 11f8 [CRegistrarCall::onReceiveRequest] REGISTER
1433920558 -> [CGWMngData::isMainServer] CPU is MAIN.
1433920558 -> [CGWMngData::isMainServer] checkwith PCS = 1
1433920558 -> CGwMngData::am_I_PCS SCSWorking : NO
1433920558 -> [CGWMngData::isMainServer ] I am main and not PCS
1433920558 -> [CGWMngData::isMainServer ] check the request for PCS
1433920558 -> check_PCS_ACTIVE start
1433920558 -> check_PCS_ACTIVE get the PCS state
1433920558 -> check_PCSstate
1433920558 -> am_I_PCS SCSWorking : NO
1433920558 -> OXE contains PCS configuration
1433920558 -> check_PCSstate find the user ip from REGISTER msg contact header
1433920558 -> check_PCSstate ipadd 10.51.82.55
1433920558 -> check_PCSstate user IP is Found ? = YES
1433920558 -> [isDomainFromGwExt] Host from request is : 10.51.82.55.
1433920558 -> [isDomainFromGwExt] no User from request.
1433920558 -> check_PCS_ACTIVE extgwid -1
1433920558 -> The recevied host 10.51.82.55
1433920558 -> Trying to find the ip address in domain list
1433920558 -> The entry dom : 1 add_type=2
1433920558 -> The entry dom ip low :196.9.33.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The entry dom : 2 add_type=2
1433920558 -> The entry dom ip low :196.9.69.0
1433920558 -> The entry ipaddress from low :10.51.82.55
1433920558 -> The entry compare :1
1433920558 -> The entry compare 2 :0
1433920558 -> The user is ipadd not in any Domain range return state as -1
1433920558 -> check_PCSstate stat of PCS is : -1
1433920558 -> check_PCS_ACTIVE the PCS state -1
1433920558 -> check_PCS_ACTIVE the PCS state is NOT ACTIVE or -1
1433920558 -> [CGWMngData::isMainServer ] request for ME precess the msg
1433920558 -> [CServRegistrar::processRegister]
1433920558 -> 11f8 [CRegistrarCall::onReceiveRequest], user not found => kill session
1433920558 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920558 -> 104 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f8
1433920558 -> 11f8 [CCall::killSession]
1433920558 -> 210d [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920558 -> 210d [CTransaction::changeState] no transaction state, terminated reason : None
1433920558 -> 11f8 [CCall::onKill Session Call manager close is called]
1433920558 -> 11f8 [CCall::killSession] notifying the call manager
1433920558 -> 104 [CCallManager::onCallClosed]
1433920558 -> 104 [CCallManager::onCallClosed()] Call 11f8 closed. Removing call 497776784 from the maps
1433920558 -> [CCall::onKill] set callmanager to null
1433920558 -> 102 [CCallManager::onIncomingRequest()]
1433920558 -> [CMotorCallManager::callFactory] For call : 17e3a14d-23590116-afde72e3@10.51.82.55.
1433920558 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.21
1433920558 -> [CMotorCallManager::callFactory]=1da35fb8.
1433920558 -> 11f9 [CCall::receiveRequest] REGISTER
1433920558 -> 11f9 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920558 -> 11f9 [CCall::getDialog] Initial Dialog Server not found
1433920558 -> 1585 [CDialog::receiveRequest]
1433920558 -> 1585 [CDialog::receiveBasicRequest]
1433920558 -> 210e [CTransaction::changeState] STATE CHANGED TO INITIAL
1433920558 -> 210e [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1585 [CDialog::onTransactionState(pTrans = 210e, previousState = Terminated, currentState = Initial, reason = None]
1433920558 -> 210e [CTransInitialState::receiveRequest] Transaction changes to Trying state
1433920558 -> 210e [CTransaction::changeState] STATE CHANGED TO TRYING
1433920558 -> 210e [CTransaction::changeState] notifying the parent dialog
1433920558 -> 1585 [CDialog::onTransactionState(pTrans = 210e, previousState = Initial, currentState = Trying, reason = Request reception]
1433920558 -> 1585 [CDialog::addTransaction] added transaction 210e with branch z9hG4bK8590fcc79A295338, with CSeq 1
1433920558 -> 11f9 [CCall::checkAuthentication] REGISTER
1433920558 -> 11f9[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1433920558 -> [CGwMngData::isAuthenticationRequiredForThisClient] 196.5.234.93 .
1433920558 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920558 -> [isDomainFromGwExt] User from request is : 7672
1433920558 -> [domain not from an External Gateway.
1433920558 -> [getFromHeader].
1433920558 -> [isUserDeclared] 7672@196.5.234.93
1433920558 -> isUserDeclared] NOT found in the dictionnary.
1433920558 -> [isSeplosStation] other station
1433920558 -> [isDomainFromGwExt] Host from request is : 196.5.234.93.
1433920558 -> [isDomainFromGwExt] User from request is : 7672
1433920558 -> 11f9[CMotorCall::toGatewayOrProxy] request for proxydomain=196.5.234.93.
1433920558 -> 11f9[CMotorCall::toGatewayOrProxy] request for proxy (ReqUri domain unknown).
1433920558 -> 11f9[CMotorCall::toGatewayOrProxy] rout to proxy.
1433920558 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, for call 17e3a14d-23590116-afde72e3@10.51.82.55
1433920558 -> 102 [CCallManager::onIncomingRequest()] E_MGR_NOT_AFFECTED, kill session for call 11f9
1433920558 -> 11f9 [CCall::killSession]
1433920558 -> 210e [CTransaction::changeState] STATE CHANGED TO TERMINATED
1433920558 -> 210e [CTransaction::changeState] no transaction state, terminated reason : None
1433920558 -> 11f9 [CCall::onKill Session Call manager close is called]
1433920558 -> 11f9 [CCall::killSession] notifying the call manager
1433920558 -> 102 [CCallManager::onCallClosed]
1433920558 -> 102 [CCallManager::onCallClosed()] Call 11f9 closed. Removing call 497246136 from the maps
1433920558 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920558 -> [CMotorCallManager::onNotifyCallClosed] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is closed.
1433920558 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1433920558 -> [CCall::onKill] set callmanager to null
1433920558 -> 103 [CCallManager::onIncomingRequest()]
1433920558 -> 11f0 [CCall::receiveRequest] REGISTER
1433920558 -> 11f0 [CCall::getDialog] Confirmed Dialog is not found (ID = ;B6310B6C-5B7C23D1)
1433920558 -> 11f0 [CCall::getDialog] Returning Initial Dialog Server
1433920558 -> 157b [CDialog::receiveRequest]
1433920558 -> 157b [CDialog::receiveBasicRequest]
1433920558 -> 157b [CDialog::receiveBasicRequest] A basic server transaction is found with the same branch
1433920558 -> [CTransaction::notifyDialog]
1433920558 -> [CTransaction::notifyDialog] notify parent dialog
1433920558 -> 1584 [CDialog::onTransactionState(pTrans = 210d, previousState = null, currentState = Terminated, reason = None]
1433920558 -> 1584 [CDialog::onTransactionState] dialog is terminated
1433920558 -> 1584 [CDialog::onTransactionState] onDialogClosed
1433920558 -> 11f8 [CCall::onDialogClosed]
1433920558 -> 11f8 [CCall::onDialogClosed] only initial *********
1433920558 -> 11f8 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920558 -> 210D [~CTransaction] transaction 1 REGISTER
1433920558 -> [CTransaction::notifyDialog]
1433920558 -> [CTransaction::notifyDialog] notify parent dialog
1433920558 -> 1585 [CDialog::onTransactionState(pTrans = 210e, previousState = null, currentState = Terminated, reason = None]
1433920558 -> 1585 [CDialog::onTransactionState] dialog is terminated
1433920558 -> 1585 [CDialog::onTransactionState] onDialogClosed
1433920558 -> 11f9 [CCall::onDialogClosed]
1433920558 -> 11f9 [CCall::onDialogClosed] only initial *********
1433920558 -> 11f9 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
1433920558 -> 210E [~CTransaction] transaction 1 REGISTER
1433920558 -> 485DB [~CRequest] req 17e3a14d-23590116-afde72e3@10.51.82.55 1 REGISTER
1433920558 -> 102 [CCallManager::removeGarbage] at index i = 1
1433920558 -> 11f9[CMotorCall::~CMotorCall] Call : 17e3a14d-23590116-afde72e3@10.51.82.55 is being destructed.
1433920558 -> 11f9 [CCall::~CCall]
1433920558 -> 11f9 [CCall::removeGarbage]
1433920558 -> 1585 [CDialog::~CDialog]
1433920558 -> 102 [CCallManager::removeGarbage] at index i = 0
1433920558 -> 11f7[CMotorCall::~CMotorCall] Call : call-8C366E0B-0000-0010-150E-54C@196.5.234.253 is being destructed.
1433920558 -> 11f7 [CCall::~CCall]
1433920558 -> 11f7 [CCall::removeGarbage]
1433920558 -> 1583 [CDialog::~CDialog]
1433920558 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1433920558 -> 29E94 [~CResponse] resp(488) call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 INVITE
1433920558 -> 485D9 [~CRequest] req call-8C366E0B-0000-0010-150E-54C@196.5.234.253 2 INVITE
1433920558 -> 104 [CCallManager::removeGarbage] at index i = 0
1433920558 -> 11f8 [CCall::~CCall]
1433920558 -> 11f8 [CCall::removeGarbage]
1433920558 -> 1584 [CDialog::~CDialog]
Re: Problem dialing from Lync
registration isuue ?!
Re: Problem dialing from Lync
Haroun
All numbers can be dialed from Lync except a few and 087xxxxx is one of them. So I dont think registration is the problem.
"Danie Vink is the caller from Lync on extension 6592 via gateway address 196.5.234.253"
There is quite a lot op sip traffic on this trace because the UX NET gateway handles Lync,polycom bridge and the pabx and they have lots of conferences daily. So some of this trace might be something else happening on SIP as well
But the Problem I have is with the call below:
INVITE sip:50877405000@196.5.234.252:5060;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, OPTIONS, REFER, REGISTER, INFO, UPDATE, PRACK
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
Contact: <sip:+27102216592@196.5.234.253:5060;transport=TCP>
Content-Length: 239
Content-Type: application/sdp
CSeq: 2 INVITE
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Max-Forwards: 69
Min-SE: 500
Session-Expires: 3600
Supported: replaces,update,timer,100rel
To: <sip:50877405000@196.5.234.252:5060;user=phone>
User-Agent: SONUS SBC2000 4.1.1v377 UX
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
thanx
All numbers can be dialed from Lync except a few and 087xxxxx is one of them. So I dont think registration is the problem.
"Danie Vink is the caller from Lync on extension 6592 via gateway address 196.5.234.253"
There is quite a lot op sip traffic on this trace because the UX NET gateway handles Lync,polycom bridge and the pabx and they have lots of conferences daily. So some of this trace might be something else happening on SIP as well
But the Problem I have is with the call below:
INVITE sip:50877405000@196.5.234.252:5060;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, OPTIONS, REFER, REGISTER, INFO, UPDATE, PRACK
Call-ID: call-8C366E0B-0000-0010-150E-54C@196.5.234.253
Contact: <sip:+27102216592@196.5.234.253:5060;transport=TCP>
Content-Length: 239
Content-Type: application/sdp
CSeq: 2 INVITE
From: "Danie Vink" <sip:+27102216592@196.5.234.253:5060;user=phone>;tag=c405eafd-c989;sgid=2
Max-Forwards: 69
Min-SE: 500
Session-Expires: 3600
Supported: replaces,update,timer,100rel
To: <sip:50877405000@196.5.234.252:5060;user=phone>
User-Agent: SONUS SBC2000 4.1.1v377 UX
Via: SIP/2.0/TCP 196.5.234.253:5060;branch=z9hG4bK-UX-c405-eafd-22f0
thanx
Re: Problem dialing from Lync
50877405000 is a sipextension or device ? 5 is prefix?
[isUserRegistred] getRegistration=50877405000.
1433920556 -> [isUserRegistred] result=-1.
[isUserRegistred] getRegistration=50877405000.
1433920556 -> [isUserRegistred] result=-1.
Re: Problem dialing from Lync
yes 5 Is Trunk seizure prefix
0877405000 is the number he dialed from extension +27102216592@196.5.234.253:5060
0877405000 is the number he dialed from extension +27102216592@196.5.234.253:5060
Re: Problem dialing from Lync
so check sip truk group public cos compatibility zone , transit others
i guess that trkgp is abcf and cos =31
i guess that trkgp is abcf and cos =31
