<html>
<head>
<meta http-equiv="Content-Type" content="text/html; charset=us-ascii">
</head>
<body style="word-wrap: break-word; -webkit-nbsp-mode: space; -webkit-line-break: after-white-space; color: rgb(0, 0, 0); font-size: 14px; font-family: Calibri, sans-serif; ">
<div>Hi All,</div>
<div><br>
</div>
<div>My home use lab uses cisco call manager 8.0. My old setup was cisco call manager to asterisk and then to google voice. Since asterisk and google voice are now broken; I'm looking to move in the direction of free switch. </div>
<div><br>
</div>
<div>Currently My cisco call manager can call any extension on free switch and leave voicemail's. When I add google talk to frees witch I'm able to call from my cisco VoIP phone, through free switch, and to google.</div>
<div><br>
</div>
<div>My issue is that free switch is unable to call my cisco call manager. Below is an output of the log of a call from extension 2002 to extension 4000. From what I can tell is that free-switch is not even trying to talk to 10.0.1.99 (my call manger). It's
failing before it gets that far.</div>
<div><br>
</div>
<div><br>
</div>
<div><br>
</div>
<div><br>
</div>
<div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[G7221:115:32000:20:48000]</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[G7221:107:16000:20:32000]</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[G722:9:8000:20:64000]</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[PCMU:0:8000:20:64000]</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:2721 Set Codec sofia/sipinterface_1/peter_gibbons@bluebox PCMU/8000 20 ms 160 samples 64000 bits</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4457 Set 2833 dtmf send/recv payload to 101</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] sofia.c:4732 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_NEW -> CS_INIT</div>
<div>2012-03-09 08:05:13.418262 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK]</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_INIT</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:342 (sofia/sipinterface_1/peter_gibbons@bluebox) State INIT</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:83 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA INIT</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:123 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_INIT -> CS_ROUTING</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK]</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:342 (sofia/sipinterface_1/peter_gibbons@bluebox) State INIT going to sleep</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_ROUTING</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_channel.c:1615 (sofia/sipinterface_1/peter_gibbons@bluebox) Callstate Change DOWN -> RINGING</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:345 (sofia/sipinterface_1/peter_gibbons@bluebox) State ROUTING</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:146 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA ROUTING</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:77 sofia/sipinterface_1/peter_gibbons@bluebox Standard ROUTING</div>
<div>2012-03-09 08:05:13.419735 [INFO] mod_dialplan_xml.c:331 Processing peter_gibbons <peter_gibbons>->4000 in context context_1</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->conditioning_callerid] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [conditioning_callerid] ${internal_caller_id_number}(2002) =~ /^.+$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_name=${internal_caller_id_name}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_number=${internal_caller_id_number}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->postroute_global] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Absolute Condition [postroute_global]</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action hash(insert/${domain_name}-last_dial/global/${uuid}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->preanswer_gtalk] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [preanswer_gtalk] source(mod_sofia) =~ /^mod_dingaling$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_trunk_1_pattern_5] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [main_trunk_1_pattern_5] destination_number(4000) =~ /^(40[0-9]{2})$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(prepend=) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [main_trunk_1_pattern_5] ${outbound_caller_id_number}(5555552002) =~ /^.+$/ break=never</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_name=${outbound_caller_id_name}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_number=${outbound_caller_id_number}) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action export(sip_cid_type=rpid) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [main_trunk_1_pattern_5] destination_number(4000) =~ /^(40[0-9]{2})$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(failure_causes=NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action bridge(sofia/gateway/trunk_1/${prepend}4000) </div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_6] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_6] destination_number(4000) =~ /^2006$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_5] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_5] destination_number(4000) =~ /^2005$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_4] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_4] destination_number(4000) =~ /^2004$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_3] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_3] destination_number(4000) =~ /^2003$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_2] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_2] destination_number(4000) =~ /^2002$/ break=on-false</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_1] continue=true</div>
<div>Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_1] destination_number(4000) =~ /^2001$/ break=on-false</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:119 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_ROUTING -> CS_EXECUTE</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK]</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:345 (sofia/sipinterface_1/peter_gibbons@bluebox) State ROUTING going to sleep</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_EXECUTE</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:352 (sofia/sipinterface_1/peter_gibbons@bluebox) State EXECUTE</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:239 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA EXECUTE</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:157 sofia/sipinterface_1/peter_gibbons@bluebox Standard EXECUTE</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_name=Peter Gibbons)</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_name]=[Peter Gibbons]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_number=2002)</div>
<div>2012-03-09 08:05:13.419735 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_number]=[2002]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox hash(insert/10.0.1.3-spymap/peter_gibbons/bc1115e3-b592-454c-8813-a6a7fb2754d4)</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox hash(insert/10.0.1.3-last_dial/peter_gibbons/4000)</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox hash(insert/10.0.1.3-last_dial/global/bc1115e3-b592-454c-8813-a6a7fb2754d4)</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(RFC2822_DATE=Fri, 09 Mar 2012 08:05:13 -0800)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [RFC2822_DATE]=[Fri, 09 Mar 2012 08:05:13 -0800]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(prepend=)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [prepend]=[UNDEF]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_name=Peter Gibbons)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_name]=[Peter Gibbons]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_number=5555552002)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_number]=[5555552002]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox export(sip_cid_type=rpid)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:933 EXPORT (export_vars) [sip_cid_type]=[rpid]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(failure_causes=NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [failure_causes]=[NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH]</div>
<div>EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox bridge(sofia/gateway/trunk_1/4000)</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:890 sofia/sipinterface_1/peter_gibbons@bluebox EXPORTING[export_vars] [sip_cid_type]=[rpid] to event</div>
<div><b>2012-03-09 08:05:13.421692 [ERR] mod_sofia.c:3738 Invalid Gateway</b></div>
<div>2012-03-09 08:05:13.421692 [NOTICE] mod_sofia.c:4060 Close Channel N/A [CS_NEW]</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:434 () Running State Change CS_DESTROY</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:444 (N/A) State DESTROY</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_sofia.c:361 N/A SOFIA DESTROY</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:444 (N/A) State DESTROY going to sleep</div>
<div><b>2012-03-09 08:05:13.421692 [ERR] switch_ivr_originate.c:2605 Cannot create outgoing channel of type [sofia] cause: [INVALID_NUMBER_FORMAT]</b></div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_ivr_originate.c:3413 Originate Resulted in Error Cause: 28 [INVALID_NUMBER_FORMAT]</div>
<div>2012-03-09 08:05:13.421692 [INFO] mod_dptools.c:2579 Originate Failed. Cause: INVALID_NUMBER_FORMAT</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:2610 Failure causes [NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH]: Cause: INVALID_NUMBER_FORMAT</div>
<div>2012-03-09 08:05:13.421692 [NOTICE] switch_core_state_machine.c:189 sofia/sipinterface_1/peter_gibbons@bluebox has executed the last dialplan instruction, hanging up.</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:2457 (sofia/sipinterface_1/peter_gibbons@bluebox) Callstate Change RINGING -> HANGUP</div>
<div>2012-03-09 08:05:13.421692 [NOTICE] switch_core_state_machine.c:191 Hangup sofia/sipinterface_1/peter_gibbons@bluebox [CS_EXECUTE] [NORMAL_CLEARING]</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:2473 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [KILL]</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK]</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:352 (sofia/sipinterface_1/peter_gibbons@bluebox) State EXECUTE going to sleep</div>
<div>2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_HANGUP</div>
<div>2012-03-09 08:05:13.423711 [DEBUG] switch_core_state_machine.c:539 (sofia/sipinterface_1/peter_gibbons@bluebox) State HANGUP</div>
<div>2012-03-09 08:05:13.423711 [DEBUG] mod_sofia.c:456 Channel sofia/sipinterface_1/peter_gibbons@bluebox hanging up, cause: NORMAL_CLEARING</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] mod_sofia.c:518 Responding to INVITE with: 480</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:46 sofia/sipinterface_1/peter_gibbons@bluebox Standard HANGUP, cause: NORMAL_CLEARING</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:539 (sofia/sipinterface_1/peter_gibbons@bluebox) State HANGUP going to sleep</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:337 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_HANGUP -> CS_REPORTING</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK]</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_REPORTING</div>
<div>2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:599 (sofia/sipinterface_1/peter_gibbons@bluebox) State REPORTING</div>
<div>2012-03-09 08:05:13.586710 [DEBUG] switch_core_state_machine.c:53 sofia/sipinterface_1/peter_gibbons@bluebox Standard REPORTING, cause: NORMAL_CLEARING</div>
<div>2012-03-09 08:05:13.586710 [DEBUG] switch_core_state_machine.c:599 (sofia/sipinterface_1/peter_gibbons@bluebox) State REPORTING going to sleep</div>
<div>2012-03-09 08:05:13.586710 [DEBUG] switch_core_state_machine.c:331 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_REPORTING -> CS_DESTROY</div>
<div>2012-03-09 08:05:13.586710 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK]</div>
<div>2012-03-09 08:05:13.586710 [DEBUG] switch_core_session.c:1224 Session 66 (sofia/sipinterface_1/peter_gibbons@bluebox) Locked, Waiting on external entities</div>
<div>2012-03-09 08:05:13.586710 [NOTICE] switch_core_session.c:1242 Session 66 (sofia/sipinterface_1/peter_gibbons@bluebox) Ended</div>
<div>2012-03-09 08:05:13.586710 [NOTICE] switch_core_session.c:1244 Close Channel sofia/sipinterface_1/peter_gibbons@bluebox [CS_DESTROY]</div>
<div>2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:431 (sofia/sipinterface_1/peter_gibbons@bluebox) Callstate Change HANGUP -> DOWN</div>
<div>2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:434 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_DESTROY</div>
<div>2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:444 (sofia/sipinterface_1/peter_gibbons@bluebox) State DESTROY</div>
<div>2012-03-09 08:05:13.588724 [DEBUG] mod_sofia.c:361 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA DESTROY</div>
<div>2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:60 sofia/sipinterface_1/peter_gibbons@bluebox Standard DESTROY</div>
<div>2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:444 (sofia/sipinterface_1/peter_gibbons@bluebox) State DESTROY going to sleep</div>
</div>
</body>
</html>