Calls Dropped with "the party is not answering" message

Hey all,

Running FreePBX distro with Asterisk 11.4.0

Within the last week we randomly get active calls dropped after 30 seconds or so with a message that the “party is not answering”. Any idea what is causing this?

Here’s the logs from the most recent incident. Number dialed 9739774526 from ext 203. The called party did answer and they talked for about 30 second between 12:14:50 and 12:15:24 and then suddenly the call dropped and the person on ex203 heard the message that the “party is not answering”.

[code][2013-11-15 12:14:50] VERBOSE[1829] chan_sip.c: == Extension Changed auto_hint_203[from-internal] new state InUse for Notify User 203
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [9739774526@from-internal:1] Macro(“SIP/203-00000065”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/203-00000065”, “TOUCH_MONITOR=1384535690.102”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/203-00000065”, “AMPUSER=203”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/203-00000065”, “0?report”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/203-00000065”, “1?Set(REALCALLERIDNUM=203)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/203-00000065”, “AMPUSER=203”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:6] Set(“SIP/203-00000065”, “AMPUSERCIDNAME=Teresa Home”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:7] GotoIf(“SIP/203-00000065”, “0?report”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/203-00000065”, “AMPUSERCID=203”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:9] Set(“SIP/203-00000065”, “__DIAL_OPTIONS=Ttr”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:10] Set(“SIP/203-00000065”, “CALLERID(all)=“Teresa Home” <203>”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:11] GotoIf(“SIP/203-00000065”, “0?limit”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:12] ExecIf(“SIP/203-00000065”, “1?Set(GROUP(concurrency_limit)=203)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:13] GosubIf(“SIP/203-00000065”, “7?sub-ccss,s,1(from-internal,9739774526)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-ccss:1] ExecIf(“SIP/203-00000065”, “0?Return()”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-ccss:2] Set(“SIP/203-00000065”, “CCSS_SETUP=TRUE”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-ccss:3] GosubIf(“SIP/203-00000065”, “0?monitor_config,1(from-internal,9739774526):monitor_default,1(from-internal,9739774526)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/203-00000065”, “0?is_exten”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [monitor_default@sub-ccss:2] StackPop(“SIP/203-00000065”, “”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [monitor_default@sub-ccss:3] Return(“SIP/203-00000065”, “FALSE”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:14] ExecIf(“SIP/203-00000065”, “0?Set(CHANNEL(language)=)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:15] GotoIf(“SIP/203-00000065”, “1?continue”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (macro-user-callerid,s,28)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/203-00000065”, “CALLERID(number)=203”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:29] Set(“SIP/203-00000065”, “CALLERID(name)=Teresa Home”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/203-00000065”, “CDR(cnum)=203”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/203-00000065”, “CDR(cnam)=Teresa Home”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-user-callerid:32] Set(“SIP/203-00000065”, “CHANNEL(language)=en”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [9739774526@from-internal:2] Set(“SIP/203-00000065”, “EMERGENCYROUTE=YES”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [9739774526@from-internal:3] Set(“SIP/203-00000065”, “MOHCLASS=default”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [9739774526@from-internal:4] Set(“SIP/203-00000065”, “_NODEST=”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [9739774526@from-internal:5] Gosub(“SIP/203-00000065”, “sub-record-check,s,1(out,9739774526,)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:1] Set(“SIP/203-00000065”, “REC_POLICY_MODE_SAVE=”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:2] GotoIf(“SIP/203-00000065”, “1?check”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (sub-record-check,s,7)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:7] Set(“SIP/203-00000065”, “__MON_FMT=wav”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:8] GotoIf(“SIP/203-00000065”, “1?next”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (sub-record-check,s,11)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“SIP/203-00000065”, “0?Return()”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:12] ExecIf(“SIP/203-00000065”, “0?Set(__REC_POLICY_MODE=)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:13] GotoIf(“SIP/203-00000065”, “0?out,1”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:14] Set(“SIP/203-00000065”, “__REC_STATUS=INITIALIZED”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:15] Set(“SIP/203-00000065”, “NOW=1384535690”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:16] Set(“SIP/203-00000065”, “__DAY=15”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:17] Set(“SIP/203-00000065”, “__MONTH=11”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:18] Set(“SIP/203-00000065”, “__YEAR=2013”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:19] Set(“SIP/203-00000065”, “__TIMESTR=20131115-121450”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:20] Set(“SIP/203-00000065”, “__FROMEXTEN=203”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:21] Set(“SIP/203-00000065”, “__CALLFILENAME=out-9739774526-203-20131115-121450-1384535690.102”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@sub-record-check:22] Goto(“SIP/203-00000065”, “out,1”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (sub-record-check,out,1)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [out@sub-record-check:1] ExecIf(“SIP/203-00000065”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [out@sub-record-check:2] GosubIf(“SIP/203-00000065”, “0?record,1(exten,9739774526,203)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [out@sub-record-check:3] Return(“SIP/203-00000065”, “”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [9739774526@from-internal:6] Macro(“SIP/203-00000065”, “dialout-trunk,3,9739774526,off”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:1] Set(“SIP/203-00000065”, “DIAL_TRUNK=3”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/203-00000065”, “0?sub-pincheck,s,1()”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/203-00000065”, “0?disabletrunk,1”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:4] Set(“SIP/203-00000065”, “DIAL_NUMBER=9739774526”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:5] Set(“SIP/203-00000065”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:6] Set(“SIP/203-00000065”, “OUTBOUND_GROUP=OUT_3”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/203-00000065”, “1?nomax”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (macro-dialout-trunk,s,9)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/203-00000065”, “0?skipoutcid”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:10] Set(“SIP/203-00000065”, “DIAL_TRUNK_OPTIONS=Tt”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:11] Macro(“SIP/203-00000065”, “outbound-callerid,3”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/203-00000065”, “0?Set(CALLERPRES()=)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/203-00000065”, “0?Set(REALCALLERIDNUM=203)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/203-00000065”, “1?normcid”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (macro-outbound-callerid,s,6)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:6] Set(“SIP/203-00000065”, “USEROUTCID=”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:7] Set(“SIP/203-00000065”, “EMERGENCYCID=”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:8] Set(“SIP/203-00000065”, “TRUNKOUTCID=<18882194227>”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/203-00000065”, “1?trunkcid”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Goto (macro-outbound-callerid,s,14)
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/203-00000065”, “1?Set(CALLERID(all)=<18882194227>)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/203-00000065”, “0?Set(CALLERID(all)=)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/203-00000065”, “0?Set(CALLERID(all)=)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/203-00000065”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:18] Set(“SIP/203-00000065”, “CDR(outbound_cnum)=18882194227”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-outbound-callerid:19] Set(“SIP/203-00000065”, “CDR(outbound_cnam)=”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/203-00000065”, “0?sub-flp-3,s,1()”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:13] Set(“SIP/203-00000065”, “OUTNUM=9739774526”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:14] Set(“SIP/203-00000065”, “custom=SIP/AshcorTelLocal”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/203-00000065”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)Tt)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/203-00000065”, “0?Set(DIAL_TRUNK_OPTIONS=TtM(confirm))”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:17] Macro(“SIP/203-00000065”, “dialout-trunk-predial-hook,”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/203-00000065”, “”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/203-00000065”, “0?bypass,1”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/203-00000065”, “1?Set(CONNECTEDLINE(num,i)=9739774526)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/203-00000065”, “1?Set(CONNECTEDLINE(name,i)=CID:18882194227)”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/203-00000065”, “0?customtrunk”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:22] Dial(“SIP/203-00000065”, “SIP/AshcorTelLocal/9739774526,300,Tt”) in new stack
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] netsock2.c: == Using SIP RTP TOS bits 184
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] netsock2.c: == Using SIP RTP CoS mark 5
[2013-11-15 12:14:50] VERBOSE[16869][C-0000002e] app_dial.c: – Called SIP/AshcorTelLocal/9739774526
[2013-11-15 12:14:53] VERBOSE[16869][C-0000002e] app_dial.c: – SIP/AshcorTelLocal-00000066 is making progress passing it to SIP/203-00000065
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] app_dial.c: – No one is available to answer at this time (1:0/0/0)
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:23] NoOp(“SIP/203-00000065”, “Dial failed for some reason with DIALSTATUS = NOANSWER and HANGUPCAUSE = 16”) in new stack
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:24] GotoIf(“SIP/203-00000065”, “0?continue,1:s-NOANSWER,1”) in new stack
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Goto (macro-dialout-trunk,s-NOANSWER,1)
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s-NOANSWER@macro-dialout-trunk:1] NoOp(“SIP/203-00000065”, “Dial failed due to trunk reporting NOANSWER - giving up”) in new stack
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s-NOANSWER@macro-dialout-trunk:2] Progress(“SIP/203-00000065”, “”) in new stack
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s-NOANSWER@macro-dialout-trunk:3] Playback(“SIP/203-00000065”, “number-not-answering,noanswer”) in new stack
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] file.c: – <SIP/203-00000065> Playing ‘number-not-answering.alaw’ (language ‘en’)
[2013-11-15 12:15:25] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s-NOANSWER@macro-dialout-trunk:4] Congestion(“SIP/203-00000065”, “20”) in new stack
[2013-11-15 12:15:25] WARNING[16869][C-0000002e] channel.c: Prodding channel ‘SIP/203-00000065’ failed
[2013-11-15 12:15:25] VERBOSE[16869][C-0000002e] app_macro.c: == Spawn extension (macro-dialout-trunk, s-NOANSWER, 4) exited non-zero on ‘SIP/203-00000065’ in macro ‘dialout-trunk’
[2013-11-15 12:15:25] VERBOSE[16869][C-0000002e] pbx.c: == Spawn extension (from-internal, 9739774526, 6) exited non-zero on ‘SIP/203-00000065’
[2013-11-15 12:15:25] VERBOSE[16869][C-0000002e] pbx.c: – Executing [h@from-internal:1] Hangup(“SIP/203-00000065”, “”) in new stack
[2013-11-15 12:15:25] VERBOSE[16869][C-0000002e] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/203-00000065’
[2013-11-15 12:15:25] VERBOSE[1829] chan_sip.c: == Extension Changed auto_hint_203[from-internal] new state Idle for Notify User 202
[2013-11-15 12:15:25] VERBOSE[1829] chan_sip.c: == Extension Changed auto_hint_203[from-internal] new state Idle for Notify User 203

[/code]

SIP provider reports: “When looking at our CDRs, it appears that you are not sending back an ACK after the 200 OK, which is causing this call to time out. However we would want to setup a live call capture to verify this”

It won’t be getting an ACK because Asterisk isn’t receiving a 200 OK from it. You almost certainly have a network routing/NAT/firewall problem. Running a SIP trace may throw some more light on the matter, but if it shows that you are sending the right addresses, but are not receiving the OK, you will need to use network level diagnostics.

Incidentally, the trace shows a very complex dialplan. That suggests you are using a GUI. Normally it is better to get support for Asterisk GUIs from the GUI developers.

As David55 said [quote]It won’t be getting an ACK because Asterisk isn’t receiving a 200 OK from it[/quote]

Too:
[2013-11-15 12:15:24] VERBOSE[16869][C-0000002e] pbx.c: – Executing [s@macro-dialout-trunk:23] NoOp(“SIP/203-00000065”, "Dial failed for some reason with DIALSTATUS = NOANSWER and HANGUPCAUSE = 16") in new stack

HANGUPCAUSE 16 normal call clearing — (*)