trunk SIP OXE-XIVO

[bwen]

I progress.. no more 404 error but now SIP/2.0 480 Temporarily not available

[cavagnaro]

And magic balls are out of service yet...so logs, what you did, some info

Enviado de meu E6633 usando Tapatalk

[bwen]

thanks for the command O big Guru Cavagnaro here is the log:

Code: Select all

----------------------utf8-----------------------
INVITE sip:2299@XXX.XXX.XXX.XXX:5060 SIP/2.0
Via: SIP/2.0/UDP XXX.XXX.XX.XX:5060;branch=z9hG4bK7788bb82
Max-Forwards: 70
From: "jean-marc " <sip:667@XXX.XXX.XX.XX>;tag=as50d36879
To: <sip:2299@XXX.XXX.XXX.XXX:5060>
Contact: <sip:667@XXX.XXX.XX.XX:5060>
Call-ID: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX
CSeq: 102 INVITE
User-Agent: XIVO PBX
Date: Thu, 29 Sep 2016 13:59:06 GMT
Session-Expires: 1800
Min-SE: 300
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Remote-Party-ID: "jean-marc " <sip:667@XXX.XXX.XX.XX>;party=calling;privacy=off;screen=no
Content-Type: application/sdp
Content-Length: 317

v=0
o=root 418981995 418981995 IN IP4 XXX.XXX.XX.XX
s=Asterisk PBX 13.9.1
c=IN IP4 XXX.XXX.XX.XX
t=0 0
m=audio 13060 RTP/AVP 8 0 4 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:4 G723/8000
a=fmtp:4 annexa=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
-------------------------------------------------

Thu Sep 29 15:59:06 2016  [CIOCom::receiveRequest] optimisation value 1
Thu Sep 29 15:59:06 2016  [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => XXX.XXX.XXX.XXX node000000
Thu Sep 29 15:59:06 2016  [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Thu Sep 29 15:59:06 2016 9E5DD [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1475157546 -> Thu Sep 29 15:59:06 2016 [CIOCom::receiveRequest] Received CRequest 9E5DD ref=1
Thu Sep 29 15:59:06 2016 [CIOCom::receiveRequest] rport1 not empty
Thu Sep 29 15:59:06 2016 [CDispatcher::onIncomingRequest()]
Thu Sep 29 15:59:06 2016 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Thu Sep 29 15:59:06 2016  102 [CCallManager::onIncomingRequest()]
Thu Sep 29 15:59:06 2016  102 [CCallManager::onIncomingRequest()] creates a new Call if this request doesn't refer to any old call
Thu Sep 29 15:59:06 2016 [CMotorCallManager::callFactory] For call : 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX.
Thu Sep 29 15:59:06 2016 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX Enterprise R10.0 j1.410.49.a
Thu Sep 29 15:59:06 2016 [CMotorCallManager::callFactory]=8508f18.
Thu Sep 29 15:59:06 2016 11c3 [CCall::receiveRequest] INVITE
Thu Sep 29 15:59:06 2016 11c3 [CCall::getDialog] Confirmed Dialog is not found (ID = ;as50d36879)
Thu Sep 29 15:59:06 2016 11c3 [CCall::getDialog] Initial Dialog Server not found
Thu Sep 29 15:59:06 2016 1525 [CDialog::receiveRequest]
Thu Sep 29 15:59:06 2016 1525 [CDialog::receiveInviteRequest]
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] STATE CHANGED TO INITIAL
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] notifying the parent dialog
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState(pTrans = 2105, previousState = Terminated, currentState = Initial, reason = None]
Thu Sep 29 15:59:06 2016 2105 [CTransInitialState::receiveRequest] Transaction changes to Proceeding state
1475157546 -> Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] STATE CHANGED TO PROCEEDING
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] notifying the parent dialog
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState(pTrans = 2105, previousState = Initial, currentState = Proceeding, reason = Request reception]
Thu Sep 29 15:59:06 2016 B7FBD [CResponse::CResponse] Creation of a response
Thu Sep 29 15:59:06 2016 2105 [CTransProceedingState::createResponse] CResponse B7FBD ref=1
Thu Sep 29 15:59:06 2016 B7FBD [CResponse::create] RESPONSE CREATION
Thu Sep 29 15:59:06 2016 B7FBD [CResponse::checkStatusLine] Create StatusLine from code given as parameter
Thu Sep 29 15:59:06 2016 B7FBD [CResponse::createViaHeaders] Copy Via headers from previous request (number : 1)
Thu Sep 29 15:59:06 2016 9E5DD [CMessage::getHeaderAtIndexFromSipMessage(Timestamp, 0)] sip_getHeaderAtIndex FAILED => HSS ERROR No exist
Thu Sep 29 15:59:06 2016 B7FBD [CResponse::create] Initialize context (Local = To & Remote = From)
Thu Sep 29 15:59:06 2016 B7FBD [CMessage::send] sip_sendMessage (XXX.XXX.XX.XX:5060)
Thu Sep 29 15:59:06 2016 SEND MESSAGE TO NETWORK (XXX.XXX.XX.XX:5060 [UDP]) (BUFF LEN = 273)
----------------------utf8-----------------------
SIP/2.0 100 Trying
To: <sip:2299@XXX.XXX.XXX.XXX:5060>
From: "jean-marc " <sip:667@XXX.XXX.XX.XX>;tag=as50d36879
Call-ID: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX
CSeq: 102 INVITE
Via: SIP/2.0/UDP XXX.XXX.XX.XX:5060;branch=z9hG4bK7788bb82
Content-Length: 0

-------------------------------------------------
1475157546 -> Thu Sep 29 15:59:06 2016 [sip_freeEventContext]
Thu Sep 29 15:59:06 2016 1525 [CDialog::receiveInviteRequest]  a new Server INVITE transaction is in progress
Thu Sep 29 15:59:06 2016 [CSessionTimerContext::CSessionTimerContext] New CSessionTimerContext from request (Server, UA)
Thu Sep 29 15:59:06 2016 [CSessionTimerContext::updateAfterRefreshReception] Update CSessionTimerContext (refresh reception)
Thu Sep 29 15:59:06 2016 [CSessionTimerContext::updateSupported] Request timer supported
Thu Sep 29 15:59:06 2016 [CSessionTimerContext::updateMinSE] Min-SE updated : 300
Thu Sep 29 15:59:06 2016 [CSessionTimerContext::updateSessionExpires] Session-Expires updated : 1800
Thu Sep 29 15:59:06 2016 [CSessionTimerContext::setRefreshMethod] Allow refreshMethod=INVITE
Thu Sep 29 15:59:06 2016 1525 [CDialog::addTransaction] added transaction 2105 with branch z9hG4bK7788bb82, with CSeq 102
Thu Sep 29 15:59:06 2016 11c3 [CCall::checkAuthentication] INVITE
Thu Sep 29 15:59:06 2016 9E5DD [CMessage::getAssertedIdCount] need to create the wrapper
Thu Sep 29 15:59:06 2016 9E5DD [CMessage::createAssertedIdWrapperFromMessage]
Thu Sep 29 15:59:06 2016 9E5DD [CMessage::createAssertedIdWrapperFromMessage] there is 0 P-Asserted-Identity header in the message
Thu Sep 29 15:59:06 2016 9E5DD [CMessage::getPreferredIdCount] need to create the wrapper
Thu Sep 29 15:59:06 2016 9E5DD [CMessage::createPreferredIdWrapperFromMessage] there is 0 P-Preferred-Identity header in the message
Thu Sep 29 15:59:06 2016 [CGwMngData::isAuthenticationRequiredForThisClient] XXX.XXX.XX.XX .
1475157546 -> Thu Sep 29 15:59:06 2016 isDomainFromGwExt  SCSWorking: NO
Thu Sep 29 15:59:06 2016 [isDomainFromGwExt] Host from request is : XXX.XXX.XX.XX.
Thu Sep 29 15:59:06 2016 [isDomainFromGwExt] User from request is : 667
Thu Sep 29 15:59:06 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Thu Sep 29 15:59:06 2016 domain from External Gateway 7.
Thu Sep 29 15:59:06 2016 8794 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 8795 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 8798 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::setFilterUsedMode] To be traced = 0
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::initOfUserType] values are reseted
Thu Sep 29 15:59:06 2016 [getFromHeader] displayName="jean-marc ".
Thu Sep 29 15:59:06 2016 [getFromHeader] =667@XXX.XXX.XX.XX.
Thu Sep 29 15:59:06 2016 [getFromHeader] clirPresent=0.
Thu Sep 29 15:59:06 2016 [isAddrInDico] user=667 host=XXX.XXX.XX.XX
Thu Sep 29 15:59:06 2016 [isUserInDico] 667@XXX.XXX.XX.XX
Thu Sep 29 15:59:06 2016 isUserInDico] NOT found in the dictionnary.
Thu Sep 29 15:59:06 2016 [isAddrInDico] other sip user
Thu Sep 29 15:59:06 2016 isDomainFromGwExt  SCSWorking: NO
Thu Sep 29 15:59:06 2016 [isDomainFromGwExt] Host from request is : XXX.XXX.XX.XX.
Thu Sep 29 15:59:06 2016 [isDomainFromGwExt] User from request is : 667
Thu Sep 29 15:59:06 2016 isDomainFromGwExt--> For Non-PCS case GwExt=7
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::getUserType] extGw = 7.
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
1475157546 -> Thu Sep 29 15:59:06 2016 11c3[CMotorCall::toGatewayOrProxy] request for proxydomain=XXX.XXX.XXX.XXX.
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 11c3[CMotorCall ABCF ExtGW
Thu Sep 29 15:59:06 2016 [isUserRegistred] getRegistration=2299.
Thu Sep 29 15:59:06 2016 [isUserRegistred] result=-1.
Thu Sep 29 15:59:06 2016 [isAddrInDico] user=2299 host=XXX.XXX.XXX.XXX
Thu Sep 29 15:59:06 2016 [isUserInDico] 2299@XXX.XXX.XXX.XXX
Thu Sep 29 15:59:06 2016 [isUserInDico]  found in the dictionnary.
Thu Sep 29 15:59:06 2016 [isAddrInDico] other sip user
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::storeRequestInCall] inRequest storage=0x8532bc8.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::onReceiveRequest] request for gateway.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::onReceiveRequest] state = INITIAL_STATE.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] nb available licenses=74 .
Thu Sep 29 15:59:06 2016 [isUserInDico] 667@XXX.XXX.XX.XX
Thu Sep 29 15:59:06 2016 isUserInDico] NOT found in the dictionnary.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] license OK.
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 3538 [CSipContextID::isValid] Call-ID is not valid
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::compareDialogFromContext] presumed to be the same Dialog
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] Invite => update the inviteContext.
Thu Sep 29 15:59:06 2016 87a1 [CSipAddrSpec::CSipAddrSpec()] Invalid type
1475157546 -> Thu Sep 29 15:59:06 2016 [CForkedBranch::CForkedBranch] context = 0x85093c0.
Thu Sep 29 15:59:06 2016 87a4 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] reqUri stored: sip:667@XXX.XXX.XX.XX:5060
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] cacUsed = 0 before.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] returnStat = 0 before.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] cacUsed = 0 after.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodInviteReceived] CAC = 0
Thu Sep 29 15:59:06 2016 [receiveInviteMessage] Call: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX eqt: -1 INITIAL_STATE received a message.
Thu Sep 29 15:59:06 2016 [decodeInviteCLIR].
Thu Sep 29 15:59:06 2016 [receiveInviteMessage] INFO present in Allow header
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016  am_I_PCS SCSWorking : NO
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016  check_extgw_PCSstate EXTGW  is : 7
Thu Sep 29 15:59:06 2016  The check_extgw_PCSstate extgwid : 7
Thu Sep 29 15:59:06 2016  The state of PCS which rescued the extgw is : -1
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 [decodeInviteFrom].
Thu Sep 29 15:59:06 2016 [receiveInviteMessage] octet3a_scrn = 1
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::analyseSessionTimer] exit with  uacGatewayMode=0 uacRefresher=0.
1475157546 -> Thu Sep 29 15:59:06 2016 [CSipMediaDescription::parseFormatString] Got 4 format(s) from string 8 0 4 101
Thu Sep 29 15:59:06 2016 [checkSdpValidity] Media 0 type 1 contains 4 formats.
Thu Sep 29 15:59:06 2016 [checkSdpValidity] Format : 8.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Thu Sep 29 15:59:06 2016 [convertSdpIntoTsdp] No Direction in the session part.
Thu Sep 29 15:59:06 2016 [convertSdpIntoTsdp] Check the direction in Session part - result:0.
Thu Sep 29 15:59:06 2016 [convertSdpIntoTsdp] media AUDIO detected (previous crypto=0).
Thu Sep 29 15:59:06 2016 [convertAudioMedia] The audio media contains  4 format(s).
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Format 0 is 8.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Format 1 is 0.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Format 2 is 4.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Format 3 is 101.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] 101.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Format is DTMF:101.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Direction is sendrecv.
Thu Sep 29 15:59:06 2016 [convertAudioMedia] Connection address retrieved in sdp: XXX.XXX.XX.XX.
Thu Sep 29 15:59:06 2016 [convertIPStrIntoTuipv] XXX.XXX.XX.XX => XXX.XXX.XX.XX
Thu Sep 29 15:59:06 2016 [display_sdp] address =XXX.XXX.XX.XX
Thu Sep 29 15:59:06 2016 [display_sdp] direction=0.
Thu Sep 29 15:59:06 2016 [convertSdpIntoTsdp] only one media taken into account xxx crypto_index=0 clear media=1
Thu Sep 29 15:59:06 2016 [convertSdpIntoTsdp] crypto_index=0 clear media=1.
1475157546 -> Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::isCryptoAuthorized] config crypto=0/0.
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 [receiveInviteMessage] NO  100rel REQUIRED for this call.
Thu Sep 29 15:59:06 2016 [CInitialState::receiveinvitemessage allow_update 0 prack_required 0
Thu Sep 29 15:59:06 2016 [decodeInviteTo].
Thu Sep 29 15:59:06 2016 [decodeInviteReferredBy].
Thu Sep 29 15:59:06 2016 [decodeInviteACSBU].
Thu Sep 29 15:59:06 2016 8794 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 8795 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 8798 [CSipAddrSpec::getAddrSpecAsString]
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::setFilterUsedMode] To be traced = 0
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 ** SIP TRUNKING **
Thu Sep 29 15:59:06 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Thu Sep 29 15:59:06 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::insertCallwithEqt] CMotorCall 3525 inserted.
Thu Sep 29 15:59:06 2016 11c3[sendLgEvtSipCreate] Event sent on eqt : 3525
Thu Sep 29 15:59:06 2016 [display_ipc_out] ------------ Begin ---------------
Thu Sep 29 15:59:06 2016 Id : -1
Thu Sep 29 15:59:06 2016 INVITE
Thu Sep 29 15:59:06 2016 REQUEST URI : <> 2299@XXX.XXX.XXX.XXX:5060 ; user=name
1475157546 -> Thu Sep 29 15:59:06 2016 FROM : <jean-marc > 667@XXX.XXX.XX.XX:5060 ; user=name
Thu Sep 29 15:59:06 2016 TO : <> 2299@XXX.XXX.XXX.XXX:5060 ; user=name
Thu Sep 29 15:59:06 2016 CAC : 0
Thu Sep 29 15:59:06 2016   CAC ADDRESS :
Thu Sep 29 15:59:06 2016 CAC-CSBU info : UNKNOWN
Thu Sep 29 15:59:06 2016 CLIR : 0
Thu Sep 29 15:59:06 2016 Prack Required : 0
Thu Sep 29 15:59:06 2016 Allow Update : 0
Thu Sep 29 15:59:06 2016 SDP :
Thu Sep 29 15:59:06 2016   ADDRESS : XXX.XXX.XX.XX :13060
Thu Sep 29 15:59:06 2016   ALGOS :
Thu Sep 29 15:59:06 2016     PCMA
Thu Sep 29 15:59:06 2016     G723
Thu Sep 29 15:59:06 2016     101
Thu Sep 29 15:59:06 2016   DIRECTION : SEND & RECEIVE
Thu Sep 29 15:59:06 2016   crypto index : 0
Thu Sep 29 15:59:06 2016        N_GW_EXT : 7
Thu Sep 29 15:59:06 2016 [display_ipc_out] ------------- End ----------------
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Thu Sep 29 15:59:06 2016 [exec_ipc] in 30138.
Thu Sep 29 15:59:06 2016 [display_ipc_in] ------------ Begin ---------------
Thu Sep 29 15:59:06 2016 neqt : 3525 Id : -1
Thu Sep 29 15:59:06 2016 REQUEST FAILURE
Thu Sep 29 15:59:06 2016 xx :       80
Thu Sep 29 15:59:06 2016        RELATIVE REQUEST : INVITE
Thu Sep 29 15:59:06 2016 [display_ipc_in] ------------- End ----------------
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onIncomingEvent] an event 10767 arrived on the eqt 3525 -1.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onIncomingEvent] state = PROCEEDING_STATE.
1475157546 -> Thu Sep 29 15:59:06 2016 [onIncomingEvent] REQUEST FAILURE arrived.
Thu Sep 29 15:59:06 2016 [receiveRequestFailureEvent] Call: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX eqt: 3525 PROCEEDING_STATE received an event.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::getOutgoingCall] outgoingCall:0
Thu Sep 29 15:59:06 2016 [receiveRequestFailureEvent] incoming call.
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 11c3[CMotorCall ABCF ExtGW
Thu Sep 29 15:59:06 2016 11c3 [CCall::makeGenericResponse] 480
Thu Sep 29 15:59:06 2016 11c3 [CCall::getDialog] Confirmed Dialog is not found (ID = ;as50d36879)
Thu Sep 29 15:59:06 2016 11c3 [CCall::getDialog] Returning Initial Dialog Server
Thu Sep 29 15:59:06 2016 1525 [CDialog::createResponse] 480
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::CResponse] Creation of a response
Thu Sep 29 15:59:06 2016 2105 [CTransProceedingState::createResponse] CResponse B7FBE ref=1
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::create] RESPONSE CREATION
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::checkStatusLine] Create StatusLine from code given as parameter
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::createToHeader] Initialize To TAG from context
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::createToHeader] Creation a tag for To header
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::createViaHeaders] Copy Via headers from previous request (number : 1)
Thu Sep 29 15:59:06 2016 B7FBE [CResponse::create] Initialize context (Local = To & Remote = From)
1475157546 -> Thu Sep 29 15:59:06 2016 B7FBE [CMessage::send] sip_sendMessage (XXX.XXX.XX.XX:5060)
Thu Sep 29 15:59:06 2016 SEND MESSAGE TO NETWORK (XXX.XXX.XX.XX:5060 [UDP]) (BUFF LEN = 462)
----------------------utf8-----------------------
SIP/2.0 480 Temporarily not available
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDATE
User-Agent: OmniPCX Enterprise R10.0 j1.410.49.a
To: <sip:2299@XXX.XXX.XXX.XXX:5060>;tag=20c70d21cb0a365004c0cc4ab2fef74b
From: "jean-marc " <sip:667@XXX.XXX.XX.XX>;tag=as50d36879
Call-ID: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX
CSeq: 102 INVITE
Via: SIP/2.0/UDP XXX.XXX.XX.XX:5060;branch=z9hG4bK7788bb82
Content-Length: 0

-------------------------------------------------
Thu Sep 29 15:59:06 2016 [sip_freeEventContext]
Thu Sep 29 15:59:06 2016 B7FBD [~CResponse] resp(100) 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX 102 INVITE
Thu Sep 29 15:59:06 2016 2105 [CTransProceedingState::createResponse] Final : Transaction changes to Completed state
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] STATE CHANGED TO COMPLETED
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] notifying the parent dialog
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState(pTrans = 2105, previousState = Proceeding, currentState = Completed, reason = Final resp creation]
Thu Sep 29 15:59:06 2016 2105 [CTransaction::startTimer] Timer G is started (delay = 500 ms)
Thu Sep 29 15:59:06 2016 2105 [CTransaction::startTimer] Timer H is started (delay = 32000 ms)
1475157546 -> Thu Sep 29 15:59:06 2016 1525 [CDialog::updateRouteSet] there are 0 record-route headers
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
Thu Sep 29 15:59:06 2016 [exec_ipc] in end 30138.
Thu Sep 29 15:59:06 2016 RECEIVE MESSAGE FROM NETWORK (XXX.XXX.XX.XX:5060 [UDP])
----------------------utf8-----------------------
ACK sip:2299@XXX.XXX.XXX.XXX:5060 SIP/2.0
Via: SIP/2.0/UDP XXX.XXX.XX.XX:5060;branch=z9hG4bK7788bb82
Max-Forwards: 70
From: "jean-marc " <sip:667@XXX.XXX.XX.XX>;tag=as50d36879
To: <sip:2299@XXX.XXX.XXX.XXX:5060>;tag=20c70d21cb0a365004c0cc4ab2fef74b
Contact: <sip:667@XXX.XXX.XX.XX:5060>
Call-ID: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX
CSeq: 102 ACK
User-Agent: XIVO PBX
Content-Length: 0

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

Thu Sep 29 15:59:06 2016  [CIOCom::receiveRequest] optimisation value 1
Thu Sep 29 15:59:06 2016  [CIOCom::IsNoeOptionsMsg] Not in same domain FAILED => XXX.XXX.XXX.XXX node000000
Thu Sep 29 15:59:06 2016  [CIOCom::IsNoeOptionsMsg] NoeOpt 0
Thu Sep 29 15:59:06 2016 9E5DE [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
Thu Sep 29 15:59:06 2016 [CIOCom::receiveRequest] Received CRequest 9E5DE ref=1
Thu Sep 29 15:59:06 2016 [CIOCom::receiveRequest] rport1 not empty
Thu Sep 29 15:59:06 2016 [CDispatcher::onIncomingRequest()]
Thu Sep 29 15:59:06 2016 [CDispatcher::processRequestFromManagerIndex()] start at index 0
Thu Sep 29 15:59:06 2016  102 [CCallManager::onIncomingRequest()]
1475157546 -> Thu Sep 29 15:59:06 2016 11c3 [CCall::receiveRequest] ACK
Thu Sep 29 15:59:06 2016 11c3 [CCall::getDialog] Confirmed Dialog is not found (ID = 20c70d21cb0a365004c0cc4ab2fef74b;as50d36879)
Thu Sep 29 15:59:06 2016 11c3 [CCall::getDialog] Returning Initial Dialog Server
Thu Sep 29 15:59:06 2016 1525 [CDialog::receiveRequest]
Thu Sep 29 15:59:06 2016 1525 [CDialog::receiveAckRequest]
Thu Sep 29 15:59:06 2016 2105 [CTransCompletedState::receiveRequest] ACK(UDP) : Transaction changes to Confirmed state
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] STATE CHANGED TO CONFIRMED
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] notifying the parent dialog
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState(pTrans = 2105, previousState = Completed, currentState = Confirmed, reason = Request reception]
Thu Sep 29 15:59:06 2016 2105 [CTransaction::freeTimerToken] Timer G is freed
Thu Sep 29 15:59:06 2016 2105 [CTransaction::freeTimerToken] Timer H is freed
Thu Sep 29 15:59:06 2016 2105 [CTransaction::startTimer] Timer I is started (delay = 5000 ms)
Thu Sep 29 15:59:06 2016 1525 [CDialog::receiveAckRequest] receiving an ACK on a previously rejected INVITE
Thu Sep 29 15:59:06 2016 11c3 [CCall::checkAuthentication] ACK
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::onReceiveRequest] s=0 d=0 v=0 o=1.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::onReceiveRequest] request for gateway.
1475157546 -> Thu Sep 29 15:59:06 2016 11c3[CMotorCall::onReceiveRequest] state = TERMINATED_STATE.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::compareDialogFromContext] same Dialog
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::methodAckReceived] Ack => update the inviteContext.
Thu Sep 29 15:59:06 2016 [receiveAckMessage] Call: 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX eqt: 3525 TERMINATED_STATE received a message.
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] CAC = 0 eqtCAC = -1
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] cacUsed=0 eqtCac=-1
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] displayIPCMessageOut
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 ** SIP TRUNKING **
Thu Sep 29 15:59:06 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Thu Sep 29 15:59:06 2016 [ipc_thread] IPC Thread : Ipc reception 30139.
Thu Sep 29 15:59:06 2016 [ipc_thread] IPC Thread : TCL thread signaled.
Thu Sep 29 15:59:06 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Thu Sep 29 15:59:06 2016 [display_ipc_out] ------------ Begin ---------------
Thu Sep 29 15:59:06 2016 Id : -1
Thu Sep 29 15:59:06 2016 ACK
Thu Sep 29 15:59:06 2016 [display_ipc_out] ------------- End ----------------
Thu Sep 29 15:59:06 2016 [exec_ipc] in 30138.
Thu Sep 29 15:59:06 2016 [display_ipc_in] ------------ Begin ---------------
1475157546 -> Thu Sep 29 15:59:06 2016 neqt : 3525 Id : -1
Thu Sep 29 15:59:06 2016 SIP EQT RELEASED
Thu Sep 29 15:59:06 2016 [display_ipc_in] ------------- End ----------------
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 3525 -1.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onIncomingEvent] The call with eqt: 3525 has released its equipment.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_ACK
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] content size (lginfo): 660 ccal crypted= 0
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel]1 T38 REINVITE TRUE
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] CAC = 0 eqtCAC = -1
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] cacUsed=0 eqtCac=-1
Thu Sep 29 15:59:06 2016 11c3[emitEventToMonitel] displayIPCMessageOut
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 [isValidGwExt] ext gw 7 is valid
Thu Sep 29 15:59:06 2016 ** SIP TRUNKING **
Thu Sep 29 15:59:06 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Thu Sep 29 15:59:06 2016 [sendLgEvtSip] Event sent on eqt : 3525 Id :-1
Thu Sep 29 15:59:06 2016 [display_ipc_out] ------------ Begin ---------------
Thu Sep 29 15:59:06 2016 Id : -1
Thu Sep 29 15:59:06 2016 SIP_EQT_RELEASE_ACK
Thu Sep 29 15:59:06 2016 [display_ipc_out] ------------- End ----------------
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::setCurrentState] NOE-SIP : sendBackupUpdate Msg not sent to twin CS
1475157546 -> Thu Sep 29 15:59:06 2016 11c3[CMotorCall::unRegister] Remove eqt : 3525 diag : -1 from the map.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::eraseCallwithEqt] erase 3525 -1.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onIncomingEvent] killSession.
Thu Sep 29 15:59:06 2016 11c3 [CCall::killSession]
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] STATE CHANGED TO TERMINATED
Thu Sep 29 15:59:06 2016 2105 [CTransaction::freeTimerToken] Timer I is freed
Thu Sep 29 15:59:06 2016 2105 [CTransaction::changeState] no transaction state, terminated reason : None
Thu Sep 29 15:59:06 2016 11c3 [CCall::killSession] notifying the call manager
Thu Sep 29 15:59:06 2016  102 [CCallManager::onCallClosed]
Thu Sep 29 15:59:06 2016  102 [CCallManager::onCallClosed()] Call 11c3 closed. Removing call 139497240 from the maps
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onNotifyCallClosed] Call : 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX is closed.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onNotifyCallClosed] Call : 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX is closed.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onNotifyCallClosed] call processResponse.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::chooseBestResponse] pForkedBranch=0x84de870 iResponseCode=2000.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::chooseBestResponse] next branch.
Thu Sep 29 15:59:06 2016 11c3[CMotorCall::processResponse] no response found.
Thu Sep 29 15:59:06 2016 [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1475157548 -> Thu Sep 29 15:59:06 2016 [exec_ipc] in end 30138.
Thu Sep 29 15:59:06 2016 [CTransaction::notifyDialog]
Thu Sep 29 15:59:06 2016 [CTransaction::notifyDialog] notify parent dialog
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState(pTrans = 2105, previousState = null, currentState = Terminated, reason = None]
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState] dialog is terminated
Thu Sep 29 15:59:06 2016 1525 [CDialog::onTransactionState] onDialogClosed
Thu Sep 29 15:59:06 2016 11c3 [CCall::onDialogClosed]
Thu Sep 29 15:59:06 2016 11c3 [CCall::onDialogClosed] only initial *********
Thu Sep 29 15:59:06 2016 11c3 [CCall::onDialogClosed] All the initial dialogs in the Call are closed
Thu Sep 29 15:59:06 2016 2105 [~CTransaction] transaction 102 INVITE
Thu Sep 29 15:59:06 2016 9E5DE [~CRequest] req 6701cd16208307e376103e2b456d25ca@XXX.XXX.XX.XX 102 ACK
Thu Sep 29 15:59:08 2016 RECEIVE MESSAGE FROM NETWORK (10.255.254.66:5060 [UDP])

[bwen]

I dont uderstand the "not in same domain" because OXE and Asterisk are both Classe C IP 192.168.X.X but this is not the reason of the fail right?

[REMI01]

Hello,

I have a trunk 4400(r9.1) and xivo (16.12) and is ok

my 4400 and xivo are in the same network
in xivo /intercom sip/name /auth/mdp/type friend/ip statique/from-extern/nat no
in 4400/gtw ext/name xivo/domaine @ip of xivo/port 5060/tr udp/domaine node000000/bean 16

in xivo*cli>sip show peers
and you see trunk registry

good luck

[bwen]

Hello Remi,

Thank you for your feedback, I have the same configuration of you except there isnt any authentication and sip show peers shows "registered". OXE and Xivo can well communicate but there is something else, i dont have enough skills to interprete the OXE traced.

[REMI01]

Re

In 4400 do you have the good locks
command > spadmin /choose 2
185 sip gateway 1
188 sip network links 8


by

[bwen]

yes I have:
185 sip gateway 1
188 sip network links 88

[cavagnaro]

You are calling from OXE to Asterisk?
Domain means in terms of OXE, not networking.
Check the public network category under that External gateway 7, the trunk used. Make sure it's category can dial those numbers.
If you left it in 31 probably will fail

Enviado de meu E6633 usando Tapatalk

[tgn]

which usertype is 2299 in oxe (noe or sip)?

regards...


--- back to basics... focus your eyes to the essential things... ---