[nsp] What is wrong with my REFER ?
Masha Dorfman
mdorfman at interwise.com
Mon Nov 10 13:51:54 EST 2003
Hello
I send REFER message to Cisco router.
I get "SIP/2.0 503 Service Unavailable" in NOTIFY body.
The configuration and logs below are taken from Cisco.
Anyone can read it and explain me what's wrong with REFER?
Thanks in advance everybody's response
The configuration is:
==========================
dial-peer voice 303 voip
application transfer_app
destination-pattern 303
session protocol sipv2
session target ipv4:10.10.200.41
session transport udp
dtmf-relay rtp-nte
codec g711ulaw
no vad
!
dial-peer voice 304 voip
application transfer_app
destination-pattern 304
session protocol sipv2
session target ipv4:10.10.4.234
session transport udp
dtmf-relay rtp-nte
codec g711ulaw
============================
(I also tried with "application session". the same results)
The log is:
++++++++++++++++++++++++++++++++++++++++
*Mar 7 02:09:59.287: Received:
REFER sip:129 at 10.10.4.93:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.4.234:0
To: "129"<sip:129 at 10.10.4.93>;tag=1F5D1A90-748
From: <sip:304 at 10.10.4.234>;tag=10710900
Call-ID: ACA3F330-19B711CC-890FDA80-27A18D7D at 10.10.4.93
CSeq: 102 REFER
Max-Forwards: 70
Refer-To: sip:41 at 10.10.200.41
Referred-By: <sip:234 at 10.10.4.234>
Contact: <sip:234 at 10.10.4.234>
Content-Length: 0
*Mar 7 02:09:59.291: HandleUdpSocketReads :Msg enqueued for SPI with IPaddr: 10.10.4.234:5060
*Mar 7 02:09:59.291: ****Found CCB in UAC table
*Mar 7 02:09:59.291: CCSIP-SPI-CONTROL: act_active_new_message
*Mar 7 02:09:59.291: CCSIP-SPI-CONTROL: sact_active_new_message_request
*Mar 7 02:09:59.295: sip_stats_method
*Mar 7 02:09:59.295: CCSIP-SPI-CONTROL: sipSPIReferIsValid
*Mar 7 02:09:59.295: transfer digits: 41
*Mar 7 02:09:59.295: CCSIP-SPI-CONTROL: sipInitCallTransfer
*Mar 7 02:09:59.299: Queued event from SIP SPI : SIPSPI_EV_SEND_MESSAGE
*Mar 7 02:09:59.299: sip_stats_status_code
*Mar 7 02:09:59.299: 0x8348528C : State change from (STATE_ACTIVE, SUBSTATE_NONE) to (STATE_RECD_X
FER, SUBSTATE_NONE)
*Mar 7 02:09:59.303: Sent:
SIP/2.0 202 Accepted
Via: SIP/2.0/UDP 10.10.4.234:0
From: <sip:304 at 10.10.4.234>;tag=10710900
To: "129" <sip:129 at 10.10.4.93>;tag=1F5D1A90-748
Date: Sun, 07 Mar 1993 02:09:59 GMT
Call-ID: ACA3F330-19B711CC-890FDA80-27A18D7D at 10.10.4.93
Server: Cisco-SIPGateway/IOS-12.x
CSeq: 102 REFER
Content-Length: 0
*Mar 7 02:09:59.307: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_FACILITY
*Mar 7 02:09:59.307: CCSIP-SPI-CONTROL: ccsip_bridge: confID = 495, srcCallID = 1652, dstCallID =
1651
*Mar 7 02:09:59.307: sipSPIUupdateCcCallIds: old src/dest ccCallids: 1652/1651, new src/dest ccCall
ids: 1652/1651
*Mar 7 02:09:59.307: sipSPIUupdateCcCallIds: old streamcallid=1652, new streamcallid=1652
*Mar 7 02:09:59.307: sipSPIProcessRtpSessions
*Mar 7 02:09:59.307: sipSPIUpdateRtcpSession: for m-line 1
*Mar 7 02:09:59.307: sipSPIUpdateRtcpSession: rtcp_session info
laddr = 10.10.4.93, lport = 17222, raddr = 10.10.4.234, rport=4000, do_rtcp=TRUE
src_callid = 1652, dest_callid = 1651, stream type = 1
*Mar 7 02:09:59.311: sipSPIUpdateRtcpSession rtp session already created - update
*Mar 7 02:09:59.311: CCSIP-SPI-CONTROL: ccsip_caps_ind
*Mar 7 02:09:59.311: ccsip_get_rtcp_session_parameters: CURRENT VALUES: stream_callid=1652, current
_seq_num=0x6D7
*Mar 7 02:09:59.311: ccsip_get_rtcp_session_parameters: NEW VALUES: stream_callid=1652, current_seq
_num=0x6F5
*Mar 7 02:09:59.311: ccsip_caps_ind: Load DSP with negotiated codec : g711ulaw, Bytes=160
*Mar 7 02:09:59.311: ccsip_caps_ind: set forking flag to 0x0
*Mar 7 02:09:59.311: sipSPISetDTMFRelayMode: set DSP for dtmf-relay = CC_CAP_DTMF_RELAY_NTE_AND_OOB
*Mar 7 02:09:59.311: sip_set_modem_caps: Preferred (or the one that came from DSM) modem relay=0, f
rom CLI config=0
*Mar 7 02:09:59.311: sip_set_modem_caps: Disabling Modem Relay...
*Mar 7 02:09:59.311: sip_set_modem_caps: Negotiation already Done. Set negotiated Modem caps
*Mar 7 02:09:59.315: sip_set_modem_caps: Modem Relay & Passthru both disabled
*Mar 7 02:09:59.315: sip_set_modem_caps: nse payload = 100, ptru mode = 0, ptru-codec=0, redundancy
=0, xid=0, relay=0, sprt-retry=12, latecncy=200, compres-dir=3, dict=1024, strnlen=32
*Mar 7 02:09:59.315: sipSPISetStreamInfo: num_streams = 1
*Mar 7 02:09:59.315: sipSPISetStreamInfo: adding stream type 1 from mline 1
*Mar 7 02:09:59.315: sipSPISetStreamInfo: caps.stream_count=1, caps.stream[0].stream_type=0x2, caps
.stream_list.xmitFunc=voip_rtp_xmit, caps.stream_list.context=0x836DC41C (gccb)
*Mar 7 02:09:59.315: ccsip_caps_ind: Load DSP with codec : g711ulaw, Bytes=160
*Mar 7 02:09:59.315: CCSIP-SPI-CONTROL: ccsip_caps_ack
*Mar 7 02:09:59.315: ccsip_caps_ack: set forking flag to 0x0
*Mar 7 02:09:59.323: CCSIP-SPI-CONTROL: act_xfer_facility_msg
*Mar 7 02:09:59.323: CHOICE: 3
*Mar 7 02:09:59.323: OPCODE: 9
*Mar 7 02:09:59.323: INVOKE ID: 1654
*Mar 7 02:09:59.323: RERROR: 1004
*Mar 7 02:09:59.323: RequestCloseConnection: Closing connid 2 Local Port 52353
*Mar 7 02:09:59.323: Queued event from SIP SPI : SIPSPI_EV_CLOSE_CONNECTION
*Mar 7 02:09:59.323: Queued event from SIP SPI : SIPSPI_EV_CREATE_CONNECTION
*Mar 7 02:09:59.323: 0x8348528C : State change from (STATE_RECD_XFER, SUBSTATE_NONE) to (STATE_REC
D_XFER, SUBSTATE_CONNECTING)
*Mar 7 02:09:59.323: 0x8348528C : State change from (STATE_RECD_XFER, SUBSTATE_CONNECTING) to (STA
TE_RECD_XFER, SUBSTATE_CONNECTING)
*Mar 7 02:09:59.327: udpsock_close_connect: Socket fd: 2 closed for connid 2 with remote port: 5060
*Mar 7 02:09:59.327: CCSIP-SPI-CONTROL: sipSPICheckSocketConnection: Connid(1) created to 10.10.4.
234:5060, local_port 52831
*Mar 7 02:09:59.327: 0x8348528C : State change from (STATE_RECD_XFER, SUBSTATE_CONNECTING) to (STA
TE_RECD_XFER, SUBSTATE_NONE)
*Mar 7 02:09:59.327: CCSIP-SPI-CONTROL: act_xfer_connection_created
*Mar 7 02:09:59.331: sipSPIAddLocalContact
*Mar 7 02:09:59.331: Queued event from SIP SPI : SIPSPI_EV_SEND_MESSAGE
*Mar 7 02:09:59.331: sip_stats_method
*Mar 7 02:09:59.331: Sent:
NOTIFY sip:304 at 10.10.4.234:5060 SIP/2.0
Via: SIP/2.0/UDP 10.10.4.93:5060
From: "129" <sip:129 at 10.10.4.93>;tag=1F5D1A90-748
To: <sip:304 at 10.10.4.234>;tag=10710900
Date: Sun, 07 Mar 1993 02:09:59 GMT
Call-ID: ACA3F330-19B711CC-890FDA80-27A18D7D at 10.10.4.93
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 6
Timestamp: 731470199
CSeq: 102 NOTIFY
Event: refer
Contact: <sip:129 at 10.10.4.93:5060>
Content-Length: 35
Content-Type: message/sipfrag
SIP/2.0 503 Service Unavailable
+++++++++++++++++++++++++++++++++++++++
Masha Dorfman
More information about the cisco-nsp
mailing list