VoIP Mailing List Archives

[juanbackson at gmail.com]

Hi,

I am running some continuous testing hitting FS. There are a couple errors that gets popped up occasionally and I am trying to find out why. In one of the trace, I am seeing FS not sending 183. The weird thing is that this problem is not happening everything, but on a very rarely basis. Also, there is no error message being sent. Does anyone know under what situation would freeswitch not sending out 183?

recv 771 bytes from udp/[192.168.1.122]:5060 at 14:28:50.460222:
------------------------------------------------------------------------
INVITE sip:0019008@192.168.1.116:5070 SIP/2.0
Record-Route: <sip:192.168.1.122;lr=on;ftag=9>
Via: SIP/2.0/UDP 192.168.1.122;branch=z9hG4bKe6e9.09c88aa1.0
Via: SIP/2.0/UDP 192.168.1.6:7001
From: 19008 <sip:19008@192.168.1.122:7001>;tag=9
To: 0019008 <sip:0019008@192.168.1.122 ([email]sip%3A0019008@192.168.1.122[/email])>
Call-ID: 9-10894@192.168.1.6 (9-10894@192.168.1.6)
CSeq: 2 INVITE
Contact: <sip:19008@192.168.1.6:7001>
Max-Forwards: 69
User-Agent: Performance Test
Content-Type: application/sdp
Content-Length: 272
P-hint: inbound->inbound

v=0
o=user1 53655765 2353687637 IN IP4 192.168.1.6
s=-
t=0 0
c=IN IP4 192.168.1.6
m=audio 6032 RTP/AVP 0 9 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:9 G722/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
------------------------------------------------------------------------
send 354 bytes to udp/[192.168.1.122]:5060 at 14:28:50.460805:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.122;branch=z9hG4bKe6e9.09c88aa1.0
Via: SIP/2.0/UDP 192.168.1.6:7001
Record-Route: <sip:192.168.1.122;lr=on;ftag=9>
From: 19008 <sip:19008@192.168.1.122:7001>;tag=9
To: 0019008 <sip:0019008@192.168.1.122 ([email]sip%3A0019008@192.168.1.122[/email])>
Call-ID: 9-10894@192.168.1.6 (9-10894@192.168.1.6)
CSeq: 2 INVITE
User-Agent: Freeswitch Media Gateway
Content-Length: 0

------------------------------------------------------------------------
2009-01-20 09:28:50 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel sofia/internal/19008@192.168.1.122:7001 ([email]sofia/internal/19008@192.168.1.122:7001[/email]) [a7f0594e-e6fe-11dd-9a2c-fbbebdd2887f]
2009-01-20 09:28:50 [INFO] mod_dialplan_xml.c:233 dialplan_hunt() Processing 19008->0019008 in context public
2009-01-20 09:28:50 [INFO] switch_ivr_async.c:1653 switch_ivr_bind_dtmf_meta_session() Bound A-Leg: 1 execute_extension::a_record XML features
2009-01-20 09:28:50 [INFO] switch_ivr_async.c:1653 switch_ivr_bind_dtmf_meta_session() Bound A-Leg: 2 execute_extension::a_stoprecord XML features
2009-01-20 09:28:50 [INFO] switch_ivr_async.c:1653 switch_ivr_bind_dtmf_meta_session() Bound A-Leg: 3 execute_extension::a_att_xfer XML features
2009-01-20 09:28:50 [INFO] switch_ivr_async.c:1660 switch_ivr_bind_dtmf_meta_session() Bound B-Leg: 1 execute_extension::b_record XML features
2009-01-20 09:28:50 [INFO] switch_ivr_async.c:1660 switch_ivr_bind_dtmf_meta_session() Bound B-Leg: 2 execute_extension::b_stoprecord XML features
2009-01-20 09:28:50 [INFO] switch_ivr_async.c:1660 switch_ivr_bind_dtmf_meta_session() Bound B-Leg: 3 execute_extension::b_att_xfer XML features
2009-01-20 09:28:50 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel sofia/internal/19008 [a816c7fa-e6fe-11dd-9a2c-fbbebdd2887f]
send 1229 bytes to udp/[192.168.1.122]:5060 at 14:28:50.715136:
------------------------------------------------------------------------
INVITE sip:19008@192.168.1.122:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.116:5070;rport;branch=z9hG4bKKe15F6Dap2jBa
Max-Forwards: 68
From: "19008" <sip:FreeswitchMediaGateway@openser;transport=udp>;tag=mB8gaveZvmF8K
To: <sip:19008@192.168.1.122:5060>
Call-ID: 7f75543a-61a1-122c-8282-001517871e28
CSeq: 110112529 INVITE
Contact: <sip:FreeswitchMediaGateway@192.168.1.116:5070;transport=udp>
User-Agent: Freeswitch Media Gateway
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
Supported: timer, precondition, path, replaces
Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Min-SE: 120
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 335
P-hint: inbound->inbound
Remote-Party-ID: "19008" <sip:19008@openser>;screen=yes;privacy=off

v=0
o=FreeSWITCH 5551695261821560906 6736752020354058642 IN IP4 192.168.1.116
s=FreeSWITCH
c=IN IP4 192.168.1.116
t=0 0
m=audio 12016 RTP/AVP 0 9 8 3 101 13
a=rtpmap:0 PCMU/8000
a=rtpmap:9 G722/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
recv 354 bytes from udp/[192.168.1.122]:5060 at 14:28:50.745112:
------------------------------------------------------------------------
SIP/2.0 100 Giving a try
Via: SIP/2.0/UDP 192.168.1.116:5070;rport=5070;branch=z9hG4bKKe15F6Dap2jBa
From: "19008" <sip:FreeswitchMediaGateway@openser;transport=udp>;tag=mB8gaveZvmF8K
To: <sip:19008@192.168.1.122:5060>
Call-ID: 7f75543a-61a1-122c-8282-001517871e28
CSeq: 110112529 INVITE
Server: OpenSIPS (1.4.3-notls (x86_64/linux))
Content-Length: 0

------------------------------------------------------------------------
recv 438 bytes from udp/[192.168.1.122]:5060 at 14:28:50.748929:
------------------------------------------------------------------------
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.1.116:5070;received=192.168.1.116;rport=5070;branch=z9hG4bKKe15F6Dap2jBa
Record-Route: <sip:192.168.1.122;lr=on;ftag=mB8gaveZvmF8K>
From: "19008" <sip:FreeswitchMediaGateway@openser;transport=udp>;tag=mB8gaveZvmF8K
To: <sip:19008@192.168.1.122:5060>;tag=9
Call-ID: 7f75543a-61a1-122c-8282-001517871e28
CSeq: 110112529 INVITE
Contact: <sip:192.168.1.7:7000;transport=UDP>
Content-Length: 0

------------------------------------------------------------------------
recv 740 bytes from udp/[192.168.1.122]:5060 at 14:28:50.749130:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.116:5070;received=192.168.1.116;rport=5070;branch=z9hG4bKKe15F6Dap2jBa
Record-Route: <sip:192.168.1.122;lr=on;ftag=mB8gaveZvmF8K>
From: "19008" <sip:FreeswitchMediaGateway@openser;transport=udp>;tag=mB8gaveZvmF8K
To: <sip:19008@192.168.1.122:5060>;tag=9
Call-ID: 7f75543a-61a1-122c-8282-001517871e28
CSeq: 110112529 INVITE
Contact: <sip:192.168.1.7:7000;transport=UDP>
Content-Type: application/sdp
Content-Length: 272

2009-01-20 09:28:50 [NOTICE] sofia.c:2627 sofia_handle_sip_i_state() Ring-Ready sofia/internal/19008!
v=0
o=user1 53655765 2353687637 IN IP4 192.168.1.7
s=-
c=IN IP4 192.168.1.7
t=0 0
m=audio 6000 RTP/AVP 0 9 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:9 G722/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
------------------------------------------------------------------------
send 463 bytes to udp/[192.168.1.122]:5060 at 14:28:50.749566:
------------------------------------------------------------------------
ACK sip:192.168.1.7:7000;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.1.116:5070;rport;branch=z9hG4bKmQtyH1yDKB9XN
Route: <sip:192.168.1.122;lr=on;ftag=mB8gaveZvmF8K>
Max-Forwards: 70
From: "19008" <sip:FreeswitchMediaGateway@openser;transport=udp>;tag=mB8gaveZvmF8K
To: <sip:19008@192.168.1.122:5060>;tag=9
Call-ID: 7f75543a-61a1-122c-8282-001517871e28
CSeq: 110112529 ACK
Contact: <sip:FreeswitchMediaGateway@192.168.1.116:5070;transport=udp>
Content-Length: 0

------------------------------------------------------------------------
2009-01-20 09:28:50 [NOTICE] sofia.c:3065 sofia_handle_sip_i_state() Channel [sofia/internal/19008] has been answered
2009-01-20 09:28:50 [INFO] mod_sofia.c:1294 sofia_receive_message() Asked to send early media by sofia/internal/19008@192.168.1.122:7001 ([email]sofia/internal/19008@192.168.1.122:7001[/email])
2009-01-20 09:28:50 [INFO] mod_sofia.c:1335 sofia_receive_message() Ring SDP:
v=0
o=FreeSWITCH 1232449708 1232449709 IN IP4 192.168.1.116
s=FreeSWITCH
c=IN IP4 192.168.1.116
t=0 0
m=audio 12022 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
2009-01-20 09:28:50 [NOTICE] mod_sofia.c:1338 sofia_receive_message() Ring-Ready sofia/internal/19008@192.168.1.122:7001 ([email]sofia/internal/19008@192.168.1.122:7001[/email])!
2009-01-20 09:28:50 [NOTICE] mod_sofia.c:1338 sofia_receive_message() Pre-Answer sofia/internal/19008@192.168.1.122:7001 ([email]sofia/internal/19008@192.168.1.122:7001[/email])!
2009-01-20 09:28:50 [NOTICE] switch_ivr_originate.c:1838 switch_ivr_originate() Channel [sofia/internal/19008@192.168.1.122:7001] has been answered
send 1058 bytes to udp/[192.168.1.122]:5060 at 14:28:50.820186:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.122;branch=z9hG4bKe6e9.09c88aa1.0
Via: SIP/2.0/UDP 192.168.1.6:7001
Record-Route: <sip:192.168.1.122;lr=on;ftag=9>
From: 19008 <sip:19008@192.168.1.122:7001>;tag=9
To: 0019008 <sip:0019008@192.168.1.122 ([email]sip%3A0019008@192.168.1.122[/email])>;tag=K2er80XUZBSNr
Call-ID: 9-10894@192.168.1.6 (9-10894@192.168.1.6)
CSeq: 2 INVITE
Contact: <sip:mod_sofia@192.168.1.116:5070;transport=udp>
User-Agent: Freeswitch Media Gateway
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
Supported: timer, precondition, path, replaces
Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Min-SE: 120
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 267

v=0
o=FreeSWITCH 6403206013178204633 6807646593930218658 IN IP4 192.168.1.116
s=FreeSWITCH
c=IN IP4 192.168.1.116
t=0 0
m=audio 12022 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
------------------------------------------------------------------------
send 1058 bytes to udp/[192.168.1.122]:5060 at 14:28:51.321221:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.122;branch=z9hG4bKe6e9.09c88aa1.0
Via: SIP/2.0/UDP 192.168.1.6:7001
Record-Route: <sip:192.168.1.122;lr=on;ftag=9>
From: 19008 <sip:19008@192.168.1.122:7001>;tag=9
To: 0019008 <sip:0019008@192.168.1.122 ([email]sip%3A0019008@192.168.1.122[/email])>;tag=K2er80XUZBSNr
Call-ID: 9-10894@192.168.1.6 (9-10894@192.168.1.6)
CSeq: 2 INVITE
Contact: <sip:mod_sofia@192.168.1.116:5070;transport=udp>
User-Agent: Freeswitch Media Gateway
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
Supported: timer, precondition, path, replaces
Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Min-SE: 120
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 267

v=0
o=FreeSWITCH 6403206013178204633 6807646593930218658 IN IP4 192.168.1.116
s=FreeSWITCH
c=IN IP4 192.168.1.116
t=0 0
m=audio 12022 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
------------------------------------------------------------------------

[brian at freeswitch.org]

I see a 180 ringing. You would see a 183 with SDP if the far end had
media to provide inband ringing.

/b

On Jan 20, 2009, at 1:56 AM, Juan Backson wrote: