<div dir="ltr"><div>check your NAT, you probably have a nat problem, do a sip trace, you'll see whom packets are not getting to other peer.<br><br></div>then it timeout<br><br></div><div class="gmail_extra"><br><div class="gmail_quote">On Thu, Jan 14, 2016 at 6:20 PM, Samuel Reamer <span dir="ltr"><<a href="mailto:adam@steffannicarpet.com" target="_blank">adam@steffannicarpet.com</a>></span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><div dir="ltr">I am using two Cisco SPA303 phones with a local FreeSwitch server. Incoming calls through Plivo dial a group ring extension and everything works as expected; however, after placing a call on hold the call is terminated after about 25 seconds. Previously I was getting a warning about the RFC2543 hold method, and Async PTIME not supported.<div><br></div><div>I set the SPA303 config setting "RFC2543 Call Hold" from yes to no, and also added <span style="color:rgb(0,0,0);line-height:normal"><param name="rtp-autofix-timing" value="false"/> to my internal.xml sip profile. The errors went away but the issue persists. </span></div><div><span style="color:rgb(0,0,0);line-height:normal"><br></span></div><div><span style="color:rgb(0,0,0);line-height:normal">Here is the log:</span></div><div><pre><font color="#000000"><span style="line-height:normal">f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:40.908307 [DEBUG] switch_channel.c:1831 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Callstate Change ACTIVE -> HELD
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [PCMU:0:8000:30:64000:1]/[PCMU:0:8000:30:64000:1]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:4208 Audio Codec Compare [PCMU:0:8000:30:64000:1] ++++ is saved as a match
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[PCMU:0:8000:30:64000:1]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:4069 Set telephone-event payload to 101@8000
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:4417 Set telephone-event payload to 101@8000
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:4473 sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> Set 2833 dtmf send payload to 101 recv payload to 101
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] switch_core_media.c:6010 Audio params are unchanged for sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>.
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.158321 [DEBUG] sofia.c:7503 Processing updated SDP
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.168322 [DEBUG] sofia.c:6756 Channel sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> entering state [completed][200]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:06:41.178318 [DEBUG] sofia.c:6756 Channel sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> entering state [ready][200]
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.288104 [DEBUG] sofia.c:6756 Channel sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> entering state [terminating][0]
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.288104 [NOTICE] sofia.c:7775 Hangup sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> [CS_EXECUTE] [NORMAL_UNSPECIFIED]
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.288104 [DEBUG] switch_ivr_bridge.c:705 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> ending bridge by request from read function
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.288104 [DEBUG] switch_ivr_bridge.c:778 BRIDGE THREAD DONE [sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_ivr_bridge.c:778 BRIDGE THREAD DONE [sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_channel.c:2019 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Callstate Change HELD -> UNHELD
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [NOTICE] switch_ivr_bridge.c:881 Hangup sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State EXCHANGE_MEDIA going to sleep
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Running State Change CS_HANGUP
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Callstate Change UNHELD -> HANGUP
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State HANGUP
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] mod_sofia.c:431 Channel sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> hanging up, cause: NORMAL_CLEARING
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.318106 [DEBUG] switch_ivr_bridge.c:1689 sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> skip receive message [UNBRIDGE] (channel is hungup already)
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] switch_ivr_bridge.c:1692 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> skip receive message [UNBRIDGE] (channel is hungup already)
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] switch_core_session.c:2796 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State EXECUTE going to sleep
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) Running State Change CS_HANGUP
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) Callstate Change ACTIVE -> HANGUP
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State HANGUP
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.318106 [DEBUG] mod_sofia.c:431 Channel sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> hanging up, cause: NORMAL_UNSPECIFIED
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.328100 [DEBUG] mod_sofia.c:484 Sending BYE to sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:60 sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> Standard HANGUP, cause: NORMAL_CLEARING
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State HANGUP going to sleep
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State Change CS_HANGUP -> CS_REPORTING
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Running State Change CS_REPORTING
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State REPORTING
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:104 sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> Standard REPORTING, cause: NORMAL_CLEARING
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State REPORTING going to sleep
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State Change CS_REPORTING -> CS_DESTROY
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_session.c:1646 Session 3 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Locked, Waiting on external entities
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [NOTICE] switch_core_session.c:1664 Session 3 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Ended
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> [CS_DESTROY]
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) Running State Change CS_DESTROY
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State DESTROY
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] mod_sofia.c:341 sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> SOFIA DESTROY
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:111 sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a> Standard DESTROY
f9765406-acd9-480c-a200-43bdc2ad2f36 2016-01-14 12:07:12.338101 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/<a href="http://1001@192.168.0.114:5060" target="_blank">1001@192.168.0.114:5060</a>) State DESTROY going to sleep
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:60 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> Standard HANGUP, cause: NORMAL_UNSPECIFIED
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State HANGUP going to sleep
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State Change CS_HANGUP -> CS_REPORTING
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) Running State Change CS_REPORTING
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State REPORTING
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:104 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> Standard REPORTING, cause: NORMAL_UNSPECIFIED
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State REPORTING going to sleep
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State Change CS_REPORTING -> CS_DESTROY
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [DEBUG] switch_core_session.c:1646 Session 1 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) Locked, Waiting on external entities
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [NOTICE] switch_core_session.c:1664 Session 1 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) Ended
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.348102 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> [CS_DESTROY]
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.358102 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) Running State Change CS_DESTROY
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.358102 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State DESTROY
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.358102 [DEBUG] mod_sofia.c:341 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> SOFIA DESTROY
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.358102 [DEBUG] switch_core_state_machine.c:111 sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a> Standard DESTROY
9cbfdabc-8f1f-4fb3-89f2-c1b0c8522c5c 2016-01-14 12:07:12.358102 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/+<a href="mailto:14196680795@184.106.123.160" target="_blank">14196680795@184.106.123.160</a>) State DESTROY going to sleep</span></font><span style="color:rgb(0,0,0);line-height:normal">
</span></pre></div><div><br></div></div>
<br>_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a href="mailto:consulting@freeswitch.org">consulting@freeswitch.org</a><br>
<a href="http://www.freeswitchsolutions.com" rel="noreferrer" target="_blank">http://www.freeswitchsolutions.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a href="http://www.freeswitch.org" rel="noreferrer" target="_blank">http://www.freeswitch.org</a><br>
<a href="http://confluence.freeswitch.org" rel="noreferrer" target="_blank">http://confluence.freeswitch.org</a><br>
<a href="http://www.cluecon.com" rel="noreferrer" target="_blank">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" rel="noreferrer" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" rel="noreferrer" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" rel="noreferrer" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br><br clear="all"><br>-- <br><div class="gmail_signature">Sincerely,<br><br>Giovanni Maruzzelli<br>Cell : +39-347-2665618<br></div>
</div>