OXE send BYE upon answering the call to sip extension.

Post Reply
ether
Member
Posts: 65
Joined: 04 Jul 2011 20:03

OXE send BYE upon answering the call to sip extension.

Post by ether »

With relate to https://www.alcatelunleashed.com/viewtopic.php?t=16888.

I am currently facing issue with incoming calls to Cetis 3300 Sip phones.

When answering a call from IP Phone, the call just get disconnected.

Below is the traced log file. Maybe I missed something.

Code: Select all

----------------------utf8-----------------------
INVITE sip:52986@10.205.137.100:5060 SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE, INFO
Supported: replaces,timer,path
User-Agent: OmniPCX Enterprise R100.0 n1.291.66.a
Session-Expires: 1800;refresher=uac
Min-SE: 900
Content-Type: application/sdp
To: "sip test" <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>
From: "Techhome" <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
Contact: <sip:88818@nodeXYZ.aaacccc.ae:5060;transport=UDP>
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748389 INVITE
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a
Max-Forwards: 70
Content-Length: 290

v=0
o=OXE 1686893426 1686893426 IN IP4 10.205.224.43
s=abs
c=IN IP4 10.205.10.155
t=0 0
m=audio 32514 RTP/AVP 18 4 97
a=sendrecv
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:4 G723/8000
a=ptime:30
a=maxptime:30
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
1686893426 -> Fri Jun 16 09:30:26 2023 32C0 [CMessage::onSendSuccess]
Fri Jun 16 09:30:26 2023 21fe [CTransaction::onSendSuccess] CMessage 32C0 send Success
Fri Jun 16 09:30:26 2023 15c2 [CDialog::onSendSuccess]
Fri Jun 16 09:30:26 2023 21fe [CTransInitialState::createRequest] Transaction changes to Calling state
Fri Jun 16 09:30:26 2023 21fe [CTransaction::changeState] STATE CHANGED TO CALLING
Fri Jun 16 09:30:26 2023 21fe [CTransaction::changeState] notifying the parent dialog
Fri Jun 16 09:30:26 2023 15c2 [CDialog::onTransactionState(pTrans = 21fe, previousState = Initial, currentState = Calling, reason = Request creation]
Fri Jun 16 09:30:26 2023 21fe [CTransaction::startTimer] Timer A is started (delay = 1500 ms)
Fri Jun 16 09:30:26 2023 21fe [CTransaction::startTimer] Timer B is started (delay = 12000 ms)
Fri Jun 16 09:30:26 2023 15c2 [CDialog::getTransactionByCSeq] CSeq = 144748389
Fri Jun 16 09:30:26 2023 15c2 [CDialog::addTransaction] added transaction 21fe with branch z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a, with CSeq 144748389
Fri Jun 16 09:30:26 2023 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Client, UA)
Fri Jun 16 09:30:26 2023 [CSessionTimerContext::updateSupported] Request timer supported 
Fri Jun 16 09:30:26 2023 [CSessionTimerContext::updateMinSE] Min-SE updated : 900
Fri Jun 16 09:30:26 2023 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
Fri Jun 16 09:30:26 2023 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1686893426 -> Fri Jun 16 09:30:26 2023 [CForkedBranch::CForkedBranch] context = 0x89f546c.
Fri Jun 16 09:30:26 2023 110b[CMotorCall::branchAllocation] pForkedBranch = 0x89bd190 and the branch number is.
Fri Jun 16 09:30:26 2023 [DBG: CSipSdpMessage::Destructor]
Fri Jun 16 09:30:26 2023 [DBG: CSipSdpMessage::Destructor] Ends
Fri Jun 16 09:30:26 2023 110b[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Fri Jun 16 09:30:26 2023 NOE-SIP : StandByCallCreation not sent to twin CS 
Fri Jun 16 09:30:26 2023 [onIncomingEvent] CallID must be inserted.
Fri Jun 16 09:30:26 2023 [onIncomingEvent] CallID inserted.
Fri Jun 16 09:30:26 2023 [exec_ipc] in end 18175.
Fri Jun 16 09:30:26 2023 RECEIVE MESSAGE FROM NETWORK (10.205.137.100:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a
From: "Techhome" <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
To: "sip test" <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748389 INVITE
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0

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

Fri Jun 16 09:30:26 2023 [CIOCom::receiveResponse] CResponse 32CA ref=1
Fri Jun 16 09:30:26 2023 [CMngData::getStackPort] >>>>> transportProtocol: 0, isMTLS: 0, m_uStackSecureMtlsPort: 6261, m_uStackSecurePort: 5061, m_uStackUnsecurePort 5060
1686893426 -> Fri Jun 16 09:30:26 2023 [CMngData::getStackPort] >>>>> port: 5060
Fri Jun 16 09:30:26 2023 [CDispatcher::processResponseFromManagerIndex] start at index 0
Fri Jun 16 09:30:26 2023  102 [CCallManager::onIncomingResponse]
Fri Jun 16 09:30:26 2023 110b [CCall::receiveResponse] 100
Fri Jun 16 09:30:26 2023 110b [CCall::getDialog] Confirmed Dialog is not found (ID = 8ea4befaef0f15dc7cd0c9092d4c0c23;)
Fri Jun 16 09:30:26 2023 110b [CCall::getDialog] Returning Initial Dialog Client
Fri Jun 16 09:30:26 2023 15c2 [CDialog::receiveResponse]
Fri Jun 16 09:30:26 2023 21fe [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
Fri Jun 16 09:30:26 2023 21fe [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Fri Jun 16 09:30:26 2023 21fe [CTransaction::changeState] notifying the parent dialog
Fri Jun 16 09:30:26 2023 15c2 [CDialog::onTransactionState(pTrans = 21fe, previousState = Calling, currentState = Proceeding, reason = 1xx response reception]
Fri Jun 16 09:30:26 2023 21fe [CTransaction::freeTimerToken] Timer A is freed
Fri Jun 16 09:30:26 2023 21fe [CTransaction::freeTimerToken] Timer B is freed
Fri Jun 16 09:30:26 2023 [DBG: CSipSdpMessage::Destructor]
Fri Jun 16 09:30:26 2023 [DBG: CSipSdpMessage::Destructor] Ends
Fri Jun 16 09:30:26 2023 110b[CMotorCall::searchForkedBranch]pForkedBranch=0x89bd190.
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] Call: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 eqt: 1536 PROCEEDING_STATE received a message.
1686893426 -> Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] setting COLP to true in preferred
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] 0 AlertInfo header(s) found
Fri Jun 16 09:30:26 2023 [CPoceedingState::receiveInformationalMessage]-->nof of PEM hdrs 0
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] No P-Early-Media header received
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] is in the else part of SDP not present
Fri Jun 16 09:30:26 2023 RECEIVE MESSAGE FROM NETWORK (10.205.137.100:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a
From: "Techhome" <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
To: "sip test" <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=659231684
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748389 INVITE
Contact: <sip:52986@10.205.137.100:5060>
Server: TMX ST2  V1.8.5-958
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0

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

Fri Jun 16 09:30:26 2023 [CIOCom::receiveResponse] CResponse 32CB ref=1
Fri Jun 16 09:30:26 2023 [CMngData::getStackPort] >>>>> transportProtocol: 0, isMTLS: 0, m_uStackSecureMtlsPort: 6261, m_uStackSecurePort: 5061, m_uStackUnsecurePort 5060
Fri Jun 16 09:30:26 2023 [CMngData::getStackPort] >>>>> port: 5060
Fri Jun 16 09:30:26 2023 [CDispatcher::processResponseFromManagerIndex] start at index 0
1686893426 -> Fri Jun 16 09:30:26 2023  102 [CCallManager::onIncomingResponse]
Fri Jun 16 09:30:26 2023 110b [CCall::receiveResponse] 180
Fri Jun 16 09:30:26 2023 110b [CCall::getDialog] Confirmed Dialog is not found (ID = 8ea4befaef0f15dc7cd0c9092d4c0c23;659231684)
Fri Jun 16 09:30:26 2023 110b [CCall::getDialog] Returning Initial Dialog Client
Fri Jun 16 09:30:26 2023 15c2 [CDialog::receiveResponse]
Fri Jun 16 09:30:26 2023 [CResponse::~CResponse]
Fri Jun 16 09:30:26 2023 32CA [~CResponse] resp(100) c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 144748389 INVITE
Fri Jun 16 09:30:26 2023 [CResponse::~CResponse Ends]
Fri Jun 16 09:30:26 2023 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Fri Jun 16 09:30:26 2023 [CMessage::~CMessage Ends]
Fri Jun 16 09:30:26 2023 15c2 [CDialog::updateRouteSet] there are 0 record-route headers
Fri Jun 16 09:30:26 2023 [DBG: CSipSdpMessage::Destructor]
Fri Jun 16 09:30:26 2023 [DBG: CSipSdpMessage::Destructor] Ends
Fri Jun 16 09:30:26 2023 110b[CMotorCall::searchForkedBranch]pForkedBranch=0x89bd190.
Fri Jun 16 09:30:26 2023 110b[CMotorCall::onReceiveResponse] lastInviteContext got updated
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] Call: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 eqt: 1536 PROCEEDING_STATE received a message.
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] setting COLP to true in preferred
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] 0 AlertInfo header(s) found
Fri Jun 16 09:30:26 2023 [CPoceedingState::receiveInformationalMessage]-->nof of PEM hdrs 0
1686893427 -> Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] No P-Early-Media header received
Fri Jun 16 09:30:26 2023 [receiveInformationalMessage] is in the else part of SDP not present
Fri Jun 16 09:30:26 2023 [methodAllowedByDistant] INFO allowed by distant.
Fri Jun 16 09:30:26 2023 110b[emitEventToMonitel] content size (lginfo): 656 ccal crypted= 0
Fri Jun 16 09:30:26 2023 110b[emitEventToMonitel] CAC = 0 eqtCAC = -1 
Fri Jun 16 09:30:26 2023 110b[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Jun 16 09:30:26 2023 110b[emitEventToMonitel] displayIPCMessageOut 
Fri Jun 16 09:30:26 2023 ** SEPLOS **
Fri Jun 16 09:30:26 2023 [sendLgEvtSip] seplos Event sent on eqt : 1536 Id :1
Fri Jun 16 09:30:26 2023 [display_ipc_out] ------------ Begin ---------------
Fri Jun 16 09:30:26 2023 Id : 1
Fri Jun 16 09:30:26 2023 INFORMATIONAL
Fri Jun 16 09:30:26 2023 xx :       80
Fri Jun 16 09:30:26 2023        RELATIVE REQUEST : INVITE
Fri Jun 16 09:30:26 2023 Allow Update : 0
Fri Jun 16 09:30:26 2023 [display_ipc_out] ------------- End ----------------
Fri Jun 16 09:30:27 2023 RECEIVE MESSAGE FROM NETWORK (10.205.96.8:53969 [TCP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a
From: "Techhome" <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
To: "sip test" <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=659231684
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748389 INVITE
Contact: <sip:52986@10.205.137.100:5060>
Supported: 100rel, replaces, timer
Server: TMX ST2  V1.8.5-958
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Type: application/sdp
Content-Length: 210

v=0
o=52986 20460510 15236149 IN IP4 10.205.137.100
s=A conversation
c=IN IP4 10.205.137.100
t=0 0
m=audio 10004 RTP/AVP 18 4
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000
a=sendrecv
-------------------------------------------------

Fri Jun 16 09:30:28 2023 [CIOCom::receiveResponse] CResponse 32CE ref=1
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> transportProtocol: 0, isMTLS: 0, m_uStackSecureMtlsPort: 6261, m_uStackSecurePort: 5061, m_uStackUnsecurePort 5060
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> port: 5060
Fri Jun 16 09:30:28 2023 [CDispatcher::processResponseFromManagerIndex] start at index 0
Fri Jun 16 09:30:28 2023  102 [CCallManager::onIncomingResponse]
Fri Jun 16 09:30:28 2023 110b [CCall::receiveResponse] 200
1686893428 -> Fri Jun 16 09:30:28 2023 110b [CCall::getDialog] Confirmed Dialog is not found (ID = 8ea4befaef0f15dc7cd0c9092d4c0c23;659231684)
Fri Jun 16 09:30:28 2023 110b [CCall::getDialog] Returning Initial Dialog Client
Fri Jun 16 09:30:28 2023 15c2 [CDialog::receiveResponse]
Fri Jun 16 09:30:28 2023 15c2 [CDialog::receiveResponse] create a CONFIRMED dialog
Fri Jun 16 09:30:28 2023 15c5 [CDialog::CDialog] look for the transaction #0, transaction key = z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a
Fri Jun 16 09:30:28 2023 15c5 [CDialog::CDialog] copy the transaction #0, transaction key = z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a
Fri Jun 16 09:30:28 2023 2100 [CTransaction::CTransaction] Transaction is cloned in 4 state
Fri Jun 16 09:30:28 2023 15c5 [CDialog::addTransaction] added transaction 2100 with branch z9hG4bKee1e8e76f5d23d47c8da104518dc2c6a, with CSeq 144748389
Fri Jun 16 09:30:28 2023 15c5 [CDialog::startDialogTTL]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::CDialog] resources number: 53
Fri Jun 16 09:30:28 2023 15c5 [CDialog::receiveResponse]
Fri Jun 16 09:30:28 2023 2100 [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
Fri Jun 16 09:30:28 2023 2100 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Fri Jun 16 09:30:28 2023 2100 [CTransaction::changeState] notifying the parent dialog
Fri Jun 16 09:30:28 2023 15c5 [CDialog::onTransactionState(pTrans = 2100, previousState = Proceeding, currentState = Completed, reason = Final resp reception]
Fri Jun 16 09:30:28 2023 2100 [CTransaction::startTimer] Timer D is started (delay = 32902 ms)
1686893428 -> Fri Jun 16 09:30:28 2023 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from response (Client, UA)
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::updateSupported] Request timer supported 
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::updateMinSE] Min-SE updated : 900
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::updateSessionExpires] Refresher updated : i
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::startTimers] Start session timer will expires : 900000
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=UPDATE
Fri Jun 16 09:30:28 2023 15c5 [CDialog::updateRouteSet] there are 0 record-route headers
Fri Jun 16 09:30:28 2023 110b [CCall::insertInDialogMap] added dialog #15c5 with the key 8ea4befaef0f15dc7cd0c9092d4c0c23;659231684
Fri Jun 16 09:30:28 2023 15c2 [CDialog::getTransactionByCSeq] CSeq = 144748390
Fri Jun 16 09:30:28 2023 15c2 [CDialog::updateRouteSet] there are 0 record-route headers
Fri Jun 16 09:30:28 2023 110b[CMotorCall::searchForkedBranch]pForkedBranch=0x89bd190.
Fri Jun 16 09:30:28 2023         [CForkedBranch::setFinalResponse] response=200.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
1686893428 -> Fri Jun 16 09:30:28 2023 110b[CMotorCall::chooseBestResponse] pForkedBranch=0x89bd190 iResponseCode=2000.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::chooseBestResponse] last iResponseCode=200.
Fri Jun 16 09:30:28 2023         [CForkedBranch::setFinalResponse] pResponse=0x8a36890.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::chooseBestResponse] next branch.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::updateTransportfromlastInviteContext] lasInviteContext Start
Fri Jun 16 09:30:28 2023 [receiveSuccessfulMessage] Call: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 eqt: 1536 PROCEEDING_STATE received a message.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::setSessionTimer] main gw sessionTimer=1800
Fri Jun 16 09:30:28 2023 110b[CMotorCall::analyseSessionTimer] Session Timer extGw=1000 sessionDelay=1800  .
Fri Jun 16 09:30:28 2023 110b[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT manged with TLS and refresh REINVITE
Fri Jun 16 09:30:28 2023 110b[CMotorCall::analyseSessionTimer] exit with  uacGatewayMode=1 uacRefresher=1.
Fri Jun 16 09:30:28 2023 [decodeACACALU] no header.
Fri Jun 16 09:30:28 2023 [receiveSuccessfulMessage] setting COLP to true in preferred
Fri Jun 16 09:30:28 2023 [checkSdpValidity] Sdp contains 1 media description(s).
Fri Jun 16 09:30:28 2023 [checkSdpValidity] without video control.
Fri Jun 16 09:30:28 2023 [checkSdpValidity] Media 0 type 1 contains 2 formats.
1686893428 -> Fri Jun 16 09:30:28 2023 [checkSdpValidity] media audio.
Fri Jun 16 09:30:28 2023 [checkSdpValidity] Format : 18.
Fri Jun 16 09:30:28 2023 [checkSdpValidity] return false.
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] Sdp contains 1 media description(s).
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] No Direction in the session part.
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] Check the direction in Session part - result:0.
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] new media analyzed=0 sdp_index=0 count=1.
Fri Jun 16 09:30:28 2023 [audioMediaSentToCH] media AUDIO detected (previous crypto=0), clearMediaLine=0
Fri Jun 16 09:30:28 2023 [convertCryptoInfoInFile] clearMediaLine2:  0.
Fri Jun 16 09:30:28 2023 [convertAudioMedia] The audio media contains  2 format(s).
Fri Jun 16 09:30:28 2023 [convertAudioMedia] Format 0 is 18 opt syst G711=0.
Fri Jun 16 09:30:28 2023 [convertAudioMedia] Format is G729.
Fri Jun 16 09:30:28 2023 [convertAudioMedia] Format 1 is 4 opt syst G711=0.
Fri Jun 16 09:30:28 2023 [convertAudioMedia] Format is G723.
Fri Jun 16 09:30:28 2023 [convertAudioMedia] Direction is sendrecv.
Fri Jun 16 09:30:28 2023 [convertAudioMedia] Connection address retrieved in sdp: 10.205.137.100.
Fri Jun 16 09:30:28 2023 [convertIPStrIntoTuipv] 10.205.137.100 => 10.205.137.100
Fri Jun 16 09:30:28 2023 [audioMediaSentToCH] sdp index=0.
Fri Jun 16 09:30:28 2023 [display_sdp] address =10.205.137.100
Fri Jun 16 09:30:28 2023 [display_sdp] codecs =17.
Fri Jun 16 09:30:28 2023 [display_sdp] codecs =16.
1686893428 -> Fri Jun 16 09:30:28 2023 [display_sdp] direction=0.
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] ok.
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] 5-crypto_info=0xbffff078 crypto_index=0 clear media=1
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] only one media taken into account xxx crypto_index=0 clear media=1
Fri Jun 16 09:30:28 2023 [convertSdpIntoTsdp] 3-crypto_info=0xbffff078 crypto_index=0 clear media=1
Fri Jun 16 09:30:28 2023 [methodAllowedByDistant] INFO allowed by distant.
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] content size (lginfo): 656 ccal crypted= 0
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] CAC = 0 eqtCAC = -1 
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] displayIPCMessageOut 
Fri Jun 16 09:30:28 2023 ** SEPLOS **
Fri Jun 16 09:30:28 2023 [sendLgEvtSip] seplos Event sent on eqt : 1536 Id :1
Fri Jun 16 09:30:28 2023 [display_ipc_out] ------------ Begin ---------------
Fri Jun 16 09:30:28 2023 Id : 1
Fri Jun 16 09:30:28 2023 SUCCESSFUL
Fri Jun 16 09:30:28 2023 xx :        0
Fri Jun 16 09:30:28 2023        RELATIVE REQUEST : INVITE
Fri Jun 16 09:30:28 2023 CAC-CSBU info : UNKNOWN
Fri Jun 16 09:30:28 2023 CLIR : 0
Fri Jun 16 09:30:28 2023 COLP : 0
Fri Jun 16 09:30:28 2023 SDP :
Fri Jun 16 09:30:28 2023   ADDRESS : 10.205.137.100 :10004
Fri Jun 16 09:30:28 2023   ALGOS :
Fri Jun 16 09:30:28 2023     G729
Fri Jun 16 09:30:28 2023     G723
Fri Jun 16 09:30:28 2023   DIRECTION : SEND & RECEIVE
1686893428 -> Fri Jun 16 09:30:28 2023   video  index : 0
Fri Jun 16 09:30:28 2023   crypto index : 0
Fri Jun 16 09:30:28 2023 [display_ipc_out] ------------- End ----------------
Fri Jun 16 09:30:28 2023 [ipc_thread] Normal case : evt 10754
Fri Jun 16 09:30:28 2023 [ipc_thread] IPC Thread : Ipc reception 18186.
Fri Jun 16 09:30:28 2023 [ipc_thread] IPC Thread : TCL thread signaled.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Fri Jun 16 09:30:28 2023 110b[CMotorCall::onReceiveResponse] retrans=0, status=200 extGw=1000.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::cancelAllCancelableForkedBranch] retrans=0.
Fri Jun 16 09:30:28 2023 [exec_ipc] in 18175.
Fri Jun 16 09:30:28 2023 [display_ipc_in] ------------ Begin ---------------
Fri Jun 16 09:30:28 2023 neqt : 1536 Id : 1
Fri Jun 16 09:30:28 2023 ACK
Fri Jun 16 09:30:28 2023 [display_ipc_in] ------------- End ----------------
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] an event 10754 arrived on the eqt 1536 1.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] seplos station.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] state = ACCEPTED_STATE.
Fri Jun 16 09:30:28 2023 [onIncomingEvent] ACK arrived.
Fri Jun 16 09:30:28 2023 [receiveAckEvent] Call: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 eqt: 1536 ACCEPTED_STATE received an event.
1686893428 -> Fri Jun 16 09:30:28 2023 110b[CMotorCall::emitAckMessage]
Fri Jun 16 09:30:28 2023 110b[CMotorCall::emitAckMessage] SDP ok.
Fri Jun 16 09:30:28 2023 110b [CCall::makeGenericRequest] ACK
Fri Jun 16 09:30:28 2023 110b [CCall::getDialog] Confirmed Dialog found
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createRequest]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::buildServicesForAllRequest]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createAckRequest]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createAckRequest], previous trans 2100 is found
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createAckRequest], previous trans 2100 is client
Fri Jun 16 09:30:28 2023 32C3 [CRequest::CRequest] Creation of a request
Fri Jun 16 09:30:28 2023 15c5 [CDialog::buildServicesForAck]
Fri Jun 16 09:30:28 2023 [DBG: CRequest::freeAttributes]
Fri Jun 16 09:30:28 2023 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Fri Jun 16 09:30:28 2023 [DBG: CRequest::freeAttributes Ends]
Fri Jun 16 09:30:28 2023 CRequest::createRequestLine Protocol UDP
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> transportProtocol: 0, isMTLS: 0, m_uStackSecureMtlsPort: 6261, m_uStackSecurePort: 5061, m_uStackUnsecurePort 5060
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> port: 5060
Fri Jun 16 09:30:28 2023 32C3 [CMessage::send] sip_sendMessage (10.205.137.100:5060)
Fri Jun 16 09:30:28 2023 SEND MESSAGE TO NETWORK (10.205.137.100:5060 [UDP]) (BUFF LEN = 543)
----------------------utf8-----------------------
ACK sip:52986@10.205.137.100:5060 SIP/2.0
Contact: <sip:88818@nodeXYZ.aaacccc.ae:5060;transport=UDP>
User-Agent: OmniPCX Enterprise R100.0 n1.291.66.a
To: "sip test" <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=659231684
From: "Techhome" <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748389 ACK
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bK6e6b755571bf245721778829182a0d38
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
1686893428 -> Fri Jun 16 09:30:28 2023 32C3 [CMessage::onSendSuccess]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::onSendSuccess]
Fri Jun 16 09:30:28 2023 2100 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Fri Jun 16 09:30:28 2023 2100 [CTransaction::freeTimerToken] Timer D is freed
Fri Jun 16 09:30:28 2023 2100 [CTransaction::changeState] no transaction state, terminated reason : Request creation
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createAckRequest] successful INVITE is terminated after the ACK is sent
Fri Jun 16 09:30:28 2023 110b[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Fri Jun 16 09:30:28 2023 [receiveAckEvent] continue with session Timer
Fri Jun 16 09:30:28 2023 [exec_ipc] in end 18175.
Fri Jun 16 09:30:28 2023 [ipc_thread] Normal case : evt 10755
Fri Jun 16 09:30:28 2023 [ipc_thread] IPC Thread : Ipc reception 18186.
Fri Jun 16 09:30:28 2023 [ipc_thread] IPC Thread : TCL thread signaled.
Fri Jun 16 09:30:28 2023 [exec_ipc] in 18175.
Fri Jun 16 09:30:28 2023 [display_ipc_in] ------------ Begin ---------------
Fri Jun 16 09:30:28 2023 neqt : 1536 Id : 1
Fri Jun 16 09:30:28 2023 BYE
Fri Jun 16 09:30:28 2023 [display_ipc_in] ------------- End ----------------
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] an event 10755 arrived on the eqt 1536 1.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] seplos station.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
Fri Jun 16 09:30:28 2023 [onIncomingEvent] BYE arrived.
1686893428 -> Fri Jun 16 09:30:28 2023 [receiveByeEvent] Call: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 eqt: 1536 COMPLETED_STATE received an event.
Fri Jun 16 09:30:28 2023 110b [CCall::makeGenericRequest] BYE
Fri Jun 16 09:30:28 2023 110b [CCall::getDialog] Confirmed Dialog found
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createRequest]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::buildServicesForAllRequest]
Fri Jun 16 09:30:28 2023 15c5 [CDialog::createByeRequest]
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] STATE CHANGED TO INITIAL
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] notifying the parent dialog
Fri Jun 16 09:30:28 2023 15c5 [CDialog::onTransactionState(pTrans = 2101, previousState = Terminated, currentState = Initial, reason = None]
Fri Jun 16 09:30:28 2023 32C4 [CRequest::CRequest] Creation of a request
Fri Jun 16 09:30:28 2023 [DBG: CRequest::freeAttributes]
Fri Jun 16 09:30:28 2023 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Fri Jun 16 09:30:28 2023 [DBG: CRequest::freeAttributes Ends]
Fri Jun 16 09:30:28 2023 CRequest::createRequestLine Protocol UDP
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> transportProtocol: 0, isMTLS: 0, m_uStackSecureMtlsPort: 6261, m_uStackSecurePort: 5061, m_uStackUnsecurePort 5060
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> port: 5060
Fri Jun 16 09:30:28 2023 32C4 [CMessage::send] sip_sendMessage (10.205.137.100:5060)
Fri Jun 16 09:30:28 2023 SEND MESSAGE TO NETWORK (10.205.137.100:5060 [UDP]) (BUFF LEN = 496)
----------------------utf8-----------------------
BYE sip:52986@10.205.137.100:5060 SIP/2.0
Supported: replaces,timer,path,100rel
User-Agent: OmniPCX Enterprise R100.0 n1.291.66.a
To: <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=659231684
From: <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748390 BYE
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bK51481a077ed12b01efb3bc491f5da406
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
1686893428 -> Fri Jun 16 09:30:28 2023 32C4 [CMessage::onSendSuccess]
Fri Jun 16 09:30:28 2023 2101 [CTransaction::onSendSuccess] CMessage 32C4 send Success
Fri Jun 16 09:30:28 2023 15c5 [CDialog::onSendSuccess]
Fri Jun 16 09:30:28 2023 2101 [CTransInitialState::createRequest] Transaction changes to Trying state
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] STATE CHANGED TO TRYING
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] notifying the parent dialog
Fri Jun 16 09:30:28 2023 15c5 [CDialog::onTransactionState(pTrans = 2101, previousState = Initial, currentState = Trying, reason = Request creation]
Fri Jun 16 09:30:28 2023 2101 [CTransTryingState::enterInState] Init timers E and F
Fri Jun 16 09:30:28 2023 2101 [CTransaction::startTimer] Timer E is started (delay = 1500 ms)
Fri Jun 16 09:30:28 2023 2101 [CTransaction::startTimer] Timer F is started (delay = 16000 ms)
Fri Jun 16 09:30:28 2023 15c5 [CDialog::addTransaction] added transaction 2101 with branch z9hG4bK51481a077ed12b01efb3bc491f5da406, with CSeq 144748390
Fri Jun 16 09:30:28 2023 [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
Fri Jun 16 09:30:28 2023 110b[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Fri Jun 16 09:30:28 2023 [exec_ipc] in end 18175.
Fri Jun 16 09:30:28 2023 [CTransaction::notifyDialog]
Fri Jun 16 09:30:28 2023 [CTransaction::notifyDialog] notify parent dialog
Fri Jun 16 09:30:28 2023 15c5 [CDialog::onTransactionState(pTrans = 2100, previousState = null, currentState = Terminated, reason = Request creation]
1686893428 -> Fri Jun 16 09:30:28 2023 2100 [~CTransaction] transaction 144748389 INVITE

1686893428 -> Fri Jun 16 09:30:28 2023 RECEIVE MESSAGE FROM NETWORK (10.205.137.100:5060 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.205.224.43;branch=z9hG4bK51481a077ed12b01efb3bc491f5da406
From: <sip:88818@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=8ea4befaef0f15dc7cd0c9092d4c0c23
To: <sip:52986@nodeXYZ.aaacccc.ae:5060;user=phone>;tag=659231684
Call-ID: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43
CSeq: 144748390 BYE
Server: TMX ST2  V1.8.5-958
Content-Length: 0

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

Fri Jun 16 09:30:28 2023 [CIOCom::receiveResponse] CResponse 32CF ref=1
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> transportProtocol: 0, isMTLS: 0, m_uStackSecureMtlsPort: 6261, m_uStackSecurePort: 5061, m_uStackUnsecurePort 5060
Fri Jun 16 09:30:28 2023 [CMngData::getStackPort] >>>>> port: 5060
Fri Jun 16 09:30:28 2023 [CDispatcher::processResponseFromManagerIndex] start at index 0
Fri Jun 16 09:30:28 2023  102 [CCallManager::onIncomingResponse]
Fri Jun 16 09:30:28 2023 110b [CCall::receiveResponse] 200
Fri Jun 16 09:30:28 2023 110b [CCall::getDialog] Confirmed Dialog found
Fri Jun 16 09:30:28 2023 15c5 [CDialog::receiveResponse]
Fri Jun 16 09:30:28 2023 2101 [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] notifying the parent dialog
1686893428 -> Fri Jun 16 09:30:28 2023 15c5 [CDialog::onTransactionState(pTrans = 2101, previousState = Trying, currentState = Completed, reason = Final resp reception]
Fri Jun 16 09:30:28 2023 2101 [CTransaction::freeTimerToken] Timer E is freed
Fri Jun 16 09:30:28 2023 2101 [CTransaction::freeTimerToken] Timer F is freed
Fri Jun 16 09:30:28 2023 2101 [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
Fri Jun 16 09:30:28 2023 [DBG: CSipSdpMessage::Destructor]
Fri Jun 16 09:30:28 2023 [DBG: CSipSdpMessage::Destructor] Ends
Fri Jun 16 09:30:28 2023 110b[CMotorCall::onReceiveResponse] Update2 the Other context.
Fri Jun 16 09:30:28 2023 [CTerminatedState::receiveSuccessfulMessage] Call: c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 eqt: 1536 TERMINATED_STATE received a message.
Fri Jun 16 09:30:28 2023 [CTerminatedState::receiveSuccessfulMessage]  relative request: 2
Fri Jun 16 09:30:28 2023 [CGenericState::getAOCInfo] INFO NULL content !!!
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] content size (lginfo): 656 ccal crypted= 0
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] CAC = 0 eqtCAC = -1 
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Jun 16 09:30:28 2023 110b[emitEventToMonitel] displayIPCMessageOut 
Fri Jun 16 09:30:28 2023 ** SEPLOS **
Fri Jun 16 09:30:28 2023 [sendLgEvtSip] seplos Event sent on eqt : 1536 Id :1
Fri Jun 16 09:30:28 2023 [display_ipc_out] ------------ Begin ---------------
Fri Jun 16 09:30:28 2023 Id : 1
Fri Jun 16 09:30:28 2023 SUCCESSFUL
1686893428 -> Fri Jun 16 09:30:28 2023 xx :        0
Fri Jun 16 09:30:28 2023        RELATIVE REQUEST : BYE
Fri Jun 16 09:30:28 2023 CAC-CSBU info : UNKNOWN
Fri Jun 16 09:30:28 2023 CLIR : 0
Fri Jun 16 09:30:28 2023 COLP : 0
Fri Jun 16 09:30:28 2023 [display_ipc_out] ------------- End ----------------
Fri Jun 16 09:30:28 2023 [ipc_thread] Normal case : evt 10773
Fri Jun 16 09:30:28 2023 [ipc_thread] IPC Thread : Ipc reception 18186.
Fri Jun 16 09:30:28 2023 [ipc_thread] IPC Thread : TCL thread signaled.
Fri Jun 16 09:30:28 2023 [exec_ipc] in 18175.
Fri Jun 16 09:30:28 2023 [display_ipc_in] ------------ Begin ---------------
Fri Jun 16 09:30:28 2023 neqt : 1536 Id : 1
Fri Jun 16 09:30:28 2023 SIP EQT RELEASED
Fri Jun 16 09:30:28 2023 [display_ipc_in] ------------- End ----------------
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 1536 1.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] The call with eqt: 1536 has released its equipment.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
Fri Jun 16 09:30:28 2023 110b[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Fri Jun 16 09:30:28 2023 110b[CMotorCall::unRegister] Remove eqt : 1536 diag : 1 from the map.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::eraseCallwithEqt] erase 1536 1.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onIncomingEvent] killSession.
Fri Jun 16 09:30:28 2023 110b [CCall::killSession]
Fri Jun 16 09:30:28 2023 21fe [CTransaction::changeState] STATE CHANGED TO TERMINATED
1686893429 -> Fri Jun 16 09:30:28 2023 21fe [CTransaction::changeState] no transaction state, terminated reason : None
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Fri Jun 16 09:30:28 2023 2101 [CTransaction::freeTimerToken] Timer K is freed
Fri Jun 16 09:30:28 2023 2101 [CTransaction::changeState] no transaction state, terminated reason : None
Fri Jun 16 09:30:28 2023 15c5 [CDialog::removeSubscriptionTimer]
Fri Jun 16 09:30:28 2023 110b [CCall::killSession] notifying the call manager
Fri Jun 16 09:30:28 2023  102 [CCallManager::onCallClosed]
Fri Jun 16 09:30:28 2023  102 [CCallManager::onCallClosed()] Call 110b closed. Removing call 144658088 from the maps
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onNotifyCallClosed] Call : c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 is closed.
Fri Jun 16 09:30:28 2023 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
Fri Jun 16 09:30:28 2023  102 [CCallManager::onCallClosed] pCall: 110b added in the Garbage List
Fri Jun 16 09:30:28 2023 [exec_ipc] in end 18175.
Fri Jun 16 09:30:29 2023 [CTransaction::notifyDialog]
Fri Jun 16 09:30:29 2023 [CTransaction::notifyDialog] notify parent dialog
Fri Jun 16 09:30:29 2023 15c2 [CDialog::onTransactionState(pTrans = 21fe, previousState = null, currentState = Terminated, reason = None]
Fri Jun 16 09:30:29 2023 15c2 [CDialog::onTransactionState] dialog is terminated
Fri Jun 16 09:30:29 2023 15c2 [CDialog::onTransactionState] onDialogClosed
Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed]
1686893429 -> Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed] not only initial *********
Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed]: the dialog 15c5 is NOT closed
Fri Jun 16 09:30:29 2023 21FE [~CTransaction] transaction 144748389 INVITE
Fri Jun 16 09:30:29 2023 [CResponse::~CResponse]
Fri Jun 16 09:30:29 2023 32CB [~CResponse] resp(180) c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 144748389 INVITE
Fri Jun 16 09:30:29 2023 [CResponse::~CResponse Ends]
Fri Jun 16 09:30:29 2023 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
Fri Jun 16 09:30:29 2023 [CMessage::~CMessage Ends]
Fri Jun 16 09:30:29 2023 [CTransaction::notifyDialog]
Fri Jun 16 09:30:29 2023 [CTransaction::notifyDialog] notify parent dialog
Fri Jun 16 09:30:29 2023 15c5 [CDialog::onTransactionState(pTrans = 2101, previousState = null, currentState = Terminated, reason = None]
Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed]
Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed] not only initial *********
Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed]: the dialog 15c5 is closed
Fri Jun 16 09:30:29 2023 110b [CCall::onDialogClosed] All the dialogs in the Call are closed
Fri Jun 16 09:30:29 2023 2101 [~CTransaction] transaction 144748390 BYE
Fri Jun 16 09:30:29 2023 [CResponse::~CResponse]
Fri Jun 16 09:30:29 2023 32CF [~CResponse] resp(200) c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 144748390 BYE
Fri Jun 16 09:30:29 2023 [CResponse::~CResponse Ends]
Fri Jun 16 09:30:29 2023 [DBG: CMessage::freeAttributes Start Alert freeAttributes !!!!!!!!]:
1686893431 -> Fri Jun 16 09:30:29 2023 [CMessage::~CMessage Ends]
Fri Jun 16 09:30:30 2023 [fnInit] *************************** Init timeout.
Fri Jun 16 09:30:30 2023 [fnInit] treatTimeout.
Fri Jun 16 09:30:30 2023 [CMotorInitTimerContext::treatTimeout] emitRegisterMessage gw=2.
Fri Jun 16 09:30:30 2023 [CMotorInitTimerContext::start] delay =6000 gw 2.
Fri Jun 16 09:30:30 2023      [startRegistration] timer value=6000.
Fri Jun 16 09:30:31 2023  102 [CCallManager::removeGarbage] at index i = 0
Fri Jun 16 09:30:31 2023 110b [CMotorCall::clear_subscription] no subscription managed
Fri Jun 16 09:30:31 2023 110b[CMotorCall::~CMotorCall] Call : c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 is being destructed.
Fri Jun 16 09:30:31 2023 [CMotorCall::getSupervisorKeys] Returning NULL value for supervisor keys
Fri Jun 16 09:30:31 2023 [DBG: CSipSdpMessage::Destructor]
Fri Jun 16 09:30:31 2023 [DBG: CSipSdpMessage::Destructor] Ends
Fri Jun 16 09:30:31 2023 [DBG: CSipSdpMessage::Destructor]
Fri Jun 16 09:30:31 2023 [DBG: CSipSdpMessage::Destructor] Ends
Fri Jun 16 09:30:31 2023 110b [CCall::~CCall] resources number: 26
Fri Jun 16 09:30:31 2023 110b [CCall::TestDegradedModeEnd] resources number: 25
Fri Jun 16 09:30:31 2023 110b [CCall::removeGarbage]
Fri Jun 16 09:30:31 2023 15c5 [CDialog::~CDialog] resources number: 52
Fri Jun 16 09:30:31 2023 15c5 [~CDialog] delete ack request # 0
Fri Jun 16 09:30:31 2023 [CRequest::~CRequest]
Fri Jun 16 09:30:31 2023 32C3 [~CRequest] req c6b928c47f9bc9f20c7e9ecd8a3d97e4@10.205.224.43 144748389 ACK
ether
Member
Posts: 65
Joined: 04 Jul 2011 20:03

Re: OXE send BYE upon answering the call to sip extension.

Post by ether »

As per ALE support Media Attribute (a): rtpmap:97 telephone-event/8000 - payload is required from the receiving SIP client part that is why this communication fails. But these phones were commisioned since 2014. So I doubt this idea from support.

Caller

Code: Select all

Message Body
    Session Description Protocol
        Session Description Protocol Version (v): 0
        Owner/Creator, Session Id (o): OXE 1686912200 1686912200 IN IP4 10.205.224.43
        Session Name (s): abs
        Connection Information (c): IN IP4 10.205.10.155
        Time Description, active time (t): 0 0
        Media Description, name and address (m): audio 32514 RTP/AVP 18 4 97
        Media Attribute (a): sendrecv
        Media Attribute (a): rtpmap:18 G729/8000
        Media Attribute (a): fmtp:18 annexb=no
        Media Attribute (a): ptime:20
        Media Attribute (a): maxptime:40
        Media Attribute (a): rtpmap:4 G723/8000
        Media Attribute (a): ptime:30
        Media Attribute (a): maxptime:30
        Media Attribute (a): rtpmap:97 telephone-event/8000
        [Generated Call-ID: 0b022455411c38769f1543b5a482f0c7@10.205.224.43]
Receiver

Code: Select all

Message Body
    Session Description Protocol
        Session Description Protocol Version (v): 0
        Owner/Creator, Session Id (o): 52986 19649166 27497815 IN IP4 10.205.137.100
        Session Name (s): A conversation
        Connection Information (c): IN IP4 10.205.137.100
        Time Description, active time (t): 0 0
        Media Description, name and address (m): audio 10030 RTP/AVP 18 4
        Media Attribute (a): rtpmap:18 G729/8000
        Media Attribute (a): fmtp:18 annexb=no
        Media Attribute (a): rtpmap:4 G723/8000
        Media Attribute (a): sendrecv
        [Generated Call-ID: 0b022455411c38769f1543b5a482f0c7@10.205.224.43]
ether
Member
Posts: 65
Joined: 04 Jul 2011 20:03

Re: OXE send BYE upon answering the call to sip extension.

Post by ether »

I found the issue. payload mismatch.
Post Reply

Return to “SIP”