[ 484][20071120.140732.718:q931.i2] Q931Machine::ProcessRequestOrMessage: 0x1498E570 Processing message 'SETUP' in state user Null
[ 2d0][20071120.140732.718:isdn.i3] 1:2:1:1: ISDN: (0x7a32): ISDNChannel::DoSetupStuff: going to SHOUTwatch state csWAITING_FOR_ROUTE
[ e4][20071120.140732.718:tel.i2] RouteRequest: Routing table entry order is: 1
[ e4][20071120.140732.718:tel.i2] RouteRequest: Local termination call...
[ e4][20071120.140732.718:tel.i2] RouteRequest: preferred media is now [G.711mu-law/sil T.38Fax STU ]
[ e4][20071120.140732.718:tel.i2] RouteRequest: Chose channel 1:15:1:1 for outgoing call
[ e4][20071120.140732.718:tel.i2] RouteRequest: outbound channel: 1:15:1:1 selected
[ e4][20071120.140732.718:tel.i2] RouteRequest: CSN 0x7a32: Setting outbound Media DiffServ level to 0x00 and Signaling Diffserv to 0x00
[ 2cc][20071120.140732.718:isdn.i3] 1:2:1:1: ISDN: (0x7a32): ISDNChannel::route: going to SHOUTwatch state csPEER_SETUP
[ 2cc][20071120.140732.718:tdm.i2] 1:2:1:1: ISDN: (0x7a32): Channel::TDMProcessTxSetup: negotiated media is now [] stream(0)
[ e4][20071120.140732.718:tel.i2] RouteRequest: Routing done for local termination.
[ 2cc][20071120.140732.718:q931.i2] Q931Machine::ProcessRequestOrMessage: 0x1498E570 Processing request 'MoreInfoRequest' in state user Call Present
[ 2cc][20071120.140732.718:tel.i2] 1:15:1:1: SIP: (0x7a32): Channel::CheckAndHandleOverlap: Called Party Number not complete, entering overlap mode.
[ 484][20071120.140736.640:q931.i2] Q931Machine::ProcessRequestOrMessage: 0x1498E570 Processing message 'SETUP' in state user Overlap Receiving
[ 2d0][20071120.140736.718:tel.i2] 1:15:1:1: SIP: (0x7a32): Channel::HandleOutboundIDDExpiry: Outbound IDD Timer expired, completing call if in overlap mode.
[ 2d0][20071120.140736.718:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleSetup: Handling Setup
[ 2d0][20071120.140736.718:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleSetup: Translated calling number is 1234567890
[ 2d0][20071120.140736.718:tel.i2] 1:15:1:1: SIP: (0x7a32): Channel::SendNatFlagToSPM: nat flag: 0
[ 2d0][20071120.140736.718:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleSetup: Address [8638e172] is resolved immediately.
[ 2d0][20071120.140736.718:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleInitialDNS: Handling InitialDNS response
[ 2dc][20071120.140736.718:rb.i2] BaseRB::RBConnect: RTP transport set local IP/port 10.56.225.113/0, remote IP/port 0.0.0.0/0
[ 2dc][20071120.140736.718:rb.i2] BaseRB::RBConnect: 1:15:1:1 to 1:2:1:1 not connected
[ 2dc][20071120.140736.718:rb.i2] BaseRB::RBConnect: RTP transport set local IP/port 10.56.225.113/16384, remote IP/port 0.0.0.0/0
[ 54c][20071120.140736.718:ip.i2] Reliable_Connection::ConnectResult: Connect SUCCESSFUL Remote address = 10.56.225.114, Remote port = 5060, local port= 2124, Connection ID 0xffff873c
[ 2d0][20071120.140736.718:ip.i2] Reliable_Connection::OpenConnection: connecting to: 10.56.225.114 Remote port 5060 Local Address 0x00000000 and Local Port 2124 Connection ID = 0xffff873c
[ 54c][20071120.140736.718:ip.i2] Reliable_Connection::Transmit: Transmitting 1003 bytes from address 0x00000000:2124 to 10.56.225.114:5060 on connection 0xffff873c
[ 2dc][20071120.140736.718:rb.i2] BaseRB::RBConnect: 1:15:1:1 from 1:2:1:1 not connected
[ 704][20071120.140736.734:stel.m0] ProcessRTPPacket: Destination unknown, dropping frame [CSN 0xfa32, payload G711_ulaw, 160 bytes]
[ 54c][20071120.140737.031:ip.i2] Reliable_Connection::Receive: Received packet on Conn ID = 0xffff873c Connected 1 Read returned: 642
[ 54c][20071120.140737.031:ip.i2] Reliable_Connection::Receive: Received packet on Conn ID = 0xffff873c Connected 1 Read returned: -1
[ 2d0][20071120.140737.031:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleRingingResponse: Handling Ringing Response
[ 54c][20071120.140737.031:ip.i2] Reliable_Connection::ConnectResult: Connect SUCCESSFUL Remote address = 10.56.225.114, Remote port = 5060, local port= 2125, Connection ID 0xffff873b
[ 2d0][20071120.140737.031:ip.i2] Reliable_Connection::OpenConnection: connecting to: 10.56.225.114 Remote port 5060 Local Address 0x00000000 and Local Port 2125 Connection ID = 0xffff873b
[ 54c][20071120.140737.031:ip.i2] Reliable_Connection::Transmit: Transmitting 722 bytes from address 0x00000000:2125 to 10.56.225.114:5060 on connection 0xffff873b
[ 2cc][20071120.140737.031:rb.i2] FindRS: 1;2;128 found for hRef 0x5de, cap: 0xC660970000A01B
[ 2cc][20071120.140737.031:rb.i2] Connect: Connecting 1:2:1:1 to 1;2;128
[ 2cc][20071120.140737.031:rs.i2] [1:2:1:1](O)[0x7a32]EndPoint::ConnectTo: Connecting to 1;2;128
[ 2cc][20071120.140737.031:rs.i2] [1;2;128-TDMRx](O)[P1:2:1:1 A]PIN_TDM_RX::Connect:Connecting succeeded
[ 2cc][20071120.140737.031:rb.i2] Connect: Connecting 1;2;128 to 1:2:1:1
[ 2cc][20071120.140737.031:rs.i2] [1:2:1:1](O)[0x7a32][PT=1;2;128]EndPoint::ConnectFrom: Connecting from 1;2;128
[ 2d0][20071120.140737.031:sys.i3] DispatchMessages: recipient mailbox vanished for sender 0x00000001, recip 0xffffffff, msg 0x000aff01 [MSG_THW_DSP_OPEN_DONE], data 0x00007a32
[ 2cc][20071120.140737.031:rs.i2] [1:2:1:1-TDMRx](O)[P1;2;128 A]PIN_TDM_RX::Connect:Connecting succeeded
[ 54c][20071120.140737.046:ip.i2] Reliable_Connection::Receive: Received packet on Conn ID = 0xffff873b Connected 1 Read returned: 661
[ 54c][20071120.140737.046:ip.i2] Reliable_Connection::Receive: Received packet on Conn ID = 0xffff873b Connected 1 Read returned: -1
[ 2d0][20071120.140737.046:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleOkOnPRACK: Handling Ok On PRACK
[ 2cc][20071120.140737.046:q931.i2] Q931Machine::ProcessRequestOrMessage: 0x1498E570 Processing request 'AlertingRequest' in state user Overlap Receiving
[ 2cc][20071120.140737.046:isdn.i4] 1:2:1:1: ISDN: (0x7a32): ISDNChannel::receiveMessage: Not playing Ringback because Service Tones are disabled in the profile.
[ 54c][20071120.140737.234:ip.i2] Reliable_Connection::Receive: Received packet on Conn ID = 0xffff873c Connected 1 Read returned: 895
[ 54c][20071120.140737.234:ip.i2] Reliable_Connection::Receive: Received packet on Conn ID = 0xffff873c Connected 1 Read returned: -1
[ 2d0][20071120.140737.234:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleOkOnInvite: Handling OkOnInvite
[ 2d0][20071120.140737.234:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleOkOnInvite: negotiated media is now [G.711mu-law/sil ] stream(0)
[ 2d0][20071120.140737.234:rs.i2] [1:15:1:1](C)[0x7a32]RTPEndPoint::Reconnect: Changing destination from IP=0.0.0.0/Port=0 to IP=IP=10.56.225.114/Port=16384
[ 54c][20071120.140737.234:ip.i2] Reliable_Connection::Transmit: Transmitting 649 bytes from address 0x00000000:2124 to 10.56.225.114:5060 on connection 0xffff873c
[ 2d0][20071120.140737.234:vox.i2] [1;2;128](O)[0x7a32][idle]baseDSP::Stop: Stopping DSP. Status = idle
[ 2d0][20071120.140737.234:isdn.i3] 1:2:1:1: ISDN: (0x7a32): ISDNChannel::msgConnect: going to SHOUTwatch state csCONNECTED
[ 2d0][20071120.140737.234:q931.i2] Q931Machine::ProcessRequestOrMessage: 0x1498E570 Processing request 'SetupResponse' in state user Call Received
[ 2dc][20071120.140737.234:rb.i2] BaseRB::GetTDMNeighbor: DSP 1;2;128 found for 1:2:1:1
[ 2dc][20071120.140737.234:rb.i2] Connect: Connecting 1:2:1:1 to 1;2;128
[ 2dc][20071120.140737.234:rs.i2] [1:2:1:1](O)[0x7a32][PT=1;2;128][PR=1;2;128]EndPoint::ConnectTo: Connecting to 1;2;128
[ 2dc][20071120.140737.234:rs.i2] [1:2:1:1-TDMTx](O)[P1;2;128 A]PIN_TDM_TX::Connect:Connecting Succeed
[ 2dc][20071120.140737.234:rs.i2] [1;2;128-TDMRx](O)[P1:2:1:1 A]PIN_TDM_RX::Connect:Connecting succeeded
[ 2dc][20071120.140737.234:rb.i2] Connect: Connecting 1;2;128 to 1:15:1:1
[ 2dc][20071120.140737.234:rs.i2] [1:15:1:1](C)[0x7a32]EndPoint::ConnectFrom: Connecting from 1;2;128
[ 2d0][20071120.140737.234:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleTxStreamStarted: Handling Tx Stream Started message
[ 2dc][20071120.140737.234:rb.i2] BaseRB::RBTraceConnections: Connection is 1:2:1:1=>1;2;128=>1:15:1:1
[ 2dc][20071120.140737.234:rb.i2] TI_RB::RBMakeTdmPktConnect: Started tone detection on TI DSP 1;2;129
[ 2dc][20071120.140737.234:rb.i2] BaseRB::RBConnect: 1:2:1:1 to 1:15:1:1 connected
[ 2dc][20071120.140737.234:rb.i2] BaseRB::GetTDMNeighbor: DSP 1;2;128 found for 1:2:1:1
[ 2dc][20071120.140737.234:rb.i2] Connect: Connecting 1:2:1:1 from 1;2;128
[ 2dc][20071120.140737.234:rs.i2] [1;2;128-TDMTx](O)[P1:2:1:1 A]PIN_TDM_TX::Connect:Connecting Succeed
[ 2dc][20071120.140737.234:rs.i2] [1:2:1:1](O)[0x7a32][PT=1;2;128][PR=1;2;128]EndPoint::ConnectFrom: Connecting from 1;2;128
[ 2dc][20071120.140737.234:rs.i2] [1:2:1:1-TDMRx](O)[P1;2;128 A]PIN_TDM_RX::Connect:Connecting succeeded
[ 2dc][20071120.140737.234:rb.i2] Connect: Connecting 1;2;128 from 1:15:1:1
[ 2dc][20071120.140737.234:rs.i2] [1:15:1:1](O)[0x7a32][PR=1;2;128]EndPoint::ConnectTo: Connecting to 1;2;128
[ 2d0][20071120.140737.234:sip.i2] 1:15:1:1: SIP: (0x7a32): SIPChannel::HandleRxStreamStarted: Handling Rx Stream Started message
[ 2dc][20071120.140737.234:rb.i2] BaseRB::RBTraceConnections: Connection is 1:2:1:1<=1;2;128<=1:15:1:1
[ 2dc][20071120.140737.234:rb.i2] TI_RB::RBMakeTdmPktConnect: Started tone detection on TI DSP 1;2;129
[ 2dc][20071120.140737.234:rb.i2] BaseRB::RBConnect: 1:2:1:1 from 1:15:1:1 connected
[ 4a0][20071120.140737.250:stu.i4] 1:2:129: start_tone_detection: Law: 1 DC Filter: Disabled
[ 4a0][20071120.140737.250:stu.i4] 1:2:129: start_tone_detection: Law: 1 DC Filter: Disabled
[ 484][20071120.140737.328:q931.i2] Q931Machine::ProcessRequestOrMessage: 0x1498E570 Processing message 'CONNECT_ACKNOWLEDGE' in state user Connect Request
[ 2cc][20071120.140737.328:isdn.i3] 1:2:1:1: ISDN: (0x7a32): ISDNChannel::SMSetupCompleteIndication: going to SHOUTwatch state csCONNECTED
[ 704][20071120.140737.390:stel.i2] ProcessRTPPacket: frame [CSN 0x7a32, payload Silence, 1 bytes]: Received RFC 3389 comfort noise frame, comfort noise payload now 13
|