Code: Select all
traced started ...
1476089134 -> Mon Oct 10 10:45:34 2016 RECEIVE MESSAGE FROM NETWORK (192.168.X.X:5060 [UDP])
----------------------utf8-----------------------
INVITE sip:2399@192.168.XXX.XXX:5060;user=phone SIP/2.0
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK7a6f5d40
Max-Forwards: 70
From: "BRYAN_" <sip:2373@192.168.X.X>;tag=as0c03c1de
To: <sip:2399@192.168.XXX.XXX:5060;user=phone>
Contact: <sip:2373@192.168.X.X:5060>
Call-ID: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060
CSeq: 102 INVITE
User-Agent: XIVO PBX
Date: Mon, 10 Oct 2016 08:45:34 GMT
Session-Expires: 1800
Min-SE: 300
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Remote-Party-ID: "BRYAN_" <sip:2373@192.168.X.X>;party=calling;privacy=off;screen=no
Content-Type: application/sdp
Content-Length: 366
v=0
o=root 1197324175 1197324175 IN IP4 192.168.X.X
s=Asterisk PBX 13.9.1
c=IN IP4 192.168.X.X
t=0 0
m=audio 17354 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=fmtp:4 annexa=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
-------------------------------------------------
Mon Oct 10 10:45:34 2016 [CIOCom::receiveRequest] optimisation value 1
Mon Oct 10 10:45:34 2016 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => 192.168.XXX.XXX node000000
Mon Oct 10 10:45:34 2016 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
1476089134 -> Mon Oct 10 10:45:34 2016 B24D2 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
Mon Oct 10 10:45:34 2016 [CIOCom::receiveRequest] Received CRequest B24D2 ref=1
Mon Oct 10 10:45:34 2016 [CIOCom::receiveRequest] rport1 not empty
Mon Oct 10 10:45:34 2016 [CDispatcher::onIncomingRequest()]
Mon Oct 10 10:45:34 2016 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Mon Oct 10 10:45:34 2016 102 [CCallManager::onIncomingRequest()]
Mon Oct 10 10:45:34 2016 102 [CCallManager::onIncomingRequest()] creates a new Call if this request doesn't refer to any old call
Mon Oct 10 10:45:34 2016 [CMotorCallManager::callFactory] For call : 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060.
Mon Oct 10 10:45:34 2016 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R10.0 j1.410.49.a
Mon Oct 10 10:45:34 2016 [CMotorCallManager::callFactory]=8586430.
Mon Oct 10 10:45:34 2016 1193 [CCall::receiveRequest] INVITE
Mon Oct 10 10:45:34 2016 1193 [CCall::getDialog] Confirmed Dialog is not found (ID = ;as0c03c1de)
Mon Oct 10 10:45:34 2016 1193 [CCall::getDialog] Initial Dialog Server not found
Mon Oct 10 10:45:34 2016 1531 [CDialog::receiveRequest]
Mon Oct 10 10:45:34 2016 1531 [CDialog::receiveInviteRequest]
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] STATE CHANGED TO INITIAL
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] notifying the parent dialog
Mon Oct 10 10:45:34 2016 1531 [CDialog::onTransactionState(pTrans = 211b, previousState = Terminated, currentState = Initial, reason = None]
1476089134 -> Mon Oct 10 10:45:34 2016 211b [CTransInitialState::receiveRequest] Transaction changes to Proceeding state
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] notifying the parent dialog
Mon Oct 10 10:45:34 2016 1531 [CDialog::onTransactionState(pTrans = 211b, previousState = Initial, currentState = Proceeding, reason = Request reception]
Mon Oct 10 10:45:34 2016 CEB41 [CResponse::CResponse] Creation of a response
Mon Oct 10 10:45:34 2016 211b [CTransProceedingState::createResponse] CResponse CEB41 ref=1
Mon Oct 10 10:45:34 2016 CEB41 [CResponse::create] RESPONSE CREATION
Mon Oct 10 10:45:34 2016 CEB41 [CResponse::checkStatusLine] Create StatusLine from code given as parameter
Mon Oct 10 10:45:34 2016 CEB41 [CResponse::createViaHeaders] Copy Via headers from previous request (number : 1)
Mon Oct 10 10:45:34 2016 B24D2 [CMessage::getHeaderAtIndexFromSipMessage(Timestamp, 0)] sip_getHeaderAtIndex FAILED => HSS ERROR No exist
Mon Oct 10 10:45:34 2016 CEB41 [CResponse::create] Initialize context (Local = To & Remote = From)
Mon Oct 10 10:45:34 2016 CEB41 [CMessage::send] sip_sendMessage (192.168.X.X:5060)
Mon Oct 10 10:45:34 2016 SEND MESSAGE TO NETWORK (192.168.X.X:5060 [UDP]) (BUFF LEN = 286)
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:2399@192.168.XXX.XXX:5060;user=phone>
From: "BRYAN_" <sip:2373@192.168.X.X>;tag=as0c03c1de
Call-ID: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060
CSeq: 102 INVITE
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK7a6f5d40
Content-Length: 0
-------------------------------------------------
1476089134 -> Mon Oct 10 10:45:34 2016 [sip_freeEventContext]
Mon Oct 10 10:45:34 2016 1531 [CDialog::receiveInviteRequest] a new Server INVITE transaction is in progress
Mon Oct 10 10:45:34 2016 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Server, UA)
Mon Oct 10 10:45:34 2016 [CSessionTimerContext::updateAfterRefreshReception] Update CSessionTimerContext (refresh reception)
Mon Oct 10 10:45:34 2016 [CSessionTimerContext::updateSupported] Request timer supported
Mon Oct 10 10:45:34 2016 [CSessionTimerContext::updateMinSE] Min-SE updated : 300
Mon Oct 10 10:45:34 2016 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Mon Oct 10 10:45:34 2016 [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=INVITE
Mon Oct 10 10:45:34 2016 1531 [CDialog::addTransaction] added transaction 211b with branch z9hG4bK7a6f5d40, with CSeq 102
Mon Oct 10 10:45:34 2016 1193 [CCall::checkAuthentication] INVITE
Mon Oct 10 10:45:34 2016 B24D2 [CMessage::getAssertedIdCount] need to create the wrapper
Mon Oct 10 10:45:34 2016 B24D2 [CMessage::createAssertedIdWrapperFromMessage]
Mon Oct 10 10:45:34 2016 B24D2 [CMessage::createAssertedIdWrapperFromMessage] there is 0 P-Asserted-Identity header in the message
Mon Oct 10 10:45:34 2016 B24D2 [CMessage::getPreferredIdCount] need to create the wrapper
Mon Oct 10 10:45:34 2016 B24D2 [CMessage::createPreferredIdWrapperFromMessage] there is 0 P-Preferred-Identity header in the message
Mon Oct 10 10:45:34 2016 [CGwMngData::isAuthenticationRequiredForThisClient] 192.168.X.X .
1476089134 -> Mon Oct 10 10:45:34 2016 isDomainFromGwExt SCSWorking: NO
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] Host from request is : 192.168.X.X.
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] User from request is : 2373
Mon Oct 10 10:45:34 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Mon Oct 10 10:45:34 2016 domain from External Gateway 7.
Mon Oct 10 10:45:34 2016 87c9 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 87ca [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 87cd [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 1193[CMotorCall::setFilterUsedMode] To be traced = 0
Mon Oct 10 10:45:34 2016 1193[CMotorCall::initOfUserType] values are reseted
Mon Oct 10 10:45:34 2016 [getFromHeader] displayName="BRYAN_".
Mon Oct 10 10:45:34 2016 [getFromHeader] =2373@192.168.X.X.
Mon Oct 10 10:45:34 2016 [getFromHeader] clirPresent=0.
Mon Oct 10 10:45:34 2016 [isAddrInDico] user=2373 host=192.168.X.X
Mon Oct 10 10:45:34 2016 [isUserInDico] 2373@192.168.X.X
Mon Oct 10 10:45:34 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 10:45:34 2016 [isAddrInDico] other sip user
Mon Oct 10 10:45:34 2016 isDomainFromGwExt SCSWorking: NO
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] Host from request is : 192.168.X.X.
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] User from request is : 2373
Mon Oct 10 10:45:34 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Mon Oct 10 10:45:34 2016 1193[CMotorCall::getUserType] extGw = 7.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
1476089134 -> Mon Oct 10 10:45:34 2016 1193[CMotorCall::toGatewayOrProxy] request for proxydomain=192.168.XXX.XXX.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall ABCF ExtGW
Mon Oct 10 10:45:34 2016 [isUserRegistred] getRegistration=2399.
Mon Oct 10 10:45:34 2016 [isUserRegistred] result=-1.
Mon Oct 10 10:45:34 2016 [isAddrInDico] user=2399 host=192.168.XXX.XXX
Mon Oct 10 10:45:34 2016 [isUserInDico] 2399@192.168.XXX.XXX
Mon Oct 10 10:45:34 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 10:45:34 2016 [isAddrInDico] other sip user
Mon Oct 10 10:45:34 2016 1193[CMotorCall::storeRequestInCall] inRequest storage=0x8551d98.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::onReceiveRequest] request for gateway.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::onReceiveRequest] state = INITIAL_STATE.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] nb available licenses=71 .
Mon Oct 10 10:45:34 2016 [isUserInDico] 2373@192.168.X.X
Mon Oct 10 10:45:34 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] license OK.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 3525 [CSipContextID::isValid] Call-ID is not valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] Invite => update the inviteContext.
Mon Oct 10 10:45:34 2016 87d6 [CSipAddrSpec::CSipAddrSpec()] Invalid type
1476089134 -> Mon Oct 10 10:45:34 2016 [CForkedBranch::CForkedBranch] context = 0x85868d8.
Mon Oct 10 10:45:34 2016 87d9 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] reqUri stored: sip:2373@192.168.X.X:5060
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] cacUsed = 0 before.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] returnStat = 0 before.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] cacUsed = 0 after.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodInviteReceived] CAC = 0
Mon Oct 10 10:45:34 2016 [receiveInviteMessage] Call: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060 eqt: -1 INITIAL_STATE received a message.
Mon Oct 10 10:45:34 2016 [decodeInviteCLIR].
Mon Oct 10 10:45:34 2016 [receiveInviteMessage] INFO present in Allow header
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 am_I_PCS SCSWorking : NO
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 check_extgw_PCSstate EXTGW is : 7
Mon Oct 10 10:45:34 2016 The check_extgw_PCSstate extgwid : 7
Mon Oct 10 10:45:34 2016 The state of PCS which rescued the extgw is : -1
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 [decodeInviteFromUsingPAI]. octet3a_scrn = 1
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::analyseSessionTimer] exit with uacGatewayMode=0 uacRefresher=0.
1476089134 -> Mon Oct 10 10:45:34 2016 [CSipMediaDescription::parseFormatString] Got 5 format(s) from string 8 0 18 4 101
Mon Oct 10 10:45:34 2016 [checkSdpValidity] Media 0 type 1 contains 5 formats.
Mon Oct 10 10:45:34 2016 [checkSdpValidity] Format : 8.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 10:45:34 2016 [convertSdpIntoTsdp] No Direction in the session part.
Mon Oct 10 10:45:34 2016 [convertSdpIntoTsdp] Check the direction in Session part - result:0.
Mon Oct 10 10:45:34 2016 [convertSdpIntoTsdp] media AUDIO detected (previous crypto=0).
Mon Oct 10 10:45:34 2016 [convertAudioMedia] The audio media contains 5 format(s).
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Format 0 is 8.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Format 1 is 0.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Format 2 is 18.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Format 3 is 4.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Format 4 is 101.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] 101.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Format is DTMF:101.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Direction is sendrecv.
Mon Oct 10 10:45:34 2016 [convertAudioMedia] Connection address retrieved in sdp: 192.168.X.X.
Mon Oct 10 10:45:34 2016 [convertIPStrIntoTuipv] 192.168.X.X => 192.168.X.X
Mon Oct 10 10:45:34 2016 [display_sdp] address =192.168.X.X
Mon Oct 10 10:45:34 2016 [display_sdp] direction=0.
Mon Oct 10 10:45:34 2016 [convertSdpIntoTsdp] only one media taken into account xxx crypto_index=0 clear media=1
1476089134 -> Mon Oct 10 10:45:34 2016 [convertSdpIntoTsdp] crypto_index=0 clear media=1.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 [receiveInviteMessage] NO 100rel REQUIRED for this call.
Mon Oct 10 10:45:34 2016 [CInitialState::receiveinvitemessage allow_update 0 prack_required 0
Mon Oct 10 10:45:34 2016 [decodeInviteTo].
Mon Oct 10 10:45:34 2016 [decodeInviteReferredBy].
Mon Oct 10 10:45:34 2016 [decodeInviteACSBU].
Mon Oct 10 10:45:34 2016 87c9 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 87ca [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 87cd [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 10:45:34 2016 1193[CMotorCall::setFilterUsedMode] To be traced = 0
Mon Oct 10 10:45:34 2016 1193[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 ** SIP TRUNKING **
Mon Oct 10 10:45:34 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Mon Oct 10 10:45:34 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Mon Oct 10 10:45:34 2016 [CMotorCallManager::insertCallwithEqt] CMotorCall 3525 inserted.
Mon Oct 10 10:45:34 2016 1193[sendLgEvtSipCreate] Event sent on eqt : 3525
Mon Oct 10 10:45:34 2016 [display_ipc_out] ------------ Begin ---------------
1476089134 -> Mon Oct 10 10:45:34 2016 Id : -1
Mon Oct 10 10:45:34 2016 INVITE
Mon Oct 10 10:45:34 2016 REQUEST URI : <> 2399@192.168.XXX.XXX:5060 ; user=phone
Mon Oct 10 10:45:34 2016 FROM : <BRYAN_> 2373@192.168.X.X:5060 ; user=name
Mon Oct 10 10:45:34 2016 TO : <> 2399@192.168.XXX.XXX:5060 ; user=phone
Mon Oct 10 10:45:34 2016 CAC : 0
Mon Oct 10 10:45:34 2016 CAC ADDRESS :
Mon Oct 10 10:45:34 2016 CAC-CSBU info : UNKNOWN
Mon Oct 10 10:45:34 2016 CLIR : 0
Mon Oct 10 10:45:34 2016 Prack Required : 0
Mon Oct 10 10:45:34 2016 Allow Update : 0
Mon Oct 10 10:45:34 2016 SDP :
Mon Oct 10 10:45:34 2016 ADDRESS : 192.168.X.X :17354
Mon Oct 10 10:45:34 2016 ALGOS :
Mon Oct 10 10:45:34 2016 PCMA
Mon Oct 10 10:45:34 2016 G729
Mon Oct 10 10:45:34 2016 G723
Mon Oct 10 10:45:34 2016 101
Mon Oct 10 10:45:34 2016 DIRECTION : SEND & RECEIVE
Mon Oct 10 10:45:34 2016 crypto index : 0
Mon Oct 10 10:45:34 2016 N_GW_EXT : 7
Mon Oct 10 10:45:34 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 10:45:34 2016 1193[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Mon Oct 10 10:45:34 2016 [exec_ipc] in 30138.
Mon Oct 10 10:45:34 2016 [display_ipc_in] ------------ Begin ---------------
Mon Oct 10 10:45:34 2016 neqt : 3525 Id : -1
Mon Oct 10 10:45:34 2016 REDIRECTION
Mon Oct 10 10:45:34 2016 CONTACT : <2371> 2371@192.168.XXX.XXX:5060
Mon Oct 10 10:45:34 2016 DIVERSION :
Mon Oct 10 10:45:34 2016 URL : <663> ▒@CCUEIL 2 :13874
Mon Oct 10 10:45:34 2016 REASON : UNKNOWN
1476089134 -> Mon Oct 10 10:45:34 2016 COUNTER : 0
Mon Oct 10 10:45:34 2016 xx : 2
Mon Oct 10 10:45:34 2016 RELATIVE REQUEST : INVITE
Mon Oct 10 10:45:34 2016 [display_ipc_in] ------------- End ----------------
Mon Oct 10 10:45:34 2016 [CMotorCallManager::onIncomingEvent] an event 10766 arrived on the eqt 3525 -1.
Mon Oct 10 10:45:34 2016 [CMotorCallManager::onIncomingEvent] state = PROCEEDING_STATE.
Mon Oct 10 10:45:34 2016 [onIncomingEvent] REDIRECTION arrived.
Mon Oct 10 10:45:34 2016 [receiveRedirectionEvent] Call: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060 eqt: 3525 PROCEEDING_STATE received an event.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::sipUriType] sip Uri.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::isTLSProtRequiredForExtGw] =0.
Mon Oct 10 10:45:34 2016 isDomainFromGwExt SCSWorking: NO
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] Host from request is : 192.168.XXX.XXX.
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] User from request is : 2371
Mon Oct 10 10:45:34 2016 1193[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::isTLSProtRequiredForExtGw] =0.
Mon Oct 10 10:45:34 2016 1193 [CCall::makeGenericResponse] 302
Mon Oct 10 10:45:34 2016 1193 [CCall::getDialog] Confirmed Dialog is not found (ID = ;as0c03c1de)
Mon Oct 10 10:45:34 2016 1193 [CCall::getDialog] Returning Initial Dialog Server
1476089134 -> Mon Oct 10 10:45:34 2016 1531 [CDialog::createResponse] 302
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::CResponse] Creation of a response
Mon Oct 10 10:45:34 2016 211b [CTransProceedingState::createResponse] CResponse CEB42 ref=1
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::create] RESPONSE CREATION
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::checkStatusLine] Create StatusLine from code given as parameter
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::createToHeader] Initialize To TAG from context
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::createToHeader] Creation a tag for To header
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::createViaHeaders] Copy Via headers from previous request (number : 1)
Mon Oct 10 10:45:34 2016 CEB42 [CResponse::create] Initialize context (Local = To & Remote = From)
Mon Oct 10 10:45:34 2016 CEB42 [CMessage::send] sip_sendMessage (192.168.X.X:5060)
Mon Oct 10 10:45:34 2016 SEND MESSAGE TO NETWORK (192.168.X.X:5060 [UDP]) (BUFF LEN = 487)
----------------------utf8-----------------------
SIP/2.0 302 Moved Temporarily
Contact: <sip:2371@192.168.XXX.XXX;user=phone>
User-Agent: OmniPCX Enterprise R10.0 j1.410.49.a
P-Alcatel-CSBU: rd=unknown;call_condition=forwardeduser
To: <sip:2399@192.168.XXX.XXX:5060;user=phone>;tag=4d882abcccd84e1481b197f3d2fe566c
From: "BRYAN_" <sip:2373@192.168.X.X>;tag=as0c03c1de
Call-ID: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060
CSeq: 102 INVITE
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK7a6f5d40
Content-Length: 0
-------------------------------------------------
1476089134 -> Mon Oct 10 10:45:34 2016 [sip_freeEventContext]
Mon Oct 10 10:45:34 2016 CEB41 [~CResponse] resp(100) 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060 102 INVITE
Mon Oct 10 10:45:34 2016 211b [CTransProceedingState::createResponse] Final : Transaction changes to Completed state
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] STATE CHANGED TO COMPLETED
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] notifying the parent dialog
Mon Oct 10 10:45:34 2016 1531 [CDialog::onTransactionState(pTrans = 211b, previousState = Proceeding, currentState = Completed, reason = Final resp creation]
Mon Oct 10 10:45:34 2016 211b [CTransaction::startTimer] Timer G is started (delay = 500 ms)
Mon Oct 10 10:45:34 2016 211b [CTransaction::startTimer] Timer H is started (delay = 32000 ms)
Mon Oct 10 10:45:34 2016 1531 [CDialog::updateRouteSet] there are 0 record-route headers
Mon Oct 10 10:45:34 2016 1193[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Mon Oct 10 10:45:34 2016 [receiveRedirectionEvent] checking CAC for ACK to sent
Mon Oct 10 10:45:34 2016 [receiveRedirectionEvent] CAC is not true
Mon Oct 10 10:45:34 2016 1193[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Mon Oct 10 10:45:34 2016 1193[emitEventToMonitel] CAC = 0 eqtCAC = -1
Mon Oct 10 10:45:34 2016 1193[emitEventToMonitel] cacUsed=0 eqtCac=-1
Mon Oct 10 10:45:34 2016 1193[emitEventToMonitel] displayIPCMessageOut
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
1476089134 -> Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 ** SIP TRUNKING **
Mon Oct 10 10:45:34 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 10:45:34 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 10:45:34 2016 [display_ipc_out] ------------ Begin ---------------
Mon Oct 10 10:45:34 2016 Id : -1
Mon Oct 10 10:45:34 2016 ACK
Mon Oct 10 10:45:34 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 10:45:34 2016 [receiveRedirectionEvent] Reset of the session.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::unRegister] Remove eqt : 3525 diag : -1 from the map.
Mon Oct 10 10:45:34 2016 [CMotorCallManager::eraseCallwithEqt] erase 3525 -1.
Mon Oct 10 10:45:34 2016 [exec_ipc] in end 30138.
Mon Oct 10 10:45:34 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Mon Oct 10 10:45:34 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Mon Oct 10 10:45:34 2016 [exec_ipc] in 30138.
Mon Oct 10 10:45:34 2016 [display_ipc_in] ------------ Begin ---------------
Mon Oct 10 10:45:34 2016 neqt : 3525 Id : -1
Mon Oct 10 10:45:34 2016 SIP EQT RELEASED
Mon Oct 10 10:45:34 2016 [display_ipc_in] ------------- End ----------------
Mon Oct 10 10:45:34 2016 [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 3525 -1.
Mon Oct 10 10:45:34 2016 [CMotorCallManager::onIncomingEvent] NO call with eqt: 3525 -1 to release.
Mon Oct 10 10:45:34 2016 [exec_ipc] in end 30138.
Mon Oct 10 10:45:34 2016 RECEIVE MESSAGE FROM NETWORK (192.168.X.X:5060 [UDP])
----------------------utf8-----------------------
ACK sip:2399@192.168.XXX.XXX:5060;user=phone SIP/2.0
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK7a6f5d40
Max-Forwards: 70
From: "BRYAN_" <sip:2373@192.168.X.X>;tag=as0c03c1de
To: <sip:2399@192.168.XXX.XXX:5060;user=phone>;tag=4d882abcccd84e1481b197f3d2fe566c
Contact: <sip:2373@192.168.X.X:5060>
Call-ID: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060
CSeq: 102 ACK
User-Agent: XIVO PBX
Content-Length: 0
-------------------------------------------------
1476089134 -> Mon Oct 10 10:45:34 2016 [CIOCom::receiveRequest] optimisation value 1
Mon Oct 10 10:45:34 2016 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => 192.168.XXX.XXX node000000
Mon Oct 10 10:45:34 2016 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Mon Oct 10 10:45:34 2016 B24D3 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
Mon Oct 10 10:45:34 2016 [CIOCom::receiveRequest] Received CRequest B24D3 ref=1
Mon Oct 10 10:45:34 2016 [CIOCom::receiveRequest] rport1 not empty
Mon Oct 10 10:45:34 2016 [CDispatcher::onIncomingRequest()]
Mon Oct 10 10:45:34 2016 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Mon Oct 10 10:45:34 2016 102 [CCallManager::onIncomingRequest()]
Mon Oct 10 10:45:34 2016 1193 [CCall::receiveRequest] ACK
Mon Oct 10 10:45:34 2016 1193 [CCall::getDialog] Confirmed Dialog is not found (ID = 4d882abcccd84e1481b197f3d2fe566c;as0c03c1de)
Mon Oct 10 10:45:34 2016 1193 [CCall::getDialog] Returning Initial Dialog Server
Mon Oct 10 10:45:34 2016 1531 [CDialog::receiveRequest]
Mon Oct 10 10:45:34 2016 1531 [CDialog::receiveAckRequest]
Mon Oct 10 10:45:34 2016 211b [CTransCompletedState::receiveRequest] ACK(UDP) : Transaction changes to Confirmed state
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] STATE CHANGED TO CONFIRMED
Mon Oct 10 10:45:34 2016 211b [CTransaction::changeState] notifying the parent dialog
Mon Oct 10 10:45:34 2016 1531 [CDialog::onTransactionState(pTrans = 211b, previousState = Completed, currentState = Confirmed, reason = Request reception]
1476089134 -> Mon Oct 10 10:45:34 2016 211b [CTransaction::freeTimerToken] Timer G is freed
Mon Oct 10 10:45:34 2016 211b [CTransaction::freeTimerToken] Timer H is freed
Mon Oct 10 10:45:34 2016 211b [CTransaction::startTimer] Timer I is started (delay = 5000 ms)
Mon Oct 10 10:45:34 2016 1531 [CDialog::receiveAckRequest] receiving an ACK on a previously rejected INVITE
Mon Oct 10 10:45:34 2016 1193 [CCall::checkAuthentication] ACK
Mon Oct 10 10:45:34 2016 1193[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
Mon Oct 10 10:45:34 2016 B24D3 [CMessage::getAssertedIdCount] need to create the wrapper
Mon Oct 10 10:45:34 2016 B24D3 [CMessage::createAssertedIdWrapperFromMessage]
Mon Oct 10 10:45:34 2016 B24D3 [CMessage::createAssertedIdWrapperFromMessage] there is 0 P-Asserted-Identity header in the message
Mon Oct 10 10:45:34 2016 B24D3 [CMessage::getPreferredIdCount] need to create the wrapper
Mon Oct 10 10:45:34 2016 B24D3 [CMessage::createPreferredIdWrapperFromMessage] there is 0 P-Preferred-Identity header in the message
Mon Oct 10 10:45:34 2016 [getFromHeader] displayName="BRYAN_".
Mon Oct 10 10:45:34 2016 [getFromHeader] =2373@192.168.X.X.
Mon Oct 10 10:45:34 2016 [getFromHeader] clirPresent=0.
Mon Oct 10 10:45:34 2016 [isAddrInDico] user=2373 host=192.168.X.X
Mon Oct 10 10:45:34 2016 [isUserInDico] 2373@192.168.X.X
Mon Oct 10 10:45:34 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 10:45:34 2016 [isAddrInDico] other sip user
Mon Oct 10 10:45:34 2016 isDomainFromGwExt SCSWorking: NO
1476089134 -> Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] Host from request is : 192.168.X.X.
Mon Oct 10 10:45:34 2016 [isDomainFromGwExt] User from request is : 2373
Mon Oct 10 10:45:34 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Mon Oct 10 10:45:34 2016 1193[CMotorCall::getUserType] extGw = 7.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::toGatewayOrProxy] request for proxydomain=192.168.XXX.XXX.
Mon Oct 10 10:45:34 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall ABCF ExtGW
Mon Oct 10 10:45:34 2016 [isUserRegistred] getRegistration=2399.
Mon Oct 10 10:45:34 2016 [isUserRegistred] result=-1.
Mon Oct 10 10:45:34 2016 [isAddrInDico] user=2399 host=192.168.XXX.XXX
Mon Oct 10 10:45:34 2016 [isUserInDico] 2399@192.168.XXX.XXX
Mon Oct 10 10:45:34 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 10:45:34 2016 [isAddrInDico] other sip user
Mon Oct 10 10:45:34 2016 1193[CMotorCall::storeRequestInCall] inRequest storage=0x85d3550.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::onReceiveRequest] request for gateway.
Mon Oct 10 10:45:34 2016 1193[CMotorCall::onReceiveRequest] state = INITIAL_STATE.
Mon Oct 10 10:45:34 2016 3525 [CSipContextID::isValid] Call-ID is not valid
Mon Oct 10 10:45:34 2016 1193[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
Mon Oct 10 10:45:34 2016 1193[CMotorCall::methodAckReceived] Ack => update the inviteContext.
Mon Oct 10 10:45:34 2016 [receiveAckMessage] Call: 4ef890fe127eda7525c422270a30dad1@192.168.X.X:5060 eqt: -1 INITIAL_STATE received a message.
1476089137 -> Mon Oct 10 10:45:34 2016 [receiveAckMessage] Call is not killed waiting for INVITE with authentication param
Code: Select all
traced started ...
1476091056 -> Mon Oct 10 11:17:34 2016 [sip_freeEventContext]
Mon Oct 10 11:17:34 2016 21d5 [CTransaction::changeState] STATE CHANGED TO TERMI NATED
Mon Oct 10 11:17:34 2016 21d5 [CTransaction::freeTimerToken] Timer D is freed
Mon Oct 10 11:17:34 2016 21d5 [CTransaction::changeState] no transaction state, terminated reason : Request creation
Mon Oct 10 11:17:34 2016 1522 [CDialog::createAckRequest] successful INVITE is t erminated after the ACK is sent
Mon Oct 10 11:17:34 2016 1122[CMotorCall::setCurrentState] NOE-SIP : sendBackupU pdate Msg not sent to twin CS
Mon Oct 10 11:17:34 2016 [exec_ipc] in end 30138.
Mon Oct 10 11:17:34 2016 [CTransaction::notifyDialog]
Mon Oct 10 11:17:34 2016 [CTransaction::notifyDialog] notify parent dialog
Mon Oct 10 11:17:34 2016 1522 [CDialog::onTransactionState(pTrans = 21d5, previo usState = null, currentState = Terminated, reason = Request creation]
Mon Oct 10 11:17:34 2016 21D5 [~CTransaction] transaction 1399642855 INVITE
Mon Oct 10 11:17:36 2016 RECEIVE MESSAGE FROM NETWORK (192.168.X.X:5060 [UDP])
----------------------utf8-----------------------
INVITE sip:2621@192.168.XXX.XXX:5060;user=phone SIP/2.0
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK5ddfda31
Max-Forwards: 70
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>
Contact: <sip:2373@192.168.X.X:5060>
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 102 INVITE
User-Agent: XIVO PBX
Date: Mon, 10 Oct 2016 09:17:36 GMT
Session-Expires: 1800
Min-SE: 300
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLIS H, MESSAGE
Supported: replaces, timer
Remote-Party-ID: "BRYAN" <sip:2373@192.168.X.X>;party=calling;privacy=of f;screen=no
Content-Type: application/sdp
Content-Length: 364
v=0
o=root 437104877 437104877 IN IP4 192.168.X.X
s=Asterisk PBX 13.9.1
c=IN IP4 192.168.X.X
t=0 0
m=audio 11270 RTP/AVP 8 0 18 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=fmtp:4 annexa=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
-------------------------------------------------
1476091056 -> Mon Oct 10 11:17:36 2016 [CIOCom::receiveRequest] optimisation va lue 1
Mon Oct 10 11:17:36 2016 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => 192.168.XXX.XXX node000000
Mon Oct 10 11:17:36 2016 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Mon Oct 10 11:17:36 2016 B26F0 [CRequest::CRequest] Creation of a request (RECEI VED FROM NETWORK)
Mon Oct 10 11:17:36 2016 [CIOCom::receiveRequest] Received CRequest B26F0 ref=1
Mon Oct 10 11:17:36 2016 [CIOCom::receiveRequest] rport1 not empty
Mon Oct 10 11:17:36 2016 [CDispatcher::onIncomingRequest()]
Mon Oct 10 11:17:36 2016 [CDispatcher::processRequestFromManagerIndex()] start a t index 0
Mon Oct 10 11:17:36 2016 102 [CCallManager::onIncomingRequest()]
Mon Oct 10 11:17:36 2016 102 [CCallManager::onIncomingRequest()] creates a new Call if this request doesn't refer to any old call
Mon Oct 10 11:17:36 2016 [CMotorCallManager::callFactory] For call : 5b2021067e7 722a144d5752d13ab0305@192.168.X.X:5060.
Mon Oct 10 11:17:36 2016 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R10.0 j1.410.49.a
Mon Oct 10 11:17:36 2016 [CMotorCallManager::callFactory]=850d6d8.
Mon Oct 10 11:17:36 2016 1125 [CCall::receiveRequest] INVITE
Mon Oct 10 11:17:36 2016 1125 [CCall::getDialog] Confirmed Dialog is not found ( ID = ;as434494ea)
Mon Oct 10 11:17:36 2016 1125 [CCall::getDialog] Initial Dialog Server not found
Mon Oct 10 11:17:36 2016 1526 [CDialog::receiveRequest]
Mon Oct 10 11:17:36 2016 1526 [CDialog::receiveInviteRequest]
Mon Oct 10 11:17:36 2016 21d6 [CTransaction::changeState] STATE CHANGED TO INITI AL
1476091056 -> Mon Oct 10 11:17:36 2016 21d6 [CTransaction::changeState] notifyin g the parent dialog
Mon Oct 10 11:17:36 2016 1526 [CDialog::onTransactionState(pTrans = 21d6, previo usState = Terminated, currentState = Initial, reason = None]
Mon Oct 10 11:17:36 2016 21d6 [CTransInitialState::receiveRequest] Transaction c hanges to Proceeding state
Mon Oct 10 11:17:36 2016 21d6 [CTransaction::changeState] STATE CHANGED TO PROCE EDING
Mon Oct 10 11:17:36 2016 21d6 [CTransaction::changeState] notifying the parent d ialog
Mon Oct 10 11:17:36 2016 1526 [CDialog::onTransactionState(pTrans = 21d6, previo usState = Initial, currentState = Proceeding, reason = Request reception]
Mon Oct 10 11:17:36 2016 CEDC9 [CResponse::CResponse] Creation of a response
Mon Oct 10 11:17:36 2016 21d6 [CTransProceedingState::createResponse] CResponse CEDC9 ref=1
Mon Oct 10 11:17:36 2016 CEDC9 [CResponse::create] RESPONSE CREATION
Mon Oct 10 11:17:36 2016 CEDC9 [CResponse::checkStatusLine] Create StatusLine fr om code given as parameter
Mon Oct 10 11:17:36 2016 CEDC9 [CResponse::createViaHeaders] Copy Via headers fr om previous request (number : 1)
Mon Oct 10 11:17:36 2016 B26F0 [CMessage::getHeaderAtIndexFromSipMessage(Timesta mp, 0)] sip_getHeaderAtIndex FAILED => HSS ERROR No exist
Mon Oct 10 11:17:36 2016 CEDC9 [CResponse::create] Initialize context (Local = T o & Remote = From)
Mon Oct 10 11:17:36 2016 CEDC9 [CMessage::send] sip_sendMessage (192.168.X.X:50 60)
Mon Oct 10 11:17:36 2016 SEND MESSAGE TO NETWORK (192.168.X.X:5060 [UDP]) (BUFF LEN = 286)
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 102 INVITE
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK5ddfda31
Content-Length: 0
-------------------------------------------------
1476091056 -> Mon Oct 10 11:17:36 2016 [sip_freeEventContext]
Mon Oct 10 11:17:36 2016 1526 [CDialog::receiveInviteRequest] a new Server INVI TE transaction is in progress
Mon Oct 10 11:17:36 2016 [CSessionTimerContext::CSessionTimerContext] New CSessi onTimerContext from request (Server, UA)
Mon Oct 10 11:17:36 2016 [CSessionTimerContext::updateAfterRefreshReception] Upd ate CSessionTimerContext (refresh reception)
Mon Oct 10 11:17:36 2016 [CSessionTimerContext::updateSupported] Request timer s upported
Mon Oct 10 11:17:36 2016 [CSessionTimerContext::updateMinSE] Min-SE updated : 30 0
Mon Oct 10 11:17:36 2016 [CSessionTimerContext::updateSessionExpires] Session-Ex pires updated : 1800
Mon Oct 10 11:17:36 2016 [CSessionTimerContext::setRefreshMethod] Allow refreshM ethod=INVITE
Mon Oct 10 11:17:36 2016 1526 [CDialog::addTransaction] added transaction 21d6 w ith branch z9hG4bK5ddfda31, with CSeq 102
Mon Oct 10 11:17:36 2016 1125 [CCall::checkAuthentication] INVITE
Mon Oct 10 11:17:36 2016 B26F0 [CMessage::getAssertedIdCount] need to create the wrapper
Mon Oct 10 11:17:36 2016 B26F0 [CMessage::createAssertedIdWrapperFromMessage]
Mon Oct 10 11:17:36 2016 B26F0 [CMessage::createAssertedIdWrapperFromMessage] th ere is 0 P-Asserted-Identity header in the message
Mon Oct 10 11:17:36 2016 B26F0 [CMessage::getPreferredIdCount] need to create th e wrapper
Mon Oct 10 11:17:36 2016 B26F0 [CMessage::createPreferredIdWrapperFromMessage] t here is 0 P-Preferred-Identity header in the message
Mon Oct 10 11:17:36 2016 [CGwMngData::isAuthenticationRequiredForThisClient] 192 .168.2.16 .
1476091056 -> Mon Oct 10 11:17:36 2016 isDomainFromGwExt SCSWorking: NO
Mon Oct 10 11:17:36 2016 [isDomainFromGwExt] Host from request is : 192.168.X.X .
Mon Oct 10 11:17:36 2016 [isDomainFromGwExt] User from request is : 2373
Mon Oct 10 11:17:36 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Mon Oct 10 11:17:36 2016 domain from External Gateway 7.
Mon Oct 10 11:17:36 2016 87d0 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 87d1 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 87d4 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 1125[CMotorCall::setFilterUsedMode] To be traced = 0
Mon Oct 10 11:17:36 2016 1125[CMotorCall::initOfUserType] values are reseted
Mon Oct 10 11:17:36 2016 [getFromHeader] displayName="BRYAN".
Mon Oct 10 11:17:36 2016 [getFromHeader] =2373@192.168.X.X.
Mon Oct 10 11:17:36 2016 [getFromHeader] clirPresent=0.
Mon Oct 10 11:17:36 2016 [isAddrInDico] user=2373 host=192.168.X.X
Mon Oct 10 11:17:36 2016 [isUserInDico] 2373@192.168.X.X
Mon Oct 10 11:17:36 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 11:17:36 2016 [isAddrInDico] other sip user
Mon Oct 10 11:17:36 2016 isDomainFromGwExt SCSWorking: NO
Mon Oct 10 11:17:36 2016 [isDomainFromGwExt] Host from request is : 192.168.X.X .
Mon Oct 10 11:17:36 2016 [isDomainFromGwExt] User from request is : 2373
Mon Oct 10 11:17:36 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Mon Oct 10 11:17:36 2016 1125[CMotorCall::getUserType] extGw = 7.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
1476091056 -> Mon Oct 10 11:17:36 2016 1125[CMotorCall::toGatewayOrProxy] reques t for proxydomain=192.168.XXX.XXX.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall ABCF ExtGW
Mon Oct 10 11:17:36 2016 [isUserRegistred] getRegistration=2621.
Mon Oct 10 11:17:36 2016 [isUserRegistred] result=-1.
Mon Oct 10 11:17:36 2016 [isAddrInDico] user=2621 host=192.168.XXX.XXX
Mon Oct 10 11:17:36 2016 [isUserInDico] 2621@192.168.XXX.XXX
Mon Oct 10 11:17:36 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 11:17:36 2016 [isAddrInDico] other sip user
Mon Oct 10 11:17:36 2016 1125[CMotorCall::storeRequestInCall] inRequest storage= 0x853d5e8.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::onReceiveRequest] request for gateway.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::onReceiveRequest] state = INITIAL_STAT E.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] nb available lic enses=74 .
Mon Oct 10 11:17:36 2016 [isUserInDico] 2373@192.168.X.X
Mon Oct 10 11:17:36 2016 isUserInDico] NOT found in the dictionnary.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] license OK.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 3517 [CSipContextID::isValid] Call-ID is not valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] Invite => update the inviteContext.
Mon Oct 10 11:17:36 2016 87dd [CSipAddrSpec::CSipAddrSpec()] Invalid type
1476091056 -> Mon Oct 10 11:17:36 2016 [CForkedBranch::CForkedBranch] context = 0x850db80.
Mon Oct 10 11:17:36 2016 87e0 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] reqUri stored: s ip:2373@192.168.X.X:5060
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] cacUsed = 0 befo re.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] returnStat = 0 b efore.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] cacUsed = 0 afte r.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::methodInviteReceived] CAC = 0
Mon Oct 10 11:17:36 2016 [receiveInviteMessage] Call: 5b2021067e7722a144d5752d13 ab0305@192.168.X.X:5060 eqt: -1 INITIAL_STATE received a message.
Mon Oct 10 11:17:36 2016 [decodeInviteCLIR].
Mon Oct 10 11:17:36 2016 [receiveInviteMessage] INFO present in Allow header
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 am_I_PCS SCSWorking : NO
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 check_extgw_PCSstate EXTGW is : 7
Mon Oct 10 11:17:36 2016 The check_extgw_PCSstate extgwid : 7
Mon Oct 10 11:17:36 2016 The state of PCS which rescued the extgw is : -1
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 [decodeInviteFromUsingPAI]. octet3a_scrn = 1
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall::analyseSessionTimer] exit with uacGat ewayMode=0 uacRefresher=0.
1476091056 -> Mon Oct 10 11:17:36 2016 [CSipMediaDescription::parseFormatString] Got 5 format(s) from string 8 0 18 4 101
Mon Oct 10 11:17:36 2016 [checkSdpValidity] Media 0 type 1 contains 5 formats.
Mon Oct 10 11:17:36 2016 [checkSdpValidity] Format : 8.
Mon Oct 10 11:17:36 2016 1125[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 11:17:36 2016 [convertSdpIntoTsdp] No Direction in the session part.
Mon Oct 10 11:17:36 2016 [convertSdpIntoTsdp] Check the direction in Session par t - result:0.
Mon Oct 10 11:17:36 2016 [convertSdpIntoTsdp] media AUDIO detected (previous cry pto=0).
Mon Oct 10 11:17:36 2016 [convertAudioMedia] The audio media contains 5 format( s).
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Format 0 is 8.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Format 1 is 0.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Format 2 is 18.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Format 3 is 4.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Format 4 is 101.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] 101.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Format is DTMF:101.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Direction is sendrecv.
Mon Oct 10 11:17:36 2016 [convertAudioMedia] Connection address retrieved in sdp : 192.168.X.X.
Mon Oct 10 11:17:36 2016 [convertIPStrIntoTuipv] 192.168.X.X => 192.168.X.X
Mon Oct 10 11:17:36 2016 [display_sdp] address =192.168.X.X
Mon Oct 10 11:17:36 2016 [display_sdp] direction=0.
Mon Oct 10 11:17:36 2016 [convertSdpIntoTsdp] only one media taken into account xxx crypto_index=0 clear media=1
1476091056 -> Mon Oct 10 11:17:36 2016 [convertSdpIntoTsdp] crypto_index=0 clear media=1.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 [receiveInviteMessage] NO 100rel REQUIRED for this cal l.
Mon Oct 10 11:17:36 2016 [CInitialState::receiveinvitemessage allow_update 0 pra ck_required 0
Mon Oct 10 11:17:36 2016 [decodeInviteTo].
Mon Oct 10 11:17:36 2016 [decodeInviteReferredBy].
Mon Oct 10 11:17:36 2016 [decodeInviteACSBU].
Mon Oct 10 11:17:36 2016 87d0 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 87d1 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 87d4 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 1125[CMotorCall::setFilterUsedMode] To be traced = 0
Mon Oct 10 11:17:36 2016 1125[emitEventToMonitel] content size (lginfo): 660 cca l crypted= 0
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 ** SIP TRUNKING **
Mon Oct 10 11:17:36 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Mon Oct 10 11:17:36 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Mon Oct 10 11:17:36 2016 [CMotorCallManager::insertCallwithEqt] CMotorCall 3525 inserted.
Mon Oct 10 11:17:36 2016 1125[sendLgEvtSipCreate] Event sent on eqt : 3525
Mon Oct 10 11:17:36 2016 [display_ipc_out] ------------ Begin ---------------
1476091056 -> Mon Oct 10 11:17:36 2016 Id : -1
Mon Oct 10 11:17:36 2016 INVITE
Mon Oct 10 11:17:36 2016 REQUEST URI : <> 2621@192.168.XXX.XXX:5060 ; user=phone
Mon Oct 10 11:17:36 2016 FROM : <BRYAN> 2373@192.168.X.X:5060 ; user=nam e
Mon Oct 10 11:17:36 2016 TO : <> 2621@192.168.XXX.XXX:5060 ; user=phone
Mon Oct 10 11:17:36 2016 CAC : 0
Mon Oct 10 11:17:36 2016 CAC ADDRESS :
Mon Oct 10 11:17:36 2016 CAC-CSBU info : UNKNOWN
Mon Oct 10 11:17:36 2016 CLIR : 0
Mon Oct 10 11:17:36 2016 Prack Required : 0
Mon Oct 10 11:17:36 2016 Allow Update : 0
Mon Oct 10 11:17:36 2016 SDP :
Mon Oct 10 11:17:36 2016 ADDRESS : 192.168.X.X :11270
Mon Oct 10 11:17:36 2016 ALGOS :
Mon Oct 10 11:17:36 2016 PCMA
Mon Oct 10 11:17:36 2016 G729
Mon Oct 10 11:17:36 2016 G723
Mon Oct 10 11:17:36 2016 101
Mon Oct 10 11:17:36 2016 DIRECTION : SEND & RECEIVE
Mon Oct 10 11:17:36 2016 crypto index : 0
Mon Oct 10 11:17:36 2016 N_GW_EXT : 7
Mon Oct 10 11:17:36 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 11:17:36 2016 1125[CMotorCall::setCurrentState] NOE-SIP : sendBackupU pdate Msg not sent to twin CS
Mon Oct 10 11:17:36 2016 [exec_ipc] in 30138.
Mon Oct 10 11:17:36 2016 [display_ipc_in] ------------ Begin ---------------
Mon Oct 10 11:17:36 2016 neqt : 3525 Id : -1
Mon Oct 10 11:17:36 2016 INFORMATIONAL
Mon Oct 10 11:17:36 2016 xx : 80
Mon Oct 10 11:17:36 2016 RELATIVE REQUEST : INVITE
Mon Oct 10 11:17:36 2016 [display_ipc_in] ------------- End ----------------
Mon Oct 10 11:17:36 2016 [CMotorCallManager::onIncomingEvent] an event 10764 arr ived on the eqt 3525 -1.
1476091056 -> Mon Oct 10 11:17:36 2016 [CMotorCallManager::onIncomingEvent] stat e = PROCEEDING_STATE.
Mon Oct 10 11:17:36 2016 [onIncomingEvent] INFORMATIONAL arrived.
Mon Oct 10 11:17:36 2016 [receiveInformationalEvent] Call: 5b2021067e7722a144d57 52d13ab0305@192.168.X.X:5060 eqt: 3525 PROCEEDING_STATE received an event.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall::isTLSProtRequiredForExtGw] =0.
Mon Oct 10 11:17:36 2016 87e5 [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:36 2016 1125[CMotorCall::buildContact] Contact: sip:192.168.20 0.1
Mon Oct 10 11:17:36 2016 0[CMotorCall::emitInformationMessage] cause=-1073745 788
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125[CMotorCall ABCF ExtGW
Mon Oct 10 11:17:36 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:36 2016 1125 [CCall::makeGenericResponse] 180
Mon Oct 10 11:17:36 2016 1125 [CCall::getDialog] Confirmed Dialog is not found ( ID = ;as434494ea)
Mon Oct 10 11:17:36 2016 1125 [CCall::getDialog] Returning Initial Dialog Server
Mon Oct 10 11:17:36 2016 1526 [CDialog::createResponse] 180
Mon Oct 10 11:17:36 2016 CEDCA [CResponse::CResponse] Creation of a response
Mon Oct 10 11:17:36 2016 21d6 [CTransProceedingState::createResponse] CResponse CEDCA ref=1
Mon Oct 10 11:17:36 2016 CEDCA [CResponse::create] RESPONSE CREATION
1476091056 -> Mon Oct 10 11:17:36 2016 CEDCA [CResponse::checkStatusLine] Create StatusLine from code given as parameter
Mon Oct 10 11:17:36 2016 CEDCA [CResponse::createToHeader] Initialize To TAG fro m context
Mon Oct 10 11:17:36 2016 CEDCA [CResponse::createToHeader] Creation a tag for To header
Mon Oct 10 11:17:36 2016 CEDCA [CResponse::createViaHeaders] Copy Via headers fr om previous request (number : 1)
Mon Oct 10 11:17:36 2016 CEDCA [CResponse::create] Initialize context (Local = T o & Remote = From)
Mon Oct 10 11:17:36 2016 CEDCA [CMessage::send] sip_sendMessage (192.168.X.X:50 60)
Mon Oct 10 11:17:36 2016 SEND MESSAGE TO NETWORK (192.168.X.X:5060 [UDP]) (BUFF LEN = 485)
----------------------utf8-----------------------
SIP/2.0 180 Ringing
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDAT E
Contact: sip:192.168.XXX.XXX
User-Agent: OmniPCX Enterprise R10.0 j1.410.49.a
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>;tag=6eef3fcb72f467410d070f15a8fc641 7
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 102 INVITE
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK5ddfda31
Content-Length: 0
-------------------------------------------------
Mon Oct 10 11:17:36 2016 [sip_freeEventContext]
Mon Oct 10 11:17:36 2016 CEDC9 [~CResponse] resp(100) 5b2021067e7722a144d5752d13 ab0305@192.168.X.X:5060 102 INVITE
Mon Oct 10 11:17:36 2016 1526 [CDialog::updateRouteSet] there are 0 record-route headers
1476091057 -> is_my_node_in_campus false
1476091058 -> Mon Oct 10 11:17:36 2016 [exec_ipc] in end 30138.
Mon Oct 10 11:17:38 2016 RECEIVE MESSAGE FROM NETWORK (10.255.254.74:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 180 Ringing
To: <sip:0623840537@10.255.254.74;user=phone>;tag=SD0tipb99-SD8a2f099-00770420-0 003-0e5b-0000-0000
From: "ACCUEIL 2 MARS" <sip:224848@192.168.XXX.XXX;user=phone>;tag=d8ff1b4b2dc9b1a c7517cdf21989d938
Call-ID: 6f38fa52e2a0af8c76243d2803114b47@192.168.XXX.XXX
CSeq: 1937285326 INVITE
Via: SIP/2.0/UDP 192.168.XXX.XXX;branch=z9hG4bK45fcd6c0129c86f4345d32bdff2d8982
Accept: application/sdp,application/isup,application/xml
Allow: INVITE,ACK,PRACK,CANCEL,BYE,NOTIFY,UPDATE,INFO,OPTIONS
Contact: <sip:10.255.254.74:5060;transport=udp>
Content-Type: application/sdp
Content-Length: 247
v=0
o=- 567627016 0 IN IP4 10.255.254.74
s=-
c=IN IP4 10.255.254.74
t=0 0
m=audio 12792 RTP/AVP 8 101
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=ptime:20
a=sqn:0
a=cdsc: 1 audio RTP/AVP 8
a=cdsc: 2 image udptl t38
-------------------------------------------------
Mon Oct 10 11:17:38 2016 CEDCB [CResponse::CResponse] Creation of a response (RE CEIVED FROM NETWORK)
Mon Oct 10 11:17:38 2016 [CIOCom::receiveResponse] CResponse CEDCB ref=1
Mon Oct 10 11:17:38 2016 [CDispatcher::processResponseFromManagerIndex] start at index 0
Mon Oct 10 11:17:38 2016 102 [CCallManager::onIncomingResponse]
Mon Oct 10 11:17:38 2016 1123 [CCall::receiveResponse] 180
Mon Oct 10 11:17:38 2016 1123 [CCall::getDialog] Confirmed Dialog is not found ( ID = d8ff1b4b2dc9b1ac7517cdf21989d938;SD0tipb99-SD8a2f099-00770420-0003-0e5b-000 0-0000)
1476091058 -> Mon Oct 10 11:17:38 2016 1123 [CCall::getDialog] Returning Initial Dialog Client
Mon Oct 10 11:17:38 2016 1524 [CDialog::receiveResponse]
Mon Oct 10 11:17:38 2016 CEDC5 [~CResponse] resp(100) 6f38fa52e2a0af8c76243d2803 114b47@192.168.XXX.XXX 1937285326 INVITE
Mon Oct 10 11:17:38 2016 1524 [CDialog::updateRouteSet] there are 0 record-route headers
Mon Oct 10 11:17:38 2016 1123[CMotorCall::searchForkedBranch]pForkedBranch=0x855 c340.
Mon Oct 10 11:17:38 2016 [receiveInformationalMessage] Call: 6f38fa52e2a0af8c762 43d2803114b47@192.168.XXX.XXX eqt: 3210 PROCEEDING_STATE received a message.
Mon Oct 10 11:17:38 2016 CEDCB [CMessage::getAssertedIdCount] need to create the wrapper
Mon Oct 10 11:17:38 2016 CEDCB [CMessage::createAssertedIdWrapperFromMessage]
Mon Oct 10 11:17:38 2016 CEDCB [CMessage::createAssertedIdWrapperFromMessage] th ere is 0 P-Asserted-Identity header in the message
Mon Oct 10 11:17:38 2016 CEDCB [CMessage::getPreferredIdCount] need to create th e wrapper
Mon Oct 10 11:17:38 2016 CEDCB [CMessage::createPreferredIdWrapperFromMessage] t here is 0 P-Preferred-Identity header in the message
Mon Oct 10 11:17:38 2016 [receiveInformationalMessage] is in the first IF of SDP present
Mon Oct 10 11:17:38 2016 [CSipMediaDescription::parseFormatString] Got 2 format( s) from string 8 101
Mon Oct 10 11:17:38 2016 [checkSdpValidity] Media 0 type 1 contains 2 formats.
Mon Oct 10 11:17:38 2016 [checkSdpValidity] Format : 8.
Mon Oct 10 11:17:38 2016 [receiveInformationalMessage] is in the else part of SD P present
1476091058 -> Mon Oct 10 11:17:38 2016 1123[CMotorCall::isCryptoAuthorized] conf ig crypto=0/0.
Mon Oct 10 11:17:38 2016 [convertSdpIntoTsdp] No Direction in the session part.
Mon Oct 10 11:17:38 2016 [convertSdpIntoTsdp] Check the direction in Session par t - result:0.
Mon Oct 10 11:17:38 2016 [convertSdpIntoTsdp] media AUDIO detected (previous cry pto=0).
Mon Oct 10 11:17:38 2016 [convertAudioMedia] The audio media contains 2 format( s).
Mon Oct 10 11:17:38 2016 [convertAudioMedia] Format 0 is 8.
Mon Oct 10 11:17:38 2016 [convertAudioMedia] Format 1 is 101.
Mon Oct 10 11:17:38 2016 [convertAudioMedia] 101.
Mon Oct 10 11:17:38 2016 [convertAudioMedia] Format is DTMF:101.
Mon Oct 10 11:17:38 2016 [convertAudioMedia] Direction is sendrecv.
Mon Oct 10 11:17:38 2016 [convertAudioMedia] Connection address retrieved in sdp : 10.255.254.74.
Mon Oct 10 11:17:38 2016 [convertIPStrIntoTuipv] 10.255.254.74 => 10.255.254.74
Mon Oct 10 11:17:38 2016 [display_sdp] address =10.255.254.74
Mon Oct 10 11:17:38 2016 [display_sdp] direction=0.
Mon Oct 10 11:17:38 2016 [convertSdpIntoTsdp] only one media taken into account xxx crypto_index=0 clear media=1
Mon Oct 10 11:17:38 2016 [convertSdpIntoTsdp] crypto_index=0 clear media=1.
Mon Oct 10 11:17:38 2016 [methodAllowedByDistant] INFO allowed by distant.
Mon Oct 10 11:17:38 2016 1123[emitEventToMonitel] content size (lginfo): 660 cca l crypted= 0
Mon Oct 10 11:17:38 2016 1123[emitEventToMonitel]1 T38 REINVITE TRUE
Mon Oct 10 11:17:38 2016 1123[emitEventToMonitel] CAC = 0 eqtCAC = -1
1476091058 -> main.trace.timer = 480mn
1476091059 -> Mon Oct 10 11:17:38 2016 1123[emitEventToMonitel] cacUsed=0 eqtCac =-1
Mon Oct 10 11:17:38 2016 1123[emitEventToMonitel] displayIPCMessageOut
Mon Oct 10 11:17:38 2016 [isValidGwExt] ext gw 2 is valid
Mon Oct 10 11:17:38 2016 [isValidGwExt] ext gw 2 is valid
Mon Oct 10 11:17:38 2016 ** SIP TRUNKING **
Mon Oct 10 11:17:38 2016 [sendLgEvtSip] Event sent on eqt : 3210 Id :-1
Mon Oct 10 11:17:38 2016 [sendLgEvtSip] Event sent on eqt : 3210 Id :-1
Mon Oct 10 11:17:38 2016 [display_ipc_out] ------------ Begin ---------------
Mon Oct 10 11:17:38 2016 Id : -1
Mon Oct 10 11:17:38 2016 INFORMATIONAL
Mon Oct 10 11:17:38 2016 xx : 80
Mon Oct 10 11:17:38 2016 RELATIVE REQUEST : INVITE
Mon Oct 10 11:17:38 2016 Allow Update : 0
Mon Oct 10 11:17:38 2016 SDP :
Mon Oct 10 11:17:38 2016 ADDRESS : 10.255.254.74 :12792
Mon Oct 10 11:17:38 2016 ALGOS :
Mon Oct 10 11:17:38 2016 PCMA
Mon Oct 10 11:17:38 2016 101
Mon Oct 10 11:17:38 2016 DIRECTION : SEND & RECEIVE
Mon Oct 10 11:17:38 2016 crypto index : 0
Mon Oct 10 11:17:38 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 11:17:39 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Mon Oct 10 11:17:39 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Mon Oct 10 11:17:39 2016 [exec_ipc] in 30138.
Mon Oct 10 11:17:39 2016 [display_ipc_in] ------------ Begin ---------------
Mon Oct 10 11:17:39 2016 neqt : 3525 Id : -1
Mon Oct 10 11:17:39 2016 SUCCESSFUL
Mon Oct 10 11:17:39 2016 xx : 0
Mon Oct 10 11:17:39 2016 RELATIVE REQUEST : INVITE
1476091059 -> Mon Oct 10 11:17:39 2016 CLIR : 0
Mon Oct 10 11:17:39 2016 COLP : 1
Mon Oct 10 11:17:39 2016 CAC-CSBU info : UNKNOWN
Mon Oct 10 11:17:39 2016 SDP :
Mon Oct 10 11:17:39 2016 ADDRESS : 10.51.255.5 :32612
Mon Oct 10 11:17:39 2016 ALGOS :
Mon Oct 10 11:17:39 2016 PCMA
Mon Oct 10 11:17:39 2016 101
Mon Oct 10 11:17:39 2016 DIRECTION : SEND & RECEIVE
Mon Oct 10 11:17:39 2016 crypto index : 0
Mon Oct 10 11:17:39 2016 [display_ipc_in] ------------- End ----------------
Mon Oct 10 11:17:39 2016 [CMotorCallManager::onIncomingEvent] an event 10765 arr ived on the eqt 3525 -1.
Mon Oct 10 11:17:39 2016 [CMotorCallManager::onIncomingEvent] state = PROCEEDING _STATE.
Mon Oct 10 11:17:39 2016 [onIncomingEvent] SUCCESSFUL arrived.
Mon Oct 10 11:17:39 2016 [onIncomingEvent] relative_request = 10752
Mon Oct 10 11:17:39 2016 [CProceedingState::receiveSuccessfulEvent] Call: 5b2021 067e7722a144d5752d13ab0305@192.168.X.X:5060 eqt: 3525 PROCEEDING_STATE received an event.
Mon Oct 10 11:17:39 2016 [quoteString] => " Bryan"
Mon Oct 10 11:17:39 2016 1125[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Mon Oct 10 11:17:39 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:39 2016 1125[CMotorCall::isTLSProtRequiredForExtGw] =0.
Mon Oct 10 11:17:39 2016 87fa [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:39 2016 1125[CMotorCall::emitSuccessfulMessage] P-Asserted-Iden tity: " Bryan" <sip:2621@192.168.XXX.XXX;user=phone>
Mon Oct 10 11:17:39 2016 [isValidGwExt] ext gw 7 is valid
1476091059 -> Mon Oct 10 11:17:39 2016 1125[CMotorCall ABCF ExtGW
Mon Oct 10 11:17:39 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:39 2016 1125[CMotorCall ABCF ExtGW
Mon Oct 10 11:17:39 2016 1125[CMotorCall::emitSuccessfullMessage] uacGatewayMode =0 uacRefresher=0.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::makeResponseSdp] Audio media.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::appendAudioAttributToMedia] Direction: 0.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::appendAudioAttributToMedia] format 101
Mon Oct 10 11:17:39 2016 1125[CMotorCall::makeResponseSdp] fromSdp.getMediaDesci prionCount :1
Mon Oct 10 11:17:39 2016 [CSipMediaDescription::parseFormatString] Got 5 format( s) from string 8 0 18 4 101
Mon Oct 10 11:17:39 2016 [sameCodec] accepted Format : 8.
Mon Oct 10 11:17:39 2016 [sameCodec] requested Format : 8.
Mon Oct 10 11:17:39 2016 [sameCodec] same Format.
Mon Oct 10 11:17:39 2016 [CSipMediaDescription::parseFormatString] Got 2 format( s) from string 8 101
Mon Oct 10 11:17:39 2016 1125[CMotorCall::mediaAccepted] Media accepted: m=audio 32612 RTP/AVP 8 101
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:101 telephone-event/8000
.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::makeResponseSdp] no crypto line, media accepted=0.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::makeResponseSdp] Final Sdp.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::emitSuccesfulMessage] Answer sdp.
Mon Oct 10 11:17:39 2016 [removeAudioMediaPortNull] media no=0.
Mon Oct 10 11:17:39 2016 1125 [CCall::makeGenericResponse] 200
1476091059 -> Mon Oct 10 11:17:39 2016 1125 [CCall::getDialog] Confirmed Dialog is not found (ID = 6eef3fcb72f467410d070f15a8fc6417;as434494ea)
Mon Oct 10 11:17:39 2016 1125 [CCall::getDialog] Returning Initial Dialog Server
Mon Oct 10 11:17:39 2016 1526 [CDialog::createResponse] 200
Mon Oct 10 11:17:39 2016 1526 [CDialog::createResponse] create a CONFIRMED dialo g
Mon Oct 10 11:17:39 2016 B26F0 [CMessage::getMyViaHeader] From index is out of b ound
Mon Oct 10 11:17:39 2016 1527 [CDialog::CDialog] look for the transaction #0, tr ansaction key = z9hG4bK5ddfda31
Mon Oct 10 11:17:39 2016 1527 [CDialog::CDialog] copy the transaction #0, transa ction key = z9hG4bK5ddfda31
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::CTransaction] Transaction is cloned in 4 state
Mon Oct 10 11:17:39 2016 1527 [CDialog::addTransaction] added transaction 21d7 w ith branch z9hG4bK5ddfda31, with CSeq 102
Mon Oct 10 11:17:39 2016 1527 [CDialog::startDialogTTL]
Mon Oct 10 11:17:39 2016 1527 [CDialog::createResponse] 200
Mon Oct 10 11:17:39 2016 CEDCC [CResponse::CResponse] Creation of a response
Mon Oct 10 11:17:39 2016 21d7 [CTransProceedingState::createResponse] CResponse CEDCC ref=1
Mon Oct 10 11:17:39 2016 CEDCC [CResponse::create] RESPONSE CREATION
Mon Oct 10 11:17:39 2016 87fb [CSipAddrSpec::getAddrSpecAsString]
Mon Oct 10 11:17:39 2016 618C [CHeadersService::applyToMessage] P-Asserted-Ident ity header = P-Asserted-Identity: " Bryan" <sip:2621@192.168.XXX.XXX;user=ph one>
Mon Oct 10 11:17:39 2016 CEDCC [CMessage::getHeaderAtIndexFromSipMessage(Content -Type, 0)] sip_getHeaderAtIndex FAILED => HSS ERROR No exist
1476091059 -> Mon Oct 10 11:17:39 2016 CEDCC [CResponse::checkStatusLine] Create StatusLine from code given as parameter
Mon Oct 10 11:17:39 2016 CEDCC [CResponse::createToHeader] Initialize To TAG fro m context
Mon Oct 10 11:17:39 2016 CEDCC [CResponse::createViaHeaders] Copy Via headers fr om previous request (number : 1)
Mon Oct 10 11:17:39 2016 CEDCC [CResponse::create] Initialize context (Local = T o & Remote = From)
Mon Oct 10 11:17:39 2016 CEDCC [CMessage::send] sip_sendMessage (192.168.X.X:50 60)
Mon Oct 10 11:17:39 2016 SEND MESSAGE TO NETWORK (192.168.X.X:5060 [UDP]) (BUFF LEN = 878)
----------------------utf8-----------------------
SIP/2.0 200 OK
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDAT E
Contact: sip:192.168.XXX.XXX
Supported: replaces,timer,path,100rel
User-Agent: OmniPCX Enterprise R10.0 j1.410.49.a
Session-Expires: 1800;refresher=uas
P-Asserted-Identity: " Bryan" <sip:2621@192.168.XXX.XXX;user=phone>
Content-Type: application/sdp
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>;tag=6eef3fcb72f467410d070f15a8fc641 7
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 102 INVITE
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK5ddfda31
Content-Length: 216
v=0
o=OXE 1476091056 1476091056 IN IP4 192.168.XXX.XXX
s=abs
c=IN IP4 10.51.255.5
t=0 0
m=audio 32612 RTP/AVP 8 101
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:101 telephone-event/8000
-------------------------------------------------
1476091059 -> Mon Oct 10 11:17:39 2016 [sip_freeEventContext]
Mon Oct 10 11:17:39 2016 21d7 [CTransProceedingState::createResponse] Final : Tr ansaction changes to Completed state
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::changeState] STATE CHANGED TO COMPL ETED
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::changeState] notifying the parent d ialog
Mon Oct 10 11:17:39 2016 1527 [CDialog::onTransactionState(pTrans = 21d7, previo usState = Proceeding, currentState = Completed, reason = Final resp creation]
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::startTimer] Timer G is started (del ay = 500 ms)
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::startTimer] Timer H is started (del ay = 32000 ms)
Mon Oct 10 11:17:39 2016 1527 [CDialog::updateRouteSet] there are 0 record-route headers
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::CSessionTimerContext] New CSessi onTimerContext from response (Server, UA)
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateAfterRefreshReception] Upd ate CSessionTimerContext (refresh reception)
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateSupported] Request timer s upported
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateMinSE] Min-SE updated : 30 0
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateSessionExpires] Session-Ex pires updated : 1800
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::setRefreshMethod] Allow refreshM ethod=INVITE
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateAfterResponseRefreshCreati on] Update CSessionTimerContext (response refresh creation)
1476091059 -> Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateSessionExpir es] Refresher updated : i
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::updateSessionExpires] Session-Ex pires updated : 1800
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
Mon Oct 10 11:17:39 2016 [CSessionTimerContext::startTimers] Start session timer will expires : 900000
Mon Oct 10 11:17:39 2016 1125 [CCall::insertInDialogMap] added dialog #1527 with the key 6eef3fcb72f467410d070f15a8fc6417;as434494ea
Mon Oct 10 11:17:39 2016 1526 [CDialog::updateRouteSet] there are 0 record-route headers
Mon Oct 10 11:17:39 2016 [CProceedingState::receiveSuccessfulEvent] emitSuccessf ulMessage OK.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::setCurrentState] NOE-SIP : sendBackupU pdate Msg not sent to twin CS
Mon Oct 10 11:17:39 2016 [exec_ipc] in end 30138.
Mon Oct 10 11:17:39 2016 RECEIVE MESSAGE FROM NETWORK (192.168.X.X:5060 [UDP])
----------------------utf8-----------------------
ACK sip:192.168.XXX.XXX SIP/2.0
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK38e224e3
Max-Forwards: 70
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>;tag=6eef3fcb72f467410d070f15a8fc641 7
Contact: <sip:2373@192.168.X.X:5060>
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 102 ACK
User-Agent: XIVO PBX
Content-Length: 0
-------------------------------------------------
Mon Oct 10 11:17:39 2016 [CIOCom::receiveRequest] optimisation value 1
1476091059 -> Mon Oct 10 11:17:39 2016 [CIOCom::IsNoeOptionsMsg] Not in same do main FAILED => 192.168.XXX.XXX node000000
Mon Oct 10 11:17:39 2016 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Mon Oct 10 11:17:39 2016 B26F1 [CRequest::CRequest] Creation of a request (RECEI VED FROM NETWORK)
Mon Oct 10 11:17:39 2016 [CIOCom::receiveRequest] Received CRequest B26F1 ref=1
Mon Oct 10 11:17:39 2016 [CIOCom::receiveRequest] rport1 not empty
Mon Oct 10 11:17:39 2016 [CDispatcher::onIncomingRequest()]
Mon Oct 10 11:17:39 2016 [CDispatcher::processRequestFromManagerIndex()] start a t index 0
Mon Oct 10 11:17:39 2016 102 [CCallManager::onIncomingRequest()]
Mon Oct 10 11:17:39 2016 1125 [CCall::receiveRequest] ACK
Mon Oct 10 11:17:39 2016 1125 [CCall::getDialog] Confirmed Dialog found
Mon Oct 10 11:17:39 2016 1527 [CDialog::receiveRequest]
Mon Oct 10 11:17:39 2016 1527 [CDialog::receiveAckRequest]
Mon Oct 10 11:17:39 2016 1527 [CDialog::getTransactionByCSeq] CSeq = 102
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::changeState] STATE CHANGED TO TERMI NATED
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::freeTimerToken] Timer G is freed
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::freeTimerToken] Timer H is freed
Mon Oct 10 11:17:39 2016 21d7 [CTransaction::changeState] no transaction state, terminated reason : Request reception
Mon Oct 10 11:17:39 2016 1527 [CDialog::receiveAckRequest] the INVITE request is terminated
Mon Oct 10 11:17:39 2016 1125 [CCall::checkAuthentication] ACK
Mon Oct 10 11:17:39 2016 1125[CMotorCall::controlAuthentication] ---*--- END --- *--- Control authentication
1476091059 -> Mon Oct 10 11:17:39 2016 1125[CMotorCall::onReceiveRequest] s=0 d= 0 v=0 o=1.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::onReceiveRequest] request for gateway.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::onReceiveRequest] state = ACCEPTED_STA TE.
Mon Oct 10 11:17:39 2016 1125[CMotorCall::compareDialogFromContext] same Dialog
Mon Oct 10 11:17:39 2016 1125[CMotorCall::methodAckReceived] Ack => update the i nviteContext.
Mon Oct 10 11:17:39 2016 [receiveAckMessage] Call: 5b2021067e7722a144d5752d13ab0 305@192.168.X.X:5060 eqt: 3525 ACCEPTED_STATE received a message.
Mon Oct 10 11:17:39 2016 [receiveAckMessage] g711u: 255 g711A: 255 g723: 255 g72 9: 255.
Mon Oct 10 11:17:39 2016 1125[emitEventToMonitel] content size (lginfo): 660 cca l crypted= 0
Mon Oct 10 11:17:39 2016 1125[emitEventToMonitel] CAC = 0 eqtCAC = -1
Mon Oct 10 11:17:39 2016 1125[emitEventToMonitel] cacUsed=0 eqtCac=-1
Mon Oct 10 11:17:39 2016 1125[emitEventToMonitel] displayIPCMessageOut
Mon Oct 10 11:17:39 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:39 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:39 2016 ** SIP TRUNKING **
Mon Oct 10 11:17:39 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 11:17:39 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 11:17:39 2016 [display_ipc_out] ------------ Begin ---------------
Mon Oct 10 11:17:39 2016 Id : -1
Mon Oct 10 11:17:39 2016 ACK
Mon Oct 10 11:17:39 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 11:17:39 2016 1125[CMotorCall::setCurrentState] NOE-SIP : sendBackupU pdate Msg not sent to twin CS
1476091061 -> Mon Oct 10 11:17:39 2016 B26F1 [~CRequest] req 5b2021067e7722a144d 5752d13ab0305@192.168.X.X:5060 102 ACK
Mon Oct 10 11:17:39 2016 [CTransaction::notifyDialog]
Mon Oct 10 11:17:39 2016 [CTransaction::notifyDialog] notify parent dialog
Mon Oct 10 11:17:39 2016 1527 [CDialog::onTransactionState(pTrans = 21d7, previo usState = null, currentState = Terminated, reason = Request reception]
Mon Oct 10 11:17:39 2016 21D7 [~CTransaction] transaction 102 INVITE
Mon Oct 10 11:17:41 2016 RECEIVE MESSAGE FROM NETWORK (192.168.X.X:5060 [UDP])
----------------------utf8-----------------------
BYE sip:192.168.XXX.XXX SIP/2.0
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK4a1bdb53
Max-Forwards: 70
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>;tag=6eef3fcb72f467410d070f15a8fc641 7
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 103 BYE
User-Agent: XIVO PBX
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0
-------------------------------------------------
Mon Oct 10 11:17:41 2016 [CIOCom::receiveRequest] optimisation value 1
Mon Oct 10 11:17:41 2016 [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => 192.168.XXX.XXX node000000
Mon Oct 10 11:17:41 2016 [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Mon Oct 10 11:17:41 2016 B26F2 [CRequest::CRequest] Creation of a request (RECEI VED FROM NETWORK)
Mon Oct 10 11:17:41 2016 [CIOCom::receiveRequest] Received CRequest B26F2 ref=1
Mon Oct 10 11:17:41 2016 [CIOCom::receiveRequest] rport1 not empty
1476091061 -> Mon Oct 10 11:17:41 2016 [CDispatcher::onIncomingRequest()]
Mon Oct 10 11:17:41 2016 [CDispatcher::processRequestFromManagerIndex()] start a t index 0
Mon Oct 10 11:17:41 2016 102 [CCallManager::onIncomingRequest()]
Mon Oct 10 11:17:41 2016 1125 [CCall::receiveRequest] BYE
Mon Oct 10 11:17:41 2016 1125 [CCall::getDialog] Confirmed Dialog found
Mon Oct 10 11:17:41 2016 1527 [CDialog::receiveRequest]
Mon Oct 10 11:17:41 2016 1527 [CDialog::receiveBasicRequest]
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] STATE CHANGED TO INITI AL
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] notifying the parent d ialog
Mon Oct 10 11:17:41 2016 1527 [CDialog::onTransactionState(pTrans = 21d8, previo usState = Terminated, currentState = Initial, reason = None]
Mon Oct 10 11:17:41 2016 21d8 [CTransInitialState::receiveRequest] Transaction c hanges to Trying state
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] STATE CHANGED TO TRYIN G
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] notifying the parent d ialog
Mon Oct 10 11:17:41 2016 1527 [CDialog::onTransactionState(pTrans = 21d8, previo usState = Initial, currentState = Trying, reason = Request reception]
Mon Oct 10 11:17:41 2016 1527 [CDialog::addTransaction] added transaction 21d8 w ith branch z9hG4bK4a1bdb53, with CSeq 103
Mon Oct 10 11:17:41 2016 [CSessionTimerContext::~CSessionTimerContext] Free CSes sionTimerContext
Mon Oct 10 11:17:41 2016 1125 [CCall::checkAuthentication] BYE
Mon Oct 10 11:17:41 2016 1125[CMotorCall::controlAuthentication] ---*--- END --- *--- Control authentication
1476091061 -> Mon Oct 10 11:17:41 2016 1125[CMotorCall::onReceiveRequest] s=0 d= 0 v=0 o=1.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::onReceiveRequest] request for gateway.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::onReceiveRequest] state = COMPLETED_ST ATE.
Mon Oct 10 11:17:41 2016 [receiveByeMessage] Call: 5b2021067e7722a144d5752d13ab0 305@192.168.X.X:5060 eqt: 3525 COMPLETED_STATE received a message.
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] content size (lginfo): 660 cca l crypted= 0
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] CAC = 0 eqtCAC = -1
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] cacUsed=0 eqtCac=-1
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] displayIPCMessageOut
Mon Oct 10 11:17:41 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:41 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:41 2016 ** SIP TRUNKING **
Mon Oct 10 11:17:41 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 11:17:41 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Mon Oct 10 11:17:41 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Mon Oct 10 11:17:41 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 11:17:41 2016 [display_ipc_out] ------------ Begin ---------------
Mon Oct 10 11:17:41 2016 Id : -1
Mon Oct 10 11:17:41 2016 BYE
Mon Oct 10 11:17:41 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 11:17:41 2016 1125[CMotorCall::setCurrentState] NOE-SIP : sendBackupU pdate Msg not sent to twin CS
Mon Oct 10 11:17:41 2016 [exec_ipc] in 30138.
1476091061 -> Mon Oct 10 11:17:41 2016 [display_ipc_in] ------------ Begin ----- ----------
Mon Oct 10 11:17:41 2016 neqt : 3525 Id : -1
Mon Oct 10 11:17:41 2016 SUCCESSFUL
Mon Oct 10 11:17:41 2016 xx : 0
Mon Oct 10 11:17:41 2016 RELATIVE REQUEST : BYE
Mon Oct 10 11:17:41 2016 CLIR : 0
Mon Oct 10 11:17:41 2016 COLP : 0
Mon Oct 10 11:17:41 2016 CAC-CSBU info : UNKNOWN
Mon Oct 10 11:17:41 2016 [display_ipc_in] ------------- End ----------------
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onIncomingEvent] an event 10765 arr ived on the eqt 3525 -1.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onIncomingEvent] state = TERMINATED _STATE.
Mon Oct 10 11:17:41 2016 [onIncomingEvent] SUCCESSFUL arrived.
Mon Oct 10 11:17:41 2016 [onIncomingEvent] relative_request = 10755
Mon Oct 10 11:17:41 2016 [receiveSuccessfulEvent] Call: 5b2021067e7722a144d5752d 13ab0305@192.168.X.X:5060 eqt: 3525 TERMINATED_STATE received an event.
Mon Oct 10 11:17:41 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:41 2016 1125[CMotorCall ABCF ExtGW
Mon Oct 10 11:17:41 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:41 2016 1125[CMotorCall ABCF ExtGW
Mon Oct 10 11:17:41 2016 1527 [CCall::findFirstServerTrans]
Mon Oct 10 11:17:41 2016 1527 [CCallLeg::findFirstOpenServerTrans] Current Reque st in transactionMapByBranch
Mon Oct 10 11:17:41 2016 1125 [CCall::makeGenericResponse] 200
Mon Oct 10 11:17:41 2016 1125 [CCall::getDialog] Confirmed Dialog found
Mon Oct 10 11:17:41 2016 1527 [CDialog::createResponse] 200
1476091061 -> Mon Oct 10 11:17:41 2016 CEDCD [CResponse::CResponse] Creation of a response
Mon Oct 10 11:17:41 2016 21d8 [CTransTryingState::createResponse] CResponse CEDC D ref=1
Mon Oct 10 11:17:41 2016 CEDCD [CResponse::create] RESPONSE CREATION
Mon Oct 10 11:17:41 2016 CEDCD [CResponse::checkStatusLine] Create StatusLine fr om code given as parameter
Mon Oct 10 11:17:41 2016 CEDCD [CResponse::createViaHeaders] Copy Via headers fr om previous request (number : 1)
Mon Oct 10 11:17:41 2016 CEDCD [CResponse::create] Initialize context (Local = T o & Remote = From)
Mon Oct 10 11:17:41 2016 CEDCD [CMessage::send] sip_sendMessage (192.168.X.X:50 60)
Mon Oct 10 11:17:41 2016 SEND MESSAGE TO NETWORK (192.168.X.X:5060 [UDP]) (BUFF LEN = 488)
----------------------utf8-----------------------
SIP/2.0 200 OK
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDAT E
Supported: replaces,timer,path,100rel
User-Agent: OmniPCX Enterprise R10.0 j1.410.49.a
To: <sip:2621@192.168.XXX.XXX:5060;user=phone>;tag=6eef3fcb72f467410d070f15a8fc641 7
From: "BRYAN" <sip:2373@192.168.X.X>;tag=as434494ea
Call-ID: 5b2021067e7722a144d5752d13ab0305@192.168.X.X:5060
CSeq: 103 BYE
Via: SIP/2.0/UDP 192.168.X.X:5060;branch=z9hG4bK4a1bdb53
Content-Length: 0
-------------------------------------------------
Mon Oct 10 11:17:41 2016 [sip_freeEventContext]
Mon Oct 10 11:17:41 2016 21d8 [CTransTryingState::createResponse] Final : Transa ction changes to Completed state
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] STATE CHANGED TO COMPL ETED
1476091061 -> Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] notifyin g the parent dialog
Mon Oct 10 11:17:41 2016 1527 [CDialog::onTransactionState(pTrans = 21d8, previo usState = Trying, currentState = Completed, reason = Final resp creation]
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::startTimer] Timer J is started (del ay = 32000 ms)
Mon Oct 10 11:17:41 2016 1527 [CDialog::updateRouteSet] there are 0 record-route headers
Mon Oct 10 11:17:41 2016 [exec_ipc] in end 30138.
Mon Oct 10 11:17:41 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Mon Oct 10 11:17:41 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Mon Oct 10 11:17:41 2016 [exec_ipc] in 30138.
Mon Oct 10 11:17:41 2016 [display_ipc_in] ------------ Begin ---------------
Mon Oct 10 11:17:41 2016 neqt : 3525 Id : -1
Mon Oct 10 11:17:41 2016 SIP EQT RELEASED
Mon Oct 10 11:17:41 2016 [display_ipc_in] ------------- End ----------------
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onIncomingEvent] an event 10773 arr ived on the eqt 3525 -1.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onIncomingEvent] The call with eqt: 3525 has released its equipment.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ ACK
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] content size (lginfo): 660 cca l crypted= 0
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel]1 T38 REINVITE TRUE
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] CAC = 0 eqtCAC = -1
Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] cacUsed=0 eqtCac=-1
1476091061 -> Mon Oct 10 11:17:41 2016 1125[emitEventToMonitel] displayIPCMessag eOut
Mon Oct 10 11:17:41 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:41 2016 [isValidGwExt] ext gw 7 is valid
Mon Oct 10 11:17:41 2016 ** SIP TRUNKING **
Mon Oct 10 11:17:41 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 11:17:41 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Mon Oct 10 11:17:41 2016 [display_ipc_out] ------------ Begin ---------------
Mon Oct 10 11:17:41 2016 Id : -1
Mon Oct 10 11:17:41 2016 SIP_EQT_RELEASE_ACK
Mon Oct 10 11:17:41 2016 [display_ipc_out] ------------- End ----------------
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onIncomingEvent] state = TERMINATED _STATE.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::setCurrentState] NOE-SIP : sendBackupU pdate Msg not sent to twin CS
Mon Oct 10 11:17:41 2016 1125[CMotorCall::unRegister] Remove eqt : 3525 diag : - 1 from the map.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::eraseCallwithEqt] erase 3525 -1.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onIncomingEvent] killSession.
Mon Oct 10 11:17:41 2016 1125 [CCall::killSession]
Mon Oct 10 11:17:41 2016 21d6 [CTransaction::changeState] STATE CHANGED TO TERMI NATED
Mon Oct 10 11:17:41 2016 21d6 [CTransaction::changeState] no transaction state, terminated reason : None
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] STATE CHANGED TO TERMI NATED
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::freeTimerToken] Timer J is freed
Mon Oct 10 11:17:41 2016 21d8 [CTransaction::changeState] no transaction state, terminated reason : None
1476091061 -> Mon Oct 10 11:17:41 2016 1125 [CCall::killSession] notifying the c all manager
Mon Oct 10 11:17:41 2016 102 [CCallManager::onCallClosed]
Mon Oct 10 11:17:41 2016 102 [CCallManager::onCallClosed()] Call 1125 closed. R emoving call 139515608 from the maps
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onNotifyCallClosed] Call : 5b202106 7e7722a144d5752d13ab0305@192.168.X.X:5060 is closed.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onNotifyCallClosed] Call : 5b202106 7e7722a144d5752d13ab0305@192.168.X.X:5060 is closed.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onNotifyCallClosed] call processRes ponse.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::chooseBestResponse] pForkedBranch=0x85 a44c0 iResponseCode=2000.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::chooseBestResponse] next branch.
Mon Oct 10 11:17:41 2016 1125[CMotorCall::processResponse] no response found.
Mon Oct 10 11:17:41 2016 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Mon Oct 10 11:17:41 2016 [exec_ipc] in end 30138.
Mon Oct 10 11:17:41 2016 [CTransaction::notifyDialog]
Mon Oct 10 11:17:41 2016 [CTransaction::notifyDialog] notify parent dialog
Mon Oct 10 11:17:41 2016 1526 [CDialog::onTransactionState(pTrans = 21d6, previo usState = null, currentState = Terminated, reason = None]
Mon Oct 10 11:17:41 2016 1526 [CDialog::onTransactionState] dialog is terminated
Mon Oct 10 11:17:41 2016 1526 [CDialog::onTransactionState] onDialogClosed
Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed]
Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed] not only initial *********
1476091061 -> Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed]: the dialog 1527 is NOT closed
Mon Oct 10 11:17:41 2016 21D6 [~CTransaction] transaction 102 INVITE
Mon Oct 10 11:17:41 2016 CEDCA [~CResponse] resp(180) 5b2021067e7722a144d5752d13 ab0305@192.168.X.X:5060 102 INVITE
Mon Oct 10 11:17:41 2016 [CTransaction::notifyDialog]
Mon Oct 10 11:17:41 2016 [CTransaction::notifyDialog] notify parent dialog
Mon Oct 10 11:17:41 2016 1527 [CDialog::onTransactionState(pTrans = 21d8, previo usState = null, currentState = Terminated, reason = None]
Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed]
Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed] not only initial *********
Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed]: the dialog 1527 is closed
Mon Oct 10 11:17:41 2016 1125 [CCall::onDialogClosed] All the dialogs in the Cal l are closed
Mon Oct 10 11:17:41 2016 21D8 [~CTransaction] transaction 103 BYE
Mon Oct 10 11:17:41 2016 102 [CCallManager::removeGarbage] at index i = 0
Mon Oct 10 11:17:41 2016 1125 [CMotorCall::clear_subscription] subscription man aged with key
Mon Oct 10 11:17:41 2016 [CMotorCallManager::eraseSubscription] tyr to erase wit h key
Mon Oct 10 11:17:41 2016 [CMotorCallManager::eraseSubscription] No call found wi th key
Mon Oct 10 11:17:41 2016 1125[CMotorCall::~CMotorCall] Call : 5b2021067e7722a144 d5752d13ab0305@192.168.X.X:5060 is being destructed.
Mon Oct 10 11:17:41 2016 1125 [CCall::~CCall]
Mon Oct 10 11:17:41 2016 1125 [CCall::removeGarbage]
Mon Oct 10 11:17:41 2016 1527 [CDialog::~CDialog]
1476091063 -> Mon Oct 10 11:17:41 2016 1526 [CDialog::~CDialog]
Mon Oct 10 11:17:41 2016 [CSessionTimerContext::~CSessionTimerContext] Free CSes sionTimerContext
Mon Oct 10 11:17:41 2016 CEDCC [~CResponse] resp(200) 5b2021067e7722a144d5752d13 ab0305@192.168.X.X:5060 102 INVITE
Mon Oct 10 11:17:41 2016 B26F0 [~CRequest] req 5b2021067e7722a144d5752d13ab0305@ 192.168.X.X:5060 102 INVITE
Mon Oct 10 11:17:41 2016 CEDCD [~CResponse] resp(200) 5b2021067e7722a144d5752d13 ab0305@192.168.X.X:5060 103 BYE
Mon Oct 10 11:17:41 2016 B26F2 [~CRequest] req 5b2021067e7722a144d5752d13ab0305@ 192.168.X.X:5060 103 BYE