Пользователь:
errorIP-адрес скрыт
Дата: 23.06.2009 15:57
Re: исходящий по SIP
sip TG прописана как isdn
звонок идет через ars
до вчерашнего дня выудить инфу как настроить sip-gateway практически не удавалось пока не пригрозили что откажемся от gateway, в это их спецы взялись за настройку этого самого gateway. честно говоря настройка gateway очень паразила меня т.е. звонок пришедший на voip плату gateway-я сперва пробегает через виртуальную Isdn плату и затем уж идет на нужный порт
фрагмент из лога
13:32:18,039849 16383 82 cctl_allocRTPportBIGSW find transcoding port 65535
13:32:18,040109 16383 82 cctl_allocRTPportBIGSW ERROR find transcoding port
вот как раз 2-ая строчка должна ссылаться на виртуальный isdn порт
в данный момент звонок проходит но обмена голосового трафика нет
--------------------------------
трасса с атс
1245738753 -> [ipc_thread] IPC Thread : Ipc reception.
1245738753 -> [ipc_thread] IPC Thread : TCL thread signaled.
1245738753 -> [exec_ipc] in.
1245738753 -> [display_ipc_in] ------------ Begin ---------------
1245738753 -> neqt : 716
1245738753 -> INVITE
1245738753 -> REQUEST URI : <> 5338813@172.16.1.9:5060 ; user=phone
1245738753 -> FROM : <7407> 7407@172.16.1.3:5060 ; user=name
1245738753 -> TO : <> 5338813@172.16.1.9:5060 ; user=phone
1245738753 -> CAC : 0
1245738753 -> neqt CAC : -1
1245738753 -> CLIR : 0
1245738753 -> SDP :
1245738753 -> ADDRESS : 172.16.1.4 :32520
1245738753 -> ALGOS :
1245738753 -> PCMA
1245738753 -> PCMU
1245738753 -> G729
1245738753 -> 97
1245738753 -> DIRECTION : SEND & RECEIVE
1245738753 -> N_GW_EXT : 0
1245738753 -> [display_ipc_in] ------------- End ----------------
1245738753 -> [CMotorCallManager::onIncomingEvent] an event 10752 arrived on the eqt 716.
1245738753 -> [CMotorCallManager::onIncomingEvent] New Call created.
1245738753 -> [CMotorCallManager::callFactory].
1245738753 -> [CMotorCallManager::callFactory]=83aad10.
1245738753 -> [CMotorCallManager::onIncomingEvent] eqt=716.
1245738753 -> [CMotorCallManager::insertCallwithEqt] CMotorCall 716 inserted.
1245738753 -> [CMotorCallManager::onIncomingEvent] state = INITIAL_STATE.
1245738753 -> [onIncomingEvent] INVITE arrived.
1245738753 -> [receiveInviteEvent] Call: eqt: 716 INITIAL_STATE received an event.
1245738753 -> 110e[CMotorCall::emitInviteMessage] begin.
1245738753 -> [isValidGwExt] ext gw 0 is valid
1245738753 -> [quoteString] => "7407"
1245738753 -> 110e[CMotorCall::inviteBuildAurlWithoutBelongingDomain] P-Asserted-Identity: "7407" <sip:7407@172.16.1.3>
1245738753 -> 110e[CMotorCall::emitInviteMessage] From: "7407" <sip:7407@172.16.1.3>
1245738753 -> 110e[CMotorCall::emitInviteMessage] reqUri :sip:5338813@172.16.1.9;user=phone
1245738753 -> 110e[CMotorCall::inviteBuildSupportedHeader] Invite directed to external gw : 0
1245738753 -> 110e[CMotorCall::emitInviteMessage] Request Uri : sip:5338813@172.16.1.9;user=phone
1245738753 -> 110e[CMotorCall::emitInviteMessage] To: <sip:5338813@172.16.1.9;user=phone>
1245738753 -> 110e[CMotorCall::emitInviteMessage] Contact: sip:172.16.1.3
1245738753 -> 110e[CMotorCall::makeRequestSdp] Begin sdp : v=0
o=OXE 1245738753 1245738753 IN IP4 172.16.1.3
s=-
c=IN IP4 0.0.0.0
t=0 0
.
1245738753 -> 110e[CMotorCall::makeRequestSdp] Direction: 0.
1245738753 -> 110e[CMotorCall::makeResponseSdp] format 97
1245738753 -> 110e[CMotorCall::makeRequestSdp] Final sdp: v=0
o=OXE 1245738753 1245738753 IN IP4 172.16.1.3
s=abs
c=IN IP4 172.16.1.4
t=0 0
m=audio 32520 RTP/AVP 8 0 18 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:0 PCMU/8000
a=ptime:20
a=maxptime:30
a=rtpmap:18 G729/8000
a=ptime:20
a=maxptime:40
a=rtpmap:97 telephone-event/8000
.
1245738753 -> 110e[CMotorCall::emitInviteMessage] The sdp build: .
1245738753 -> 110e[CMotorCall::new_determineTargetsForTheRequest] is not Responsible For This URI.
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] nb contacts=1.
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] *pcszNameToFind : 5338813
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest]-->extGw=0
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] contact : sip:5338813@172.16.1.9;user=phone
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] nb available licenses=99999 .
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] req_Uri_OK=0
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest]-->pSipAddSpec->getHost()=172.16.1.9
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] user= 5338813
1245738753 -> [CGWMngData::isMainServer] CPU is MAIN.
1245738753 -> 110e [CCall::makeGenericRequest] INVITE
1245738753 -> 110e [CCall::getDialog] Confirmed Dialog is not found (ID = ;)
1245738753 -> 110e [CCall::getDialog] Returning Initial Dialog Client
1245738753 -> 1515 [CDialog::createRequest]
1245738753 -> 1515 [CDialog::buildServicesForAllRequest]
1245738753 -> 1515 [CDialog::createInviteRequest]
1245738753 -> 211c [CTransaction::changeState] STATE CHANGED TO INITIAL
1245738753 -> 211c [CTransaction::changeState] notifying the parent dialog
1245738753 -> 1515 [CDialog::onTransactionState(pTrans = 211c, previousState = Terminated, currentState = Initial, reason = None]
1245738753 -> 22 [CRequest::CRequest] Creation of a request
1245738753 -> 22 [CMessage::send] sip_sendMessage (172.16.1.9:5060)
1245738753 -> SEND MESSAGE TO NETWORK (172.16.1.9:5060 [UDP]) (BUFF LEN = 835)
----------------------utf8-----------------------
INVITE sip:5338813@172.16.1.9;user=phone SIP/2.0
Supported: replaces,100rel
User-Agent: ABS GW v5.1.0
P-Asserted-Identity: "7407" <sip:7407@172.16.1.3>
Content-Type: application/sdp
To: <sip:5338813@172.16.1.9;user=phone>
From: "7407" <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
Contact: sip:172.16.1.3
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 635538580 INVITE
Via: SIP/2.0/UDP 172.16.1.3;branch=z9hG4bK1ac9cf303e2c6aa3ecc983273712f8ee
Max-Forwards: 70
Content-Length: 314
v=0
o=OXE 1245738753 1245738753 IN IP4 172.16.1.3
s=abs
c=IN IP4 172.16.1.4
t=0 0
m=audio 32520 RTP/AVP 8 0 18 97
a=sendrecv
a=rtpmap:8 PCMA/8000
a=ptime:20
a=maxptime:30
a=rtpmap:0 PCMU/8000
a=ptime:20
a=maxptime:30
a=rtpmap:18 G729/8000
a=ptime:20
a=maxptime:40
a=rtpmap:97 telephone-event/8000
-------------------------------------------------
1245738753 -> 211c [CTransInitialState::createRequest] Transaction changes to Calling state
1245738753 -> 211c [CTransaction::changeState] STATE CHANGED TO CALLING
1245738753 -> 211c [CTransaction::changeState] notifying the parent dialog
1245738753 -> 1515 [CDialog::onTransactionState(pTrans = 211c, previousState = Initial, currentState = Calling, reason = Request creation]
1245738753 -> 211c [CTransaction::startTimer] Timer A is started (delay = 500 ms)
1245738753 -> 211c [CTransaction::startTimer] Timer B is started (delay = 32000 ms)
1245738753 -> [---*--- SESSION-TIMER ---*---] New CSessionTimerContext from request (Client, UA)
1245738753 -> [---*--- SESSION-TIMER ---*---] Update CSessionTimerContext (refresh creation)
1245738753 -> 110e[CMotorCall::makeInitialMotorRequest] nb contact=1.
1245738753 -> [CForkedBranch::CForkedBranch] context = 0x83aae04.
1245738753 -> 110e[CMotorCall::branchAllocation] built branch number=1.
1245738753 -> [onIncomingEvent] CallID must be inserted.
1245738753 -> [onIncomingEvent] CallID inserted.
1245738754 -> RECEIVE MESSAGE FROM NETWORK (172.16.1.9:50195 [UDP])
----------------------utf8-----------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.1.3;branch=z9hG4bK1ac9cf303e2c6aa3ecc983273712f8ee
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 635538580 INVITE
From: "7407" <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
To: <sip:5338813@172.16.1.9;user=phone>;tag=top7eaca361
Contact: <sip:5338813@172.16.1.9:5060>
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO,UPDATE,REFER,SUBSCRIBE,NOTIFY,PUBLISH
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1245738754 -> [CIOCom::receiveResponse] CResponse 2C ref=1
1245738754 -> [CDispatcher::onIncomingResponse]
1245738754 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1245738754 -> 102 [CCallManager::onIncomingResponse]
1245738754 -> 110e [CCall::receiveResponse] 100
1245738754 -> 110e [CCall::receiveResponse]Trying to find the right dialog
1245738754 -> 110e [CCall::getDialog] Confirmed Dialog is not found (ID = 86dc8343e89f40424027da4702cad252;top7eaca361)
1245738754 -> 110e [CCall::receiveResponse]One dialog found
1245738754 -> 1515 [CDialog::receiveResponse]
1245738754 -> 211c [CTransCallingState::receiveResponse] Provisional : Transaction changes to Proceeding state
1245738754 -> 211c [CTransaction::changeState] STATE CHANGED TO PROCEEDING
1245738754 -> 211c [CTransaction::changeState] notifying the parent dialog
1245738754 -> 1515 [CDialog::onTransactionState(pTrans = 211c, previousState = Calling, currentState = Proceeding, reason = 1xx response reception]
1245738754 -> 211c [CTransaction::freeTimerToken] Timer A is freed
1245738754 -> 211c [CTransaction::freeTimerToken] Timer B is freed
1245738754 -> 110e[CMotorCall::searchForkedBranch]pForkedBranch=0x839e688.
1245738754 -> [receiveInformationalMessage] Call: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 eqt: 716 PROCEEDING_STATE received a message.
1245738756 -> RECEIVE MESSAGE FROM NETWORK (172.16.1.9:50195 [UDP])
----------------------utf8-----------------------
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 172.16.1.3;branch=z9hG4bK1ac9cf303e2c6aa3ecc983273712f8ee
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 635538580 INVITE
From: "7407" <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
To: <sip:5338813@172.16.1.9;user=phone>;tag=top7eaca361
Contact: <sip:5338813@172.16.1.9:5060>
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO,UPDATE,REFER,SUBSCRIBE,NOTIFY,PUBLISH
Max-Forwards: 70
Content-Type: application/sdp
Content-Length: 141
v=0
o=root 386787 386787 IN IP4 172.16.1.9
s=Topex
c=IN IP4 172.16.1.9
t=0 0
m=audio 32518 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=sendrecv
-------------------------------------------------
1245738756 -> [CIOCom::receiveResponse] CResponse 2D ref=1
1245738756 -> [CDispatcher::onIncomingResponse]
1245738756 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1245738756 -> 102 [CCallManager::onIncomingResponse]
1245738756 -> 110e [CCall::receiveResponse] 183
1245738756 -> 110e [CCall::receiveResponse]Trying to find the right dialog
1245738756 -> 110e [CCall::getDialog] Confirmed Dialog is not found (ID = 86dc8343e89f40424027da4702cad252;top7eaca361)
1245738756 -> 110e [CCall::receiveResponse]One dialog found
1245738756 -> 1515 [CDialog::receiveResponse]
1245738756 -> 2C [~CResponse] resp(100) c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 635538580 INVITE
1245738756 -> 1515 [CDialog::updateRouteSet] there are 0 record-route headers
1245738756 -> 110e[CMotorCall::searchForkedBranch]pForkedBranch=0x839e688.
1245738756 -> [receiveInformationalMessage] Call: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 eqt: 716 PROCEEDING_STATE received a message.
1245738756 -> [checkSdpValidity] Sdp contains 1 media description(s).
1245738756 -> [checkSdpValidity] Media 0 type 1 contains 1 formats.
1245738756 -> [checkSdpValidity] Format : 8.
1245738756 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1245738756 -> [convertSdpIntoTsdp] The audio media contains 1 format(s).
1245738756 -> [convertSdpIntoTsdp] Format 0 is 8.
1245738756 -> [convertSdpIntoTsdp] Get the direction.
1245738756 -> [convertSdpIntoTsdp] Direction is sendrecv.
1245738756 -> [convertSdpIntoTsdp] The connection is at session level.
1245738756 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 172.16.1.9.
1245738756 -> [convertIPStrIntoTuipv] 172.16.1.9 => 172.16.1.9
1245738756 -> 110e[CMotorCall::emitEventToMonitel] content size (lginfo): 652
1245738756 -> 110e[CMotorCall::emitEventToMonitel] CAC = 0 eqtCAC = -1
1245738756 -> 110e[CMotorCall::emitEventToMonitel] CAC = 0
1245738756 -> 110e[CMotorCall::emitEventToMonitel] Event sent on eqt : 716
1245738756 -> [display_ipc_out] ------------ Begin ---------------
1245738756 -> INFORMATIONAL
1245738756 -> xx : 83
1245738756 -> RELATIVE REQUEST : INVITE
1245738756 -> SDP :
1245738756 -> ADDRESS : 172.16.1.9 :32518
1245738756 -> ALGOS :
1245738756 -> PCMA
1245738756 -> DIRECTION : SEND & RECEIVE
1245738756 -> [display_ipc_out] ------------- End ----------------
1245738760 -> RECEIVE MESSAGE FROM NETWORK (172.16.1.9:50195 [UDP])
----------------------utf8-----------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.1.3;branch=z9hG4bK1ac9cf303e2c6aa3ecc983273712f8ee
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 635538580 INVITE
From: "7407" <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
To: <sip:5338813@172.16.1.9;user=phone>;tag=top7eaca361
Contact: <sip:5338813@172.16.1.9:5060>
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO,UPDATE,REFER,SUBSCRIBE,NOTIFY,PUBLISH
Max-Forwards: 70
Content-Type: application/sdp
Content-Length: 141
v=0
o=root 529264 529264 IN IP4 172.16.1.9
s=Topex
c=IN IP4 172.16.1.9
t=0 0
m=audio 32518 RTP/AVP 8
a=rtpmap:8 PCMA/8000
a=sendrecv
-------------------------------------------------
1245738760 -> [CIOCom::receiveResponse] CResponse 2E ref=1
1245738760 -> [CDispatcher::onIncomingResponse]
1245738760 -> [CDispatcher::processResponseFromManagerIndex] start at index 0
1245738760 -> 102 [CCallManager::onIncomingResponse]
1245738760 -> 110e [CCall::receiveResponse] 200
1245738760 -> 110e [CCall::receiveResponse]Trying to find the right dialog
1245738760 -> 110e [CCall::getDialog] Confirmed Dialog is not found (ID = 86dc8343e89f40424027da4702cad252;top7eaca361)
1245738760 -> 110e [CCall::receiveResponse]One dialog found
1245738760 -> 1515 [CDialog::receiveResponse]
1245738760 -> 1515 [CDialog::receiveResponse] create a CONFIRMED dialog
1245738760 -> 1516 [CDialog::CDialog] look for the transaction #0, transaction key = z9hG4bK1ac9cf303e2c6aa3ecc983273712f8ee
1245738760 -> 1516 [CDialog::CDialog] copy the transaction #0, transaction key = z9hG4bK1ac9cf303e2c6aa3ecc983273712f8ee
1245738760 -> 211d [CTransaction::CTransaction] Transaction is cloned in 4 state
1245738760 -> 1516 [CDialog::startDialogTTL]
1245738760 -> 1516 [CDialog::receiveResponse]
1245738760 -> 211d [CTransProceedingState::receiveResponse] Final : Transaction changes to Completed state
1245738760 -> 211d [CTransaction::changeState] STATE CHANGED TO COMPLETED
1245738760 -> 211d [CTransaction::changeState] notifying the parent dialog
1245738760 -> 1516 [CDialog::onTransactionState(pTrans = 211d, previousState = Proceeding, currentState = Completed, reason = Final resp reception]
1245738760 -> 211d [CTransaction::startTimer] Timer D is started (delay = 32361 ms)
1245738760 -> [---*--- SESSION-TIMER ---*---] New CSessionTimerContext from response (Client, UA)
1245738760 -> [---*--- SESSION-TIMER ---*---] Update CSessionTimerContext (response refresh reception)
1245738760 -> [---*--- SESSION-TIMER ---*---] No refresh
1245738760 -> 1516 [CDialog::updateRouteSet] there are 0 record-route headers
1245738760 -> 110e [CCall::insertInDialogMap] added dialog #1516 with the key 86dc8343e89f40424027da4702cad252;top7eaca361
1245738760 -> 1515 [CDialog::updateRouteSet] there are 0 record-route headers
1245738760 -> 110e[CMotorCall::searchForkedBranch]pForkedBranch=0x839e688.
1245738760 -> [CForkedBranch::setFinalResponse] pResponse=0x839c230.
1245738760 -> [CForkedBranch::setFinalResponse] response=200.
1245738760 -> 110e[CMotorCall::responseToInviteOrCancel] call chooseBestResponse.
1245738760 -> 110e[CMotorCall::chooseBestResponse] pForkedBranch=0x839e688 iResponseCode=2000.
1245738760 -> [CForkedBranch::getResponseCode] response=200.
1245738760 -> [CForkedBranch::getResponseCode] response=200.
1245738760 -> 110e[CMotorCall::chooseBestResponse] last iResponseCode=200.
1245738760 -> [CForkedBranch::setFinalResponse] pResponse=0x839c230.
1245738760 -> 110e[CMotorCall::chooseBestResponse] next branch.
1245738760 -> 110e[CMotorCall::responseToInviteOrCancel] inviteResponse => update the lastInviteContext.
1245738760 -> [receiveSuccessfulMessage] Call: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 eqt: 716 PROCEEDING_STATE received a message.
1245738760 -> [checkSdpValidity] Sdp contains 1 media description(s).
1245738760 -> [checkSdpValidity] Media 0 type 1 contains 1 formats.
1245738760 -> [checkSdpValidity] Format : 8.
1245738760 -> [convertSdpIntoTsdp] Sdp contains 1 media description(s).
1245738760 -> [convertSdpIntoTsdp] default T38 config.
1245738760 -> [convertSdpIntoTsdp] The audio media contains 1 format(s).
1245738760 -> [convertSdpIntoTsdp] Format 0 is 8.
1245738760 -> [convertSdpIntoTsdp] Get the direction.
1245738760 -> [convertSdpIntoTsdp] Direction is sendrecv.
1245738760 -> [convertSdpIntoTsdp] The connection is at session level.
1245738760 -> [convertSdpIntoTsdp] Connection address retrieved in sdp: 172.16.1.9.
1245738760 -> [convertIPStrIntoTuipv] 172.16.1.9 => 172.16.1.9
1245738760 -> 110e[CMotorCall::emitEventToMonitel] content size (lginfo): 652
1245738760 -> 110e[CMotorCall::emitEventToMonitel] CAC = 0 eqtCAC = -1
1245738760 -> 110e[CMotorCall::emitEventToMonitel] CAC = 0
1245738760 -> [ipc_thread] IPC Thread : Ipc reception.
1245738760 -> [ipc_thread] IPC Thread : TCL thread signaled.
1245738760 -> 110e[CMotorCall::emitEventToMonitel] Event sent on eqt : 716
1245738760 -> [display_ipc_out] ------------ Begin ---------------
1245738760 -> SUCCESSFUL
1245738760 -> xx : 0
1245738760 -> RELATIVE REQUEST : INVITE
1245738760 -> CLIR : 0
1245738760 -> COLP : 0
1245738760 -> SDP :
1245738760 -> ADDRESS : 172.16.1.9 :32518
1245738760 -> ALGOS :
1245738760 -> PCMA
1245738760 -> DIRECTION : SEND & RECEIVE
1245738760 -> [display_ipc_out] ------------- End ----------------
1245738760 -> 110e[CMotorCall::onReceiveResponse] INVITE case => cancelAllCancelableForkedBranch.
1245738760 -> 110e[CMotorCall::cancelAllCancelableForkedBranch] nb branch=1.
1245738760 -> [CForkedBranch::getResponseCode] response=200.
1245738760 -> [CForkedBranch::getResponseCode] response=200.
1245738760 -> [exec_ipc] in.
1245738760 -> [display_ipc_in] ------------ Begin ---------------
1245738760 -> neqt : 716
1245738760 -> ACK
1245738760 -> [display_ipc_in] ------------- End ----------------
1245738760 -> [CMotorCallManager::onIncomingEvent] an event 10754 arrived on the eqt 716.
1245738760 -> [CMotorCallManager::onIncomingEvent] state = ACCEPTED_STATE.
1245738760 -> [onIncomingEvent] ACK arrived.
1245738760 -> [receiveAckEvent] Call: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 eqt: 716 ACCEPTED_STATE received an event.
1245738760 -> 110e[CMotorCall::emitAckMessage] begin.
1245738760 -> 110e[CMotorCall::emitAckMessage] SDP ok.
1245738760 -> 110e [CCall::makeGenericRequest] ACK
1245738760 -> 110e [CCall::getDialog] Confirmed Dialog found
1245738760 -> 1516 [CDialog::createRequest]
1245738760 -> 1516 [CDialog::buildServicesForAllRequest]
1245738760 -> 1516 [CDialog::createAckRequest]
1245738760 -> 1516 [CDialog::createAckRequest], previous trans 211d is found
1245738760 -> 1516 [CDialog::createAckRequest], previous trans 211d is client
1245738760 -> 23 [CRequest::CRequest] Creation of a request
1245738760 -> 1516 [CDialog::buildServicesForAck]
1245738760 -> 23 [CMessage::send] sip_sendMessage (172.16.1.9:5060)
1245738760 -> SEND MESSAGE TO NETWORK (172.16.1.9:5060 [UDP]) (BUFF LEN = 413)
----------------------utf8-----------------------
ACK sip:5338813@172.16.1.9:5060 SIP/2.0
Contact: sip:172.16.1.3
User-Agent: ABS GW v5.1.0
To: <sip:5338813@172.16.1.9;user=phone>;tag=top7eaca361
From: "7407" <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 635538580 ACK
Via: SIP/2.0/UDP 172.16.1.3;branch=z9hG4bK7e9a8303002a2dd7b73012f48dc664fc
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1245738760 -> 211d [CTransaction::changeState] STATE CHANGED TO TERMINATED
1245738760 -> 211d [CTransaction::freeTimerToken] Timer D is freed
1245738760 -> 211d [CTransaction::changeState] no transaction state
1245738760 -> 1516 [CDialog::createAckRequest] successful INVITE is terminated after the ACK is sent
1245738760 -> [CTransaction::notifyDialog]
1245738760 -> [CTransaction::notifyDialog] notify parent dialog
1245738760 -> 1516 [CDialog::onTransactionState(pTrans = 211d, previousState = null, currentState = Terminated, reason = Request creation]
1245738769 -> RECEIVE MESSAGE FROM NETWORK (172.16.1.9:50195 [UDP])
----------------------utf8-----------------------
BYE sip:172.16.1.3 SIP/2.0
Via: SIP/2.0/UDP 172.16.1.9:5060;branch=z9hG4bK72d9de66
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 1 BYE
From: <sip:5338813@172.16.1.9:5060>;tag=top7eaca361
To: <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
Reason: Q.850 ;cause=16 ;text="Normal call clearing"
Supported: timer,replaces
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,INFO,UPDATE,REFER,SUBSCRIBE,NOTIFY,PUBLISH
Max-Forwards: 70
Content-Length: 0
-------------------------------------------------
1245738769 -> 24 [CRequest::CRequest] Creation of a request (RECEIVED FROM NETWORK)
1245738769 -> [CIOCom::receiveRequest] Received CRequest 24 ref=1
1245738769 -> [CDispatcher::onIncomingRequest()]
1245738769 -> [CDispatcher::processRequestFromManagerIndex()] start at index 0
1245738769 -> 102 [CCallManager::onIncomingRequest()]
1245738769 -> 110e [CCall::receiveRequest] BYE
1245738769 -> 110e [CCall::getDialog] Confirmed Dialog found
1245738769 -> 1516 [CDialog::receiveRequest]
1245738769 -> 1516 [CDialog::receiveBasicRequest]
1245738769 -> 211e [CTransaction::changeState] STATE CHANGED TO INITIAL
1245738769 -> 211e [CTransaction::changeState] notifying the parent dialog
1245738769 -> 1516 [CDialog::onTransactionState(pTrans = 211e, previousState = Terminated, currentState = Initial, reason = None]
1245738769 -> 211e [CTransInitialState::receiveRequest] Transaction changes to Trying state
1245738769 -> 211e [CTransaction::changeState] STATE CHANGED TO TRYING
1245738769 -> 211e [CTransaction::changeState] notifying the parent dialog
1245738769 -> 1516 [CDialog::onTransactionState(pTrans = 211e, previousState = Initial, currentState = Trying, reason = Request reception]
1245738769 -> [---*--- SESSION-TIMER ---*---] Free CSessionTimerContext
1245738769 -> 110e [CCall::checkAuthentication] BYE
1245738769 -> 110e[CMotorCall::controlAuthentication] ---*--- AUTH ---*--- Control authentication
1245738769 -> 110e[CMotorCall::controlAuthentication] ---*--- END ---*--- Control authentication
1245738769 -> 110e[CMotorCall::toGatewayOrProxy] request for proxydomain=172.16.1.3.
1245738769 -> [isUserRegistred] result=-1.
1245738769 -> 110e[CMotorCall::onReceiveRequest] request for gateway.
1245738769 -> 110e[CMotorCall::onReceiveRequest] state = COMPLETED_STATE.
1245738769 -> [receiveByeMessage] Call: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 eqt: 716 COMPLETED_STATE received a message.
1245738769 -> 110e[CMotorCall::emitEventToMonitel] content size (lginfo): 652
1245738769 -> 110e[CMotorCall::emitEventToMonitel] CAC = 0 eqtCAC = -1
1245738769 -> 110e[CMotorCall::emitEventToMonitel] CAC = 0
1245738769 -> [ipc_thread] IPC Thread : Ipc reception.
1245738769 -> [ipc_thread] IPC Thread : TCL thread signaled.
1245738769 -> 110e[CMotorCall::emitEventToMonitel] Event sent on eqt : 716
1245738769 -> [display_ipc_out] ------------ Begin ---------------
1245738769 -> BYE
1245738769 -> [display_ipc_out] ------------- End ----------------
1245738769 -> [exec_ipc] in.
1245738769 -> [display_ipc_in] ------------ Begin ---------------
1245738769 -> neqt : 716
1245738769 -> SUCCESSFUL
1245738769 -> xx : 0
1245738769 -> RELATIVE REQUEST : BYE
1245738769 -> CLIR : 0
1245738769 -> COLP : 0
1245738769 -> [display_ipc_in] ------------- End ----------------
1245738769 -> [CMotorCallManager::onIncomingEvent] an event 10765 arrived on the eqt 716.
1245738769 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1245738769 -> [onIncomingEvent] SUCCESSFUL arrived.
1245738769 -> [receiveSuccessfulEvent] Call: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 eqt: 716 TERMINATED_STATE received an event.
1245738769 -> 110e [CCall::findFirstServerTrans]
1245738769 -> 1516 [CCall::findFirstServerTrans]
1245738769 -> 1516 [CCallLeg::findFirstOpenServerTrans] Current Request in transactionMapByBranch
1245738769 -> 110e [CCall::makeGenericResponse] 200
1245738769 -> 110e [CCall::getDialog] Confirmed Dialog found
1245738769 -> 1516 [CDialog::createResponse] 200
1245738769 -> 211e [CTransTryingState::createResponse] CResponse 2F ref=1
1245738769 -> 2F [CMessage::send] sip_sendMessage (172.16.1.9:5060)
1245738769 -> SEND MESSAGE TO NETWORK (172.16.1.9:5060 [UDP]) (BUFF LEN = 401)
----------------------utf8-----------------------
SIP/2.0 200 OK
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, SUBSCRIBE, OPTIONS
Supported: replaces,100rel
User-Agent: ABS GW v5.1.0
To: <sip:7407@172.16.1.3>;tag=86dc8343e89f40424027da4702cad252
From: <sip:5338813@172.16.1.9:5060>;tag=top7eaca361
Call-ID: c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3
CSeq: 1 BYE
Via: SIP/2.0/UDP 172.16.1.9:5060;branch=z9hG4bK72d9de66
Content-Length: 0
-------------------------------------------------
1245738769 -> 211e [CTransTryingState::createResponse] Final : Transaction changes to Completed state
1245738769 -> 211e [CTransaction::changeState] STATE CHANGED TO COMPLETED
1245738769 -> 211e [CTransaction::changeState] notifying the parent dialog
1245738769 -> 1516 [CDialog::onTransactionState(pTrans = 211e, previousState = Trying, currentState = Completed, reason = Final resp creation]
1245738769 -> 211e [CTransaction::startTimer] Timer J is started (delay = 32000 ms)
1245738769 -> 1516 [CDialog::updateRouteSet] there are 0 record-route headers
1245738769 -> [ipc_thread] IPC Thread : Ipc reception.
1245738769 -> [ipc_thread] IPC Thread : TCL thread signaled.
1245738769 -> [exec_ipc] in.
1245738769 -> [display_ipc_in] ------------ Begin ---------------
1245738769 -> neqt : 716
1245738769 -> SIP EQT RELEASED
1245738769 -> [display_ipc_in] ------------- End ----------------
1245738769 -> [CMotorCallManager::onIncomingEvent] an event 10773 arrived on the eqt 716.
1245738769 -> [CMotorCallManager::onIncomingEvent] The call with eqt: 716 has released its equipment.
1245738769 -> 110e[CMotorCall::unRegister] Remove eqt : 716 from the map.
1245738769 -> [CMotorCallManager::eraseCallwithEqt] CMotorCall 716 erased.
1245738769 -> [CMotorCallManager::onIncomingEvent] state = TERMINATED_STATE.
1245738769 -> [CMotorCallManager::onIncomingEvent] killSession.
1245738769 -> 110e [CCall::killSession]
1245738769 -> 211c [CTransaction::changeState] STATE CHANGED TO TERMINATED
1245738769 -> 211c [CTransaction::changeState] no transaction state
1245738769 -> 211e [CTransaction::changeState] STATE CHANGED TO TERMINATED
1245738769 -> 211e [CTransaction::freeTimerToken] Timer J is freed
1245738769 -> 211e [CTransaction::changeState] no transaction state
1245738769 -> 110e [CCall::onKill Session Call manager close is called]
1245738769 -> 110e [CCall::killSession] notifying the call manager
1245738769 -> 102 [CCallManager::onCallClosed]
1245738769 -> 102 [CCallManager::onCallClosed()] removing from the maps
1245738769 -> [CMotorCallManager::onNotifyCallClosed] Call : c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 is closed.
1245738769 -> [CMotorCallManager::onNotifyCallClosed] Remove eqt from the map.
1245738769 -> [CCall::onKill] set callmanager to null
1245738769 -> [CTransaction::notifyDialog]
1245738769 -> [CTransaction::notifyDialog] notify parent dialog
1245738769 -> 1515 [CDialog::onTransactionState(pTrans = 211c, previousState = null, currentState = Terminated, reason = None]
1245738769 -> 1515 [CDialog::onTransactionState] dialog is terminated
1245738769 -> 1515 [CDialog::onTransactionState] onDialogClosed
1245738769 -> 110e [CCall::onDialogClosed]
1245738769 -> 110e [CCall::onDialogClosed] not only initial *********
1245738769 -> 110e [CCall::onDialogClosed]: the dialog 1516 is NOT closed
1245738769 -> 2D [~CResponse] resp(183) c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 635538580 INVITE
1245738769 -> [CTransaction::notifyDialog]
1245738769 -> [CTransaction::notifyDialog] notify parent dialog
1245738769 -> 1516 [CDialog::onTransactionState(pTrans = 211e, previousState = null, currentState = Terminated, reason = None]
1245738769 -> 110e [CCall::onDialogClosed]
1245738769 -> 110e [CCall::onDialogClosed] not only initial *********
1245738769 -> 110e [CCall::onDialogClosed]: the dialog 1516 is closed
1245738769 -> 110e [CCall::onDialogClosed] All the dialogs in the Call are closed
1245738769 -> 102 [CCallManager::removeGarbage] at index i = 0
1245738769 -> 110e[CMotorCall::~CMotorCall] Call : c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 is being destructed.
1245738769 -> 110e [CCall::~CCall]
1245738769 -> 110e [CCall::removeGarbage]
1245738769 -> 1516 [CDialog::~CDialog]
1245738769 -> 1515 [CDialog::~CDialog]
1245738769 -> [---*--- SESSION-TIMER ---*---] Free CSessionTimerContext
1245738769 -> 23 [~CRequest] req c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 635538580 ACK
1245738769 -> 2E [~CResponse] resp(200) c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 635538580 INVITE
1245738769 -> 22 [~CRequest] req c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 635538580 INVITE
1245738769 -> 2F [~CResponse] resp(200) c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 1 BYE
1245738769 -> 24 [~CRequest] req c9bdf9e7fc74b9828979a41fd2db9b86@172.16.1.3 1 BYE
--------------------------------------
трасса этого звонка с gayeway
SETUP
call_type: normalcallin
ani: 7407;pr_alwd;scrn_netw
presentation: 7407;pr_alwd;scrn_netw
dnis: 5338813
src_sign_addr: 172.16.1.3:10005
audio_codec: pt=8;ms=20;vad=0;rxtx=2;smap=PCMA/8000
audio_codec: pt=0;ms=20;vad=0;rxtx=2;smap=PCMU/8000
audio_codec: pt=18;ms=20;vad=0;rxtx=2;smap=G729/8000
audio_codec: pt=97;ms=20;vad=0;rxtx=2;smap=telephone-event/8000
audio_addr: 172.16.1.4:32520
a_sip: user=255
nat: no
b_sip: user=255
08:30:52,563863 16383 7 voipidle00
08:30:52,564827 16383 7 cctl_rxSETUP codec 8 rtpmap
08:30:52,565450 16383 7 cctl_rxSETUP codec 0 rtpmap
08:30:52,566074 16383 7 cctl_rxSETUP codec 18 rtpmap
08:30:52,566695 16383 7 cctl_rxSETUP codec 97 rtpmap
08:30:52,567320 16383 7 cctl_rxSETUP fast_start 1
08:30:52,568035 16383 7 voipidle00 Rx SETUP ani '7407' dnis '5338813' -> Tx SETUP_ACK
08:30:52,568792 16383 7 SendMessISDN sursa 7 dest 65535 tip 254 len 24 proto 4
08:30:52,569409 16383 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:52,570079 16383 7 SendMess2SIP src 7 dst 65535 tip 254 len 24 proto 4
08:30:52,571901 16383 7 SendMess2SIP SendMesPBX2SIP(dest 263)
08:30:52,572546 16383 7 SendMesPBX2SIP Tx src 7 dst 263 len 24 pid_ua 1...
SETUP_ACK
sid: 5e6ba664
08:30:52,573869 16383 7 SendMesPBX2SIP Tx to dest 263
08:30:52,574522 16383 7 LiveMonitorSetup
08:30:52,575210 16383 7 in_check_access_1
08:30:52,575846 16383 7 in_check_access_1 NR_DIRIN_PBX 4000
08:30:52,576521 16383 7 in_check_access_1 0 ip1 ac100103 mask ffffffff ip2 ac100103
08:30:52,577159 16383 7 in_check_access_1 digits 5338813 prg_diripin[0].digits
08:30:52,577843 16383 7 in_check_access_1 Found diripin from_pbx, 0 simult calls from 172.16.1.3/32 proxy 0 transcoding=0 ssw_calls 0 max_ssw_calls 100000
08:30:52,578497 16383 7 CheckCallIn class 'from_pbx' nrcallin 1 maxspeachin 0 speachin 0 maxcostin 0.000000 costin 0.000000, ssw_calls 1
08:30:52,579234 16383 7 CountSysCallIn IN SYSTEM medium_cps 0.000000 max_cps 0 MAX 0
08:30:52,579932 16383 7 CountSysCallIn IN SYSTEM sec 1245735052 calls in this sec 1
08:30:52,581322 16383 7 CountCallInOn IN dir nr 21 name from_pbx medium_cps 0.000000 max_cps 0 MAX 0 calls IN 1
08:30:52,582021 16383 7 CountCallInOn IN dir nr 21 name from_pbx sec 1245735052 calls in this sec 1
08:30:52,582707 16383 7 voipidle00 have all digits fast_start is 1
08:30:52,583344 16383 7 SendMessISDN sursa 7 dest 65535 tip 130 len 1 proto 4
08:30:52,583972 16383 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:52,584594 16383 7 SendMess2SIP src 7 dst 65535 tip 130 len 1 proto 4
08:30:52,585286 16383 7 SendMessISDN sursa 7 dest 65535 tip 254 len 36 proto 4
08:30:52,585913 16383 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:52,586702 16383 7 SendMess2SIP src 7 dst 65535 tip 254 len 36 proto 4
08:30:52,587345 16383 7 SendMess2SIP SendMesPBX2SIP(dest 263)
08:30:52,587994 16383 7 SendMesPBX2SIP Tx src 7 dst 263 len 36 pid_ua 1...
ACM
bci: isup_used_alltheway;charge
08:30:52,589340 16383 7 SendMesPBX2SIP Tx to dest 263
08:30:52,589999 16383 7 voipidle00 Instal(dialdigits, 30000)
08:30:52,591469 16383 7 Set_Timer tmr 0 val 30000
08:30:52,684294 16383 7 dialdigits ident '7407' number '5338813' id_tradu '7407' nr_tradu '5338813' route 0x0000
08:30:52,684965 16383 7 dialdigits M_RUN
08:30:52,685718 16383 7 dialdig_run ta->rtpproxy 0
08:30:52,686380 16383 7 dialdig_run pupi_db_id len 0, number 5338813
08:30:52,687130 16383 7 GetDest GetDest rn 0
08:30:52,687780 16383 7 GetDest classid 21
08:30:52,688412 16383 7 GetDest search_bin_tradu class 21 alldigit 1
08:30:52,689182 16383 7 search_nr_jonbin digit 5 first_poz 4 nr_poz 1
08:30:52,689859 16383 7 GetDest poz 7fff len 0 match 0 noa 3
08:30:52,691312 16383 7 search_nr_jonbin digit 15 first_poz -1 nr_poz 0
08:30:52,692058 16383 7 GetDest tryf poz 32767 len 0 match 0 noa 3
08:30:52,692721 16383 7 GetDest try with default route
08:30:52,693420 16383 7 GetDest GetDest rn 0
08:30:52,694230 16383 7 GetDest classid 65535
08:30:52,694904 16383 7 GetDest search_bin_tradu class 65535 alldigit 1
08:30:52,695671 16383 7 search_nr_jonbin digit 5 first_poz 4 nr_poz 1
08:30:52,696329 16383 7 GetDest poz 9004 len 7 match 1 noa 3
08:30:52,697081 16383 7 GetDest route 0x9004 rlen 7 rmatch 1 r 0x4049575c nr 0
08:30:52,697757 16383 7 GetDest find 1 routes
08:30:52,698378 16383 7 GetDest find maxpoz 4
08:30:52,699126 16383 7 search_nr_jonbin digit 15 first_poz -1 nr_poz 0
08:30:52,699803 16383 7 GetDest find all f tryf poz 32767 len 7 match 1 noa 3
08:30:52,701265 16383 7 GetDest find ok routes 1
08:30:52,701901 16383 7 GetDest DIRACTION poz 0x9004 idx 4 dest 0x1 type_dir 0x1
08:30:52,702700 16383 7 play_announcement Missing route play_file -> return
08:30:52,703415 16383 7 dialdig_run ident '7407' number '5338813' id_tradu '7407' nr_tradu '5338813' route 0x9004
08:30:52,704177 16383 7 dialdig_run tax from tradu is 0 bpf_r_in 0 connection time is 0 min
08:30:52,704923 16383 7 get_maxproxy_in proxyin 0
08:30:52,705661 16383 7 dialdig_recmes_switch DIRACTION
08:30:52,706300 16383 7 dialdig_recmes_switch nrtrytodir 0
08:30:52,707140 16383 7 try_play_time ppu is NULL -> return 0
08:30:52,707809 16383 7 dialdig_recmes_switch NewCallJon(nr_out '5338813', id_out '7407')
08:30:52,708572 16383 7 NewCallJon route 36868
08:30:52,709352 16383 7 NewCallJon GetRoute 1
08:30:52,710034 16383 7 GetRoute route 4 mode 0 data 0
08:30:52,712203 16383 7 GetRoute route 4 mode 0 data 0 dir GSM ASR 0.000000
08:30:52,712950 16383 7 GetRoute return route 9004 ASR max 0.000000 on dir 1
08:30:52,713801 16383 7 NewCallJon global_route 0 fork_alg 0
08:30:52,714450 16383 7 NewCallJon route 9004 poz 4
08:30:52,715085 16383 7 NewCallJon dir GSM proto UNKNOWN nr_out '5338813' id_out '7407'
08:30:52,715854 16383 7 NewCallJon dir 1 translate_out 0
08:30:52,716569 16383 7 try_alloc_transcoding
08:30:52,717375 16383 7 try_alloc_transcoding 3
08:30:52,718235 16383 7 CallJonDir IP to TDM
08:30:52,719053 16383 7 CallJonDir find portB 8 ch 0 0
08:30:52,719775 00259 7 cctl_allocRTPportBIGSW find transcoding port 259
08:30:52,721244 00259 7 Port2Slot port 259 type_eq 2
08:30:52,721871 00259 7 Port2Slot WARN port 259 pid 65535
08:30:52,722489 00259 7 Port2Slot WARN return slot -108:30:52,723110 00259 7 SendSETTIMESLOT WARN VOIP port 259
08:30:52,723736 00259 7 get_port card 32 sign_card 32512 port 259
08:30:52,724368 00259 7 SetParamRTPLOCAL aPORT 32518
08:30:52,724989 00259 7 get_maxproxy_in proxyin 0
08:30:52,725640 00259 7 cctl_allocRTPportBIGSW fast_start is 1 aPT[0].ptime is 20
08:30:52,726319 00259 7 match_codec_poz match codec 8 ptime 20 vad 0
08:30:52,727010 00259 7 SetStare port 259 state old 0 new 1
08:30:52,727698 00259 7 LiveMonitorSetup
08:30:52,728317 00259 7 TxPublish port 259 state 1,rx_dialog_sub 0 sip_pid 65535
08:30:52,728957 00259 7 CallJonDir find portA 259
08:30:52,729589 00259 7 SendCall mod 1, work 0x00000023, dirname 'GSM', proto 'UNKNOWN' nrcalls 0, prtb 8 nextroute 36868
08:30:52,730932 00259 7 SendCall ALLDIGITBIT -> SendCallJon
08:30:52,731622 00259 7 SendCallJon sign 0x0 ta->RB_pi 0x0
08:30:52,732250 00259 7 SendCallJon work 51
08:30:52,732868 00259 7 SendCallJon SendMessCallTDM len 30
08:30:52,733556 00259 7 SendMessCallTDM len 30
08:30:52,734451 00259 7 SendMessCallTDM GetProcTa() 8
08:30:52,735074 00259 7 SendMessCallTDM cat1 0 type 0 proto 'CAS'
08:30:52,735758 00259 7 CopyToB_pid dnis_noa 3
08:30:52,736390 00259 7 CopyToB_pid category 10
08:30:52,737011 00259 7 CopyToB_pid ani_noa 3 pi 0 si 0
08:30:52,737635 00259 7 CopyToB_pid category 10
08:30:52,738253 00259 7 CopyToB_pid tmr 3
08:30:52,738874 00259 7 CopyToB_pid action 1 proto 1 dir 1 routedir 1 transport 0 media
08:30:52,739502 00259 7 CopyToB_pid call_info 100
08:30:52,740120 00259 7 CopyToB_pid orig_dnis '' redirect_by ''
08:30:52,741631 00259 7 SendMessCallTDM increment nrcallout[GSM] new_val 1
08:30:52,742397 00259 7 CountSysCallOut OUT SYSTEM medium_cps 0.000000 max_cps 0 MAX 0
08:30:52,743119 00259 7 CountSysCallOut OUT SYSTEM sec 1245735052 calls in this sec 1
08:30:52,743788 00259 7 CountCallOut OUT dir nr 1 name GSM medium_cps 0.000000 max_cps 0 MAX 0 calls OUT 1
08:30:52,744487 00259 7 CountCallOut OUT dir nr 1 name GSM sec 1245735052 calls in this sec 1
08:30:52,745121 00259 7 SendMessCallTDM is_user_ccs 0 -> Tx M_CALL len 30 to 8 ani_pi 0
08:30:52,745759 00259 7 FuncTabPort GSM -> SetFunc(pid 8, gsm00)
08:30:52,746386 00259 7 SendMessCallTDM global_b_pid 8
08:30:52,747058 00259 7 Set_Timer tmr 1 val 200
08:30:52,747701 00259 7 Set_Timer tmr 0 val 202
08:30:52,748334 00259 7 SendCall end
08:30:52,748951 00259 7 NewCallJon global_b_pid 8
08:30:52,749629 00259 7 NewCallJon ret 0 nrtrytodir 1 param 0
08:30:52,750962 00259 7 EndNewCallJon ret 0
08:30:52,751576 00259 7 InformPortB port 259
08:30:52,752192 00259 7 InformPortB port 259
08:30:52,752815 00259 7 EndNewCallJon ret 0 find PORTB 8
08:30:52,754227 00008 8 gsm00 stare_port 0 sim_port 0
08:30:52,754881 00008 8 gsm00 M_CALL mod 1
08:30:52,755576 00008 8 GetParamM_CALL ANI '7407' DNIS '5338813'
08:30:52,756205 00008 8 gsm00 M_CALL mod 1 cat 1 b_pid 7 prtb 103 s170
08:30:52,757005 00008 8 gsm00 Digits 5338813 Ident 7407
08:30:52,757653 00008 8 GetCh flow 1 channel 2
08:30:52,758299 00008 8 SetStare port 8 state old 0 new 1
08:30:52,759017 00008 8 SendM Tx SERIAL CAS/ISDN card 1 len 3 data 30 02 00
08:30:52,759729 00008 8 LiveMonitorSetup
08:30:52,761670 00008 8 MTxPublish b_pid 7 prtb 259
08:30:52,762291 00008 8 MTxPublish b_pid prt 259
08:30:52,762907 00008 8 MTxPublish b_pid prtpid 263
08:30:52,763526 00008 8 TxPublish port 8 state 1,rx_dialog_sub 0 sip_pid 263
08:30:52,764163 00008 8 Set_Timer tmr 0 val 1
08:30:52,764891 00008 8 MTxPublish b_pid 7 prtb 259
08:30:52,765520 00008 8 MTxPublish b_pid prt 259
08:30:52,766147 00008 8 MTxPublish b_pid prtpid 263
08:30:52,766768 00008 8 TxPublish port 8 state 2,rx_dialog_sub 0 sip_pid 263
08:30:52,767 00008 217610 Tx GSM ATD5338813i;
08:30:52,768130 00008 8 translateGSMMES buffering len 14 cardISDN 3 lenbuf 0
08:30:52,768820 00008 8 translateGSMMES Tx GSM len 14 33 38 38 31 00 33 69 3b
08:30:52,769430 00008 8 Set_Timer tmr 0 val 3000
08:30:52,770102 00259 7 dialdigits ident '7407' number '5338813' id_tradu '7407' nr_tradu '5338813' route 0x9004
08:30:52,771527 00259 7 dialdigits ACK to M_CALL work 33 b_pid 8
08:30:52,772223 00259 7 dialdigits Instal(dialdest, 30000)
08:30:52,772859 00259 7 Set_Timer tmr 0 val 30000
08:30:52,773531 65535 8 RunWhileMain int in int retval 422864
08:30:52,774456 65535 212 SendM Tx SERIAL CAS/ISDN card 1 len 14 data 08 0c 00 44 35 33 33 38 38 31 00 33 69 3b
08:30:52,811758 65535 349 FuncCardUnBlock2ME1ISDN
8:30:55,358478 00259 7 GetLocalRtpIpPort
08:30:55,359097 00259 7 get_pattern_addr bIP.IP 40110ac bIPs.IP 30110ac remoteID
08:30:55,359763 00259 7 get_pattern_addr IP from remote media 172.16.1.4
08:30:55,360913 00259 7 GetLocalRtpIpPort b_pid 8 rtpproxy 0 SRC_audio_RTPproxyport 65535 bIPs 172.16.1.3 remoteID '' B_rtpproxy 0 B_DST_audio_RTPproxyport 65535
08:30:55,361660 00259 7 get_group_rtp_ip group 2 pattern 172.16.1.4, match rtp_ip 172.16.1.9
08:30:55,362317 00259 7 GetLocalRtpIpPort port<NRPORTURI, RTPP no, Tx port RTP IP 172.16.1.9:32518
08:30:55,363098 00259 7 SendMessISDN sursa 7 dest 259 tip 254 len 109 proto 4
08:30:55,363727 00259 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:55,364358 00259 7 SendMess2SIP src 7 dst 259 tip 254 len 109 proto 4
08:30:55,364998 00259 7 SendMess2SIP SendMesPBX2SIP(dest 263)
08:30:55,365634 00259 7 SendMesPBX2SIP Tx src 7 dst 263 len 109 pid_ua 1...
PROGRESS
event: inband_info
audio_addr: 172.16.1.9:32518
audio_codec: pt=8;ms=20;vad=0;rxtx=2;smap=PCMA/8000
08:30:55,366906 00259 7 SendMesPBX2SIP Tx to dest 263
08:30:55,367641 00259 7 XCONNECTVOIP prt 259 prtb 8 aPORT 32518 bPORT 32520
08:30:55,368291 00259 7 Port2Slot port 259 type_eq 2
08:30:55,368920 00259 7 Port2Slot port 8 ch 2 slot 162
08:30:55,369538 00259 7 Port2Slot slot 162 slotport[674]=259 return slot 162
08:30:55,370177 00259 7 VoipTxOnOffSlotVoip slot 162
08:30:55,371908 00259 7 msp_mgr_msg_tx rslot 162
08:30:55,372872 00259 7 XCONNECTVOIP vad 255
08:30:55,373541 00259 7 XCONNECTVOIP txrx 2
08:30:55,374291 00259 7 XCONNECTVOIP rtpproxy 0, DST_proxy 65535
08:30:55,374956 00259 7 XCONNECTVOIP VOIP_RTCP 0 VOIP_any 0 rtpudp 0
08:30:55,375787 00259 7 msp_mgr_msg_tx Rrtp 162 -sid "5e6ba664" -p 8 -m 20 32518 172.16.1.4 32520
08:30:55,376618 00259 7 dialdest M_CONNECT -> XCONNECTVOIPA()
08:30:55,377420 00259 7 dialdest Tx M_PINFO:RING to port 259
08:30:55,378083 00259 7 SendMessISDN sursa 7 dest 259 tip 130 len 2 proto 4
08:30:55,378825 00259 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:55,379475 00259 7 SendMess2SIP src 7 dst 259 tip 130 len 2 proto 4
08:30:55,380149 00259 7 MTxPublish b_pid 8 prtb 8
08:30:55,381451 00259 7 TxPublish port 259 state 3,rx_dialog_sub 0 sip_pid 65535
08:30:55,382219 00259 7 XCONNECTVOIP prt 259 prtb 8 aPORT 32518 bPORT 32520
08:30:55,382891 00259 7 XCONNECTVOIP str_tratap->make_RTP 1 -> return
08:30:55,383519 00259 7 dialdest Instal(preanswerA, 180000)
08:30:55,384317 00259 7 Set_Timer tmr 0 val 180000
08:30:55,471622 00259 7 preanswerA WARN Unknown msg 78 -> ign
08:30:55,472318 65535 8 RunWhileMain int in int retval 121552
08:30:55,473417 65535 349 FuncCardUnBlock2ME1ISDN
08:30:55,474218 65535 349 add_ISDNcard card 16 type 1 dsp -1
08:30:55,474853 65535 349 add_ISDNcard card 16 type 1 chfl 50
08:30:55,475484 65535 349 GetJonDirDMaHDLC dir 9 eq 0
08:30:55,476126 65535 349 FindDSPISDNFromVoIP card 16 portvoip 65535
08:30:55,476754 65535 349 start_ISDN card 16 type 1 port 0
08:30:55,481320 65535 349 FuncCardUnBlock2ME1ISDN
08:30:58,495673 65535 344 analize_mes_ana Rx SERIAL ISDN adr 8 tip 78 len 4 data 61 78 03 00 4f 4b
08:30:58,496309 65535 344 analize_mes_ana buflng 7
08:30:58,496928 65535 344 translateINGSMMES len 3 nrpack 0 rest 3
08:30:58,497718 65535 344 analize_mes_ana buflng 6
08:30:58,498342 65535 344 CardComSetState card 1 up 1 old_stat 0
08:30:58,499097 65535 344 DispatchFromPort === 1 tip 125
08:30:58,499739 65535 344 DispatchFromPort M_PORTISDN port 8
08:30:58,500608 65535 344 DispatchFromPort MSKJON
08:30:58,501263 65535 344 DispatchFromPort P_KEYPAD dest 8 len 3 debug_run 1 debug_gsm 0 moniport 1
08:30:58,502 00008 223750 Rx GSM OK
08:30:58,502737 00008 8 gpreanswerB rx OK
08:30:58,503523 00008 8 XCONNECTVOIP TypeModulFromAddr != VOIP -> return
08:30:58,504367 00008 8 InitTimpTax rad_bill 0 tx_accounting_start 1
08:30:58,505013 00008 8 gpreanswerB OK -> ANSWER
08:30:58,505750 00008 8 MTxPublish b_pid 7 prtb 259
08:30:58,506393 00008 8 MTxPublish b_pid prt 259
08:30:58,507129 00008 8 MTxPublish b_pid prtpid 263
08:30:58,507782 00008 8 TxPublish port 8 state 4,rx_dialog_sub 0 sip_pid 263
08:30:58,508520 00259 7 preanswerA M_OFFHOOK
08:30:58,509289 00259 7 XCONNECTVOIP prt 259 prtb 8 aPORT 32518 bPORT 32520
08:30:58,509964 00259 7 XCONNECTVOIP str_tratap->make_RTP 1 -> return
08:30:58,511476 00259 7 SendTaxPortConnect r_tax 0
08:30:58,512235 00259 7 SendMessISDN sursa 7 dest 259 tip 131 len 1 proto 4
08:30:58,512885 00259 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:58,513512 00259 7 SendMess2SIP src 7 dst 259 tip 131 len 1 proto 4
08:30:58,514313 00259 7 SendMess2SIP TxAsciMedia(), SendMessISDN(proto 4)
08:30:58,514974 00259 7 GetLocalRtpIpPort
08:30:58,515713 00259 7 get_pattern_addr bIP.IP 40110ac bIPs.IP 30110ac remoteID
08:30:58,516400 00259 7 get_pattern_addr IP from remote media 172.16.1.4
08:30:58,517170 00259 7 GetLocalRtpIpPort b_pid 8 rtpproxy 0 SRC_audio_RTPproxyport 65535 bIPs 172.16.1.3 remoteID '' B_rtpproxy 0 B_DST_audio_RTPproxyport 65535
08:30:58,517898 00259 7 get_group_rtp_ip group 2 pattern 172.16.1.4, match rtp_ip 172.16.1.9
08:30:58,518554 00259 7 GetLocalRtpIpPort port<NRPORTURI, RTPP no, Tx port RTP IP 172.16.1.9:32518
08:30:58,519435 00259 7 SendMessISDN sursa 7 dest 259 tip 254 len 99 proto 4
08:30:58,520066 00259 7 SendMessISDN proto SIP -> SendMes2SIP()
08:30:58,521044 00259 7 SendMess2SIP src 7 dst 259 tip 254 len 99 proto 4
08:30:58,521685 00259 7 SendMess2SIP SendMesPBX2SIP(dest 263)
08:30:58,522443 00259 7 SendMesPBX2SIP Tx src 7 dst 263 len 99 pid_ua 1...
ANSWER
proto: CAS
audio_addr: 172.16.1.9:32518
audio_codec: pt=8;ms=20;vad=0;rxtx=2;smap=PCMA/8000
08:30:58,523867 00259 7 SendMesPBX2SIP Tx to dest 263
08:30:58,524701 00259 7 InitTimpTax rad_bill 0 tx_accounting_start 1
08:30:58,525459 00259 7 MTxPublish b_pid 8 prtb 8
08:30:58,526129 00259 7 TxPublish port 259 state 4,rx_dialog_sub 0 sip_pid 65535
08:30:58,526771 00259 7 preanswerA GoTo(answerA)
08:30:58,533861 65535 8 S_GetTr malloc(32)
08:30:58,541133 65535 8 RunWhileMain int in int retval 50268
08:30:58,557420 65535 177 SendMesSIP2PBX Rx src 263 dst 7 len 11 ...
ANSWER_ACK
08:30:58,558969 00259 7 answerA PROXYASCII to b_pid 8
08:30:58,559872 00008 8 GetLocalRtpIpPort
08:30:58,561340 00008 8 get_pattern_addr bIP.IP 0 bIPs.IP 0 remoteID
08:30:58,561967 00008 8 get_pattern_addr WARN can't get B IP
08:30:58,562785 00008 8 GetLocalRtpIpPort b_pid 7 rtpproxy 0 SRC_audio_RTPproxyport 65535 bIPs 0.0.0.0 remoteID '' B_rtpproxy 0 B_DST_audio_RTPproxyport 65535
08:30:58,563464 00008 8 get_group_rtp_ip ERROR group 0 pattern 0.0.0.0, no class matched -> return 0.0.0.0
08:30:58,564240 00008 8 GetLocalRtpIpPort port<NRPORTURI, RTPP no, Tx port RTP IP 0.0.0.0:65535
08:30:58,564899 00008 8 cctl_M_PROXYASCII rez is 1(RTP proxy,transc on) ..I must send my data
08:30:58,565717 00008 8 SendMessISDN sursa 8 dest 8 tip 254 len 11 proto 1
08:30:58,566367 00008 8 SendMessISDN port 8 tip 254
08:30:58,567151 00008 8 SendMessISDN src 8 dst 8 tip 254 len 11 proto 1
08:30:58,567851 00008 8 SendMessISDN port type 0 and card type 11 != BRICARD|RGCARD -> return 387
08:30:58,581898 65535 349 FuncCardUnBlock2ME1ISDN
08:31:07,825359 65535 349 add_ISDNcard card 17 type 1 dsp -1
08:31:07,825989 65535 349 add_ISDNcard card 17 type 1 chfl 70
08:31:07,826620 65535 349 GetJonDirDMaHDLC dir 9 eq 0
08:31:07,827260 65535 349 FindDSPISDNFromVoIP card 17 portvoip 65535
08:31:07,827889 65535 349 start_ISDN card 17 type 1 port 0
08:31:07,860784 65535 347 analize_mes_ana Rx SERIAL ISDN adr 8 tip 78 len 13 data 61 78 0c 00 4e 4f 20 43 41 52 52 00 49 45 52
08:31:07,861425 65535 347 analize_mes_ana buflng 16
08:31:07,862047 65535 347 translateINGSMMES len 12 nrpack 1 rest 4
08:31:07,862832 65535 347 analize_mes_ana buflng 14
08:31:07,863450 65535 347 CardComSetState card 1 up 1 old_stat 0
08:31:07,864233 65535 347 DispatchFromPort === 1 tip 125
08:31:07,864880 65535 347 DispatchFromPort M_PORTISDN port 8
08:31:07,865621 65535 347 DispatchFromPort MSKJON
08:31:07,866267 65535 347 DispatchFromPort P_KEYPAD dest 8 len 11 debug_run 1 debug_gsm 0 moniport 1
08:31:07,867 00008 233110 Rx GSM NO CARRIER
08:31:07,867763 00008 8 answerB M_PKEYPAD -> handle_M_PKEYPAD()
08:31:07,868465 00008 8 handle_M_PKEYPAD Tx M_CANCELDN to b_pid 7, TxDisactPort()
08:31:07,869449 00008 8 get_sign_media aIP 0.0.0.0:65535
08:31:07,870149 00008 8 GetLocalRtpIpPort
08:31:07,871518 00008 8 get_pattern_addr bIP.IP 0 bIPs.IP 0 remoteID
08:31:07,872257 00008 8 get_pattern_addr WARN can't get B IP
08:31:07,872943 00008 8 GetLocalRtpIpPort b_pid 7 rtpproxy 0 SRC_audio_RTPproxyport 65535 bIPs 0.0.0.0 remoteID '' B_rtpproxy 0 B_DST_audio_RTPproxyport 65535
08:31:07,873621 00008 8 get_group_rtp_ip ERROR group 0 pattern 0.0.0.0, no class matched -> return 0.0.0.0
08:31:07,874431 00008 8 GetLocalRtpIpPort port<NRPORTURI, RTPP no, Tx port RTP IP 0.0.0.0:65535
08:31:07,875110 00008 8 get_sign_media sourceIP :0 sourceRTP 0.0.0.0:65535 destIP 172.16.1.9:0 destRTP 0.0.0.0:65535
08:31:07,875857 00008 8 MTxPublish b_pid 7 prtb 259
08:31:07,876502 00008 8 MTxPublish b_pid prt 259
08:31:07,877251 00008 8 MTxPublish b_pid prtpid 263
08:31:07,877901 00008 8 TxPublish port 8 state 5,rx_dialog_sub 0 sip_pid 263
08:31:07,878711 00008 8 TxDisactPort
08:31:07,879494 00008 8 UnalocDTMF WARN no voip slot alocated
08:31:07,880116 00008 8 TxDisactPort code 16
08:31:07,881272 00008 8 SendM Tx SERIAL CAS/ISDN card 1 len 2 data 38 7f
08:31:07,881967 00008 8 Port2Slot port 8 type_eq 2
08:31:07,882783 00008 8 Port2Slot port 8 ch 2 slot 162
08:31:07,883450 00008 8 Port2Slot return slot 162
08:31:07,884095 00008 8 VoipTxOnOffSlotVoip slot 162
08:31:07,884806 00008 8 msp_mgr_msg_tx rslot 162
08:31:07,885724 00008 8 UnalocCh flow 1 channel 2
08:31:07,886382 00008 8 Set_Timer tmr 0 val 1500
08:31:07,887386 00259 7 kill_rtp ta->prtd 65535 ta->e_pid 65535
08:31:07,888054 00259 7 kill_rtp Tx M_CANCELDN to prtd 65535
08:31:07,888683 00259 7 kill_rtp Tx M_RESETINFO to rtp pid 65535
08:31:07,889481 00259 7 SendMes WARN dest pid 65535 is higher than nrproc 354 -> msg not sent
08:31:07,890176 00259 7 answerA M_CANCELDN
08:31:07,892062 00259 7 update_prepaid_credit ppu (nil), OD_ppu (nil), RB_ppu (nil)
08:31:07,892986 00259 7 get_sign_media aIP 172.16.1.9:32518
08:31:07,893697 00259 7 GetLocalRtpIpPort
08:31:07,894468 00259 7 get_pattern_addr bIP.IP 40110ac bIPs.IP 30110ac remoteID
08:31:07,895148 00259 7 get_pattern_addr IP from remote media 172.16.1.4
08:31:07,895920 00259 7 GetLocalRtpIpPort b_pid 8 rtpproxy 0 SRC_audio_RTPproxyport 65535 bIPs 172.16.1.3 remoteID '' B_rtpproxy 0 B_DST_audio_RTPproxyport 65535
08:31:07,896644 00259 7 get_group_rtp_ip group 2 pattern 172.16.1.4, match rtp_ip 172.16.1.9
08:31:07,897420 00259 7 GetLocalRtpIpPort port<NRPORTURI, RTPP no, Tx port RTP IP 172.16.1.9:32518
08:31:07,898117 00259 7 get_sign_media sourceIP 172.16.1.3:10005 sourceRTP 172.16.1.4:32520 destIP 172.16.1.9:0 destRTP 172.16.1.9:32518
08:31:07,898757 00259 7 MTxPublish b_pid 8 prtb 8
08:31:07,899556 00259 7 TxPublish port 259 state 5,rx_dialog_sub 0 sip_pid 65535
08:31:07,901205 00259 7 do_tax tip 'C' duration 9 finalize 'BOK' sid 5e6ba664
08:31:07,901844 00259 7 do_tax SIGN_s 172.16.1.3:10005 RTP_s 172.16.1.4:32520 SIGN_d 172.16.1.9:0 RTP_d 172.16.1.9:32518
08:31:07,903204 00259 7 TxDisactPort
08:31:07,903945 00259 7 UnalocDTMF WARN no voip slot alocated
08:31:07,904597 00259 7 TxDisactPort code 16
08:31:07,905224 00259 7 Port2Slot port 8 type_eq 2
08:31:07,905968 00259 7 Port2Slot WARN return slot -108:31:07,906614 00259 7 SendRESTIMESLOT WARN mombasa and VoIP port -> return
08:31:07,907363 00259 7 SendMessISDN sursa 7 dest 259 tip 134 len 1 proto 4
08:31:07,908021 00259 7 SendMessISDN proto SIP -> SendMes2SIP()
08:31:07,908643 00259 7 SendMess2SIP src 7 dst 259 tip 134 len 1 proto 4
08:31:07,909514 00259 7 SendMess2SIP nex 7 mod 0 mcpsin 0.000000 curcpsin 1
08:31:07,910916 00259 7 SendMessISDN sursa 7 dest 259 tip 254 len 18 proto 4
08:31:07,911582 00259 7 SendMessISDN proto SIP -> SendMes2SIP()
08:31:07,912326 00259 7 SendMess2SIP src 7 dst 259 tip 254 len 18 proto 4
08:31:07,912985 00259 7 SendMess2SIP SendMesPBX2SIP(dest 263)
08:31:07,913617 00259 7 SendMesPBX2SIP Tx src 7 dst 263 len 18 pid_ua 1...
RELEASE
cause: 16
08:31:07,915040 00259 7 SendMesPBX2SIP Tx to dest 263
08:31:07,915815 00259 7 Set_Timer tmr 0 val 6000
08:31:07,920742 65535 8 SendMesSIP2PBX Rx src 263 dst 7 len 17 ...
RELEASE_COMPLETE