Having trouble making a custom app info a fully functional extension

hyegeek · February 2, 2017, 3:13pm

Hopefully I will be able to explain what I’m trying to do well enough…

I’ve created a custom app and placed it in extensions_custom.conf. I’ve successfully created a custom destination and used it in a time condition. So far so good, but I want to be able to transfer calls to it as well as allowing it to be dialed from an IVR.

After reading a suggestion I found via google, I made a virtual extension and pointed all of the optional destination to my custom destination. This seemed to work great. I was able to dial it from an IVR and I setup a BLF button pointing to it which showed me when it had been dialed and allowed me to dial it via that button.

Unfortunately, when I tried to transfer a call to it via the blf button (or even just doing a transfer) the person being transfer only got a busy signal and the CDR log showed congestion.

I also tried setting up a misc application. This worked for allowing me to transfer to it, but I don’t think I can setup a BLF button to a misc application and it doesn’t work when I try to dial it from an IVR.

Any suggestions on how to get what I’m after? Thanks.

cynjut · February 3, 2017, 12:03am

Logs - we need to see what contexts are being accessed to make this do this.

/var/log/asterisk/full trimmed up around the one call would be super.

hyegeek · February 3, 2017, 12:19am

From which atttempt? When I made it a virtual extension? I’ll try to get that setup again, and send get the log.

Currently, with the “extension” setup as a misc application, when I setup a blf key, that key does not show any status, but the transfer does work. I also can’t dial (as an extension) from my ivf. Since it is a misc application, freepbx tells me that making a custom extension causes a conflict, so I don’t know how to make it work from the ivf other than coding in each extension I setup manually.

hyegeek · February 3, 2017, 12:50am

Here’s the log that resulted in calling from one extension to another and then trying to use the blf key to transfer to my virtual extention.

The log was too long even trimmed down, trying to get just the most important now.

[2017-02-02 16:39:40] VERBOSE[24868][C-000000bb] bridge_channel.c: Channel SIP/601-0000011c joined 'simple_bridge' basic-bridge <da4f2ca2-8803-4435-867e-5c8b41341418>
[2017-02-02 16:39:40] VERBOSE[24866][C-000000bb] bridge_channel.c: Channel PJSIP/614-0000002a joined 'simple_bridge' basic-bridge <da4f2ca2-8803-4435-867e-5c8b41341418>
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] bridge_channel.c: Channel PJSIP/614-0000002a left 'simple_bridge' basic-bridge <da4f2ca2-8803-4435-867e-5c8b41341418>
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] app_macro.c: Channel 'PJSIP/614-0000002a' jumping out of macro 'dial-one'
[2017-02-02 16:39:44] NOTICE[32305][C-000000bb] chan_sip.c: Got OK on REFER Notify message
[2017-02-02 16:39:44] VERBOSE[24868][C-000000bb] bridge_channel.c: Channel SIP/601-0000011c left 'simple_bridge' basic-bridge <da4f2ca2-8803-4435-867e-5c8b41341418>
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] app_macro.c: Channel 'PJSIP/614-0000002a' jumping out of macro 'exten-vm'
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [663@from-internal-xfer:1] GotoIf("PJSIP/614-0000002a", "1?ext-local,663,1:followme-check,663,1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (ext-local,663,1)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [663@ext-local:1] Set("PJSIP/614-0000002a", "__RINGTIMER=25") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [663@ext-local:2] Macro("PJSIP/614-0000002a", "exten-vm,novm,663,1,1,1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/614-0000002a", "user-callerid,") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/614-0000002a", "TOUCH_MONITOR=1486082377.348") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/614-0000002a", "AMPUSER=614") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/614-0000002a", "12?report") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-user-callerid,s,15)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:15] GotoIf("PJSIP/614-0000002a", "0?continue") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:16] ExecIf("PJSIP/614-0000002a", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/614-0000002a", "__TTL=63") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("PJSIP/614-0000002a", "1?continue") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:29] Set("PJSIP/614-0000002a", "CALLERID(number)=614") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:30] Set("PJSIP/614-0000002a", "CALLERID(name)=Karl's Phone") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/614-0000002a", "0?cnum") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:32] Set("PJSIP/614-0000002a", "CDR(cnam)=Karl's Phone") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:33] Set("PJSIP/614-0000002a", "CDR(cnum)=614") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-user-callerid:34] Set("PJSIP/614-0000002a", "CHANNEL(language)=en") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/614-0000002a", "RingGroupMethod=none") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/614-0000002a", "__EXTTOCALL=663") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/614-0000002a", "__PICKUPMARK=663") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/614-0000002a", "RT=25") in new stack
[2017-02-02 16:39:44] WARNING[24866][C-000000bb] chan_sip.c: This function can only be used on SIP channels.
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("PJSIP/614-0000002a", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2017-02-02 16:39:44] WARNING[24866][C-000000bb] chan_sip.c: This function can only be used on SIP channels.
[2017-02-02 16:39:44] WARNING[24866][C-000000bb] chan_sip.c: This function can only be used on SIP channels.
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("PJSIP/614-0000002a", "0?MacroExit()") in new stack
[2017-02-02 16:39:44] WARNING[24866][C-000000bb] chan_sip.c: This function can only be used on SIP channels.
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:8] Gosub("PJSIP/614-0000002a", "sub-record-check,s,1(exten,663,dontcare)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/614-0000002a", "3?initialized") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (sub-record-check,s,10)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/614-0000002a", "Recordings initialized") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/614-0000002a", "0?Set(ARG3=dontcare)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/614-0000002a", "REC_POLICY_MODE_SAVE=") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/614-0000002a", "1?Set(REC_STATUS=NO)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/614-0000002a", "5?checkaction") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (sub-record-check,s,17)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/614-0000002a", "1?sub-record-check,exten,1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/614-0000002a", "Exten Recording Check between 614 and 663") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/614-0000002a", "CALLTYPE=internal") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/614-0000002a", "0?Set(CALLTYPE=)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/614-0000002a", "CALLEE=dontcare") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/614-0000002a", "0?Set(CALLEE=dontcare)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/614-0000002a", "0?callee") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/614-0000002a", "1?caller") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/614-0000002a", "RECMODE=dontcare") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:14] ExecIf("PJSIP/614-0000002a", "0?Set(RECMODE=dontcare)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:15] ExecIf("PJSIP/614-0000002a", "1?Set(RECMODE=dontcare)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:16] Gosub("PJSIP/614-0000002a", "recordcheck,1(dontcare,internal,663)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/614-0000002a", "Starting recording check against dontcare") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/614-0000002a", "dontcare") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/614-0000002a", "") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [exten@sub-record-check:17] Return("PJSIP/614-0000002a", "") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:9] GotoIf("PJSIP/614-0000002a", "1?macrodial") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-exten-vm,s,15)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:15] GosubIf("PJSIP/614-0000002a", "0?clrheader,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:16] Macro("PJSIP/614-0000002a", "dial-one,25,Ttr,663") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/614-0000002a", "DEXTEN=663") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:2] ExecIf("PJSIP/614-0000002a", "0?Set(EXTTOCALL=663)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:3] Set("PJSIP/614-0000002a", "DIALSTATUS_CW=") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:4] GosubIf("PJSIP/614-0000002a", "0?screen,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/614-0000002a", "0?cf,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:6] GotoIf("PJSIP/614-0000002a", "1?skip1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-dial-one,s,9)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:9] GotoIf("PJSIP/614-0000002a", "0?nodial") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/614-0000002a", "0?continue") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:11] Set("PJSIP/614-0000002a", "EXTHASCW=ENABLED") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:12] GotoIf("PJSIP/614-0000002a", "0?next1:cwinusebusy") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-dial-one,s,24)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:24] GotoIf("PJSIP/614-0000002a", "0?next3:continue") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-dial-one,s,26)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:26] GotoIf("PJSIP/614-0000002a", "0?nodial") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:27] GosubIf("PJSIP/614-0000002a", "1?dstring,1():dlocal,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/614-0000002a", "DSTRING=") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/614-0000002a", "DEVICES=663") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/614-0000002a", "0?Return()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/614-0000002a", "0?Set(DEVICES=63)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/614-0000002a", "LOOPCNT=1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/614-0000002a", "ITER=1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/614-0000002a", "THISDIAL=") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/614-0000002a", "1?zap2dahdi,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/614-0000002a", "1?Return()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/614-0000002a", "1?docheck") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-dial-one,dstring,14)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/614-0000002a", "1?skipset") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-dial-one,dstring,16)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/614-0000002a", "ITER=2") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/614-0000002a", "0?begin") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/614-0000002a", "1?Return()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/614-0000002a", "1?nodial") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-dial-one,s,56)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:56] ExecIf("PJSIP/614-0000002a", "0?Set(DIALSTATUS=NOANSWER)") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:57] NoOp("PJSIP/614-0000002a", "Returned from dial-one with nothing to call and DIALSTATUS: ANSWER") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-dial-one:58] MacroExit("PJSIP/614-0000002a", "") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:17] Set("PJSIP/614-0000002a", "SV_DIALSTATUS=ANSWER") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:18] GosubIf("PJSIP/614-0000002a", "0?docfu,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:19] GosubIf("PJSIP/614-0000002a", "0?docfb,1()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:20] Set("PJSIP/614-0000002a", "DIALSTATUS=ANSWER") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:21] ExecIf("PJSIP/614-0000002a", "0?MacroExit()") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-exten-vm:22] GotoIf("PJSIP/614-0000002a", "1?s-ANSWER,1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-exten-vm,s-ANSWER,1)
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s-ANSWER@macro-exten-vm:1] GotoIf("PJSIP/614-0000002a", "0?exit,1") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s-ANSWER@macro-exten-vm:2] PlayTones("PJSIP/614-0000002a", "congestion") in new stack
[2017-02-02 16:39:44] VERBOSE[24866][C-000000bb] pbx.c: Executing [s-ANSWER@macro-exten-vm:3] Congestion("PJSIP/614-0000002a", "10") in new stack
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] app_macro.c: Spawn extension (macro-exten-vm, s-ANSWER, 3) exited non-zero on 'PJSIP/614-0000002a' in macro 'exten-vm'
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx.c: Spawn extension (ext-local, 663, 2) exited non-zero on 'PJSIP/614-0000002a'
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/614-0000002a", "hangupcall,") in new stack
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/614-0000002a", "1?theend") in new stack
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/614-0000002a", "0?Set(CDR(recordingfile)=)") in new stack
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx.c: Executing [s@macro-hangupcall:4] Hangup("PJSIP/614-0000002a", "") in new stack
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/614-0000002a' in macro 'hangupcall'
[2017-02-02 16:39:48] VERBOSE[24866][C-000000bb] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/614-0000002a'
[2017-02-02 16:39:48] VERBOSE[32231] chan_sip.c: Extension Changed 614[ext-local] new state Idle for Notify User 601