VoIP Mailing List Archives

[ted at pbxpal.com]

I'm having a problem with failover. I have the call_timeout set to 15 seconds which results in a landline ringing 4 rings, and INSTANTLY after the 4th ring fails over to the failover destination. However, if the number being dialed is a cell phone I've had one of two things happen: it will either ring and ring until voicemail, or what seems to happening now (I'm not sure what setting caused this) it will rings twice and there will be dead air and eventually the calling side will time out and fail.

timeout=15
desk phone: 4 rings -> failover
sprint mobile: 5 rings -> voicemail
verizon mobile: 5 rings -> voicemail

<section name="dialplan" description="">
<context name="public">
<extension name="did">
<condition field="destination_number" expression="^($did)$">

<!-- set the caller id -->
<action application="set" data="effective_caller_id_name=Bob Smith"/>
<action application="set" data="effective_caller_id_number=8005551234"/>

<!-- stops processing the dialplan after call is bridged -->
<!-- <action application="set" data="hangup_after_bridge=true"/> -->

<!-- this is needed to allow call_timeout to work after bridging to a gateway -->
<action application="set" data="ignore_early_media=true"/>

<!-- continue to process the dialplan after failure -->
<action application="set" data="continue_on_fail=NO_ANSWER"/>
<action application="set" data="continue_on_fail=true"/>

<!-- <action application="set" data="continue_on_fail=NORMAL_TEMPORARY_FAILURE,TIMEOUT,NO_ROUTE_DESTINATION,NO_ANSWER"/> -->


<!-- try the client shop -->
<action application="set" data="call_timeout=15"/>
<action application="bridge" data="sofia/vitelity/<number to try>@<carrier>"/>

<!-- failover destination -->
<action application="bridge" data="sofia/vitelity/$0@<failover dest>"/>

</condition>
</extension>
</context>
</section>

call to desk:
2008-10-15 15:47:13 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel sofia/vitelity/<caller>@<carrier> [1022c19a-9af2-11dd-bf67-89c26635687a]
2008-10-15 15:47:13 [INFO] mod_dialplan_xml.c:222 dialplan_hunt() Processing <caller>->4073921320@public
2008-10-15 15:47:13 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel sofia/vitelity/4078023342@<carrier> [1026f4ae-9af2-11dd-bf67-89c26635687a]
2008-10-15 15:47:14 [NOTICE] sofia.c:2167 sofia_handle_sip_i_state() Ring-Ready sofia/vitelity/4078023342@<carrier>!
2008-10-15 15:47:14 [NOTICE] mod_sofia.c:1058 sofia_receive_message() Ring-Ready sofia/vitelity/<caller>@<carrier>!
2008-10-15 15:47:14 [NOTICE] switch_ivr_originate.c:1148 switch_ivr_originate() Ring Ready sofia/vitelity/<caller>@<carrier>!
2008-10-15 15:47:28 [NOTICE] switch_ivr_originate.c:1277 switch_ivr_originate() Hangup sofia/vitelity/4078023342@<carrier> [CS_CONSUME_MEDIA] [NO_ANSWER]
2008-10-15 15:47:28 [INFO] mod_dptools.c:1789 audio_bridge_function() Originate Failed. Cause: NO_ANSWER
2008-10-15 15:47:28 [NOTICE] switch_core_session.c:807 switch_core_session_thread() Session 181 (sofia/vitelity/4078023342@<carrier>) Ended
2008-10-15 15:47:28 [NOTICE] switch_core_session.c:809 switch_core_session_thread() Close Channel sofia/vitelity/4078023342@<carrier> [CS_HANGUP]
2008-10-15 15:47:28 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel sofia/vitelity/4073921320@<failover dest> [18d07116-9af2-11dd-bf67-89c26635687a]
2008-10-15 15:47:28 [NOTICE] sofia.c:2456 sofia_handle_sip_i_state() Channel [sofia/vitelity/4073921320@<failover dest>] has been answered
2008-10-15 15:47:28 [NOTICE] sofia.c:2469 sofia_handle_sip_i_state() Channel [sofia/vitelity/<caller>@<carrier>] has been answered
2008-10-15 15:47:45 [NOTICE] sofia.c:2545 sofia_handle_sip_i_state() Hangup sofia/vitelity/<caller>@<carrier> [CS_HIBERNATE] [NORMAL_CLEARING]
2008-10-15 15:47:45 [NOTICE] switch_ivr_bridge.c:586 signal_bridge_on_hangup() Hangup sofia/vitelity/4073921320@<failover dest> [CS_HIBERNATE] [NORMAL_CLEARING]
2008-10-15 15:47:45 [NOTICE] switch_core_session.c:807 switch_core_session_thread() Session 180 (sofia/vitelity/<caller>@<carrier>) Ended
2008-10-15 15:47:45 [NOTICE] switch_core_session.c:809 switch_core_session_thread() Close Channel sofia/vitelity/<caller>@<carrier> [CS_HANGUP]
2008-10-15 15:47:45 [NOTICE] switch_core_session.c:807 switch_core_session_thread() Session 182 (sofia/vitelity/4073921320@<failover dest>) Ended
2008-10-15 15:47:45 [NOTICE] switch_core_session.c:809 switch_core_session_thread() Close Channel sofia/vitelity/4073921320@<failover dest> [CS_HANGUP]

call to cell phone:
2008-10-15 15:51:09 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel sofia/vitelity/<caller>@<carrier> [9cce820a-9af2-11dd-bf67-89c26635687a]
2008-10-15 15:51:09 [INFO] mod_dialplan_xml.c:222 dialplan_hunt() Processing <caller>->4073921320@public
2008-10-15 15:51:09 [NOTICE] switch_channel.c:534 switch_channel_set_name() New Channel sofia/vitelity/3216956446@<carrier> [9cd274fa-9af2-11dd-bf67-89c26635687a]
2008-10-15 15:51:13 [NOTICE] switch_channel.c:1406 switch_channel_perform_mark_pre_answered() Ring-Ready sofia/vitelity/3216956446@<carrier>!
2008-10-15 15:51:13 [NOTICE] sofia.c:2188 sofia_handle_sip_i_state() Pre-Answer sofia/vitelity/3216956446@<carrier>!
2008-10-15 15:51:13 [INFO] mod_sofia.c:1072 sofia_receive_message() Asked to send early media by sofia/vitelity/<caller>@<carrier>
2008-10-15 15:51:13 [NOTICE] switch_channel.c:1406 switch_channel_perform_mark_pre_answered() Ring-Ready sofia/vitelity/<caller>@<carrier>!
2008-10-15 15:51:13 [NOTICE] mod_sofia.c:1116 sofia_receive_message() Pre-Answer sofia/vitelity/<caller>@<carrier>!
2008-10-15 15:51:24 [NOTICE] switch_ivr_originate.c:1277 switch_ivr_originate() Hangup sofia/vitelity/3216956446@<carrier> [CS_CONSUME_MEDIA] [NO_ANSWER]
2008-10-15 15:51:24 [INFO] mod_dptools.c:1789 audio_bridge_function() Originate Failed. Cause: NO_ANSWER
2008-10-15 15:51:24 [NOTICE] switch_core_session.c:807 switch_core_session_thread() Session 187 (sofia/vitelity/3216956446@<carrier>) Ended
2008-10-15 15:51:24 [NOTICE] switch_core_session.c:809 switch_core_session_thread() Close Channel sofia/vitelity/3216956446@<carrier> [CS_HANGUP]
2008-10-15 15:52:14 [NOTICE] sofia.c:2545 sofia_handle_sip_i_state() Hangup sofia/vitelity/<caller>@<carrier> [CS_EXECUTE] [ORIGINATOR_CANCEL]
2008-10-15 15:52:25 [INFO] mod_dptools.c:1789 audio_bridge_function() Originate Failed. Cause: ORIGINATOR_CANCEL
2008-10-15 15:52:25 [NOTICE] switch_core_session.c:807 switch_core_session_thread() Session 186 (sofia/vitelity/<caller>@<carrier>) Ended
2008-10-15 15:52:25 [NOTICE] switch_core_session.c:809 switch_core_session_thread() Close Channel sofia/vitelity/<caller>@<carrier> [CS_HANGUP]


I'm not sure what to make of the differences between these logs. Any ideas?

Ted (irc:fedya)