Здравствуйте.
Есть две ОХЕ R11.0.1-k152029e, одна MG, другая AS. На обеих ситуация одна и та же. SIP аппарат Alcatel IP600 работает нормально и как SIP device, и как SIP extension. А вот Greenlite при входящем звонке отбивает с причиной Temporary Unavailable.
Вот что показывает sipregister:
-------------------------------------------------
Address of record : 6902
contact : sip:6902@10.246.100.234:5063, udp, 2088 s
-------------------------------------------------
Address of record : 6904
contact : sip:6904@10.246.100.217, udp, 1345 s
*************************************************
****** registred user number : 2
*************************************************
6902 - IP600, 6904 - Greenlite. Оба сделаны как SIP Device. Сразу вопрос - почему у 6904 нет порта UDP?
В трассе звонка видно, что IP600 использует порт 5063, а Greenlite - порт 5060. Думал, что дело в этом. Поменял у 6904 локальный порт на 5069. В трассе порт поменялся, входящие звонки все равно не пошли.
*************************************************
Dump local registrar base
-------------------------------------------------
Address of record : 6902
contact : sip:6902@10.246.100.234:5063, udp, 2027 s
-------------------------------------------------
Address of record : 6904
contact : sip:6904@10.246.100.217:5069, udp, 1744 s
*************************************************
****** registred user number : 2
*************************************************
Вот трасса входящего звонка на Greenlite
(132)isod_32> traced
** UNIX-trace-daemon started ... (static user group No 1) **
traced started ...
1411748597 -> Fri Sep 26 20:23:17 2014 [ipc_thread] Normal case : evt 10752
Fri Sep 26 20:23:17 2014 [ipc_thread] IPC Thread : Ipc reception 4037.
Fri Sep 26 20:23:17 2014 [exec_ipc] in 4036.
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 neqt : 912 Id : -1
Fri Sep 26 20:23:17 2014 INVITE
Fri Sep 26 20:23:17 2014 REQUEST URI : <> 6904@node_isod_32:5060 ; user=phone
Fri Sep 26 20:23:17 2014 FROM : <Node 32 6901 IP Test> 6901@172.16.245.76:5060 ;
user=phone
Fri Sep 26 20:23:17 2014 TO : <> 6904@node_isod_32:5060 ; user=phone
Fri Sep 26 20:23:17 2014 CAC : 0
Fri Sep 26 20:23:17 2014 neqt CAC : -1
Fri Sep 26 20:23:17 2014 CAC-CSBU info : UNKNOWN
Fri Sep 26 20:23:17 2014 CLIR : 0
Fri Sep 26 20:23:17 2014 SDP :
Fri Sep 26 20:23:17 2014 ADDRESS : 10.246.100.24010.246.100.240 :32514
Fri Sep 26 20:23:17 2014 ALGOS :
Fri Sep 26 20:23:17 2014 G729
Fri Sep 26 20:23:17 2014 97
Fri Sep 26 20:23:17 2014 DIRECTION : SEND & RECEIVE
Fri Sep 26 20:23:17 2014 crypto index : 0
Fri Sep 26 20:23:17 2014 N_GW_EXT : 1000
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------- End ----------------
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] an event 10752 arr
ived on the eqt 912 -1.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] New Call created.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::callFactory].
Fri Sep 26 20:23:17 2014 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX
Enterprise R11.0.1 k1.520.29.e
1411748597 -> Fri Sep 26 20:23:17 2014 [CMotorCallManager::callFactory]=84fb8e8.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::insertCallwithEqt] CMotorCall 912 i
nserted.
Fri Sep 26 20:23:17 2014 inviteBuildFromAssertedId-->extGw=-1
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 [quoteString] => "Node 32 6901 IP Test"
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildFromAssertedId] no P_Assert
ed_Identity
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::setFilterUsedMode] To be traced = 0
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] state = INITIAL_ST
ATE.
Fri Sep 26 20:23:17 2014 [onIncomingEvent] INVITE arrived.
Fri Sep 26 20:23:17 2014 [receiveInviteEvent] Call: eqt: 912 INITIAL_STATE rece
ived an event.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] begin. size=656 cal
l_type: 0
Fri Sep 26 20:23:17 2014 1113[CMotorCall::getUserType] Begin extGw=1000.
Fri Sep 26 20:23:17 2014 [isUserInDico] found in the dictionnary.
Fri Sep 26 20:23:17 2014 [isAddrInDico] sip device station OK
Fri Sep 26 20:23:17 2014 [getExternalStationParameters] stat=13 digit=4 app=0 co
m=0 data=1 term=142.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::getUserType] device station crypto=0,
extGateway=-1.
Fri Sep 26 20:23:17 2014
1411748597 -> Fri Sep 26 20:23:17 2014 inviteBuildFromAssertedId-->extGw=1000
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 [quoteString] => "Node 32 6901 IP Test"
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildFromAssertedId] no P_Assert
ed_Identity
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] From: "Node 32 6901
IP Test" <sip:6901@172.16.245.76;user=phone>
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] reqUri :sip:6904@no
de_isod_32;user=phone
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage]-->SIP_INFO_allowed=
1 allow_update=1
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] To: <sip:6904@node
_isod_32;user=phone>
Fri Sep 26 20:23:17 2014 am_I_PCS SCSWorking : NO
Fri Sep 26 20:23:17 2014 check_PCSstate
Fri Sep 26 20:23:17 2014 am_I_PCS SCSWorking : NO
Fri Sep 26 20:23:17 2014 check_PCSstate stat of PCS is : -1
Fri Sep 26 20:23:17 2014 [inviteBuildContact] trunk_number=80 extGw =1000.
Fri Sep 26 20:23:17 2014 [137339-InviteBuildContact] userinfo : 6901
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildContact] Contact: sip:6901
@172.16.245.76
Fri Sep 26 20:23:17 2014 1113[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT mang
ed with TLS and refresh REINVITE
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildSessionTimer] uacGatewayMod
e=1 uacRefresher=1.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] Begin sd
p.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::appendAudioAttributToMedia] Direction:
0.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::appendAudioAttributToMedia] format 97
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] crypto index3=0 clearM
ediaLine=0.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] appendMediaDescription
ok.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] Final sdp.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] The sdp build.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::new_determineTargetsForTheRequest] is
Responsible For This URI.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::new_determineTargets] pcszNameToFind_1
=6904.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] nb contacts=1
.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] *pcszNameToFi
nd : 6904
Fri Sep 26 20:23:17 2014 [isUserInDico] found in the dictionnary.
Fri Sep 26 20:23:17 2014 [CGwServAuthenticate::isUserDeclared] found in the dic
tionnary.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] contact : sip
:6904@10.246.100.217:5069
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] nb available
licenses=9999 .
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0
and pSipAddSpec->getHost()=10.246.100.217
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] contact nb=13
9445432
Fri Sep 26 20:23:17 2014 [CGWMngDat a::isMainServer] CPU is MAIN.
1411748597 -> Fri Sep 26 20:23:17 2014 [CGWMngDat a::isMainServer] checkwith PCS
= 0
Fri Sep 26 20:23:17 2014 1113[CMotorCall::isTLSProtRequiredForExtGw] =0.
Fri Sep 26 20:23:17 2014 SEND MESSAGE TO NETWORK (10.246.100.217:5069 [UDP]) (BU
FF LEN = 931)
----------------------utf8-----------------------
INVITE sip:6904@10.246.100.217:5069 SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDAT
E, INFO
Supported: replaces,timer,path
User-Agent: OmniPCX Enterprise R11.0.1 k1.520.29.e
Session-Expires: 1800;refresher=uac
Min-SE: 900
Content-Type: application/sdp
To: <sip:6904@node_isod_32;user=phone>
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
Contact: <sip:6901@172.16.245.76;transport=UDP>
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
CSeq: 66498149 INVITE
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
Max-Forwards: 70
Content-Length: 240
v=0
o=OXE 1411748597 1411748597 IN IP4 172.16.245.76
s=abs
c=IN IP4 10.246.100.240
t=0 0
m=audio 32514 RTP/AVP 18 97
a=sendrecv
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
Fri Sep 26 20:23:17 2014 [CForkedBranch::CForkedBranch] context = 0x84fbd9c.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::branchAllocation] pForkedBranch = 0x84
fa2e8 and the branch number is.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] reqUri duplic
ation pForkedBranch = 0x84fa2e8.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::setCurrentState] NOE-SIP
: sendBackupUpdate Msg not sent to twin CS
Fri Sep 26 20:23:17 2014 NOE-SIP : StandByCallCreation not sent to twin CS
Fri Sep 26 20:23:17 2014 [onIncomingEvent] CallID must be inserted.
Fri Sep 26 20:23:17 2014 [onIncomingEvent] CallID inserted.
Fri Sep 26 20:23:17 2014 [exec_ipc] in end 4036.
Fri Sep 26 20:23:17 2014 RECEIVE MESSAGE FROM NETWORK (10.246.100.217:5069 [UDP]
)
----------------------utf8-----------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
To: <sip:6904@node_isod_32;user=phone>
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
CSeq: 66498149 INVITE
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, ME
SSAGE
Content-Length: 0
-------------------------------------------------
Fri Sep 26 20:23:17 2014 1113[CMotorCall::searchForkedBranch]pForkedBranch=0x84f
a2e8.
Fri Sep 26 20:23:17 2014 [receiveInformationalMessage] Call: dc76e98d7acbe652d76
148142977d698@172.16.245.76 eqt: 912 PROCEEDING_STATE received a message.
Fri Sep 26 20:23:17 2014 [CPoceedingState::receiveInformationalMessage]-->nof of
PEM hdrs 0
Fri Sep 26 20:23:17 2014 [receiveInformationalMessage] No P-Early-Media header r
eceived
Fri Sep 26 20:23:17 2014 [receiveInformationalMessage] is in the else part of SD
P not present
Fri Sep 26 20:23:17 2014 RECEIVE MESSAGE FROM NETWORK (10.246.100.217:5069 [UDP]
)
----------------------utf8-----------------------
SIP/2.0 480 Temporarily not available
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
To: <sip:6904@node_isod_32;user=phone>;tag=853018002
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
CSeq: 66498149 INVITE
Contact: <sip:6904@10.246.100.217:5069>
Server: Greenlite ATOM V2.0
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0
-------------------------------------------------
1411748597 -> Fri Sep 26 20:23:17 2014 SEND MESSAGE TO NETWORK (10.246.100.217:5069 [UDP])
(BUFF LEN = 376)
----------------------utf8-----------------------
ACK sip:6904@10.246.100.217:5069 SIP/2.0
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
To: <sip:6904@node_isod_32;user=phone>;tag=853018002
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
CSeq: 66498149 ACK
Content-Length: 0
-------------------------------------------------
Fri Sep 26 20:23:17 2014 1113[CMotorCall::searchForkedBranch]pForkedBranch=0x84f
a2e8.
Fri Sep 26 20:23:17 2014 [CForkedBranch::setFinalResponse] response=480.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] no response
to the CH m_cancelSent=0.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] all response
s are received 1.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] call chooseB
estResponse.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::chooseBestResponse] pForkedBranch=0x84
fa2e8 iResponseCode=2000.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::chooseBestResponse] last iResponseCode
=480.
Fri Sep 26 20:23:17 2014 [CForkedBranch::setFinalResponse] pResponse=0x8
504018.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::chooseBestResponse] next branch.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] inviteRespon
se => update the lastInviteContext.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::updateTransportfromlastI
nviteContext] lasInviteContext Start
Fri Sep 26 20:23:17 2014 [receiveRequestFailureMessage] Call: dc76e98d7acbe652d7
6148142977d698@172.16.245.76 eqt: 912 PROCEEDING_STATE received a message.
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] content size (lginfo): 660 cca
l crypted= 0
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] CAC = 0 eqtCAC = -1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] displayIPCMessageOut
Fri Sep 26 20:23:17 2014 ** SIP DEVICE **
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [ipc_thread] Normal case : evt 10773
Fri Sep 26 20:23:17 2014 [ipc_thread] IPC Thread : Ipc reception 4037.
Fri Sep 26 20:23:17 2014 [ipc_thread] IPC Thread : TCL thread signaled.
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 Id : -1
Fri Sep 26 20:23:17 2014 REQUEST FAILURE
Fri Sep 26 20:23:17 2014 xx : 80
Fri Sep 26 20:23:17 2014 RELATIVE REQUEST : INVITE
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------- End ----------------
Fri Sep 26 20:23:17 2014 1113[CMotorCall::setCurrentState] NOE-SIP : sendBackupU
pdate Msg not sent to twin CS
Fri Sep 26 20:23:17 2014 1113[CMotorCall::onReceiveResponse] retrans=0, status=4
80 extGw=1000.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::onReceiveResponse] INVITE case => canc
elAllCancelableForkedBranch.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::cancelAllCancelableForke
dBranch] nb branch=1.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::cancelAllCancelableForkedBranch] retra
ns=0.
Fri Sep 26 20:23:17 2014 [exec_ipc] in 4036.
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 neqt : 912 Id : -1
Fri Sep 26 20:23:17 2014 SIP EQT RELEASED
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------- End ----------------
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] an event 10773 arr
ived on the eqt 912 -1.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] The call with eqt:
912 has released its equipment.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_
ACK
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] content size (lginfo): 660 cca
l crypted= 0
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel]1 T38 REINVITE TRUE
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] CAC = 0 eqtCAC = -1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] displayIPCMessageOut
Fri Sep 26 20:23:17 2014 ** SIP DEVICE **
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 Id : -1
Fri Sep 26 20:23:17 2014 SIP_EQT_RELEASE_ACK
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------- End ----------------
1411748601 -> Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] stat
e = TERMINATED_STATE.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::setCurrentState] NOE-SIP : sendBackupU
pdate Msg not sent to twin CS
Fri Sep 26 20:23:17 2014 1113[CMotorCall::unRegister] Remove eqt : 912 diag : -1
from the map.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::eraseCallwithEqt] erase 912 -1.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] killSession.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onNotifyCallClosed] Call : dc76e98d
7acbe652d76148142977d698@172.16.245.76 is closed.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onNotifyCallClosed] Call : dc76e98d
7acbe652d76148142977d698@172.16.245.76 is closed.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onNotifyCallClosed] Remove eqt from
the map.
Fri Sep 26 20:23:17 2014 [exec_ipc] in end 4036.
Fri Sep 26 20:23:19 2014 1113 [CMotorCall::clear_subscription] no subscription m
anaged
Fri Sep 26 20:23:19 2014 1113[CMotorCall::~CMotorCall] Call : dc76e98d7acbe652d7
6148142977d698@172.16.245.76 is being destructed.
Есть две ОХЕ R11.0.1-k152029e, одна MG, другая AS. На обеих ситуация одна и та же. SIP аппарат Alcatel IP600 работает нормально и как SIP device, и как SIP extension. А вот Greenlite при входящем звонке отбивает с причиной Temporary Unavailable.
Вот что показывает sipregister:
-------------------------------------------------
Address of record : 6902
contact : sip:6902@10.246.100.234:5063, udp, 2088 s
-------------------------------------------------
Address of record : 6904
contact : sip:6904@10.246.100.217, udp, 1345 s
*************************************************
****** registred user number : 2
*************************************************
6902 - IP600, 6904 - Greenlite. Оба сделаны как SIP Device. Сразу вопрос - почему у 6904 нет порта UDP?
В трассе звонка видно, что IP600 использует порт 5063, а Greenlite - порт 5060. Думал, что дело в этом. Поменял у 6904 локальный порт на 5069. В трассе порт поменялся, входящие звонки все равно не пошли.
*************************************************
Dump local registrar base
-------------------------------------------------
Address of record : 6902
contact : sip:6902@10.246.100.234:5063, udp, 2027 s
-------------------------------------------------
Address of record : 6904
contact : sip:6904@10.246.100.217:5069, udp, 1744 s
*************************************************
****** registred user number : 2
*************************************************
Вот трасса входящего звонка на Greenlite
(132)isod_32> traced
** UNIX-trace-daemon started ... (static user group No 1) **
traced started ...
1411748597 -> Fri Sep 26 20:23:17 2014 [ipc_thread] Normal case : evt 10752
Fri Sep 26 20:23:17 2014 [ipc_thread] IPC Thread : Ipc reception 4037.
Fri Sep 26 20:23:17 2014 [exec_ipc] in 4036.
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 neqt : 912 Id : -1
Fri Sep 26 20:23:17 2014 INVITE
Fri Sep 26 20:23:17 2014 REQUEST URI : <> 6904@node_isod_32:5060 ; user=phone
Fri Sep 26 20:23:17 2014 FROM : <Node 32 6901 IP Test> 6901@172.16.245.76:5060 ;
user=phone
Fri Sep 26 20:23:17 2014 TO : <> 6904@node_isod_32:5060 ; user=phone
Fri Sep 26 20:23:17 2014 CAC : 0
Fri Sep 26 20:23:17 2014 neqt CAC : -1
Fri Sep 26 20:23:17 2014 CAC-CSBU info : UNKNOWN
Fri Sep 26 20:23:17 2014 CLIR : 0
Fri Sep 26 20:23:17 2014 SDP :
Fri Sep 26 20:23:17 2014 ADDRESS : 10.246.100.24010.246.100.240 :32514
Fri Sep 26 20:23:17 2014 ALGOS :
Fri Sep 26 20:23:17 2014 G729
Fri Sep 26 20:23:17 2014 97
Fri Sep 26 20:23:17 2014 DIRECTION : SEND & RECEIVE
Fri Sep 26 20:23:17 2014 crypto index : 0
Fri Sep 26 20:23:17 2014 N_GW_EXT : 1000
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------- End ----------------
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] an event 10752 arr
ived on the eqt 912 -1.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] New Call created.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::callFactory].
Fri Sep 26 20:23:17 2014 [CMotorCall :: CMotorCall()] Oxe_Version_Name = OmniPCX
Enterprise R11.0.1 k1.520.29.e
1411748597 -> Fri Sep 26 20:23:17 2014 [CMotorCallManager::callFactory]=84fb8e8.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::insertCallwithEqt] CMotorCall 912 i
nserted.
Fri Sep 26 20:23:17 2014 inviteBuildFromAssertedId-->extGw=-1
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 [quoteString] => "Node 32 6901 IP Test"
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildFromAssertedId] no P_Assert
ed_Identity
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::setFilterUsedMode] To be traced = 0
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] state = INITIAL_ST
ATE.
Fri Sep 26 20:23:17 2014 [onIncomingEvent] INVITE arrived.
Fri Sep 26 20:23:17 2014 [receiveInviteEvent] Call: eqt: 912 INITIAL_STATE rece
ived an event.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] begin. size=656 cal
l_type: 0
Fri Sep 26 20:23:17 2014 1113[CMotorCall::getUserType] Begin extGw=1000.
Fri Sep 26 20:23:17 2014 [isUserInDico] found in the dictionnary.
Fri Sep 26 20:23:17 2014 [isAddrInDico] sip device station OK
Fri Sep 26 20:23:17 2014 [getExternalStationParameters] stat=13 digit=4 app=0 co
m=0 data=1 term=142.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::getUserType] device station crypto=0,
extGateway=-1.
Fri Sep 26 20:23:17 2014
1411748597 -> Fri Sep 26 20:23:17 2014 inviteBuildFromAssertedId-->extGw=1000
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 [quoteString] => "Node 32 6901 IP Test"
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildFromAssertedId] no P_Assert
ed_Identity
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] From: "Node 32 6901
IP Test" <sip:6901@172.16.245.76;user=phone>
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] reqUri :sip:6904@no
de_isod_32;user=phone
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage]-->SIP_INFO_allowed=
1 allow_update=1
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] To: <sip:6904@node
_isod_32;user=phone>
Fri Sep 26 20:23:17 2014 am_I_PCS SCSWorking : NO
Fri Sep 26 20:23:17 2014 check_PCSstate
Fri Sep 26 20:23:17 2014 am_I_PCS SCSWorking : NO
Fri Sep 26 20:23:17 2014 check_PCSstate stat of PCS is : -1
Fri Sep 26 20:23:17 2014 [inviteBuildContact] trunk_number=80 extGw =1000.
Fri Sep 26 20:23:17 2014 [137339-InviteBuildContact] userinfo : 6901
Fri Sep 26 20:23:17 2014 1113[CMotorCall::sipUriType] sip Uri.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildContact] Contact: sip:6901
@172.16.245.76
Fri Sep 26 20:23:17 2014 1113[CMotorCall::isExtGwTLSwithREINVITE] ExtGw NOT mang
ed with TLS and refresh REINVITE
Fri Sep 26 20:23:17 2014 1113[CMotorCall::inviteBuildSessionTimer] uacGatewayMod
e=1 uacRefresher=1.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] Begin sd
p.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::appendAudioAttributToMedia] Direction:
0.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::appendAudioAttributToMedia] format 97
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] crypto index3=0 clearM
ediaLine=0.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] appendMediaDescription
ok.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeRequestSdp] Final sdp.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitInviteMessage] The sdp build.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::new_determineTargetsForTheRequest] is
Responsible For This URI.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::new_determineTargets] pcszNameToFind_1
=6904.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] nb contacts=1
.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] *pcszNameToFi
nd : 6904
Fri Sep 26 20:23:17 2014 [isUserInDico] found in the dictionnary.
Fri Sep 26 20:23:17 2014 [CGwServAuthenticate::isUserDeclared] found in the dic
tionnary.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] contact : sip
:6904@10.246.100.217:5069
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] nb available
licenses=9999 .
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0
and pSipAddSpec->getHost()=10.246.100.217
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] contact nb=13
9445432
Fri Sep 26 20:23:17 2014 [CGWMngDat a::isMainServer] CPU is MAIN.
1411748597 -> Fri Sep 26 20:23:17 2014 [CGWMngDat a::isMainServer] checkwith PCS
= 0
Fri Sep 26 20:23:17 2014 1113[CMotorCall::isTLSProtRequiredForExtGw] =0.
Fri Sep 26 20:23:17 2014 SEND MESSAGE TO NETWORK (10.246.100.217:5069 [UDP]) (BU
FF LEN = 931)
----------------------utf8-----------------------
INVITE sip:6904@10.246.100.217:5069 SIP/2.0
Allow: INVITE, ACK, CANCEL, BYE, PRACK, NOTIFY, REFER, SUBSCRIBE, OPTIONS, UPDAT
E, INFO
Supported: replaces,timer,path
User-Agent: OmniPCX Enterprise R11.0.1 k1.520.29.e
Session-Expires: 1800;refresher=uac
Min-SE: 900
Content-Type: application/sdp
To: <sip:6904@node_isod_32;user=phone>
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
Contact: <sip:6901@172.16.245.76;transport=UDP>
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
CSeq: 66498149 INVITE
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
Max-Forwards: 70
Content-Length: 240
v=0
o=OXE 1411748597 1411748597 IN IP4 172.16.245.76
s=abs
c=IN IP4 10.246.100.240
t=0 0
m=audio 32514 RTP/AVP 18 97
a=sendrecv
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=maxptime:40
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
Fri Sep 26 20:23:17 2014 [CForkedBranch::CForkedBranch] context = 0x84fbd9c.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::branchAllocation] pForkedBranch = 0x84
fa2e8 and the branch number is.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::makeInitialMotorRequest] reqUri duplic
ation pForkedBranch = 0x84fa2e8.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::setCurrentState] NOE-SIP
: sendBackupUpdate Msg not sent to twin CS
Fri Sep 26 20:23:17 2014 NOE-SIP : StandByCallCreation not sent to twin CS
Fri Sep 26 20:23:17 2014 [onIncomingEvent] CallID must be inserted.
Fri Sep 26 20:23:17 2014 [onIncomingEvent] CallID inserted.
Fri Sep 26 20:23:17 2014 [exec_ipc] in end 4036.
Fri Sep 26 20:23:17 2014 RECEIVE MESSAGE FROM NETWORK (10.246.100.217:5069 [UDP]
)
----------------------utf8-----------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
To: <sip:6904@node_isod_32;user=phone>
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
CSeq: 66498149 INVITE
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, ME
SSAGE
Content-Length: 0
-------------------------------------------------
Fri Sep 26 20:23:17 2014 1113[CMotorCall::searchForkedBranch]pForkedBranch=0x84f
a2e8.
Fri Sep 26 20:23:17 2014 [receiveInformationalMessage] Call: dc76e98d7acbe652d76
148142977d698@172.16.245.76 eqt: 912 PROCEEDING_STATE received a message.
Fri Sep 26 20:23:17 2014 [CPoceedingState::receiveInformationalMessage]-->nof of
PEM hdrs 0
Fri Sep 26 20:23:17 2014 [receiveInformationalMessage] No P-Early-Media header r
eceived
Fri Sep 26 20:23:17 2014 [receiveInformationalMessage] is in the else part of SD
P not present
Fri Sep 26 20:23:17 2014 RECEIVE MESSAGE FROM NETWORK (10.246.100.217:5069 [UDP]
)
----------------------utf8-----------------------
SIP/2.0 480 Temporarily not available
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
To: <sip:6904@node_isod_32;user=phone>;tag=853018002
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
CSeq: 66498149 INVITE
Contact: <sip:6904@10.246.100.217:5069>
Server: Greenlite ATOM V2.0
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0
-------------------------------------------------
1411748597 -> Fri Sep 26 20:23:17 2014 SEND MESSAGE TO NETWORK (10.246.100.217:5069 [UDP])
(BUFF LEN = 376)
----------------------utf8-----------------------
ACK sip:6904@10.246.100.217:5069 SIP/2.0
Call-ID: dc76e98d7acbe652d76148142977d698@172.16.245.76
From: "Node 32 6901 IP Test" <sip:6901@172.16.245.76;user=phone>;tag=a8f5c656a92
b64c82d4c688ce0676b87
To: <sip:6904@node_isod_32;user=phone>;tag=853018002
Via: SIP/2.0/UDP 172.16.245.76;branch=z9hG4bK5c23054921fe752c37990d52a7561541
CSeq: 66498149 ACK
Content-Length: 0
-------------------------------------------------
Fri Sep 26 20:23:17 2014 1113[CMotorCall::searchForkedBranch]pForkedBranch=0x84f
a2e8.
Fri Sep 26 20:23:17 2014 [CForkedBranch::setFinalResponse] response=480.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] no response
to the CH m_cancelSent=0.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] all response
s are received 1.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] call chooseB
estResponse.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::chooseBestResponse] pForkedBranch=0x84
fa2e8 iResponseCode=2000.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::chooseBestResponse] last iResponseCode
=480.
Fri Sep 26 20:23:17 2014 [CForkedBranch::setFinalResponse] pResponse=0x8
504018.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::chooseBestResponse] next branch.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::responseToInviteOrCancel] inviteRespon
se => update the lastInviteContext.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::updateTransportfromlastI
nviteContext] lasInviteContext Start
Fri Sep 26 20:23:17 2014 [receiveRequestFailureMessage] Call: dc76e98d7acbe652d7
6148142977d698@172.16.245.76 eqt: 912 PROCEEDING_STATE received a message.
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] content size (lginfo): 660 cca
l crypted= 0
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] CAC = 0 eqtCAC = -1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] displayIPCMessageOut
Fri Sep 26 20:23:17 2014 ** SIP DEVICE **
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [ipc_thread] Normal case : evt 10773
Fri Sep 26 20:23:17 2014 [ipc_thread] IPC Thread : Ipc reception 4037.
Fri Sep 26 20:23:17 2014 [ipc_thread] IPC Thread : TCL thread signaled.
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 Id : -1
Fri Sep 26 20:23:17 2014 REQUEST FAILURE
Fri Sep 26 20:23:17 2014 xx : 80
Fri Sep 26 20:23:17 2014 RELATIVE REQUEST : INVITE
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------- End ----------------
Fri Sep 26 20:23:17 2014 1113[CMotorCall::setCurrentState] NOE-SIP : sendBackupU
pdate Msg not sent to twin CS
Fri Sep 26 20:23:17 2014 1113[CMotorCall::onReceiveResponse] retrans=0, status=4
80 extGw=1000.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::onReceiveResponse] INVITE case => canc
elAllCancelableForkedBranch.
1411748597 -> Fri Sep 26 20:23:17 2014 1113[CMotorCall::cancelAllCancelableForke
dBranch] nb branch=1.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::cancelAllCancelableForkedBranch] retra
ns=0.
Fri Sep 26 20:23:17 2014 [exec_ipc] in 4036.
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 neqt : 912 Id : -1
Fri Sep 26 20:23:17 2014 SIP EQT RELEASED
Fri Sep 26 20:23:17 2014 [display_ipc_in] ------------- End ----------------
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] an event 10773 arr
ived on the eqt 912 -1.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] The call with eqt:
912 has released its equipment.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::emitSipEqtReleaseAck] SIP_EQT_RELEASE_
ACK
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] content size (lginfo): 660 cca
l crypted= 0
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel]1 T38 REINVITE TRUE
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] CAC = 0 eqtCAC = -1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] cacUsed=0 eqtCac=-1
Fri Sep 26 20:23:17 2014 1113[emitEventToMonitel] displayIPCMessageOut
Fri Sep 26 20:23:17 2014 ** SIP DEVICE **
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [sendLgEvtSip] Event sent on eqt : 912 Id :-1
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------ Begin ---------------
Fri Sep 26 20:23:17 2014 Id : -1
Fri Sep 26 20:23:17 2014 SIP_EQT_RELEASE_ACK
Fri Sep 26 20:23:17 2014 [display_ipc_out] ------------- End ----------------
1411748601 -> Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] stat
e = TERMINATED_STATE.
Fri Sep 26 20:23:17 2014 1113[CMotorCall::setCurrentState] NOE-SIP : sendBackupU
pdate Msg not sent to twin CS
Fri Sep 26 20:23:17 2014 1113[CMotorCall::unRegister] Remove eqt : 912 diag : -1
from the map.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::eraseCallwithEqt] erase 912 -1.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onIncomingEvent] killSession.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onNotifyCallClosed] Call : dc76e98d
7acbe652d76148142977d698@172.16.245.76 is closed.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onNotifyCallClosed] Call : dc76e98d
7acbe652d76148142977d698@172.16.245.76 is closed.
Fri Sep 26 20:23:17 2014 [CMotorCallManager::onNotifyCallClosed] Remove eqt from
the map.
Fri Sep 26 20:23:17 2014 [exec_ipc] in end 4036.
Fri Sep 26 20:23:19 2014 1113 [CMotorCall::clear_subscription] no subscription m
anaged
Fri Sep 26 20:23:19 2014 1113[CMotorCall::~CMotorCall] Call : dc76e98d7acbe652d7
6148142977d698@172.16.245.76 is being destructed.
