<div>Hi,</div><div><br></div><div>I am trying to integrate Newfies with Freeswitch.</div><div><br></div><div>I tried using loopback to route it to 9171 to default context. However, it doesnot works. When the customer picks up the call, there is a dead air.</div>
<div><br></div><div>Pleae advice.</div><div><br></div><div>Logs for your refernce. </div><div><br></div><div>13526785574 = external number </div><div><br></div><div>2011-11-08 08:11:21.192674 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(hangup_after_bridge=false)</div>
<div>EXECUTE sofia/external/13526785574 set(hangup_after_bridge=false)</div><div>2011-11-08 08:11:21.212673 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [hangup_after_bridge]=[false]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute unset(call_timeout)</div>
<div>EXECUTE sofia/external/13526785574 unset(call_timeout)</div><div>2011-11-08 08:11:21.212673 [DEBUG] mod_dptools.c:1294 UNSET [call_timeout]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute unset(effective_caller_id_number)</div>
<div>EXECUTE sofia/external/13526785574 unset(effective_caller_id_number)</div><div>2011-11-08 08:11:21.212673 [DEBUG] mod_dptools.c:1294 UNSET [effective_caller_id_number]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute unset(effective_caller_id_name)</div>
<div>EXECUTE sofia/external/13526785574 unset(effective_caller_id_name)</div><div>2011-11-08 08:11:21.212673 [DEBUG] mod_dptools.c:1294 UNSET [effective_caller_id_name]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(continue_on_fail=true)</div>
<div>EXECUTE sofia/external/13526785574 set(continue_on_fail=true)</div><div>2011-11-08 08:11:21.212673 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [continue_on_fail]=[true]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.212673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(hangup_after_bridge=false)</div><div>EXECUTE sofia/external/13526785574 set(hangup_after_bridge=false)</div><div>2011-11-08 08:11:21.212673 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [hangup_after_bridge]=[false]</div>
<div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.212673 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(plivo_dial_rang=false)</div>
<div>EXECUTE sofia/external/13526785574 set(plivo_dial_rang=false)</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [plivo_dial_rang]=[false]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute unset(bridge_terminate_key)</div>
<div>EXECUTE sofia/external/13526785574 unset(bridge_terminate_key)</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_dptools.c:1294 UNSET [bridge_terminate_key]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(bridge_early_media=false)</div>
<div>EXECUTE sofia/external/13526785574 set(bridge_early_media=false)</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [bridge_early_media]=[false]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(instant_ringback=true)</div>
<div>EXECUTE sofia/external/13526785574 set(instant_ringback=true)</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [instant_ringback]=[true]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute set(ringback=$${us-ring}})</div>
<div>EXECUTE sofia/external/13526785574 set(ringback=$%(2000,4000,440,480)})</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_dptools.c:1177 sofia/external/13526785574 SET [ringback]=[$%(2000,4000,440,480)}]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute ring_ready()</div>
<div>EXECUTE sofia/external/13526785574 ring_ready()</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute bridge(<api_on_ring='uuid_setvar 225b5e18-0a0b-11e1-ba82-590058a85379 plivo_dial_rang true',api_on_pre_answer='uuid_setvar 225b5e18-0a0b-11e1-ba82-590058a85379 plivo_dial_rang true',api_on_answer_1='sched_api +300 26f2e3f6-0a0b-11e1-8b92-bc305bec2901 uuid_transfer 225b5e18-0a0b-11e1-ba82-590058a85379 -bleg hangup:ALLOTTED_TIMEOUT inline'>[leg_timeout=10]loopback/9171/default/xml:_:)</div>
<div>EXECUTE sofia/external/13526785574 bridge(<api_on_ring='uuid_setvar 225b5e18-0a0b-11e1-ba82-590058a85379 plivo_dial_rang true',api_on_pre_answer='uuid_setvar 225b5e18-0a0b-11e1-ba82-590058a85379 plivo_dial_rang true',api_on_answer_1='sched_api +300 26f2e3f6-0a0b-11e1-8b92-bc305bec2901 uuid_transfer 225b5e18-0a0b-11e1-ba82-590058a85379 -bleg hangup:ALLOTTED_TIMEOUT inline'>[leg_timeout=10]loopback/9171/default/xml:_:)</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:1413 Parsing ultra-global variables</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_event.c:1521 Parsing variable [api_on_ring]=[uuid_setvar 225b5e18-0a0b-11e1-ba82-590058a85379 plivo_dial_rang true]</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_event.c:1521 Parsing variable [api_on_pre_answer]=[uuid_setvar 225b5e18-0a0b-11e1-ba82-590058a85379 plivo_dial_rang true]</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_event.c:1521 Parsing variable [api_on_answer_1]=[sched_api +300 26f2e3f6-0a0b-11e1-8b92-bc305bec2901 uuid_transfer 225b5e18-0a0b-11e1-ba82-590058a85379 -bleg hangup:ALLOTTED_TIMEOUT inline]</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:2299 Parsing session specific variables</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:1884 Parsing global variables</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_event.c:1521 Parsing variable [leg_timeout]=[10]</div><div>2011-11-08 08:11:21.232676 [WARNING] switch_ivr_originate.c:1903 No origination URL specified!</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:3348 Originate Resulted in Error Cause: 27 [DESTINATION_OUT_OF_ORDER]</div>
<div>2011-11-08 08:11:21.232676 [NOTICE] switch_channel.c:915 New Channel loopback/9171/default/xml-a [26f5283c-0a0b-11e1-ba88-590058a85379]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:143 loopback/9171/default/xml-a setup codec L16/8000/20</div>
<div>2011-11-08 08:11:21.232676 [NOTICE] switch_channel.c:913 Rename Channel loopback/9171/default/xml-a->loopback/9171-a [26f5283c-0a0b-11e1-ba88-590058a85379]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:943 (loopback/9171-a) State Change CS_NEW -> CS_INIT</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-a [BREAK]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:2554 loopback/9171-a Setting leg timeout to 10</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-a) Running State Change CS_INIT</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:401 (loopback/9171-a) State INIT</div>
<div>2011-11-08 08:11:21.232676 [NOTICE] switch_channel.c:915 New Channel loopback/9171-b [26f53af2-0a0b-11e1-ba8a-590058a85379]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:143 loopback/9171-b setup codec L16/8000/20</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:256 (loopback/9171-b) State Change CS_NEW -> CS_INIT</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:302 (loopback/9171-a) State Change CS_INIT -> CS_ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-a [BREAK]</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:401 (loopback/9171-a) State INIT going to sleep</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-b) Running State Change CS_INIT</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:401 (loopback/9171-b) State INIT</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:302 (loopback/9171-b) State Change CS_INIT -> CS_ROUTING</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:401 (loopback/9171-b) State INIT going to sleep</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-a) Running State Change CS_ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_channel.c:1844 (loopback/9171-a) Callstate Change DOWN -> RINGING</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-b) Running State Change CS_ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_channel.c:1844 (loopback/9171-b) Callstate Change DOWN -> RINGING</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:410 (loopback/9171-a) State ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:334 loopback/9171-a CHANNEL ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_ivr_originate.c:66 (loopback/9171-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-a [BREAK]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:410 (loopback/9171-a) State ROUTING going to sleep</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-a) Running State Change CS_CONSUME_MEDIA</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:410 (loopback/9171-b) State ROUTING</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:429 (loopback/9171-a) State CONSUME_MEDIA</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:334 loopback/9171-b CHANNEL ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:533 CHANNEL CONSUME_MEDIA</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:104 loopback/9171-b Standard ROUTING</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:429 (loopback/9171-a) State CONSUME_MEDIA going to sleep</div>
<div>2011-11-08 08:11:21.232676 [INFO] mod_dialplan_xml.c:336 Processing Outbound Call <13526785574>->9171 in context default</div><div>Dialplan: loopback/9171-b parsing [default->plivo] continue=false</div><div>
Dialplan: loopback/9171-b Regex (PASS) [plivo] destination_number(9171) =~ /^(\d+)$/ break=on-false</div><div>Dialplan: loopback/9171-b Action socket(<a href="http://127.0.0.1:8084">127.0.0.1:8084</a> async full)</div><div>
2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:154 (loopback/9171-b) State Change CS_ROUTING -> CS_EXECUTE</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:410 (loopback/9171-b) State ROUTING going to sleep</div><div>
2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-b) Running State Change CS_EXECUTE</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:417 (loopback/9171-b) State EXECUTE</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:373 loopback/9171-b CHANNEL EXECUTE</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_state_machine.c:192 loopback/9171-b Standard EXECUTE</div><div>EXECUTE loopback/9171-b socket(<a href="http://127.0.0.1:8084">127.0.0.1:8084</a> async full)</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1009 Send signal loopback/9171-b [BREAK]</div><div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.232676 [DEBUG] switch_core_session.c:1009 Send signal loopback/9171-b [BREAK]</div>
<div>2011-11-08 08:11:21.232676 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1009 Send signal loopback/9171-b [BREAK]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] mod_event_socket.c:2617 (loopback/9171-b) State Change CS_EXECUTE -> CS_RESET</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_ivr.c:577 loopback/9171-b Command Execute set(plivo_app=true)</div><div>EXECUTE loopback/9171-b set(plivo_app=true)</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] mod_dptools.c:1177 loopback/9171-b SET [plivo_app]=[true]</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_ivr.c:577 loopback/9171-b Command Execute set(hangup_after_bridge=false)</div>
<div>EXECUTE loopback/9171-b set(hangup_after_bridge=false)</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_dptools.c:1177 loopback/9171-b SET [hangup_after_bridge]=[false]</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_ivr.c:577 loopback/9171-b Command Execute hangup()</div>
<div>EXECUTE loopback/9171-b hangup()</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_channel.c:2804 (loopback/9171-b) Callstate Change RINGING -> HANGUP</div><div>2011-11-08 08:11:21.252674 [NOTICE] mod_dptools.c:1030 Hangup loopback/9171-b [CS_RESET] [NORMAL_CLEARING]</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_channel.c:2820 Send signal loopback/9171-b [KILL]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:2262 loopback/9171-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:2262 loopback/9171-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:417 (loopback/9171-b) State EXECUTE going to sleep</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-b) Running State Change CS_HANGUP</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:602 (loopback/9171-b) State HANGUP</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:425 loopback/9171-b CHANNEL HANGUP</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_channel.c:2804 (loopback/9171-a) Callstate Change RINGING -> HANGUP</div><div>
2011-11-08 08:11:21.252674 [NOTICE] mod_loopback.c:436 Hangup loopback/9171-a [CS_CONSUME_MEDIA] [NORMAL_CLEARING]</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_channel.c:2820 Send signal loopback/9171-a [KILL]</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-a [BREAK]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:47 loopback/9171-b Standard HANGUP, cause: NORMAL_CLEARING</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:602 (loopback/9171-b) State HANGUP going to sleep</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-a) Running State Change CS_HANGUP</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:393 (loopback/9171-b) State Change CS_HANGUP -> CS_REPORTING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-b) Running State Change CS_REPORTING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:662 (loopback/9171-b) State REPORTING</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:602 (loopback/9171-a) State HANGUP</div><div>
2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:425 loopback/9171-a CHANNEL HANGUP</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:47 loopback/9171-a Standard HANGUP, cause: NORMAL_CLEARING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:602 (loopback/9171-a) State HANGUP going to sleep</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:393 (loopback/9171-a) State Change CS_HANGUP -> CS_REPORTING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-a [BREAK]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:362 (loopback/9171-a) Running State Change CS_REPORTING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:662 (loopback/9171-a) State REPORTING</div><div>2011-11-08 08:11:21.252674 [ERR] mod_xml_cdr.c:366 Got error [0] posting to web server [NEWFIES_API_STORE_CDR]</div>
<div>2011-11-08 08:11:21.252674 [ERR] mod_xml_cdr.c:373 Retry will be with url [NEWFIES_API_STORE_CDR]</div><div>2011-11-08 08:11:21.252674 [ERR] mod_xml_cdr.c:384 Unable to post to web server, writing to file</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:79 loopback/9171-b Standard REPORTING, cause: NORMAL_CLEARING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:662 (loopback/9171-b) State REPORTING going to sleep</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:387 (loopback/9171-b) State Change CS_REPORTING -> CS_DESTROY</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-b [BREAK]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-b CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1377 Session 148 (loopback/9171-b) Locked, Waiting on external entities</div>
<div>2011-11-08 08:11:21.252674 [NOTICE] switch_core_session.c:1395 Session 148 (loopback/9171-b) Ended</div><div>2011-11-08 08:11:21.252674 [NOTICE] switch_core_session.c:1397 Close Channel loopback/9171-b [CS_DESTROY]</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:491 (loopback/9171-b) Callstate Change HANGUP -> DOWN</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:494 (loopback/9171-b) Running State Change CS_DESTROY</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:504 (loopback/9171-b) State DESTROY</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:86 loopback/9171-b Standard DESTROY</div><div>
2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:504 (loopback/9171-b) State DESTROY going to sleep</div><div>2011-11-08 08:11:21.252674 [ERR] mod_xml_cdr.c:366 Got error [0] posting to web server [NEWFIES_API_STORE_CDR]</div>
<div>2011-11-08 08:11:21.252674 [ERR] mod_xml_cdr.c:373 Retry will be with url [NEWFIES_API_STORE_CDR]</div><div>2011-11-08 08:11:21.252674 [ERR] mod_xml_cdr.c:384 Unable to post to web server, writing to file</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:79 loopback/9171-a Standard REPORTING, cause: NORMAL_CLEARING</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:662 (loopback/9171-a) State REPORTING going to sleep</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:387 (loopback/9171-a) State Change CS_REPORTING -> CS_DESTROY</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1177 Send signal loopback/9171-a [BREAK]</div><div>2011-11-08 08:11:21.252674 [DEBUG] mod_loopback.c:473 loopback/9171-a CHANNEL KILL</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_session.c:1377 Session 147 (loopback/9171-a) Locked, Waiting on external entities</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_ivr_originate.c:3348 Originate Resulted in Error Cause: 16 [NORMAL_CLEARING]</div><div>2011-11-08 08:11:21.252674 [NOTICE] switch_core_session.c:1395 Session 147 (loopback/9171-a) Ended</div>
<div>2011-11-08 08:11:21.252674 [NOTICE] switch_core_session.c:1397 Close Channel loopback/9171-a [CS_DESTROY]</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:491 (loopback/9171-a) Callstate Change HANGUP -> DOWN</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:494 (loopback/9171-a) Running State Change CS_DESTROY</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:504 (loopback/9171-a) State DESTROY</div>
<div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:86 loopback/9171-a Standard DESTROY</div><div>2011-11-08 08:11:21.252674 [DEBUG] switch_core_state_machine.c:504 (loopback/9171-a) State DESTROY going to sleep</div>
<div>2011-11-08 08:11:21.272673 [DEBUG] switch_rtp.c:3181 Correct ip/port confirmed.</div><div>2011-11-08 08:11:21.312678 [INFO] mod_dptools.c:2811 Originate Failed. Cause: NORMAL_CLEARING</div><div>2011-11-08 08:11:21.312678 [DEBUG] switch_core_session.c:1009 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.312678 [DEBUG] mod_event_socket.c:2617 (sofia/external/13526785574) State Change CS_EXECUTE -> CS_RESET</div><div>2011-11-08 08:11:21.312678 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_ivr.c:577 sofia/external/13526785574 Command Execute hangup()</div><div>EXECUTE sofia/external/13526785574 hangup()</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_channel.c:2804 (sofia/external/13526785574) Callstate Change ACTIVE -> HANGUP</div>
<div>2011-11-08 08:11:21.332673 [NOTICE] mod_dptools.c:1030 Hangup sofia/external/13526785574 [CS_RESET] [NORMAL_CLEARING]</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_channel.c:2820 Send signal sofia/external/13526785574 [KILL]</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_session.c:2262 sofia/external/13526785574 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_session.c:2262 sofia/external/13526785574 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:417 (sofia/external/13526785574) State EXECUTE going to sleep</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:362 (sofia/external/13526785574) Running State Change CS_HANGUP</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:602 (sofia/external/13526785574) State HANGUP</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] mod_sofia.c:465 Channel sofia/external/13526785574 hanging up, cause: NORMAL_CLEARING</div><div>2011-11-08 08:11:21.332673 [DEBUG] mod_sofia.c:509 Sending BYE to sofia/external/13526785574</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:47 sofia/external/13526785574 Standard HANGUP, cause: NORMAL_CLEARING</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:602 (sofia/external/13526785574) State HANGUP going to sleep</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:393 (sofia/external/13526785574) State Change CS_HANGUP -> CS_REPORTING</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/13526785574 [BREAK]</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:362 (sofia/external/13526785574) Running State Change CS_REPORTING</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:662 (sofia/external/13526785574) State REPORTING</div>
<div>2011-11-08 08:11:21.332673 [ERR] mod_xml_cdr.c:366 Got error [0] posting to web server [NEWFIES_API_STORE_CDR]</div><div>2011-11-08 08:11:21.332673 [ERR] mod_xml_cdr.c:373 Retry will be with url [NEWFIES_API_STORE_CDR]</div>
<div>2011-11-08 08:11:21.332673 [ERR] mod_xml_cdr.c:384 Unable to post to web server, writing to file</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:79 sofia/external/13526785574 Standard REPORTING, cause: NORMAL_CLEARING</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:662 (sofia/external/13526785574) State REPORTING going to sleep</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:387 (sofia/external/13526785574) State Change CS_REPORTING -> CS_DESTROY</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_session.c:1177 Send signal sofia/external/13526785574 [BREAK]</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_session.c:1377 Session 146 (sofia/external/13526785574) Locked, Waiting on external entities</div>
<div>2011-11-08 08:11:21.332673 [NOTICE] switch_core_session.c:1395 Session 146 (sofia/external/13526785574) Ended</div><div>2011-11-08 08:11:21.332673 [NOTICE] switch_core_session.c:1397 Close Channel sofia/external/13526785574 [CS_DESTROY]</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:491 (sofia/external/13526785574) Callstate Change HANGUP -> DOWN</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:494 (sofia/external/13526785574) Running State Change CS_DESTROY</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:504 (sofia/external/13526785574) State DESTROY</div><div>2011-11-08 08:11:21.332673 [DEBUG] mod_sofia.c:370 sofia/external/13526785574 SOFIA DESTROY</div>
<div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:86 sofia/external/13526785574 Standard DESTROY</div><div>2011-11-08 08:11:21.332673 [DEBUG] switch_core_state_machine.c:504 (sofia/external/13526785574) State DESTROY going to sleep</div>
<div><br></div>