Hope I did this right. I’m a bit crosseyed trying to dissect this though.
Intercom Call (no beep)
root@PIAF:~ $ tail -f /var/log/asterisk/full
[2018-01-07 16:19:38] VERBOSE[1893][C-00000011] netsock2.c: Using SIP RTP TOS bits 184
[2018-01-07 16:19:38] VERBOSE[1893][C-00000011] netsock2.c: Using SIP RTP CoS mark 5
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@from-internal:1] Goto("SIP/702-00000011", "ext-intercom,*80733,1") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (ext-intercom,*80733,1)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:1] Macro("SIP/702-00000011", "user-callerid,") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/702-00000011", "TOUCH_MONITOR=1515359978.41") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/702-00000011", "AMPUSER=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("SIP/702-00000011", "0?report") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("SIP/702-00000011", "1?Set(REALCALLERIDNUM=702)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/702-00000011", "AMPUSER=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("SIP/702-00000011", "0?limit") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:7] Set("SIP/702-00000011", "AMPUSERCIDNAME=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/702-00000011", "0?report") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:9] Set("SIP/702-00000011", "AMPUSERCID=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/702-00000011", "__DIAL_OPTIONS=Ttr") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:11] Set("SIP/702-00000011", "CALLERID(all)="702" <702>") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:12] GotoIf("SIP/702-00000011", "0?limit") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/702-00000011", "0?Set(GROUP(concurrency_limit)=702)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/702-00000011", "0?continue") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:15] Set("SIP/702-00000011", "__TTL=6") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("SIP/702-00000011", "1?continue") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (macro-user-callerid,s,27)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:27] Set("SIP/702-00000011", "CALLERID(number)=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:28] Set("SIP/702-00000011", "CALLERID(name)=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("SIP/702-00000011", "0?cnum") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:30] Set("SIP/702-00000011", "CDR(cnam)=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:31] Set("SIP/702-00000011", "CDR(cnum)=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-user-callerid:32] Set("SIP/702-00000011", "CHANNEL(language)=en") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:2] Set("SIP/702-00000011", "dialnumber=733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:3] Set("SIP/702-00000011", "INTERCOM_CALL=TRUE") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:4] Gosub("SIP/702-00000011", "sub-record-check,s,1(exten,733)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/702-00000011", "0?initialized") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:2] Set("SIP/702-00000011", "__REC_STATUS=INITIALIZED") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:3] Set("SIP/702-00000011", "NOW=1515359978") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:4] Set("SIP/702-00000011", "__DAY=07") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:5] Set("SIP/702-00000011", "__MONTH=01") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:6] Set("SIP/702-00000011", "__YEAR=2018") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:7] Set("SIP/702-00000011", "__TIMESTR=20180107-161938") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:8] Set("SIP/702-00000011", "__FROMEXTEN=702") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:9] Set("SIP/702-00000011", "__MON_FMT=wav") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/702-00000011", "Recordings initialized") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/702-00000011", "1?Set(ARG3=dontcare)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:12] Set("SIP/702-00000011", "REC_POLICY_MODE_SAVE=") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/702-00000011", "0?Set(REC_STATUS=NO)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/702-00000011", "5?checkaction") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (sub-record-check,s,17)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/702-00000011", "1?sub-record-check,exten,1") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:1] NoOp("SIP/702-00000011", "Exten Recording Check between 702 and 733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:2] Set("SIP/702-00000011", "CALLTYPE=internal") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:3] ExecIf("SIP/702-00000011", "0?Set(CALLTYPE=)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:4] Set("SIP/702-00000011", "CALLEE=dontcare") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:5] ExecIf("SIP/702-00000011", "0?Set(CALLEE=dontcare)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:6] GotoIf("SIP/702-00000011", "0?callee") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:7] GotoIf("SIP/702-00000011", "1?caller") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:13] Set("SIP/702-00000011", "RECMODE=dontcare") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:14] ExecIf("SIP/702-00000011", "0?Set(RECMODE=dontcare)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:15] ExecIf("SIP/702-00000011", "1?Set(RECMODE=dontcare)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:16] Gosub("SIP/702-00000011", "recordcheck,1(dontcare,internal,733)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/702-00000011", "Starting recording check against dontcare") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/702-00000011", "dontcare") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/702-00000011", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [exten@sub-record-check:17] Return("SIP/702-00000011", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:5] GotoIf("SIP/702-00000011", "0?end") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:6] GotoIf("SIP/702-00000011", "0?end") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:7] GotoIf("SIP/702-00000011", "0?allow") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:8] GotoIf("SIP/702-00000011", "0?nointercom") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:9] GotoIf("SIP/702-00000011", "0?nointercom") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:10] Set("SIP/702-00000011", "DEVICES=733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:11] GotoIf("SIP/702-00000011", "0?end") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:12] Set("SIP/702-00000011", "OVERRIDE=") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:13] Set("SIP/702-00000011", "LOOPCNT=1") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:14] Set("SIP/702-00000011", "_SIPURI=") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:15] Set("SIP/702-00000011", "_ALERTINFO=Ring Answer") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:16] Set("SIP/702-00000011", "_CALLINFO=<uri>;answer-after=0") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:17] Set("SIP/702-00000011", "_SIPURI=intercom=true") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:18] Set("SIP/702-00000011", "_DTIME=5") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:19] Set("SIP/702-00000011", "_ANSWERMACRO=") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:20] GotoIf("SIP/702-00000011", "0?pagemode") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:21] Macro("SIP/702-00000011", "autoanswer,733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:1] GotoIf("SIP/702-00000011", "0?knowndial") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:2] Set("SIP/702-00000011", "DEVICE=SIP/733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:3] GotoIf("SIP/702-00000011", "0?dopjsip") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:4] Set("SIP/702-00000011", "KNOWNDIAL=SIP/733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:5] Goto("SIP/702-00000011", "knowndial") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (macro-autoanswer,s,19)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:19] Set("SIP/702-00000011", "DIAL=SIP/733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:20] ExecIf("SIP/702-00000011", "0?Set(DIAL=DAHDI/733)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:21] GotoIf("SIP/702-00000011", "0?macro") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:22] GotoIf("SIP/702-00000011", "0?pjsipua") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:23] Set("SIP/702-00000011", "USERAGENT=Grandstream GXP2140 1.0.9.26") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:24] Goto("SIP/702-00000011", "uafin") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (macro-autoanswer,s,28)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:28] ExecIf("SIP/702-00000011", "0?Set(USERAGENT=)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:29] ExecIf("SIP/702-00000011", "0?Set(PAGE_VOL=;volume=)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:30] ExecIf("SIP/702-00000011", "0?Set(CALLINFO=<sip:broadworks.net>;answer-after=0)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:31] ExecIf("SIP/702-00000011", "0?Set(ALERTINFO=Intercom)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:32] ExecIf("SIP/702-00000011", "0?Set(ALERTINFO=info=Auto Answer)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:33] ExecIf("SIP/702-00000011", "0?Set(ALERTINFO=ring-answer)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:34] ExecIf("SIP/702-00000011", "0?Set(ALERTINFO=<http://www.sangoma.com>;info=external)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:35] ExecIf("SIP/702-00000011", "0?Set(ALERTINFO=<http://example.com>;info=alert-autoanswer)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@macro-autoanswer:36] ExecIf("SIP/702-00000011", "1?Set(__SIP_URI_OPTIONS=intercom=true)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:22] Set("SIP/702-00000011", "_DOPTIONS=A()b(autoanswer^s^1(Ring Answer,<uri>;answer-after=0))") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:23] ChanIsAvail("SIP/702-00000011", "SIP/733,s") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] netsock2.c: Using SIP RTP TOS bits 184
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] netsock2.c: Using SIP RTP CoS mark 5
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:24] ExecIf("SIP/702-00000011", "0?Set(AVAILORIGCHAN=SIP/733)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:25] GotoIf("SIP/702-00000011", "1?continue") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx_builtins.c: Goto (ext-intercom,*80733,30)
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:30] NoOp("SIP/702-00000011", "Continuing with page") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:31] GotoIf("SIP/702-00000011", "0?godial") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:32] Set("SIP/702-00000011", "CONNECTEDLINE(name,i)=733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:33] Set("SIP/702-00000011", "CONNECTEDLINE(num)=733") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [*80733@ext-intercom:34] Dial("SIP/702-00000011", "SIP/733,5,IA()b(autoanswer^s^1(Ring Answer,<uri>;answer-after=0))") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] netsock2.c: Using SIP RTP TOS bits 184
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] netsock2.c: Using SIP RTP CoS mark 5
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] app_stack.c: SIP/733-00000013 Internal Gosub(autoanswer,s,1(Ring Answer,<uri>;answer-after=0)) start
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@autoanswer:1] GosubIf("SIP/733-00000013", "1?func-set-sipheader,s,1(Alert-Info,Ring Answer)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-set-sipheader:1] NoOp("SIP/733-00000013", "Sip Add Header function called. Adding Alert-Info = Ring Answer") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-set-sipheader:2] Set("SIP/733-00000013", "HASH(_SIPHEADERS,Alert-Info)=Ring Answer") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-set-sipheader:3] Return("SIP/733-00000013", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@autoanswer:2] GosubIf("SIP/733-00000013", "1?func-set-sipheader,s,1(Call-Info,<uri>;answer-after=0)") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-set-sipheader:1] NoOp("SIP/733-00000013", "Sip Add Header function called. Adding Call-Info = <uri>;answer-after=0") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-set-sipheader:2] Set("SIP/733-00000013", "HASH(_SIPHEADERS,Call-Info)=<uri>;answer-after=0") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-set-sipheader:3] Return("SIP/733-00000013", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@autoanswer:3] Gosub("SIP/733-00000013", "func-apply-sipheaders,s,1()") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/733-00000013", "Applying SIP Headers to channel") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/733-00000013", "SIPHEADERKEYS=Call-Info,Alert-Info") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/733-00000013", "1") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/733-00000013", "sipheader=<uri>;answer-after=0") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:5] SIPAddHeader("SIP/733-00000013", "Call-Info: <uri>;answer-after=0") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/733-00000013", "PJSIP_HEADER(add,Call-Info)=<uri>;answer-after=0") in new stack
[2018-01-07 16:19:38] ERROR[14802][C-00000011] res_pjsip_header_funcs.c: This function requires a PJSIP channel.
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:7] EndWhile("SIP/733-00000013", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/733-00000013", "1") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/733-00000013", "sipheader=Ring Answer") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:5] SIPAddHeader("SIP/733-00000013", "Alert-Info: Ring Answer") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/733-00000013", "PJSIP_HEADER(add,Alert-Info)=Ring Answer") in new stack
[2018-01-07 16:19:38] ERROR[14802][C-00000011] res_pjsip_header_funcs.c: This function requires a PJSIP channel.
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:7] EndWhile("SIP/733-00000013", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/733-00000013", "0") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@func-apply-sipheaders:8] Return("SIP/733-00000013", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] pbx.c: Executing [s@autoanswer:4] Return("SIP/733-00000013", "") in new stack
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] app_stack.c: Spawn extension (from-internal, *80733, 1) exited non-zero on 'SIP/733-00000013'
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] app_stack.c: SIP/733-00000013 Internal Gosub(autoanswer,s,1(Ring Answer,<uri>;answer-after=0)) complete GOSUB_RETVAL=
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] app_dial.c: Called SIP/733
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] app_dial.c: Connected line update to SIP/702-00000011 prevented.
[2018-01-07 16:19:38] VERBOSE[14802][C-00000011] app_dial.c: SIP/733-00000013 is ringing
[2018-01-07 16:19:39] VERBOSE[14802][C-00000011] app_dial.c: Connected line update to SIP/702-00000011 prevented.
[2018-01-07 16:19:39] VERBOSE[14802][C-00000011] app_dial.c: SIP/733-00000013 answered SIP/702-00000011
[2018-01-07 16:19:39] VERBOSE[14805][C-00000011] bridge_channel.c: Channel SIP/733-00000013 joined 'simple_bridge' basic-bridge <723f3211-990a-4be2-a52e-2f264c062ff2>
[2018-01-07 16:19:39] VERBOSE[14802][C-00000011] bridge_channel.c: Channel SIP/702-00000011 joined 'simple_bridge' basic-bridge <723f3211-990a-4be2-a52e-2f264c062ff2>
[2018-01-07 16:19:43] VERBOSE[14802][C-00000011] bridge_channel.c: Channel SIP/702-00000011 left 'simple_bridge' basic-bridge <723f3211-990a-4be2-a52e-2f264c062ff2>
[2018-01-07 16:19:43] VERBOSE[14802][C-00000011] pbx.c: Spawn extension (ext-intercom, *80733, 34) exited non-zero on 'SIP/702-00000011'
[2018-01-07 16:19:43] VERBOSE[14805][C-00000011] bridge_channel.c: Channel SIP/733-00000013 left 'simple_bridge' basic-bridge <723f3211-990a-4be2-a52e-2f264c062ff2>