No Fax Tone

User avatar
cavagnaro
Alcatel Unleashed Certified Guru
Alcatel Unleashed Certified Guru
Posts: 7000
Joined: 14 Sep 2005 19:45
Location: Brasil, Porto Alegre
Contact:

No Fax Tone

Post by cavagnaro » 26 Nov 2013 16:03

Hi guys,
I'm installing this on a customer and having an issue where I have no Fax Tone. The SIP is coming fine as I can see the port being used on the FaxAdmin monitoring options and can send faxes internally via the web interface.
I have all in G711 (the TG). I have also a GVP working fine here.

OXE: R9.1-i1.605-30-br-c0
FaxServer: 6.6.0.16 (No hotfixes installed)

Here is my compvisu sys

Code: Select all

+====================================================
|                               C O M P V I S U
+====================================================
| Inter-node protocol H323....... yes
| RTP Direct..................... yes
| RTP Direct for H323 terminals.. yes
| Fast Start..................... yes
| VAD (Voice Activity Detection):
|               - G723/G729...... no
|               - G711........... no
| ECE (Echo Canceller)........... yes
|              - INTIP/GA/GD..... 128 ms
| Volume for IP Phone ...........   0dB
| Volume for other device. ......   0dB
| Law (Except Media Gateway)..... A law
| Global compression type ....... G729
| Multi-algorithm (for H323/SIP) .... no
| Compression for INTIP/GD  ..... with
| Compression for IPP ........... with
| Transit on IP Boards ...........yes
| ticket Stat IP................. yes
| IP version..................... IPv4
| Transit compatibility.......... no
| Voip Framing G711 ............. 20 ms
| Voip Framing G723 ............. 30 ms
| Voip Framing G729 ............. 20 ms
| No RBT For Direct RTP H323..... no
| T38 FAX........................ yes
+====================================================
Sample call:

internal Fax number: 103400
OXE IP: 192.168.26.94
FaxServer IP: 192.168.25.59

Code: Select all

1385498602 -> RECEIVE MESSAGE FROM NETWORK (192.168.26.27:5080 [UDP])
----------------------utf8-----------------------
REFER sip:5135740353@core3;transport=UDP SIP/2.0
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164781
To: "5135740353" <sip:5135740353@core3;user=phone>;tag=3b655c58ec19ac1efc2d60b7125882a6
Call-ID: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94
CSeq: 1 REFER
Content-Length: 0
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307084
Contact: <sip:192.168.26.27:5080>
X-Genesys-CallInfo: routed
Refer-To: <sip:103181@192.168.26.94:5060>
Referred-By: sip:103300@192.168.26.27:5080;user=phone
X-Genesys-CallUUID: K8ACDUBPK94KN3ASBMINBN1S28002GEI
Max-Forwards: 70

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

1385498602 -> 6269A [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1385498602 -> [CIOCom::receiveRequest] Received CRequest 6269A ref=1
1385498602 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498602 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498602 -> [CIOCom::receiveRequest] rport1 not empty 
1385498602 -> [CDispatcher::onIncomingRequest()]
1385498602 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1385498602 ->  102 [CCallManager::onIncomingRequest()]
1385498602 -> 1170 [CCall::receiveRequest] REFER
1385498602 -> 1170 [CCall::getDialog] Confirmed Dialog found
1385498602 -> 159a [CDialog::receiveRequest]
1385498602 -> 159a [CDialog::receiveBasicRequest]
1385498602 -> 213c [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498602 -> 213c [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213c, previousState = Terminated, currentState = Initial, reason = None]
1385498602 -> 213c [CTransInitialState::receiveRequest] Transaction changes to Trying state
1385498602 -> 213c [CTransaction::changeState] STATE CHANGED TO TRYING
1385498602 -> 213c [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213c, previousState = Initial, currentState = Trying, reason = Request reception]
1385498602 -> 159a [CDialog::addTransaction] added transaction 213c with branch z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307084, with CSeq 1
1385498602 -> 1170 [CCall::checkAuthentication] REFER
1385498602 -> 1170[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1385498602 -> [CGwMngData::isAuthenticationRequiredForThisClient] 192.168.26.27 .
1385498602 -> [isDomainFromGwExt] Host from request is : 192.168.26.27.
1385498602 -> [isDomainFromGwExt] User from request is : 103300
1385498602 -> isDomainFromGwExt--> GwExt=0
1385498602 -> domain from External Gateway 0.
1385498602 -> [getFromHeader].
1385498602 ->    0[CMotorCall::onReceiveRequest] route already analyzed.
1385498602 -> 1170[CMotorCall::onReceiveRequest] request for gateway.
1385498602 -> 1170[CMotorCall::onReceiveRequest] state = COMPLETED_STATE.
1385498602 -> [CSubscriptionState::receiveReferMessage] Call: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 eqt: 3782 SUBSCRIPTION_STATE received a message.
1385498602 -> [CSubscriptionState::receiveReferMessage] No valid replaces field in the REFER message.
1385498602 -> 1170[emitEventToMonitel] content size (lginfo): 656
1385498602 -> 1170[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498602 -> 1170[emitEventToMonitel] CAC = 0 
1385498602 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498602 -> [display_ipc_out] ------------ Begin ---------------
1385498602 -> Id : -1
1385498602 -> REFER
1385498602 -> 	REFER TO : 103181@192.168.26.94:5060
1385498602 -> 	REFER BY : 103300@192.168.26.27:5080
1385498602 -> 	Neqt : -2 dialogId : -1
1385498602 -> [display_ipc_out] ------------- End ----------------
1385498602 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498602 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498602 -> [exec_ipc] in 1845.
1385498602 -> [display_ipc_in] ------------ Begin ---------------
1385498602 -> neqt : 3782 Id : -1
1385498602 -> SUCCESSFUL
1385498602 -> xx :        2
1385498602 -> 	RELATIVE REQUEST : REFER
1385498602 -> CLIR : 0
1385498602 -> COLP : 0
1385498602 -> [display_ipc_in] ------------- End ----------------
1385498602 -> [CMotorCallManager::onIncomingEvent] an event 10765 arrived on the eqt 3782--1.
1385498602 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1385498602 -> [onIncomingEvent] SUCCESSFUL arrived.
1385498602 -> [onIncomingEvent] relative_request = 10757
1385498602 -> [CSubscriptionState::receiveResponseEvent] Call: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 eqt: 3782 SUBSCRIPTION_STATE received an event.
1385498602 -> [isValidGwExt] ext gw 0 is not valid
1385498602 -> 1170[CMotorCall ABCF ExtGW 
1385498602 -> [isValidGwExt] ext gw 0 is not valid
1385498602 -> 1170[CMotorCall ABCF ExtGW 
1385498602 -> 1170[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498602 -> 1170 [CCall::findFirstServerTrans]
1385498602 -> 159a [CCall::findFirstServerTrans]
1385498602 -> 159a [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
1385498602 -> 1170 [CCall::makeGenericResponse] 202
1385498602 -> 1170 [CCall::getDialog] Confirmed Dialog found
1385498602 -> 159a [CDialog::createResponse] 202
1385498602 -> 213c [CTransTryingState::createResponse] CResponse 62596 ref=1
1385498602 -> 62596 [CMessage::send] sip_sendMessage (192.168.26.27:5080)
1385498602 -> SEND MESSAGE TO NETWORK (192.168.26.27:5080 [UDP]) (BUFF LEN = 581)
----------------------utf8-----------------------
SIP/2.0 202 Accepted
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Contact: sip:core3
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
To: "5135740353" <sip:5135740353@core3;user=phone>;tag=3b655c58ec19ac1efc2d60b7125882a6
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164781
Call-ID: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94
CSeq: 1 REFER
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307084
Content-Length: 0

-------------------------------------------------
1385498602 -> 213c [CTransTryingState::createResponse] Final : Transaction changes to Completed state
1385498602 -> 213c [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498602 -> 213c [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213c, previousState = Trying, currentState = Completed, reason = Final resp creation]
1385498602 -> 213c [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
1385498602 -> 159a [CDialog::updateRouteSet] there are 0 record-route headers
1385498602 ->   b6 [CSubscription::CSubscription]
1385498602 ->   b6 [CSubscription::update] update on response
1385498602 ->   b6 [CSubscription::startSubscriptionTimer]
1385498602 ->   b6 [CSubscription::stopSubscriptionTimer]
1385498602 ->   b6 [CSubscription::startSubscriptionTimer]Start subscription timer 180000
1385498602 -> [exec_ipc] in end 1845.
1385498602 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498602 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498602 -> [exec_ipc] in 1845.
1385498602 -> [display_ipc_in] ------------ Begin ---------------
1385498602 -> neqt : 3782 Id : -1
1385498602 -> NOTIFY
1385498602 -> 	Response : 200
1385498602 -> [display_ipc_in] ------------- End ----------------
1385498602 -> [CMotorCallManager::onIncomingEvent] an event 10758 arrived on the eqt 3782--1.
1385498602 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1385498602 -> [onIncomingEvent] NOTIFY arrived.
1385498602 -> [CSubscriptionState::receiveNotifyEvent] Call: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 eqt: 3782 SUBSCRIPTION_STATE received an event.
1385498602 -> [isValidGwExt] ext gw 0 is not valid
1385498602 -> 1170[CMotorCall ABCF ExtGW 
1385498602 -> 1170[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498602 -> 1170[CMotorCall::emitNotifyMessage] The sip body is: SIP/2.0 200 OK
.
1385498602 -> 1170 [CCall::makeGenericRequest] NOTIFY
1385498602 -> 1170 [CCall::getDialog] Confirmed Dialog found
1385498602 -> 159a [CDialog::createRequest]
1385498602 -> 159a [CDialog::buildServicesForAllRequest]
1385498602 -> 159a [CDialog::createBasicRequest]
1385498602 -> 213d [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498602 -> 213d [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213d, previousState = Terminated, currentState = Initial, reason = None]
1385498602 -> 6269B [CRequest::CRequest] Creation of a request
1385498602 -> 6269B [CMessage::send] sip_sendMessage (192.168.26.27:5080)
1385498602 -> SEND MESSAGE TO NETWORK (192.168.26.27:5080 [UDP]) (BUFF LEN = 608)
----------------------utf8-----------------------
NOTIFY sip:192.168.26.27:5080 SIP/2.0
Content-Type: message/sipfrag
Contact: sip:core3
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
Event: refer
Subscription-State: terminated;reason=noresource
To: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164781
From: <sip:5135740353@core3;user=phone>;tag=3b655c58ec19ac1efc2d60b7125882a6
Call-ID: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94
CSeq: 1656825919 NOTIFY
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bKdd5043cc7fd015c6347ed05cc07a1bbf
Content-Length: 16

SIP/2.0 200 OK
-------------------------------------------------
1385498602 -> 213d [CTransInitialState::createRequest] Transaction changes to Trying state
1385498602 -> 213d [CTransaction::changeState] STATE CHANGED TO TRYING
1385498602 -> 213d [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213d, previousState = Initial, currentState = Trying, reason = Request creation]
1385498602 -> 213d [CTransTryingState::enterInState] Init timers E and F
1385498602 -> 213d [CTransaction::startTimer] Timer E is started (delay = 500 ms)
1385498602 -> 213d [CTransaction::startTimer] Timer F is started (delay = 32000 ms)
1385498602 -> 159a [CDialog::addTransaction] added transaction 213d with branch z9hG4bKdd5043cc7fd015c6347ed05cc07a1bbf, with CSeq 1656825919
1385498602 -> [exec_ipc] in end 1845.
1385498602 -> RECEIVE MESSAGE FROM NETWORK (192.168.26.27:5080 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164781
From: <sip:5135740353@core3;user=phone>;tag=3b655c58ec19ac1efc2d60b7125882a6
Call-ID: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94
CSeq: 1656825919 NOTIFY
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bKdd5043cc7fd015c6347ed05cc07a1bbf;received=192.168.26.94
Contact: <sip:192.168.26.27:5080>
X-Genesys-CallUUID: K8ACDUBPK94KN3ASBMINBN1S28002GEI
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Supported: uui
Content-Length: 0

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

1385498602 -> [CIOCom::receiveResponse] CResponse 62597 ref=1
1385498602 -> [CDispatcher::onIncomingResponse]
1385498602 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1385498602 ->  102 [CCallManager::onIncomingResponse]
1385498602 -> 1170 [CCall::receiveResponse] 200
1385498602 -> 1170 [CCall::receiveResponse]Trying to find the right dialog
1385498602 -> 1170 [CCall::getDialog] Confirmed Dialog found
1385498602 -> 1170 [CCall::receiveResponse]One dialog found
1385498602 -> 159a [CDialog::receiveResponse]
1385498602 -> 213d [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
1385498602 -> 213d [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498602 -> 213d [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213d, previousState = Trying, currentState = Completed, reason = Final resp reception]
1385498602 -> 213d [CTransaction::freeTimerToken] Timer E is freed
1385498602 -> 213d [CTransaction::freeTimerToken] Timer F is freed
1385498602 -> 213d [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
1385498602 ->   b6 [CSubscription::update] update on request
1385498602 ->   b6 [CSubscription::stopSubscriptionTimer]
1385498602 ->   b6 [CSubscription::setSubscriptionState] state = terminated
1385498602 ->   b6 [CSubscription::stopSubscriptionTimer]
1385498602 -> 159a [CDialog::onSubscriptionTerminated] :   b6
1385498602 -> 1170---------------------------------------------------------------------
1385498602 -> 1170[CMotorCall::getOutgoingCall] outgoingCall:1
1385498602 -> 1170[CMotorCall::onSubscriptionTerminated]  end of outgoing subscription.
1385498602 -> 1170---------------------------------------------------------------------
1385498602 -> 1170[CMotorCall::onSubscriptionTerminated] Error!!!!! eqt=3782.-1.
1385498602 ->   b6 [CSubscription::~CSubscription]
1385498602 ->   b6 [CSubscription::stopSubscriptionTimer]
1385498602 -> 1170[CMotorCall::onReceiveResponse] Update1 the Other context.
1385498602 -> [CSubscriptionState::receiveResponseMessage] Call: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 eqt: 3782 SUBSCRIPTION_STATE received a message.
1385498602 -> 1170[emitEventToMonitel] content size (lginfo): 656
1385498602 -> 1170[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498602 -> 1170[emitEventToMonitel] CAC = 0 
1385498602 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498602 -> [display_ipc_out] ------------ Begin ---------------
1385498602 -> Id : -1
1385498602 -> SUCCESSFUL
1385498602 -> xx :        0
1385498602 -> 	RELATIVE REQUEST : NOTIFY
1385498602 -> CLIR : 0
1385498602 -> COLP : 0
1385498602 -> [display_ipc_out] ------------- End ----------------
1385498602 -> RECEIVE MESSAGE FROM NETWORK (192.168.26.27:5080 [UDP])
----------------------utf8-----------------------
BYE sip:5135740353@core3;transport=UDP SIP/2.0
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164781
To: "5135740353" <sip:5135740353@core3;user=phone>;tag=3b655c58ec19ac1efc2d60b7125882a6
Call-ID: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94
CSeq: 2 BYE
Content-Length: 0
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307085
Max-Forwards: 70

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

1385498602 -> 6269C [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1385498602 -> [CIOCom::receiveRequest] Received CRequest 6269C ref=1
1385498602 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498602 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498602 -> [CIOCom::receiveRequest] rport1 not empty 
1385498602 -> [CDispatcher::onIncomingRequest()]
1385498602 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1385498602 ->  102 [CCallManager::onIncomingRequest()]
1385498602 -> 1170 [CCall::receiveRequest] BYE
1385498602 -> 1170 [CCall::getDialog] Confirmed Dialog found
1385498602 -> 159a [CDialog::receiveRequest]
1385498602 -> 159a [CDialog::receiveBasicRequest]
1385498602 -> 213e [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498602 -> 213e [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213e, previousState = Terminated, currentState = Initial, reason = None]
1385498602 -> 213e [CTransInitialState::receiveRequest] Transaction changes to Trying state
1385498602 -> 213e [CTransaction::changeState] STATE CHANGED TO TRYING
1385498602 -> 213e [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213e, previousState = Initial, currentState = Trying, reason = Request reception]
1385498602 -> 159a [CDialog::addTransaction] added transaction 213e with branch z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307085, with CSeq 2
1385498602 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1385498602 -> 1170 [CCall::checkAuthentication] BYE
1385498602 -> 1170[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1385498602 -> 1170[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
1385498602 ->    0[CMotorCall::onReceiveRequest] route already analyzed.
1385498602 -> 1170[CMotorCall::onReceiveRequest] request for gateway.
1385498602 -> 1170[CMotorCall::onReceiveRequest] state = COMPLETED_STATE.
1385498602 -> [receiveByeMessage] Call: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 eqt: 3782 COMPLETED_STATE received a message.
1385498602 -> 1170[emitEventToMonitel] content size (lginfo): 656
1385498602 -> 1170[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498602 -> 1170[emitEventToMonitel] CAC = 0 
1385498602 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498602 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498602 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498602 -> [display_ipc_out] ------------ Begin ---------------
1385498602 -> Id : -1
1385498602 -> BYE
1385498602 -> [display_ipc_out] ------------- End ----------------
1385498602 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498602 -> [exec_ipc] in 1845.
1385498602 -> [display_ipc_in] ------------ Begin ---------------
1385498602 -> neqt : 3782 Id : -1
1385498602 -> SUCCESSFUL
1385498602 -> xx :        0
1385498602 -> 	RELATIVE REQUEST : BYE
1385498602 -> CLIR : 0
1385498602 -> COLP : 0
1385498602 -> [display_ipc_in] ------------- End ----------------
1385498602 -> [CMotorCallManager::onIncomingEvent] an event 10765 arrived on the eqt 3782--1.
1385498602 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1385498602 -> [onIncomingEvent] SUCCESSFUL arrived.
1385498602 -> [onIncomingEvent] relative_request = 10755
1385498602 -> [receiveSuccessfulEvent] Call: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 eqt: 3782 TERMINATED_STATE received an event.
1385498602 -> [isValidGwExt] ext gw 0 is not valid
1385498602 -> 1170[CMotorCall ABCF ExtGW 
1385498602 -> [isValidGwExt] ext gw 0 is not valid
1385498602 -> 1170[CMotorCall ABCF ExtGW 
1385498602 -> 1170[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498602 -> 1170 [CCall::findFirstServerTrans]
1385498602 -> 159a [CCall::findFirstServerTrans]
1385498602 -> 159a [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
1385498602 -> 1170 [CCall::makeGenericResponse] 200
1385498602 -> 1170 [CCall::getDialog] Confirmed Dialog found
1385498602 -> 159a [CDialog::createResponse] 200
1385498602 -> 213e [CTransTryingState::createResponse] CResponse 62598 ref=1
1385498602 -> 62598 [CMessage::send] sip_sendMessage (192.168.26.27:5080)
1385498602 -> SEND MESSAGE TO NETWORK (192.168.26.27:5080 [UDP]) (BUFF LEN = 553)
----------------------utf8-----------------------
SIP/2.0 200 OK
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
To: "5135740353" <sip:5135740353@core3;user=phone>;tag=3b655c58ec19ac1efc2d60b7125882a6
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164781
Call-ID: 81c2b1429ff24692c0327ce606e695ab@192.168.26.94
CSeq: 2 BYE
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307085
Content-Length: 0

-------------------------------------------------
1385498602 -> 213e [CTransTryingState::createResponse] Final : Transaction changes to Completed state
1385498602 -> 213e [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498602 -> 213e [CTransaction::changeState] notifying the parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213e, previousState = Trying, currentState = Completed, reason = Final resp creation]
1385498602 -> 213e [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
1385498602 -> 159a [CDialog::updateRouteSet] there are 0 record-route headers
1385498602 -> [exec_ipc] in end 1845.
1385498602 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498602 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498602 -> [exec_ipc] in 1845.
1385498602 -> [display_ipc_in] ------------ Begin ---------------
1385498602 -> neqt : 3782 Id : -1
1385498602 -> SIP EQT RELEASED
1385498602 -> [display_ipc_in] ------------- End ----------------
1385498602 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 3782--1.
1385498602 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 3782 has released its equipment.
1385498602 -> 1170[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
1385498602 -> 1170[emitEventToMonitel] content size (lginfo): 656
1385498602 -> 1170[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498602 -> 1170[emitEventToMonitel] CAC = 0 
1385498602 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498602 -> [display_ipc_out] ------------ Begin ---------------
1385498602 -> Id : -1
1385498602 -> UNKNOWN MESSAGE
1385498602 -> [display_ipc_out] ------------- End ----------------
1385498602 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1385498602 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498602 -> 1170[CMotorCall::unRegister] Remove eqt : 3782 diag : -1 from the map.
1385498602 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 3782 erased.
1385498602 -> [CMotorCallManager::onIncomingEvent] killSession.
1385498602 -> 1170 [CCall::killSession]
1385498602 -> 2135 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498602 -> 2135 [CTransaction::changeState] no transaction state, terminated reason : None
1385498602 -> 213c [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498602 -> 213c [CTransaction::freeTimerToken] Timer J is freed
1385498602 -> 213c [CTransaction::changeState] no transaction state, terminated reason : None
1385498602 -> 213e [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498602 -> 213e [CTransaction::freeTimerToken] Timer J is freed
1385498602 -> 213e [CTransaction::changeState] no transaction state, terminated reason : None
1385498602 -> 213d [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498602 -> 213d [CTransaction::freeTimerToken] Timer K is freed
1385498602 -> 213d [CTransaction::changeState] no transaction state, terminated reason : None
1385498602 -> 1170 [CCall::onKill Session Call manager close is called]
1385498602 -> 1170 [CCall::killSession] notifying the call manager
1385498602 ->  102 [CCallManager::onCallClosed]
1385498602 ->  102 [CCallManager::onCallClosed()] Call 1170 closed. Removing call 223101992 from the maps
1385498602 -> [CMotorCallManager::onNotifyCallClosed] Call : 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 is closed.
1385498602 -> [CMotorCallManager::onNotifyCallClosed] Call : 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 is closed.
1385498602 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1385498602 -> [CCall::onKill] set callmanager to null
1385498602 -> [exec_ipc] in end 1845.
1385498602 -> [CTransaction::notifyDialog]
1385498602 -> [CTransaction::notifyDialog] notify parent dialog
1385498602 -> 1599 [CDialog::onTransactionState(pTrans = 2135, previousState = null, currentState = Terminated, reason = None]
1385498602 -> 1599 [CDialog::onTransactionState] dialog is terminated
1385498602 -> 1599 [CDialog::onTransactionState] onDialogClosed
1385498602 -> 1170 [CCall::onDialogClosed]
1385498602 -> 1170 [CCall::onDialogClosed] not only initial *********
1385498602 -> 1170 [CCall::onDialogClosed]: the dialog 159a is NOT closed
1385498602 -> 2135 [~CTransaction] transaction 1656825918 INVITE
1385498602 -> 6258F [~CResponse] resp(180) 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1656825918 INVITE
1385498602 -> [CTransaction::notifyDialog]
1385498602 -> [CTransaction::notifyDialog] notify parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213c, previousState = null, currentState = Terminated, reason = None]
1385498602 -> 1170 [CCall::onDialogClosed]
1385498602 -> 1170 [CCall::onDialogClosed] not only initial *********
1385498602 -> 1170 [CCall::onDialogClosed]: the dialog 159a is closed
1385498602 -> 1170 [CCall::onDialogClosed] All the dialogs in the Call are closed
1385498602 -> 213C [~CTransaction] transaction 1 REFER
1385498602 -> 62596 [~CResponse] resp(202) 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1 REFER
1385498602 -> [CTransaction::notifyDialog]
1385498602 -> [CTransaction::notifyDialog] notify parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213e, previousState = null, currentState = Terminated, reason = None]
1385498602 -> 1170 [CCall::onDialogClosed]
1385498602 -> 1170 [CCall::onDialogClosed] This call is already closed
1385498602 -> 213E [~CTransaction] transaction 2 BYE
1385498602 -> [CTransaction::notifyDialog]
1385498602 -> [CTransaction::notifyDialog] notify parent dialog
1385498602 -> 159a [CDialog::onTransactionState(pTrans = 213d, previousState = null, currentState = Terminated, reason = None]
1385498602 -> 1170 [CCall::onDialogClosed]
1385498602 -> 1170 [CCall::onDialogClosed] This call is already closed
1385498602 -> 213D [~CTransaction] transaction 1656825919 NOTIFY
1385498602 -> 62597 [~CResponse] resp(200) 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1656825919 NOTIFY
1385498604 -> Send Logs Failed -1
1385498605 ->  102 [CCallManager::removeGarbage] at index i = 0
1385498605 -> 1170[CMotorCall::~CMotorCall] Call : 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 is being destructed.
1385498605 -> 6269A [~CRequest] req 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1 REFER
1385498605 -> 1170 [CCall::~CCall]
1385498605 -> 1170 [CCall::removeGarbage]
1385498605 -> 159a [CDialog::~CDialog]
1385498605 -> 159a [~CDialog] delete ack request # 0
1385498605 -> 62694 [~CRequest] req 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1656825918 ACK
1385498605 -> 62590 [~CResponse] resp(200) 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1656825918 INVITE
1385498605 -> 1599 [CDialog::~CDialog]
1385498605 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1385498605 -> 62693 [~CRequest] req 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1656825918 INVITE
1385498605 -> 6269B [~CRequest] req 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 1656825919 NOTIFY
1385498605 -> 62598 [~CResponse] resp(200) 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 2 BYE
1385498605 -> 6269C [~CRequest] req 81c2b1429ff24692c0327ce606e695ab@192.168.26.94 2 BYE
1385498605 -> Send Logs Failed -1
1385498606 -> Send Logs Failed -1
1385498607 -> Send Logs Failed -1
1385498610 -> EAu: Block Memory Size: 4011440
1385498610 -> EAu: Dupli window: 0/1 (max: 1)
1385498612 -> Send Logs Failed -1
1385498614 -> Send Logs Failed -1
1385498614 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498614 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498614 -> [exec_ipc] in 1845.
1385498614 -> [display_ipc_in] ------------ Begin ---------------
1385498614 -> neqt : 3782 Id : -1
1385498614 -> INVITE
1385498614 -> REQUEST URI : <> 103400@192.168.25.59:5360 ; user=phone
1385498614 -> FROM : <5130147100> 5130147100@core3:5060 ; user=phone
1385498614 -> TO : <> 103400@192.168.25.59:5360 ; user=phone
1385498614 -> CAC : 0
1385498614 -> neqt CAC : -1
1385498614 -> CLIR : 0
1385498614 -> SDP :
1385498614 ->   ADDRESS : 192.168.26.67 :32724
1385498614 ->   ALGOS :
1385498614 ->     PCMA
1385498614 ->     G729
1385498614 ->     97
1385498614 ->   DIRECTION : SEND & RECEIVE
1385498614 -> 	N_GW_EXT : 1
1385498614 -> [display_ipc_in] ------------- End ----------------
1385498614 -> [CMotorCallManager::onIncomingEvent] an event 10752 arrived on the eqt 3782--1.
1385498614 -> [CMotorCallManager::onIncomingEvent] New Call created.
1385498614 -> [CMotorCallManager::callFactory].
1385498614 -> [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R9.1 i1.605.30 
1385498614 -> [CMotorCallManager::callFactory]=d4c4428.
1385498614 -> [CMotorCallManager::onIncomingEvent] eqt=3782 -1.
1385498614 -> [CMotorCallManager::insertCallwithEqt] CMotorCall 3782 inserted.
1385498614 -> [quoteString] => "5130147100"
1385498614 -> 1172[CMotorCall::inviteBuildFromAssertedId] no P_Asserted_Identity 
1385498614 -> 1172[CMotorCall::setFilterUsedMode] To be traced = 0
1385498614 -> [CMotorCallManager::onIncomingEvent] state = INITIAL_STATE.
1385498614 -> [onIncomingEvent] INVITE arrived.
1385498614 -> [receiveInviteEvent] Call:  eqt: 3782 INITIAL_STATE received an event.
1385498614 -> 1172[CMotorCall::emitInviteMessage] begin.
1385498614 -> [isValidGwExt] ext gw 1 is not valid
1385498614 -> [quoteString] => "5130147100"
1385498614 -> 1172[CMotorCall::inviteBuildFromAssertedId] no P_Asserted_Identity 
1385498614 -> 1172[CMotorCall::emitInviteMessage] From: "5130147100" <sip:5130147100@core3;user=phone>
1385498614 -> 1172[CMotorCall::emitInviteMessage] reqUri :sip:103400@192.168.25.59:5360;user=phone
1385498614 -> 1172[CMotorCall::emitInviteMessage]-->SIP_INFO_allowed=1
1385498614 -> [isValidGwExt] ext gw 1 is not valid
1385498614 -> 1172[CMotorCall ABCF ExtGW 
1385498614 -> [isValidGwExt] ext gw 1 is not valid
1385498614 -> 1172[CMotorCall ABCF ExtGW 
1385498614 -> 1172[CMotorCall::inviteBuildSupportedHeader] Invite directed to external gw : 1
1385498614 -> 1172[CMotorCall::emitInviteMessage] Request Uri : sip:103400@192.168.25.59:5360;user=phone
1385498614 -> 1172[CMotorCall::emitInviteMessage]  To: <sip:103400@192.168.25.59:5360;user=phone>
1385498614 ->  am_I_PCS SCSWorking : NO
1385498614 ->  check_PCSstate 
1385498614 ->  am_I_PCS SCSWorking : NO
1385498614 ->  check_PCSstate stat of PCS  is : -1
1385498614 -> 1172[CMotorCall::inviteBuildContact] begin. crms00137339  
1385498614 -> [137339 - inviteBuildContact] trunk_number=30 extGw =1.
1385498614 -> [137339-InviteBuildContact]  userinfo : 5130147100
1385498614 -> 1172[CMotorCall::inviteBuildContact]  Contact: sip:5130147100@core3
1385498614 -> 1172[CMotorCall::emitInviteMessage] uacGatewayMode=1 uacRefresher=1.
1385498614 -> 1172[CMotorCall::makeRequestSdp] Begin sdp.
1385498614 -> 1172[CMotorCall::makeRequestSdp] Direction: 0.
1385498614 -> 1172[CMotorCall::makeRequestSdp] format 97
1385498614 -> 1172[CMotorCall::makeRequestSdp] Final sdp.
1385498614 -> 1172[CMotorCall::emitInviteMessage] The sdp build.
1385498614 -> 1172[CMotorCall::new_determineTargetsForTheRequest] is not Responsible For This URI.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] isResolution=0.
1385498614 -> [isValidGwExt] ext gw 1 is not valid
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] target is not the local node.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] nb contacts=1.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] *pcszNameToFind : 103400
1385498614 -> [isUserDeclared] 103400@192.168.25.59
1385498614 -> isUserDeclared] NOT found in the dictionnary.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest]-->extGw=1 
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] contact : sip:103400@192.168.25.59:5360;user=phone
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] nb available licenses=59 .
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] license OK.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest]-->pSipAddSpec->getHost()=192.168.25.59 
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] user= 103400
1385498614 -> [CGWMngData::isMainServer] CPU is MAIN.
1385498614 -> [CGWMngData::isMainServer] checkwith PCS = 0
1385498614 ->         [CMotorCall::makeInitialMotorRequest] count = 3.
1385498614 ->         [CMotorCall::makeInitialMotorRequest] service=0 0xbffff0bc.
1385498614 ->         [CMotorCall::makeInitialMotorRequest] service=1 0xbfffed5c.
1385498614 ->         [CMotorCall::makeInitialMotorRequest] service=2 0xbfffe740.
1385498614 -> 1172 [CCall::makeGenericRequest] INVITE
1385498614 -> 1172 [CCall::getDialog] Confirmed Dialog is not found (ID = ;)
1385498614 -> 1172 [CCall::getDialog] Initial Dialog Client not found
1385498614 -> 159d [CDialog::createRequest]
1385498614 -> 159d [CDialog::buildServicesForAllRequest]
1385498614 -> 159d [CDialog::createInviteRequest]
1385498614 -> 213f [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498614 -> 213f [CTransaction::changeState] notifying the parent dialog
1385498614 -> 159d [CDialog::onTransactionState(pTrans = 213f, previousState = Terminated, currentState = Initial, reason = None]
1385498614 -> 6269D [CRequest::CRequest] Creation of a request
1385498614 -> 6269D [CMessage::send] sip_sendMessage (192.168.25.59:5360)
1385498614 -> SEND MESSAGE TO NETWORK (192.168.25.59:5360 [UDP]) (BUFF LEN = 958)
----------------------utf8-----------------------
INVITE sip:103400@192.168.25.59:5360;user=phone SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE, INFO
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
Session-Expires: 1800;refresher=uac
Min-SE: 900
Content-Type: application/sdp
To: <sip:103400@192.168.25.59:5360;user=phone>
From: "5130147100" <sip:5130147100@core3;user=phone>;tag=8b0bf167ae0919a92e49377ac87c1910
Contact: <sip:5130147100@core3;transport=UDP>
Call-ID: 6883c1383b1f15435d275f47d07643a7@192.168.26.94
CSeq: 659835933 INVITE
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK1bbc3293720c9776df0791d914c52923
Max-Forwards: 70
Content-Length: 263

v=0
o=OXE 1385498614 1385498614 IN IP4 192.168.26.94
s=abs
c=IN IP4 192.168.26.67
t=0 0
m=audio 32724 RTP/AVP 8 18 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:97 telephone-event/8000
a=ptime:20
a=maxptime:40
-------------------------------------------------
1385498614 -> 213f [CTransInitialState::createRequest] Transaction changes to Calling state
1385498614 -> 213f [CTransaction::changeState] STATE CHANGED TO CALLING
1385498614 -> 213f [CTransaction::changeState] notifying the parent dialog
1385498614 -> 159d [CDialog::onTransactionState(pTrans = 213f, previousState = Initial, currentState = Calling, reason = Request creation]
1385498614 -> 213f [CTransaction::startTimer] Timer A is started (delay = 500 ms)
1385498614 -> 213f [CTransaction::startTimer] Timer B is started (delay = 8000 ms)
1385498614 -> 159d [CDialog::getTransactionByCSeq] CSeq = 659835933
1385498614 -> 159d [CDialog::addTransaction] added transaction 213f with branch z9hG4bK1bbc3293720c9776df0791d914c52923, with CSeq 659835933
1385498614 -> [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Client, UA)
1385498614 -> [CSessionTimerContext::updateAfterRefreshCreation] Update CSessionTimerContext (refresh creation)
1385498614 -> [CSessionTimerContext::updateSupported] Request timer supported 
1385498614 -> [CSessionTimerContext::updateMinSE] Min-SE updated : 900
1385498614 -> [CSessionTimerContext::updateSessionExpires] header value : 1800
1385498614 -> [CSessionTimerContext::updateSessionExpires] updated
1385498614 -> [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1385498614 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] nb contact=1.
1385498614 -> [CForkedBranch::CForkedBranch] context = 0xd4c4890.
1385498614 -> 1172[CMotorCall::branchAllocation] built branch number=1.
1385498614 -> 1172[CMotorCall::branchAllocation] pForkedBranch = 0xd4c8390.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] reqUri duplication  pForkedBranch = 0xd4c8390.
1385498614 -> 1172[CMotorCall::makeInitialMotorRequest] reqUri duplication2.
1385498614 -> 1172[CMotorCall::getOutgoingCall] outgoingCall:1
1385498614 -> 1172 [CCall::getCallDuplicationData]
1385498614 -> [CViaSetSerializer::copy] Added via 7c30 at index 0
1385498614 -> 1172 [CCall::getCallDuplicationData] : Request URI = sip:103400@192.168.25.59:5360;user=phone, Call ID = 6883c1383b1f15435d275f47d07643a7@192.168.26.94, Local URI = sip:5130147100@core3;user=phone, Local Tag = 8b0bf167ae0919a92e49377ac87c1910, Remote URI = sip:103400@192.168.25.59:5360;user=phone, Remote Tag = , Local CSeq = 659835933, Remote CSeq = 0 
1385498614 -> [CViaSetSerializer::serialize] Serialized via set : ViaSerialize=Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK1bbc3293720c9776df0791d914c52923
1385498614 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498614 -> [onIncomingEvent] CallID must be inserted.
1385498614 -> [onIncomingEvent] CallID inserted.
1385498614 -> [exec_ipc] in end 1845.
1385498614 -> RECEIVE MESSAGE FROM NETWORK (192.168.25.59:5360 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK1bbc3293720c9776df0791d914c52923
From: "5130147100" <sip:5130147100@core3;user=phone>;tag=8b0bf167ae0919a92e49377ac87c1910
To: <sip:103400@192.168.25.59:5360;user=phone>
Call-ID: 6883c1383b1f15435d275f47d07643a7@192.168.26.94
CSeq: 659835933 INVITE
Allow: INVITE, ACK, BYE, CANCEL
Contact: <sip:103400@192.168.25.59:5360;user=phone>
Server: Alcatel-Lucent OmniTouch Fax Software/6.6.0.16
Content-Length: 0

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

1385498614 -> [CIOCom::receiveResponse] CResponse 62599 ref=1
1385498614 -> [CDispatcher::onIncomingResponse]
1385498614 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1385498614 ->  102 [CCallManager::onIncomingResponse]
1385498614 -> 1172 [CCall::receiveResponse] 100
1385498614 -> 1172 [CCall::receiveResponse]Trying to find the right dialog
1385498614 -> 1172 [CCall::getDialog] Confirmed Dialog is not found (ID = 8b0bf167ae0919a92e49377ac87c1910;)
1385498614 -> 1172 [CCall::getDialog] Returning Initial Dialog Client
1385498614 -> 1172 [CCall::receiveResponse]One dialog found
1385498614 -> 159d [CDialog::receiveResponse]
1385498614 -> 213f [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
1385498614 -> 213f [CTransaction::changeState] STATE CHANGED TO PROCEEDING
1385498614 -> 213f [CTransaction::changeState] notifying the parent dialog
1385498614 -> 159d [CDialog::onTransactionState(pTrans = 213f, previousState = Calling, currentState = Proceeding, reason = 1xx response reception]
1385498614 -> 213f [CTransaction::freeTimerToken] Timer A is freed
1385498614 -> 213f [CTransaction::freeTimerToken] Timer B is freed
1385498614 -> 1172[CMotorCall::searchForkedBranch]pForkedBranch=0xd4c8390.
1385498614 -> [receiveInformationalMessage] Call: 6883c1383b1f15435d275f47d07643a7@192.168.26.94 eqt: 3782 PROCEEDING_STATE received a message.
1385498614 -> RECEIVE MESSAGE FROM NETWORK (192.168.25.59:5360 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK1bbc3293720c9776df0791d914c52923
From: "5130147100" <sip:5130147100@core3;user=phone>;tag=8b0bf167ae0919a92e49377ac87c1910
To: <sip:103400@192.168.25.59:5360;user=phone>;tag=C9D461C4C698
Call-ID: 6883c1383b1f15435d275f47d07643a7@192.168.26.94
CSeq: 659835933 INVITE
Allow: INVITE, ACK, BYE, CANCEL
Contact: <sip:103400@192.168.25.59:5360;user=phone>
Server: Alcatel-Lucent OmniTouch Fax Software/6.6.0.16
Content-Type: application/sdp
Content-Length: 162

v=0
o=XMedius-Fax-Gateway 72148022 22 IN IP4 192.168.25.59
s=abs
c=IN IP4 192.168.25.59
t=0 0
m=audio 62904 RTP/AVP 8 101
a=sendrecv
a=rtpmap:8 PCMA/8000
-------------------------------------------------

1385498614 -> [CIOCom::receiveResponse] CResponse 6259A ref=1
1385498614 -> [CDispatcher::onIncomingResponse]
1385498614 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1385498614 ->  102 [CCallManager::onIncomingResponse]
1385498614 -> 1172 [CCall::receiveResponse] 200
1385498614 -> 1172 [CCall::receiveResponse]Trying to find the right dialog
1385498614 -> 1172 [CCall::getDialog] Confirmed Dialog is not found (ID = 8b0bf167ae0919a92e49377ac87c1910;C9D461C4C698)
1385498614 -> 1172 [CCall::getDialog] Returning Initial Dialog Client
1385498614 -> 1172 [CCall::receiveResponse]One dialog found
1385498614 -> 159d [CDialog::receiveResponse]
1385498614 -> 159d [CDialog::receiveResponse] create a CONFIRMED dialog
1385498614 -> 159e [CDialog::CDialog] look for the transaction #0, transaction key = z9hG4bK1bbc3293720c9776df0791d914c52923
1385498614 -> 159e [CDialog::CDialog] copy the transaction #0, transaction key = z9hG4bK1bbc3293720c9776df0791d914c52923
1385498614 -> 2140 [CTransaction::CTransaction] Transaction is cloned in 4 state
1385498614 -> 159e [CDialog::addTransaction] added transaction 2140 with branch z9hG4bK1bbc3293720c9776df0791d914c52923, with CSeq 659835933
1385498614 -> 159e [CDialog::startDialogTTL]
1385498614 -> 159e [CDialog::receiveResponse]
1385498614 -> 2140 [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
1385498614 -> 2140 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498614 -> 2140 [CTransaction::changeState] notifying the parent dialog
1385498614 -> 159e [CDialog::onTransactionState(pTrans = 2140, previousState = Proceeding, currentState = Completed, reason = Final resp reception]
1385498614 -> 2140 [CTransaction::startTimer] Timer D is started (delay = 32305 ms)
1385498614 -> [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from response (Client, UA)
1385498614 -> [CSessionTimerContext::updateAfterRefreshCreation] Update CSessionTimerContext (refresh creation)
1385498614 -> [CSessionTimerContext::updateSupported] Request timer supported 
1385498614 -> [CSessionTimerContext::updateMinSE] Min-SE updated : 900
1385498614 -> [CSessionTimerContext::updateSessionExpires] header value : 1800
1385498614 -> [CSessionTimerContext::updateSessionExpires] updated
1385498614 -> [CSessionTimerContext::updateSessionExpires] Refresher updated : i
1385498614 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1385498614 -> [CSessionTimerContext::updateAfterResponseRefreshReception] Update CSessionTimerContext (response refresh reception)
1385498614 -> [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
1385498614 -> [CSessionTimerContext::startTimers] Start session timer expiration : 1800000
1385498614 -> [CSessionTimerContext::startTimers] Start session timer will expires : 900000
1385498614 -> [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=INVITE
1385498614 -> 159e [CDialog::updateRouteSet] there are 0 record-route headers
1385498614 -> 1172 [CCall::insertInDialogMap] added dialog #159e with the key 8b0bf167ae0919a92e49377ac87c1910;C9D461C4C698

1385498614 -> 159d [CDialog::getTransactionByCSeq] CSeq = 659835934
1385498614 -> 159d [CDialog::updateRouteSet] there are 0 record-route headers
1385498614 -> 1172[CMotorCall::searchForkedBranch]pForkedBranch=0xd4c8390.
1385498614 ->         [CForkedBranch::setFinalResponse] pResponse=0xd4bd5c8.
1385498614 ->         [CForkedBranch::setFinalResponse] response=200.
1385498614 -> 1172[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
1385498614 -> 1172[CMotorCall::chooseBestResponse] pForkedBranch=0xd4c8390 iResponseCode=2000.
1385498614 ->         [CForkedBranch::getResponseCode] response=200.
1385498614 ->         [CForkedBranch::getResponseCode] response=200.
1385498614 -> 1172[CMotorCall::chooseBestResponse] last iResponseCode=200.
1385498614 ->         [CForkedBranch::setFinalResponse] pResponse=0xd4bd5c8.
1385498614 -> 1172[CMotorCall::chooseBestResponse] next branch.
1385498614 -> 1172[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
1385498614 -> [receiveSuccessfulMessage] Call: 6883c1383b1f15435d275f47d07643a7@192.168.26.94 eqt: 3782 PROCEEDING_STATE received a message.
1385498614 -> 1172[CMotorCall::analyseSessionTimer] exit with  uacGatewayMode=1 uacRefresher=1.
1385498614 -> [checkSdpValidity] Sdp contains 1 media description(s).
1385498614 -> [checkSdpValidity] Media 0 type 1 contains 2 formats.
1385498614 -> [checkSdpValidity] Format : 8.
1385498614 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1385498614 -> [convertSdpIntoTsdp] default T38 config.
1385498614 -> [convertSdpIntoTsdp] No Direction in the session part.
1385498614 -> [convertSdpIntoTsdp] Check the direction in Session part - result:0.
1385498614 -> [convertSdpIntoTsdp] The audio media contains  2 format(s).
1385498614 -> [convertSdpIntoTsdp] Format 0 is 8.
1385498614 -> [convertSdpIntoTsdp] Format 1 is 101.
1385498614 -> [convertSdpIntoTsdp] Get the direction.
1385498614 -> [convertSdpIntoTsdp] Direction is sendrecv.
1385498614 -> [convertSdpIntoTsdp] The connection is at session level.
1385498614 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 192.168.25.59.
1385498614 -> [convertIPStrIntoTuipv] 192.168.25.59 => 192.168.25.59
1385498614 -> [methodAllowedByDistant] INFO not allowed by distant !!
1385498614 -> 1172[emitEventToMonitel] content size (lginfo): 656
1385498614 -> 1172[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498614 -> 1172[emitEventToMonitel] CAC = 0 
1385498614 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498614 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498614 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498614 -> [display_ipc_out] ------------ Begin ---------------
1385498614 -> Id : -1
1385498614 -> SUCCESSFUL
1385498614 -> xx :        0
1385498614 -> 	RELATIVE REQUEST : INVITE
1385498614 -> CLIR : 0
1385498614 -> COLP : 0
1385498614 -> SDP :
1385498614 ->   ADDRESS : 192.168.25.59 :62904
1385498614 ->   ALGOS :
1385498614 ->     PCMA
1385498614 ->   DIRECTION : SEND & RECEIVE
1385498614 -> [display_ipc_out] ------------- End ----------------
1385498614 -> [receiveSuccessfulMessage] SRV_OK received update FROM TAG on the StandBy.
1385498614 -> 1172 [CCall::getCallDuplicationData]
1385498614 -> 1172 [CCall::getCallDuplicationData] : Request URI = , Call ID = 6883c1383b1f15435d275f47d07643a7@192.168.26.94, Local URI = sip:5130147100@core3;user=phone, Local Tag = 8b0bf167ae0919a92e49377ac87c1910, Remote URI = sip:103400@192.168.25.59:5360;user=phone, Remote Tag = C9D461C4C698, Local CSeq = 659835933, Remote CSeq = 0 
1385498614 -> [CViaSetSerializer::serialize] Serialized via set : 
1385498614 -> [CRouteSet::serialize] Serialized route set : Contact=sip:103400@192.168.25.59:5360;user=phone
1385498614 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498614 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498614 -> 1172[CMotorCall::getOutgoingCall] outgoingCall:1
1385498614 -> 1172[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
1385498614 -> 1172[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
1385498614 ->         [CForkedBranch::getResponseCode] response=200.
1385498614 ->         [CForkedBranch::getResponseCode] response=200.
1385498614 -> [exec_ipc] in 1845.
1385498614 -> [display_ipc_in] ------------ Begin ---------------
1385498614 -> neqt : 3782 Id : -1
1385498614 -> ACK
1385498614 -> [display_ipc_in] ------------- End ----------------
1385498614 -> [CMotorCallManager::onIncomingEvent] an event 10754 arrived on the eqt 3782--1.
1385498614 -> [CMotorCallManager::onIncomingEvent] state = ACCEPTED_STATE.
1385498614 -> [onIncomingEvent] ACK arrived.
1385498614 -> [receiveAckEvent] Call: 6883c1383b1f15435d275f47d07643a7@192.168.26.94 eqt: 3782 ACCEPTED_STATE received an event.
1385498614 -> 1172[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498614 -> 1172[CMotorCall::emitAckMessage] begin.
1385498614 -> 1172[CMotorCall::emitAckMessage] SDP ok.
1385498614 -> 1172 [CCall::makeGenericRequest] ACK
1385498614 -> 1172 [CCall::getDialog] Confirmed Dialog found
1385498614 -> 159e [CDialog::createRequest]
1385498614 -> 159e [CDialog::buildServicesForAllRequest]
1385498614 -> 159e [CDialog::createAckRequest]
1385498614 -> 159e [CDialog::createAckRequest], previous trans 2140 is found
1385498614 -> 159e [CDialog::createAckRequest], previous trans 2140 is client
1385498614 -> 6269E [CRequest::CRequest] Creation of a request
1385498614 -> 159e [CDialog::buildServicesForAck]
1385498614 -> 6269E [CMessage::send] sip_sendMessage (192.168.25.59:5360)
1385498614 -> SEND MESSAGE TO NETWORK (192.168.25.59:5360 [UDP]) (BUFF LEN = 473)
----------------------utf8-----------------------
ACK sip:103400@192.168.25.59:5360;user=phone SIP/2.0
Contact: sip:core3
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
To: <sip:103400@192.168.25.59:5360;user=phone>;tag=C9D461C4C698
From: "5130147100" <sip:5130147100@core3;user=phone>;tag=8b0bf167ae0919a92e49377ac87c1910
Call-ID: 6883c1383b1f15435d275f47d07643a7@192.168.26.94
CSeq: 659835933 ACK
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK6aaa8869d43e070ea11c41597e301ca2
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
1385498614 -> 2140 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498614 -> 2140 [CTransaction::freeTimerToken] Timer D is freed
1385498614 -> 2140 [CTransaction::changeState] no transaction state, terminated reason : Request creation
1385498614 -> 159e [CDialog::createAckRequest] successful INVITE is terminated after the ACK is sent
1385498614 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498614 -> 1172 [CCall::getCallDuplicationData]
1385498614 -> 1172 [CCall::getCallDuplicationData] : Request URI = , Call ID = 6883c1383b1f15435d275f47d07643a7@192.168.26.94, Local URI = sip:5130147100@core3;user=phone, Local Tag = 8b0bf167ae0919a92e49377ac87c1910, Remote URI = sip:103400@192.168.25.59:5360;user=phone, Remote Tag = C9D461C4C698, Local CSeq = 659835933, Remote CSeq = 0 
1385498614 -> [CViaSetSerializer::serialize] Serialized via set : 
1385498614 -> [CRouteSet::serialize] Serialized route set : Contact=sip:103400@192.168.25.59:5360;user=phone
1385498614 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498614 -> [exec_ipc] in end 1845.
1385498614 -> [CTransaction::notifyDialog]
1385498614 -> [CTransaction::notifyDialog] notify parent dialog
1385498614 -> 159e [CDialog::onTransactionState(pTrans = 2140, previousState = null, currentState = Terminated, reason = Request creation]
1385498614 -> 2140 [~CTransaction] transaction 659835933 INVITE
1385498614 -> Send Logs Failed -1
1385498615 -> Send Logs Failed -1
1385498615 -> Send Logs Failed -1
1385498617 -> Send Logs Failed -1
1385498617 -> RECEIVE MESSAGE FROM NETWORK (192.168.26.27:5080 [UDP])
----------------------utf8-----------------------
REFER sip:5198254509@core3;transport=UDP SIP/2.0
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164783
To: "5198254509" <sip:5198254509@core3;user=phone>;tag=d21b3c0310d50657c9a78d48d0262163
Call-ID: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94
CSeq: 1 REFER
Content-Length: 0
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307086
Contact: <sip:192.168.26.27:5080>
X-Genesys-CallInfo: routed
Refer-To: <sip:103181@192.168.26.94:5060>
Referred-By: sip:103300@192.168.26.27:5080;user=phone
X-Genesys-CallUUID: K8ACDUBPK94KN3ASBMINBN1S28002GEJ
Max-Forwards: 70

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

1385498617 -> 6269F [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1385498617 -> [CIOCom::receiveRequest] Received CRequest 6269F ref=1
1385498617 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498617 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498617 -> [CIOCom::receiveRequest] rport1 not empty 
1385498617 -> [CDispatcher::onIncomingRequest()]
1385498617 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1385498617 ->  102 [CCallManager::onIncomingRequest()]
1385498617 -> 1171 [CCall::receiveRequest] REFER
1385498617 -> 1171 [CCall::getDialog] Confirmed Dialog found
1385498617 -> 159c [CDialog::receiveRequest]
1385498617 -> 159c [CDialog::receiveBasicRequest]
1385498617 -> 2141 [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498617 -> 2141 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2141, previousState = Terminated, currentState = Initial, reason = None]
1385498617 -> 2141 [CTransInitialState::receiveRequest] Transaction changes to Trying state
1385498617 -> 2141 [CTransaction::changeState] STATE CHANGED TO TRYING
1385498617 -> 2141 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2141, previousState = Initial, currentState = Trying, reason = Request reception]
1385498617 -> 159c [CDialog::addTransaction] added transaction 2141 with branch z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307086, with CSeq 1
1385498617 -> 1171 [CCall::checkAuthentication] REFER
1385498617 -> 1171[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1385498617 -> [CGwMngData::isAuthenticationRequiredForThisClient] 192.168.26.27 .
1385498617 -> [isDomainFromGwExt] Host from request is : 192.168.26.27.
1385498617 -> [isDomainFromGwExt] User from request is : 103300
1385498617 -> isDomainFromGwExt--> GwExt=0
1385498617 -> domain from External Gateway 0.
1385498617 -> [getFromHeader].
1385498617 ->    0[CMotorCall::onReceiveRequest] route already analyzed.
1385498617 -> 1171[CMotorCall::onReceiveRequest] request for gateway.
1385498617 -> 1171[CMotorCall::onReceiveRequest] state = COMPLETED_STATE.
1385498617 -> [CSubscriptionState::receiveReferMessage] Call: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 eqt: 3783 SUBSCRIPTION_STATE received a message.
1385498617 -> [CSubscriptionState::receiveReferMessage] No valid replaces field in the REFER message.
1385498617 -> 1171[emitEventToMonitel] content size (lginfo): 656
1385498617 -> 1171[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498617 -> 1171[emitEventToMonitel] CAC = 0 
1385498617 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498617 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498617 -> [sendLgEvtSip] Event sent on eqt : 3783 Id :-1
1385498617 -> [display_ipc_out] ------------ Begin ---------------
1385498617 -> Id : -1
1385498617 -> REFER
1385498617 -> 	REFER TO : 103181@192.168.26.94:5060
1385498617 -> 	REFER BY : 103300@192.168.26.27:5080
1385498617 -> 	Neqt : -2 dialogId : -1
1385498617 -> [display_ipc_out] ------------- End ----------------
1385498617 -> [exec_ipc] in 1845.
1385498617 -> [display_ipc_in] ------------ Begin ---------------
1385498617 -> neqt : 3783 Id : -1
1385498617 -> SUCCESSFUL
1385498617 -> xx :        2
1385498617 -> 	RELATIVE REQUEST : REFER
1385498617 -> CLIR : 0
1385498617 -> COLP : 0
1385498617 -> [display_ipc_in] ------------- End ----------------
1385498617 -> [CMotorCallManager::onIncomingEvent] an event 10765 arrived on the eqt 3783--1.
1385498617 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1385498617 -> [onIncomingEvent] SUCCESSFUL arrived.
1385498617 -> [onIncomingEvent] relative_request = 10757
1385498617 -> [CSubscriptionState::receiveResponseEvent] Call: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 eqt: 3783 SUBSCRIPTION_STATE received an event.
1385498617 -> [isValidGwExt] ext gw 0 is not valid
1385498617 -> 1171[CMotorCall ABCF ExtGW 
1385498617 -> [isValidGwExt] ext gw 0 is not valid
1385498617 -> 1171[CMotorCall ABCF ExtGW 
1385498617 -> 1171[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498617 -> 1171 [CCall::findFirstServerTrans]
1385498617 -> 159c [CCall::findFirstServerTrans]
1385498617 -> 159c [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
1385498617 -> 1171 [CCall::makeGenericResponse] 202
1385498617 -> 1171 [CCall::getDialog] Confirmed Dialog found
1385498617 -> 159c [CDialog::createResponse] 202
1385498617 -> 2141 [CTransTryingState::createResponse] CResponse 6259B ref=1
1385498617 -> 6259B [CMessage::send] sip_sendMessage (192.168.26.27:5080)
1385498617 -> SEND MESSAGE TO NETWORK (192.168.26.27:5080 [UDP]) (BUFF LEN = 581)
----------------------utf8-----------------------
SIP/2.0 202 Accepted
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Contact: sip:core3
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
To: "5198254509" <sip:5198254509@core3;user=phone>;tag=d21b3c0310d50657c9a78d48d0262163
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164783
Call-ID: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94
CSeq: 1 REFER
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307086
Content-Length: 0

-------------------------------------------------
1385498617 -> 2141 [CTransTryingState::createResponse] Final : Transaction changes to Completed state
1385498617 -> 2141 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498617 -> 2141 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2141, previousState = Trying, currentState = Completed, reason = Final resp creation]
1385498617 -> 2141 [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
1385498617 -> 159c [CDialog::updateRouteSet] there are 0 record-route headers
1385498617 ->   b7 [CSubscription::CSubscription]
1385498617 ->   b7 [CSubscription::update] update on response
1385498617 ->   b7 [CSubscription::startSubscriptionTimer]
1385498617 ->   b7 [CSubscription::stopSubscriptionTimer]
1385498617 ->   b7 [CSubscription::startSubscriptionTimer]Start subscription timer 180000
1385498617 -> [exec_ipc] in end 1845.
1385498617 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498617 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498617 -> [exec_ipc] in 1845.
1385498617 -> [display_ipc_in] ------------ Begin ---------------
1385498617 -> neqt : 3783 Id : -1
1385498617 -> NOTIFY
1385498617 -> 	Response : 200
1385498617 -> [display_ipc_in] ------------- End ----------------
1385498617 -> [CMotorCallManager::onIncomingEvent] an event 10758 arrived on the eqt 3783--1.
1385498617 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1385498617 -> [onIncomingEvent] NOTIFY arrived.
1385498617 -> [CSubscriptionState::receiveNotifyEvent] Call: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 eqt: 3783 SUBSCRIPTION_STATE received an event.
1385498617 -> [isValidGwExt] ext gw 0 is not valid
1385498617 -> 1171[CMotorCall ABCF ExtGW 
1385498617 -> 1171[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498617 -> 1171[CMotorCall::emitNotifyMessage] The sip body is: SIP/2.0 200 OK
.
1385498617 -> 1171 [CCall::makeGenericRequest] NOTIFY
1385498617 -> 1171 [CCall::getDialog] Confirmed Dialog found
1385498617 -> 159c [CDialog::createRequest]
1385498617 -> 159c [CDialog::buildServicesForAllRequest]
1385498617 -> 159c [CDialog::createBasicRequest]
1385498617 -> 2142 [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498617 -> 2142 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2142, previousState = Terminated, currentState = Initial, reason = None]
1385498617 -> 626A0 [CRequest::CRequest] Creation of a request
1385498617 -> 626A0 [CMessage::send] sip_sendMessage (192.168.26.27:5080)
1385498617 -> SEND MESSAGE TO NETWORK (192.168.26.27:5080 [UDP]) (BUFF LEN = 608)
----------------------utf8-----------------------
NOTIFY sip:192.168.26.27:5080 SIP/2.0
Content-Type: message/sipfrag
Contact: sip:core3
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
Event: refer
Subscription-State: terminated;reason=noresource
To: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164783
From: <sip:5198254509@core3;user=phone>;tag=d21b3c0310d50657c9a78d48d0262163
Call-ID: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94
CSeq: 1627600488 NOTIFY
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK1ec80c740ef8172019a46253158250a1
Content-Length: 16

SIP/2.0 200 OK
-------------------------------------------------
1385498617 -> 2142 [CTransInitialState::createRequest] Transaction changes to Trying state
1385498617 -> 2142 [CTransaction::changeState] STATE CHANGED TO TRYING
1385498617 -> 2142 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2142, previousState = Initial, currentState = Trying, reason = Request creation]
1385498617 -> 2142 [CTransTryingState::enterInState] Init timers E and F
1385498617 -> 2142 [CTransaction::startTimer] Timer E is started (delay = 500 ms)
1385498617 -> 2142 [CTransaction::startTimer] Timer F is started (delay = 32000 ms)
1385498617 -> 159c [CDialog::addTransaction] added transaction 2142 with branch z9hG4bK1ec80c740ef8172019a46253158250a1, with CSeq 1627600488
1385498617 -> [exec_ipc] in end 1845.
1385498617 -> RECEIVE MESSAGE FROM NETWORK (192.168.26.27:5080 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
To: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164783
From: <sip:5198254509@core3;user=phone>;tag=d21b3c0310d50657c9a78d48d0262163
Call-ID: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94
CSeq: 1627600488 NOTIFY
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK1ec80c740ef8172019a46253158250a1;received=192.168.26.94
Contact: <sip:192.168.26.27:5080>
X-Genesys-CallUUID: K8ACDUBPK94KN3ASBMINBN1S28002GEJ
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Supported: uui
Content-Length: 0

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

1385498617 -> [CIOCom::receiveResponse] CResponse 6259C ref=1
1385498617 -> [CDispatcher::onIncomingResponse]
1385498617 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1385498617 ->  102 [CCallManager::onIncomingResponse]
1385498617 -> 1171 [CCall::receiveResponse] 200
1385498617 -> 1171 [CCall::receiveResponse]Trying to find the right dialog
1385498617 -> 1171 [CCall::getDialog] Confirmed Dialog found
1385498617 -> 1171 [CCall::receiveResponse]One dialog found
1385498617 -> 159c [CDialog::receiveResponse]
1385498617 -> 2142 [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
1385498617 -> 2142 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498617 -> 2142 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2142, previousState = Trying, currentState = Completed, reason = Final resp reception]
1385498617 -> 2142 [CTransaction::freeTimerToken] Timer E is freed
1385498617 -> 2142 [CTransaction::freeTimerToken] Timer F is freed
1385498617 -> 2142 [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
1385498617 ->   b7 [CSubscription::update] update on request
1385498617 ->   b7 [CSubscription::stopSubscriptionTimer]
1385498617 ->   b7 [CSubscription::setSubscriptionState] state = terminated
1385498617 ->   b7 [CSubscription::stopSubscriptionTimer]
1385498617 -> 159c [CDialog::onSubscriptionTerminated] :   b7
1385498617 -> 1171---------------------------------------------------------------------
1385498617 -> 1171[CMotorCall::getOutgoingCall] outgoingCall:1
1385498617 -> 1171[CMotorCall::onSubscriptionTerminated]  end of outgoing subscription.
1385498617 -> 1171---------------------------------------------------------------------
1385498617 -> 1171[CMotorCall::onSubscriptionTerminated] Error!!!!! eqt=3783.-1.
1385498617 ->   b7 [CSubscription::~CSubscription]
1385498617 ->   b7 [CSubscription::stopSubscriptionTimer]
1385498617 -> 1171[CMotorCall::onReceiveResponse] Update1 the Other context.
1385498617 -> [CSubscriptionState::receiveResponseMessage] Call: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 eqt: 3783 SUBSCRIPTION_STATE received a message.
1385498617 -> 1171[emitEventToMonitel] content size (lginfo): 656
1385498617 -> 1171[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498617 -> 1171[emitEventToMonitel] CAC = 0 
1385498617 -> [sendLgEvtSip] Event sent on eqt : 3783 Id :-1
1385498617 -> [display_ipc_out] ------------ Begin ---------------
1385498617 -> Id : -1
1385498617 -> SUCCESSFUL
1385498617 -> xx :        0
1385498617 -> 	RELATIVE REQUEST : NOTIFY
1385498617 -> CLIR : 0
1385498617 -> COLP : 0
1385498617 -> [display_ipc_out] ------------- End ----------------
1385498617 -> RECEIVE MESSAGE FROM NETWORK (192.168.26.27:5080 [UDP])
----------------------utf8-----------------------
BYE sip:5198254509@core3;transport=UDP SIP/2.0
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164783
To: "5198254509" <sip:5198254509@core3;user=phone>;tag=d21b3c0310d50657c9a78d48d0262163
Call-ID: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94
CSeq: 2 BYE
Content-Length: 0
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307087
Max-Forwards: 70

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

1385498617 -> 626A1 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1385498617 -> [CIOCom::receiveRequest] Received CRequest 626A1 ref=1
1385498617 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498617 -> [CIOCom::checkHostInBlackList] host=192.168.26.27
1385498617 -> [CIOCom::receiveRequest] rport1 not empty 
1385498617 -> [CDispatcher::onIncomingRequest()]
1385498617 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1385498617 ->  102 [CCallManager::onIncomingRequest()]
1385498617 -> 1171 [CCall::receiveRequest] BYE
1385498617 -> 1171 [CCall::getDialog] Confirmed Dialog found
1385498617 -> 159c [CDialog::receiveRequest]
1385498617 -> 159c [CDialog::receiveBasicRequest]
1385498617 -> 2143 [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498617 -> 2143 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2143, previousState = Terminated, currentState = Initial, reason = None]
1385498617 -> 2143 [CTransInitialState::receiveRequest] Transaction changes to Trying state
1385498617 -> 2143 [CTransaction::changeState] STATE CHANGED TO TRYING
1385498617 -> 2143 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2143, previousState = Initial, currentState = Trying, reason = Request reception]
1385498617 -> 159c [CDialog::addTransaction] added transaction 2143 with branch z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307087, with CSeq 2
1385498617 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1385498617 -> 1171 [CCall::checkAuthentication] BYE
1385498617 -> 1171[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1385498617 -> 1171[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
1385498617 ->    0[CMotorCall::onReceiveRequest] route already analyzed.
1385498617 -> 1171[CMotorCall::onReceiveRequest] request for gateway.
1385498617 -> 1171[CMotorCall::onReceiveRequest] state = COMPLETED_STATE.
1385498617 -> [receiveByeMessage] Call: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 eqt: 3783 COMPLETED_STATE received a message.
1385498617 -> 1171[emitEventToMonitel] content size (lginfo): 656
1385498617 -> 1171[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498617 -> 1171[emitEventToMonitel] CAC = 0 
1385498617 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498617 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498617 -> [sendLgEvtSip] Event sent on eqt : 3783 Id :-1
1385498617 -> [display_ipc_out] ------------ Begin ---------------
1385498617 -> Id : -1
1385498617 -> BYE
1385498617 -> [display_ipc_out] ------------- End ----------------
1385498617 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498617 -> [exec_ipc] in 1845.
1385498617 -> [display_ipc_in] ------------ Begin ---------------
1385498617 -> neqt : 3783 Id : -1
1385498617 -> SUCCESSFUL
1385498617 -> xx :        0
1385498617 -> 	RELATIVE REQUEST : BYE
1385498617 -> CLIR : 0
1385498617 -> COLP : 0
1385498617 -> [display_ipc_in] ------------- End ----------------
1385498617 -> [CMotorCallManager::onIncomingEvent] an event 10765 arrived on the eqt 3783--1.
1385498617 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1385498617 -> [onIncomingEvent] SUCCESSFUL arrived.
1385498617 -> [onIncomingEvent] relative_request = 10755
1385498617 -> [receiveSuccessfulEvent] Call: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 eqt: 3783 TERMINATED_STATE received an event.
1385498617 -> [isValidGwExt] ext gw 0 is not valid
1385498617 -> 1171[CMotorCall ABCF ExtGW 
1385498617 -> [isValidGwExt] ext gw 0 is not valid
1385498617 -> 1171[CMotorCall ABCF ExtGW 
1385498617 -> 1171[CMotorCall::inviteBuildContact]  Contact: sip:core3
1385498617 -> 1171 [CCall::findFirstServerTrans]
1385498617 -> 159c [CCall::findFirstServerTrans]
1385498617 -> 159c [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
1385498617 -> 1171 [CCall::makeGenericResponse] 200
1385498617 -> 1171 [CCall::getDialog] Confirmed Dialog found
1385498617 -> 159c [CDialog::createResponse] 200
1385498617 -> 2143 [CTransTryingState::createResponse] CResponse 6259D ref=1
1385498617 -> 6259D [CMessage::send] sip_sendMessage (192.168.26.27:5080)
1385498617 -> SEND MESSAGE TO NETWORK (192.168.26.27:5080 [UDP]) (BUFF LEN = 553)
----------------------utf8-----------------------
SIP/2.0 200 OK
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
To: "5198254509" <sip:5198254509@core3;user=phone>;tag=d21b3c0310d50657c9a78d48d0262163
From: <sip:103300@192.168.26.27:5080;user=phone>;tag=DBD72CB2-BC1E-42ED-8129-43B604C0BFFA-164783
Call-ID: a9e9534dc445ad6c2eba506992d5137e@192.168.26.94
CSeq: 2 BYE
Via: SIP/2.0/UDP 192.168.26.27:5080;branch=z9hG4bKC06D0828-0127-4A7E-9743-E0B72F236504-307087
Content-Length: 0

-------------------------------------------------
1385498617 -> 2143 [CTransTryingState::createResponse] Final : Transaction changes to Completed state
1385498617 -> 2143 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498617 -> 2143 [CTransaction::changeState] notifying the parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2143, previousState = Trying, currentState = Completed, reason = Final resp creation]
1385498617 -> 2143 [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
1385498617 -> 159c [CDialog::updateRouteSet] there are 0 record-route headers
1385498617 -> [exec_ipc] in end 1845.
1385498617 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498617 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498617 -> [exec_ipc] in 1845.
1385498617 -> [display_ipc_in] ------------ Begin ---------------
1385498617 -> neqt : 3783 Id : -1
1385498617 -> SIP EQT RELEASED
1385498617 -> [display_ipc_in] ------------- End ----------------
1385498617 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 3783--1.
1385498617 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 3783 has released its equipment.
1385498617 -> 1171[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
1385498617 -> 1171[emitEventToMonitel] content size (lginfo): 656
1385498617 -> 1171[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498617 -> 1171[emitEventToMonitel] CAC = 0 
1385498617 -> [sendLgEvtSip] Event sent on eqt : 3783 Id :-1
1385498617 -> [display_ipc_out] ------------ Begin ---------------
1385498617 -> Id : -1
1385498617 -> UNKNOWN MESSAGE
1385498617 -> [display_ipc_out] ------------- End ----------------
1385498617 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1385498617 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498617 -> 1171[CMotorCall::unRegister] Remove eqt : 3783 diag : -1 from the map.
1385498617 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 3783 erased.
1385498617 -> [CMotorCallManager::onIncomingEvent] killSession.
1385498617 -> 1171 [CCall::killSession]
1385498617 -> 213a [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498617 -> 213a [CTransaction::changeState] no transaction state, terminated reason : None
1385498617 -> 2143 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498617 -> 2143 [CTransaction::freeTimerToken] Timer J is freed
1385498617 -> 2143 [CTransaction::changeState] no transaction state, terminated reason : None
1385498617 -> 2142 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498617 -> 2142 [CTransaction::freeTimerToken] Timer K is freed
1385498617 -> 2142 [CTransaction::changeState] no transaction state, terminated reason : None
1385498617 -> 2141 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498617 -> 2141 [CTransaction::freeTimerToken] Timer J is freed
1385498617 -> 2141 [CTransaction::changeState] no transaction state, terminated reason : None
1385498617 -> 1171 [CCall::onKill Session Call manager close is called]
1385498617 -> 1171 [CCall::killSession] notifying the call manager
1385498617 ->  102 [CCallManager::onCallClosed]
1385498617 ->  102 [CCallManager::onCallClosed()] Call 1171 closed. Removing call 222971032 from the maps
1385498617 -> [CMotorCallManager::onNotifyCallClosed] Call : a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 is closed.
1385498617 -> [CMotorCallManager::onNotifyCallClosed] Call : a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 is closed.
1385498617 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1385498617 -> [CCall::onKill] set callmanager to null
1385498617 -> [exec_ipc] in end 1845.
1385498617 -> [CTransaction::notifyDialog]
1385498617 -> [CTransaction::notifyDialog] notify parent dialog
1385498617 -> 159b [CDialog::onTransactionState(pTrans = 213a, previousState = null, currentState = Terminated, reason = None]
1385498617 -> 159b [CDialog::onTransactionState] dialog is terminated
1385498617 -> 159b [CDialog::onTransactionState] onDialogClosed
1385498617 -> 1171 [CCall::onDialogClosed]
1385498617 -> 1171 [CCall::onDialogClosed] not only initial *********
1385498617 -> 1171 [CCall::onDialogClosed]: the dialog 159c is NOT closed
1385498617 -> 213A [~CTransaction] transaction 1627600487 INVITE
1385498617 -> 62594 [~CResponse] resp(180) a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1627600487 INVITE
1385498617 -> [CTransaction::notifyDialog]
1385498617 -> [CTransaction::notifyDialog] notify parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2143, previousState = null, currentState = Terminated, reason = None]
1385498617 -> 1171 [CCall::onDialogClosed]
1385498617 -> 1171 [CCall::onDialogClosed] not only initial *********
1385498617 -> 1171 [CCall::onDialogClosed]: the dialog 159c is closed
1385498617 -> 1171 [CCall::onDialogClosed] All the dialogs in the Call are closed
1385498617 -> 2143 [~CTransaction] transaction 2 BYE
1385498617 -> [CTransaction::notifyDialog]
1385498617 -> [CTransaction::notifyDialog] notify parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2142, previousState = null, currentState = Terminated, reason = None]
1385498617 -> 1171 [CCall::onDialogClosed]
1385498617 -> 1171 [CCall::onDialogClosed] This call is already closed
1385498617 -> 2142 [~CTransaction] transaction 1627600488 NOTIFY
1385498617 -> 6259C [~CResponse] resp(200) a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1627600488 NOTIFY
1385498617 -> [CTransaction::notifyDialog]
1385498617 -> [CTransaction::notifyDialog] notify parent dialog
1385498617 -> 159c [CDialog::onTransactionState(pTrans = 2141, previousState = null, currentState = Terminated, reason = None]
1385498617 -> 1171 [CCall::onDialogClosed]
1385498617 -> 1171 [CCall::onDialogClosed] This call is already closed
1385498617 -> 2141 [~CTransaction] transaction 1 REFER
1385498617 -> 6259B [~CResponse] resp(202) a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1 REFER
1385498618 -> Send Logs Failed -1
1385498618 -> DLLINK : no msg be ack last_ack=1147 ack=1145 do not send NACK
1385498619 -> Send Logs Failed -1
1385498619 -> Send Logs Failed -1
1385498620 ->  102 [CCallManager::removeGarbage] at index i = 0
1385498620 -> 1171[CMotorCall::~CMotorCall] Call : a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 is being destructed.
1385498620 -> 6269F [~CRequest] req a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1 REFER
1385498620 -> 1171 [CCall::~CCall]
1385498620 -> 1171 [CCall::removeGarbage]
1385498620 -> 159c [CDialog::~CDialog]
1385498620 -> 159c [~CDialog] delete ack request # 0
1385498620 -> 62699 [~CRequest] req a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1627600487 ACK
1385498620 -> 62595 [~CResponse] resp(200) a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1627600487 INVITE
1385498620 -> 159b [CDialog::~CDialog]
1385498620 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1385498620 -> 62698 [~CRequest] req a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1627600487 INVITE
1385498620 -> 626A0 [~CRequest] req a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 1627600488 NOTIFY
1385498620 -> 6259D [~CResponse] resp(200) a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 2 BYE
1385498620 -> 626A1 [~CRequest] req a9e9534dc445ad6c2eba506992d5137e@192.168.26.94 2 BYE
1385498620 -> Send Logs Failed -1
1385498621 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498621 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498621 -> [exec_ipc] in 1845.
1385498621 -> [display_ipc_in] ------------ Begin ---------------
1385498621 -> neqt : 3782 Id : -1
1385498621 -> BYE
1385498621 -> [display_ipc_in] ------------- End ----------------
1385498621 -> [CMotorCallManager::onIncomingEvent] an event 10755 arrived on the eqt 3782--1.
1385498621 -> [CMotorCallManager::onIncomingEvent] state = COMPLETED_STATE.
1385498621 -> [onIncomingEvent] BYE arrived.
1385498621 -> [receiveByeEvent] Call: 6883c1383b1f15435d275f47d07643a7@192.168.26.94 eqt: 3782 COMPLETED_STATE received an event.
1385498621 -> [isValidGwExt] ext gw 1 is not valid
1385498621 -> 1172[CMotorCall ABCF ExtGW 
1385498621 -> 1172 [CCall::makeGenericRequest] BYE
1385498621 -> 1172 [CCall::getDialog] Confirmed Dialog found
1385498621 -> 159e [CDialog::createRequest]
1385498621 -> 159e [CDialog::buildServicesForAllRequest]
1385498621 -> 159e [CDialog::createByeRequest]
1385498621 -> 2144 [CTransaction::changeState] STATE CHANGED TO INITIAL
1385498621 -> 2144 [CTransaction::changeState] notifying the parent dialog
1385498621 -> 159e [CDialog::onTransactionState(pTrans = 2144, previousState = Terminated, currentState = Initial, reason = None]
1385498621 -> 626A2 [CRequest::CRequest] Creation of a request
1385498621 -> 626A2 [CMessage::send] sip_sendMessage (192.168.25.59:5360)
1385498621 -> SEND MESSAGE TO NETWORK (192.168.25.59:5360 [UDP]) (BUFF LEN = 474)
----------------------utf8-----------------------
BYE sip:103400@192.168.25.59:5360;user=phone SIP/2.0
Supported: replaces,timer,100rel
User-Agent: OmniPCX Enterprise R9.1 i1.605.30
To: <sip:103400@192.168.25.59:5360;user=phone>;tag=C9D461C4C698
From: <sip:5130147100@core3;user=phone>;tag=8b0bf167ae0919a92e49377ac87c1910
Call-ID: 6883c1383b1f15435d275f47d07643a7@192.168.26.94
CSeq: 659835934 BYE
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK16464216c35a205a265e5d42f8830148
Max-Forwards: 70
Content-Length: 0

-------------------------------------------------
1385498621 -> 2144 [CTransInitialState::createRequest] Transaction changes to Trying state
1385498621 -> 2144 [CTransaction::changeState] STATE CHANGED TO TRYING
1385498621 -> 2144 [CTransaction::changeState] notifying the parent dialog
1385498621 -> 159e [CDialog::onTransactionState(pTrans = 2144, previousState = Initial, currentState = Trying, reason = Request creation]
1385498621 -> 2144 [CTransTryingState::enterInState] Init timers E and F
1385498621 -> 2144 [CTransaction::startTimer] Timer E is started (delay = 500 ms)
1385498621 -> 2144 [CTransaction::startTimer] Timer F is started (delay = 32000 ms)
1385498621 -> 159e [CDialog::addTransaction] added transaction 2144 with branch z9hG4bK16464216c35a205a265e5d42f8830148, with CSeq 659835934
1385498621 -> [CSessionTimerContext::~CSessionTimerContext] Free CSessionTimerContext
1385498621 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498621 -> [exec_ipc] in end 1845.
1385498621 -> RECEIVE MESSAGE FROM NETWORK (192.168.25.59:5360 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.26.94;branch=z9hG4bK16464216c35a205a265e5d42f8830148
From: <sip:5130147100@core3;user=phone>;tag=8b0bf167ae0919a92e49377ac87c1910
To: <sip:103400@192.168.25.59:5360;user=phone>;tag=C9D461C4C698
Call-ID: 6883c1383b1f15435d275f47d07643a7@192.168.26.94
CSeq: 659835934 BYE
Allow: INVITE, ACK, BYE, CANCEL
Contact: <sip:103400@192.168.25.59:5360;user=phone>
Server: Alcatel-Lucent OmniTouch Fax Software/6.6.0.16
Content-Length: 0

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

1385498621 -> [CIOCom::receiveResponse] CResponse 6259E ref=1
1385498621 -> [CDispatcher::onIncomingResponse]
1385498621 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1385498621 ->  102 [CCallManager::onIncomingResponse]
1385498621 -> 1172 [CCall::receiveResponse] 200
1385498621 -> 1172 [CCall::receiveResponse]Trying to find the right dialog
1385498621 -> 1172 [CCall::getDialog] Confirmed Dialog found
1385498621 -> 1172 [CCall::receiveResponse]One dialog found
1385498621 -> 159e [CDialog::receiveResponse]
1385498621 -> 2144 [CTransTryingState::receiveResponse] Final : Transaction changes to Completed state
1385498621 -> 2144 [CTransaction::changeState] STATE CHANGED TO COMPLETED
1385498621 -> 2144 [CTransaction::changeState] notifying the parent dialog
1385498621 -> 159e [CDialog::onTransactionState(pTrans = 2144, previousState = Trying, currentState = Completed, reason = Final resp reception]
1385498621 -> 2144 [CTransaction::freeTimerToken] Timer E is freed
1385498621 -> 2144 [CTransaction::freeTimerToken] Timer F is freed
1385498621 -> 2144 [CTransaction::startTimer] Timer K is started (delay = 5000 ms)
1385498621 -> 1172[CMotorCall::onReceiveResponse] Update2 the Other context.
1385498621 -> [receiveSuccessfulMessage] Call: 6883c1383b1f15435d275f47d07643a7@192.168.26.94 eqt: 3782 TERMINATED_STATE received a message.
1385498621 -> 1172[emitEventToMonitel] content size (lginfo): 656
1385498621 -> 1172[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498621 -> 1172[emitEventToMonitel] CAC = 0 
1385498621 -> [ipc_thread] IPC Thread : Ipc reception 1846.
1385498621 -> [ipc_thread] IPC Thread : TCL thread signaled.
1385498621 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498621 -> [display_ipc_out] ------------ Begin ---------------
1385498621 -> Id : -1
1385498621 -> SUCCESSFUL
1385498621 -> xx :        0
1385498621 -> 	RELATIVE REQUEST : BYE
1385498621 -> CLIR : 0
1385498621 -> COLP : 0
1385498621 -> [display_ipc_out] ------------- End ----------------
1385498621 -> [exec_ipc] in 1845.
1385498621 -> [display_ipc_in] ------------ Begin ---------------
1385498621 -> neqt : 3782 Id : -1
1385498621 -> SIP EQT RELEASED
1385498621 -> [display_ipc_in] ------------- End ----------------
1385498621 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 3782--1.
1385498621 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 3782 has released its equipment.
1385498621 -> 1172[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
1385498621 -> 1172[emitEventToMonitel] content size (lginfo): 656
1385498621 -> 1172[emitEventToMonitel] CAC = 0 eqtCAC = -1 
1385498621 -> 1172[emitEventToMonitel] CAC = 0 
1385498621 -> [sendLgEvtSip] Event sent on eqt : 3782 Id :-1
1385498621 -> [display_ipc_out] ------------ Begin ---------------
1385498621 -> Id : -1
1385498621 -> UNKNOWN MESSAGE
1385498621 -> [display_ipc_out] ------------- End ----------------
1385498621 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1385498621 -> SendToSipgwCpuSec: Message sent to the STAND-BY CPU
1385498621 -> 1172[CMotorCall::unRegister] Remove eqt : 3782 diag : -1 from the map.
1385498621 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 3782 erased.
1385498621 -> [CMotorCallManager::onIncomingEvent] killSession.
1385498621 -> 1172 [CCall::killSession]
1385498621 -> 213f [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498621 -> 213f [CTransaction::changeState] no transaction state, terminated reason : None
1385498621 -> 2144 [CTransaction::changeState] STATE CHANGED TO TERMINATED
1385498621 -> 2144 [CTransaction::freeTimerToken] Timer K is freed
1385498621 -> 2144 [CTransaction::changeState] no transaction state, terminated reason : None
1385498621 -> 1172 [CCall::onKill Session Call manager close is called]
1385498621 -> 1172 [CCall::killSession] notifying the call manager
1385498621 ->  102 [CCallManager::onCallClosed]
1385498621 ->  102 [CCallManager::onCallClosed()] Call 1172 closed. Removing call 223101992 from the maps
1385498621 -> [CMotorCallManager::onNotifyCallClosed] Call : 6883c1383b1f15435d275f47d07643a7@192.168.26.94 is closed.
1385498621 -> [CMotorCallManager::onNotifyCallClosed] Call : 6883c1383b1f15435d275f47d07643a7@192.168.26.94 is closed.
1385498621 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt
Ext. GW:

Code: Select all

┌─Consult/Modify: External Gateways────────────────────────────────────────────┐
│                                                                              │
│             Node Number (reserved) : 1                                       │
│                Instance (reserved) : 1                                       │
│                           Instance : 1                                       │
│                                                                              │
│                       Gateway Name : FaxServer_ICS                           │
│                      Remote domain : 192.168.25.59                           │
│                     PCS IP address : --------------------------------------- │
│                        Port number : 5360                                    │
│                     Transport type + UDP                                     │
│                  Belonging  domain : --------------------------------------- │
│                    Registration Id : --------------------------------------- │
│      Registration ID in P_Asserted + False                                   │
│                 Registration timer : 0                                       │
│                     Outbound Proxy : --------------------------------------- │
│                  Supervision timer : 0                                       │
│                 Trunk group number : 30                                      │
│                        Pool Number : -1                                      │
│                     Outgoing realm : --------------------------------------- │
│                  Outgoing username : --------------------------------------- │
│                                                                              │
│                  Outgoing Password : ----------                              │
│                            Confirm : ----------                              │
│                                                                              │
│                  Incoming username : --------------------------------------- │
│                                                                              │
│                  Incoming Password : ----------                              │
│                            Confirm : ----------                              │
│                                                                              │
│  RFC 3325 supported by the distant + False                                   │
│                           DNS type + DNS A                                   │
│               First DNS IP Address : --------------------------------------- │
│              Second DNS IP Address : --------------------------------------- │
│                         SDP in 18x + False                                   │
│      Minimal authentication method + None                                    │
│   INFO method for remote extension + False                                   │
│         Send only trunk group algo + False                                   │
│                             To EMS + False                                   │
│                Routing Application + False                                   │
│         Ignore inactive/black hole + False                                   │
│      Dynamic Payload type for dtmf : 97                                      │
│         100 REL for Outbound Calls + Supported                               │
│         100 REL for Incoming Calls + Not Requested                           │
│                                                                              │
└──────────────────────────────────────────────────────────────────────────────┘
Thanks
Ignorance is not the problem, the problem is the one who doesn't want to learn

OTUC/ICS ACFE/ACSE R3.0/4.0/5.0/6.0
Certified Genesys CIV 8.5
Certified Genesys Troubleshooting 8.5
Certified Genesys BEP 8.x
Genesys Developer

haroun
Member
Posts: 899
Joined: 29 Mar 2010 11:09

Re: No Fax Tone

Post by haroun » 27 Nov 2013 04:54

same release oxe as you have with patch 38
Alcatel-Lucent - Alcatel-Lucent OmniTouch Fax Server Application 6.5.6.26
fro external gateway sip upd port is 5061 at oxe side
at ofs side
5360 should be for localsip tcp
and 5061 is for local sip udp port
also you have invalid external gatway may be dns ip aderesses is missing in your config
other thing the unique difference with my compvisu is
Multi-algorithm (for H323/SIP) .... no is set to yes
may be it helps

haroun
Member
Posts: 899
Joined: 29 Mar 2010 11:09

Re: No Fax Tone

Post by haroun » 27 Nov 2013 04:59

sorry
exgatway
sdp in 180 is set to true

User avatar
cavagnaro
Alcatel Unleashed Certified Guru
Alcatel Unleashed Certified Guru
Posts: 7000
Joined: 14 Sep 2005 19:45
Location: Brasil, Porto Alegre
Contact:

Re: No Fax Tone

Post by cavagnaro » 27 Nov 2013 10:18

Hi,
Don't understand all your answers but thanks.
I enabled the SDP in 180 and still same issue.
This is a new install, so default port is 5360 on FaxServer.

I also see that invalid gw error message, but no clue why...it works fine however.
What do you mean about DNS? Where? On OXE?

Will check the Multi-algorith, however I see only PCMA being used...which is ok
Ignorance is not the problem, the problem is the one who doesn't want to learn

OTUC/ICS ACFE/ACSE R3.0/4.0/5.0/6.0
Certified Genesys CIV 8.5
Certified Genesys Troubleshooting 8.5
Certified Genesys BEP 8.x
Genesys Developer

haroun
Member
Posts: 899
Joined: 29 Mar 2010 11:09

Re: No Fax Tone

Post by haroun » 28 Nov 2013 05:55

yes on the external gateway parameter you have dns a
but no dns ip

haroun
Member
Posts: 899
Joined: 29 Mar 2010 11:09

Re: No Fax Tone

Post by haroun » 28 Nov 2013 06:03

stonge but for me the port is 5061
You do not have the required permissions to view the files attached to this post.

jasic
Member
Posts: 140
Joined: 14 Oct 2005 09:18

Re: No Fax Tone

Post by jasic » 28 Nov 2013 08:18

Did you call from a IP Phone? In that case you don't get a fax tone.
Your from device is @core3 so I mean you need a DNS to resolve that name.

Port 5360 is ok and is used be new installations 5061 was the old one.
But it's only the port and if the configurations is done one both site for this port it doesn't matter.

User avatar
cavagnaro
Alcatel Unleashed Certified Guru
Alcatel Unleashed Certified Guru
Posts: 7000
Joined: 14 Sep 2005 19:45
Location: Brasil, Porto Alegre
Contact:

Re: No Fax Tone

Post by cavagnaro » 28 Nov 2013 08:26

Ahh ok. Got the DNS issue...yeah, will check it.
No I was calling from PSTN.

Yes, Haroun, your port is 5061 because you did an old installation and then an upgrade. Old port is used, no problem. Only on new fresh installations port is 5361 or 5360 (with or without security)

Thanks! Will check the DNS
Ignorance is not the problem, the problem is the one who doesn't want to learn

OTUC/ICS ACFE/ACSE R3.0/4.0/5.0/6.0
Certified Genesys CIV 8.5
Certified Genesys Troubleshooting 8.5
Certified Genesys BEP 8.x
Genesys Developer

haroun
Member
Posts: 899
Joined: 29 Mar 2010 11:09

Re: No Fax Tone

Post by haroun » 28 Nov 2013 09:17

have u the CheckSystemLinux.sh? very helpfull tool for check ofs Installation and ready to use or note

User avatar
cavagnaro
Alcatel Unleashed Certified Guru
Alcatel Unleashed Certified Guru
Posts: 7000
Joined: 14 Sep 2005 19:45
Location: Brasil, Porto Alegre
Contact:

Re: No Fax Tone

Post by cavagnaro » 28 Nov 2013 09:28

Solved. Adding the core3 ip address on the hosts file of the FaxServer did the trick.
Have to do it for spatial redundancy now but now I know where to attack.

Thanks guys!
Ignorance is not the problem, the problem is the one who doesn't want to learn

OTUC/ICS ACFE/ACSE R3.0/4.0/5.0/6.0
Certified Genesys CIV 8.5
Certified Genesys Troubleshooting 8.5
Certified Genesys BEP 8.x
Genesys Developer

Post Reply

Return to “OmniTouch 8450 Fax Software”