<div dir="ltr"><div><br></div><div>Hi, I'm trying to originate a call to an external endpoint (a mobile phone) through a gateway (<a href="http://freeconet.pl">freeconet.pl</a>) service and I'm getting intermittent 'NORMAL_UNSPECIFIED'</div>
<div>errors. The command will randomly succeed or fail with the following result.</div><div><br></div><div>originate {call_timeout=60,origination_uuid=d399361f-56a1-4c7c-acd8-447a6e1ea742}sofia/gateway/freeconet/602415455 6668</div>
<div>Event: FAILURE, Body: -ERR NORMAL_UNSPECIFIED</div><div><br></div><div><br></div><div>The destination extension (6668) is an IVR service based on mod_httapi, but I don't think this is related to my application as there are no httapi calls made. The 'freeconet' gateway is REGED.</div>
<div>Corresponding freeswitch log is below. Can you please help me figure out what's going on?<br></div><div><br></div><div>Best regards</div><div>Rafal</div><div><br></div><div>2013-07-03 11:14:05.016851 [DEBUG] switch_ivr_originate.c:2050 Parsing global variables</div>
<div>2013-07-03 11:14:05.016851 [DEBUG] switch_event.c:1617 Parsing variable [call_timeout]=[60]</div><div>2013-07-03 11:14:05.016851 [DEBUG] switch_event.c:1617 Parsing variable [origination_uuid]=[d399361f-56a1-4c7c-acd8-447a6e1ea742]</div>
<div>2013-07-03 11:14:05.016851 [NOTICE] switch_channel.c:1030 New Channel sofia/external/602415455 [d399361f-56a1-4c7c-acd8-447a6e1ea742]</div><div>2013-07-03 11:14:05.016851 [DEBUG] mod_sofia.c:4420 (sofia/external/602415455) State Change CS_NEW -> CS_INIT</div>
<div>2013-07-03 11:14:05.016851 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.016851 [DEBUG] switch_core_session.c:583 sofia/external/602415455 set UUID=d399361f-56a1-4c7c-acd8-447a6e1ea742</div>
<div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:416 (sofia/external/602415455) Running State Change CS_INIT</div><div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:455 (sofia/external/602415455) State INIT</div>
<div>2013-07-03 11:14:05.026852 [DEBUG] mod_sofia.c:87 sofia/external/602415455 SOFIA INIT</div><div>2013-07-03 11:14:05.026852 [DEBUG] sofia_glue.c:1220 Local SDP:</div><div>v=0</div><div>o=FreeSWITCH 1372826251 1372826252 IN IP4 192.168.119.50</div>
<div>s=FreeSWITCH</div><div>c=IN IP4 192.168.119.50</div><div>t=0 0</div><div>m=audio 16594 RTP/AVP 0 8 3 101 13</div><div>a=rtpmap:101 telephone-event/8000</div><div>a=fmtp:101 0-16</div><div>a=ptime:20</div><div>a=sendrecv</div>
<div><br></div><div>2013-07-03 11:14:05.026852 [DEBUG] mod_sofia.c:114 (sofia/external/602415455) State Change CS_INIT -> CS_ROUTING</div><div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/602415455 [BREAK]</div>
<div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:455 (sofia/external/602415455) State INIT going to sleep</div><div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:416 (sofia/external/602415455) Running State Change CS_ROUTING</div>
<div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:471 (sofia/external/602415455) State ROUTING</div><div>2013-07-03 11:14:05.026852 [DEBUG] mod_sofia.c:137 sofia/external/602415455 SOFIA ROUTING</div><div>
2013-07-03 11:14:05.026852 [DEBUG] switch_ivr_originate.c:67 (sofia/external/602415455) State Change CS_ROUTING -> CS_CONSUME_MEDIA</div><div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/602415455 [BREAK]</div>
<div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:471 (sofia/external/602415455) State ROUTING going to sleep</div><div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:416 (sofia/external/602415455) Running State Change CS_CONSUME_MEDIA</div>
<div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:490 (sofia/external/602415455) State CONSUME_MEDIA</div><div>2013-07-03 11:14:05.026852 [DEBUG] switch_core_state_machine.c:490 (sofia/external/602415455) State CONSUME_MEDIA going to sleep</div>
<div>2013-07-03 11:14:05.036853 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.036853 [DEBUG] sofia.c:5764 Channel sofia/external/602415455 entering state [calling][0]</div>
<div>2013-07-03 11:14:05.096861 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.096861 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div>
<div>2013-07-03 11:14:05.096861 [DEBUG] sofia.c:5764 Channel sofia/external/602415455 entering state [calling][0]</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1006 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.126865 [DEBUG] sofia.c:5764 Channel sofia/external/602415455 entering state [terminated][904]</div>
<div>2013-07-03 11:14:05.126865 [NOTICE] sofia.c:6572 Hangup sofia/external/602415455 [CS_CONSUME_MEDIA] [NORMAL_UNSPECIFIED]</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_channel.c:3135 Send signal sofia/external/602415455 [KILL]</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:416 (sofia/external/602415455) Running State Change CS_HANGUP</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:679 (sofia/external/602415455) State HANGUP</div><div>2013-07-03 11:14:05.126865 [DEBUG] mod_sofia.c:463 Channel sofia/external/602415455 hanging up, cause: NORMAL_UNSPECIFIED</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:48 sofia/external/602415455 Standard HANGUP, cause: NORMAL_UNSPECIFIED</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:679 (sofia/external/602415455) State HANGUP going to sleep</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:692 (sofia/external/602415455) Callstate Change DOWN -> HANGUP</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:447 (sofia/external/602415455) State Change CS_HANGUP -> CS_REPORTING</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:416 (sofia/external/602415455) Running State Change CS_REPORTING</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:764 (sofia/external/602415455) State REPORTING</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:92 sofia/external/602415455 Standard REPORTING, cause: NORMAL_UNSPECIFIED</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:764 (sofia/external/602415455) State REPORTING going to sleep</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_state_machine.c:441 (sofia/external/602415455) State Change CS_REPORTING -> CS_DESTROY</div>
<div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1341 Send signal sofia/external/602415455 [BREAK]</div><div>2013-07-03 11:14:05.126865 [DEBUG] switch_core_session.c:1549 Session 85 (sofia/external/602415455) Locked, Waiting on external entities</div>
<div>2013-07-03 11:14:05.146867 [DEBUG] switch_ivr_originate.c:3622 Originate Resulted in Error Cause: 31 [NORMAL_UNSPECIFIED]</div><div>2013-07-03 11:14:05.146867 [NOTICE] switch_core_session.c:1567 Session 85 (sofia/external/602415455) Ended</div>
<div>2013-07-03 11:14:05.146867 [NOTICE] switch_core_session.c:1571 Close Channel sofia/external/602415455 [CS_DESTROY]</div><div>2013-07-03 11:14:05.146867 [DEBUG] switch_core_state_machine.c:566 (sofia/external/602415455) Callstate Change HANGUP -> DOWN</div>
<div>2013-07-03 11:14:05.146867 [DEBUG] switch_core_state_machine.c:569 (sofia/external/602415455) Running State Change CS_DESTROY</div><div>2013-07-03 11:14:05.146867 [DEBUG] switch_core_state_machine.c:579 (sofia/external/602415455) State DESTROY</div>
<div>2013-07-03 11:14:05.146867 [DEBUG] mod_sofia.c:373 sofia/external/602415455 SOFIA DESTROY</div><div>2013-07-03 11:14:05.146867 [DEBUG] switch_core_state_machine.c:99 sofia/external/602415455 Standard DESTROY</div><div>
2013-07-03 11:14:05.146867 [DEBUG] switch_core_state_machine.c:579 (sofia/external/602415455) State DESTROY going to sleep</div><div><br></div></div>