This is a tricky one. When intercomming certain extensions, the extension initiating the intercom does not hear a beep when the call is established. A single ring is heard instead.
I examined the logs for each call and they diverge at this point:
Intercom with ring instead of beep:
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:20] GotoIf(“PJSIP/28-00031eef”, “0?pagemode”) in new stack
Intercom with beep:
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:20] GotoIf(“PJSIP/27-00031db9”, “1?pagemode”) in new stack
As you can see, the pagemode values are different for extension 29 and 27.
I exported the extension list for the PBX and cross referenced the values for the extension set that results in a ring and the set that results in a beep. The culprit setting appears to be “send_connected_line”. It looks like when intercomming extensions that have this set to yes a beep is heard. Several extension have no value for this setting. The setting appears to have been removed from the extension’s advanced tab so I can’t test this directly. I couldn’t find this setting in the configuration files or the db to try and manually change it.
This is where I’m stuck.
Here’s a larger log excerpt for each call:
correct behavior (beep plays for both parties):
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:20] GotoIf(“PJSIP/27-00031db9”, “1?pagemode”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx_builtins.c: Goto (ext-intercom,*8022,38)
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:38] Set(“PJSIP/27-00031db9”, “ITER=1”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:39] Set(“PJSIP/27-00031db9”, “DIALSTR=”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:40] ChanIsAvail(“PJSIP/27-00031db9”, “PJSIP/22,s”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:41] GotoIf(“PJSIP/27-00031db9”, “0?skip”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:42] Set(“PJSIP/27-00031db9”, “DIALSTR=-22”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:43] Set(“PJSIP/27-00031db9”, “ITER=2”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:44] GotoIf(“PJSIP/27-00031db9”, “1?begin”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx_builtins.c: Goto (ext-intercom,*8022,40)
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:40] ChanIsAvail(“PJSIP/27-00031db9”, “PJSIP/9822,s”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:41] GotoIf(“PJSIP/27-00031db9”, “1?skip”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx_builtins.c: Goto (ext-intercom,*8022,43)
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:43] Set(“PJSIP/27-00031db9”, “ITER=3”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:44] GotoIf(“PJSIP/27-00031db9”, “0?begin”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:45] Set(“PJSIP/27-00031db9”, “DIALSTR=22”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:46] GotoIf(“PJSIP/27-00031db9”, “0?checkpageoption”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:47] Set(“PJSIP/27-00031db9”, “_AMPUSER=27”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [*8022@ext-intercom:48] Gosub(“PJSIP/27-00031db9”, “page,1(22)”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:1] Set(“PJSIP/27-00031db9”, “PAGE_CONF=1734719432672”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:2] Set(“PJSIP/27-00031db9”, “PAGEMODE=PAGE”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:3] Set(“PJSIP/27-00031db9”, “PAGE_MEMBERS=22”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:4] Set(“PJSIP/27-00031db9”, “PAGE_CONF_OPTS=duplex”) in new stack
[2024-12-20 13:30:32] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:5] AGI(“PJSIP/27-00031db9”, “agi://127.0.0.1/page.agi”) in new stack
[2024-12-20 13:30:33] VERBOSE[11281] dial.c: Called s@app-page-stream
[2024-12-20 13:30:33] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:1] Wait(“Local/s@app-page-stream-0000c4f8;2”, “1”) in new stack
[2024-12-20 13:30:33] VERBOSE[11285] dial.c: Called PAGE22@app-paging/n
[2024-12-20 13:30:33] VERBOSE[11286] dial.c: Called s@app-page-stream
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [PAGE22@app-paging:1] Macro(“Local/PAGE22@app-paging-0000c4f9;2”, “autoanswer,22”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:1] GotoIf(“Local/PAGE22@app-paging-0000c4f9;2”, “1?knowndial”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx_builtins.c: Goto (macro-autoanswer,s,19)
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:19] Set(“Local/PAGE22@app-paging-0000c4f9;2”, “DIAL=PJSIP/22/sip:[email protected]:1028;x-ast-orig-host=192.168.1.36:5060”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:20] GotoIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?macro”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:21] GotoIf(“Local/PAGE22@app-paging-0000c4f9;2”, “1?pjsipua”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx_builtins.c: Goto (macro-autoanswer,s,24)
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:24] Set(“Local/PAGE22@app-paging-0000c4f9;2”, “AOR=22”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:25] Set(“Local/PAGE22@app-paging-0000c4f9;2”, “CONTACT=22;@4a47d457d2a307f43cd982ec3fa21136”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:26] Set(“Local/PAGE22@app-paging-0000c4f9;2”, “USERAGENT=Yealink SIP-T46S 66.84.0.125”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:27] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “1?Set(USERAGENT=Yealink SIP-T46S 66.84.0.125)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:28] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(PAGE_VOL=;volume=)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:29] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=ring-answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:30] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(CALLINFO=sip:broadworks.net;answer-after=0)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:31] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=http://example.com;info=alert-autoanswer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:32] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=Intercom)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:33] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=Alert-Info: Auto Answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:34] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=http://www.sangoma.com;info=external)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:35] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=Direct-Intercom)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:36] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=ring-answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:37] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=http://www.sangoma.com;info=external)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:38] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “0?Set(ALERTINFO=Direct-Intercom)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@macro-autoanswer:39] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “1?Set(__SIP_URI_OPTIONS=intercom=true)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [PAGE22@app-paging:2] NoOp(“Local/PAGE22@app-paging-0000c4f9;2”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [PAGE22@app-paging:3] GotoIf(“Local/PAGE22@app-paging-0000c4f9;2”, “1?doptions”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx_builtins.c: Goto (app-paging,PAGE22,6)
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [PAGE22@app-paging:6] ExecIf(“Local/PAGE22@app-paging-0000c4f9;2”, “1?Set(_DOPTIONS=b(autoanswer^s^1(Ring Answer,;answer-after=0)))”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [PAGE22@app-paging:7] Dial(“Local/PAGE22@app-paging-0000c4f9;2”, “PJSIP/22/sip:[email protected]:1028;x-ast-orig-host=192.168.1.36:5060,5,A()b(autoanswer^s^1(Ring Answer,;answer-after=0))”) in new stack
[2024-12-20 13:30:33] VERBOSE[11272][C-00012271] res_agi.c: <PJSIP/27-00031db9>AGI Script agi://127.0.0.1/page.agi completed, returning 0
[2024-12-20 13:30:33] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:6] Set(“PJSIP/27-00031db9”, “CONFBRIDGE(user,template)=page_user_duplex”) in new stack
[2024-12-20 13:30:33] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:7] Set(“PJSIP/27-00031db9”, “CONFBRIDGE(user,admin)=yes”) in new stack
[2024-12-20 13:30:33] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:8] Set(“PJSIP/27-00031db9”, “CONFBRIDGE(user,marked)=yes”) in new stack
[2024-12-20 13:30:33] VERBOSE[11272][C-00012271] pbx.c: Executing [page@ext-intercom:9] ConfBridge(“PJSIP/27-00031db9”, “1734719432672,admin_menu”) in new stack
[2024-12-20 13:30:33] VERBOSE[11288][C-00012274] pbx.c: Executing [s@app-page-stream:1] Wait(“Local/s@app-page-stream-0000c4fa;2”, “1”) in new stack
[2024-12-20 13:30:33] VERBOSE[11291][C-00012271] bridge_channel.c: Channel CBAnn/1734719432672-0000c4fb;2 joined ‘softmix’ base-bridge <7b36a96b-b62b-492b-a430-983ed17f3a4a>
[2024-12-20 13:30:33] VERBOSE[11272][C-00012271] bridge_channel.c: Channel PJSIP/27-00031db9 joined ‘softmix’ base-bridge <7b36a96b-b62b-492b-a430-983ed17f3a4a>
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] app_stack.c: PJSIP/22-00031dbb Internal Gosub(autoanswer,s,1(Ring Answer,;answer-after=0)) start
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@autoanswer:1] GosubIf(“PJSIP/22-00031dbb”, “1?func-set-sipheader,s,1(Alert-Info,Ring Answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-set-sipheader:1] NoOp(“PJSIP/22-00031dbb”, “Sip Add Header function called. Adding Alert-Info = Ring Answer”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-set-sipheader:2] Set(“PJSIP/22-00031dbb”, “HASH(__SIPHEADERS,Alert-Info)=Ring Answer”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-set-sipheader:3] Return(“PJSIP/22-00031dbb”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@autoanswer:2] GosubIf(“PJSIP/22-00031dbb”, “1?func-set-sipheader,s,1(Call-Info,;answer-after=0)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-set-sipheader:1] NoOp(“PJSIP/22-00031dbb”, “Sip Add Header function called. Adding Call-Info = ;answer-after=0”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-set-sipheader:2] Set(“PJSIP/22-00031dbb”, “HASH(__SIPHEADERS,Call-Info)=;answer-after=0”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-set-sipheader:3] Return(“PJSIP/22-00031dbb”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@autoanswer:3] Gosub(“PJSIP/22-00031dbb”, “func-apply-sipheaders,s,1()”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(“PJSIP/22-00031dbb”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(“PJSIP/22-00031dbb”, “Applying SIP Headers to channel PJSIP/22-00031dbb”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“PJSIP/22-00031dbb”, “TECH=PJSIP”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:4] Set(“PJSIP/22-00031dbb”, “SIPHEADERKEYS=Call-Info,Alert-Info”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:5] While(“PJSIP/22-00031dbb”, “1”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:6] Set(“PJSIP/22-00031dbb”, “sipheader=;answer-after=0”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(“PJSIP/22-00031dbb”, “0?SIPRemoveHeader(Call-Info:)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf(“PJSIP/22-00031dbb”, “0?Set(PJSIP_HEADER(remove,Call-Info)=)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf(“PJSIP/22-00031dbb”, “0?Set(sipheader=http://127.0.0.1;info=;answer-after=0)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf(“PJSIP/22-00031dbb”, “0?Set(sipheader=http://127.0.0.1;answer-after=0)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf(“PJSIP/22-00031dbb”, “0?SIPAddHeader(Call-Info:;answer-after=0)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf(“PJSIP/22-00031dbb”, “1?Set(PJSIP_HEADER(add,Call-Info)=;answer-after=0)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile(“PJSIP/22-00031dbb”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:5] While(“PJSIP/22-00031dbb”, “1”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:6] Set(“PJSIP/22-00031dbb”, “sipheader=Ring Answer”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(“PJSIP/22-00031dbb”, “0?SIPRemoveHeader(Alert-Info:)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf(“PJSIP/22-00031dbb”, “0?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf(“PJSIP/22-00031dbb”, “1?Set(sipheader=http://127.0.0.1;info=Ring Answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf(“PJSIP/22-00031dbb”, “0?Set(sipheader=http://127.0.0.1http://127.0.0.1;info=Ring Answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf(“PJSIP/22-00031dbb”, “0?SIPAddHeader(Alert-Info:http://127.0.0.1;info=Ring Answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf(“PJSIP/22-00031dbb”, “1?Set(PJSIP_HEADER(add,Alert-Info)=http://127.0.0.1;info=Ring Answer)”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile(“PJSIP/22-00031dbb”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:5] While(“PJSIP/22-00031dbb”, “0”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@func-apply-sipheaders:14] Return(“PJSIP/22-00031dbb”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] pbx.c: Executing [s@autoanswer:4] Return(“PJSIP/22-00031dbb”, “”) in new stack
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] app_stack.c: Spawn extension (from-internal, PAGE22, 1) exited non-zero on ‘PJSIP/22-00031dbb’
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] app_stack.c: PJSIP/22-00031dbb Internal Gosub(autoanswer,s,1(Ring Answer,;answer-after=0)) complete GOSUB_RETVAL=
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] app_dial.c: Called PJSIP/22/sip:[email protected]:1028;x-ast-orig-host=192.168.1.36:5060
[2024-12-20 13:30:33] VERBOSE[3543] netsock2.c: Using SIP RTP Audio TOS bits 184
[2024-12-20 13:30:33] VERBOSE[3543] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2024-12-20 13:30:33] VERBOSE[3543] netsock2.c: Using SIP RTP Audio CoS mark 5
[2024-12-20 13:30:33] VERBOSE[11287][C-00012273] app_dial.c: PJSIP/22-00031dbb is ringing
[2024-12-20 13:30:33] VERBOSE[11285] dial.c: Local/PAGE22@app-paging-0000c4f9;1 is ringing
[2024-12-20 13:30:34] VERBOSE[11287][C-00012273] app_dial.c: PJSIP/22-00031dbb answered Local/PAGE22@app-paging-0000c4f9;2
[2024-12-20 13:30:34] VERBOSE[11285] dial.c: Local/PAGE22@app-paging-0000c4f9;1 answered
[2024-12-20 13:30:34] VERBOSE[11285] bridge_channel.c: Channel Local/PAGE22@app-paging-0000c4f9;1 joined ‘softmix’ base-bridge <7b36a96b-b62b-492b-a430-983ed17f3a4a>
[2024-12-20 13:30:34] VERBOSE[11292][C-00012273] bridge_channel.c: Channel PJSIP/22-00031dbb joined ‘simple_bridge’ basic-bridge <84f4b336-5bb8-4bd1-a7c5-937b04d621b5>
[2024-12-20 13:30:34] VERBOSE[11287][C-00012273] bridge_channel.c: Channel Local/PAGE22@app-paging-0000c4f9;2 joined ‘simple_bridge’ basic-bridge <84f4b336-5bb8-4bd1-a7c5-937b04d621b5>
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:2] Answer(“Local/s@app-page-stream-0000c4f8;2”, “”) in new stack
[2024-12-20 13:30:34] VERBOSE[11281] dial.c: Local/s@app-page-stream-0000c4f8;1 answered
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:3] Set(“Local/s@app-page-stream-0000c4f8;2”, “CHANNEL(language)=en”) in new stack
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:4] Set(“Local/s@app-page-stream-0000c4f8;2”, “CONFBRIDGE(user,template)=page_user_duplex”) in new stack
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:5] Set(“Local/s@app-page-stream-0000c4f8;2”, “CONFBRIDGE(user,marked)=yes”) in new stack
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:6] ExecIf(“Local/s@app-page-stream-0000c4f8;2”, “0?Set(CONFBRIDGE(user,startmuted)=yes)”) in new stack
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:7] ExecIf(“Local/s@app-page-stream-0000c4f8;2”, “0?Set(CONFBRIDGE(user,marked)=yes)”) in new stack
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] pbx.c: Executing [s@app-page-stream:8] ConfBridge(“Local/s@app-page-stream-0000c4f8;2”, “1734719432672,”) in new stack
[2024-12-20 13:30:34] VERBOSE[11282][C-00012272] bridge_channel.c: Channel Local/s@app-page-stream-0000c4f8;2 joined ‘softmix’ base-bridge <7b36a96b-b62b-492b-a430-983ed17f3a4a>
[2024-12-20 13:30:34] VERBOSE[11288][C-00012274] pbx.c: Executing [s@app-page-stream:2] Answer(“Local/s@app-page-stream-0000c4fa;2”, “”) in new stack
[2024-12-20 13:30:34] VERBOSE[11286] dial.c: Local/s@app-page-stream-0000c4fa;1 answered
[2024-12-20 13:30:34] VERBOSE[11286] file.c: <Local/s@app-page-stream-0000c4fa;1> Playing ‘beep.slin16’ (language ‘en’)
incorrect behavior (beep only played to callee):
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:20] GotoIf(“PJSIP/28-00031eef”, “0?pagemode”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:21] Macro(“PJSIP/28-00031eef”, “autoanswer,29”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:1] GotoIf(“PJSIP/28-00031eef”, “0?knowndial”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:2] Set(“PJSIP/28-00031eef”, “DEVICE=PJSIP/29”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:3] GotoIf(“PJSIP/28-00031eef”, “1?dopjsip”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx_builtins.c: Goto (macro-autoanswer,s,6)
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:6] Set(“PJSIP/28-00031eef”, “KNOWNDIAL=PJSIP/29/sip:[email protected]:5060;x-ast-orig-host=192.168.254.138:5060”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:7] GotoIf(“PJSIP/28-00031eef”, “1?knowndial”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx_builtins.c: Goto (macro-autoanswer,s,19)
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:19] Set(“PJSIP/28-00031eef”, “DIAL=PJSIP/29/sip:[email protected]:5060;x-ast-orig-host=192.168.254.138:5060”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:20] GotoIf(“PJSIP/28-00031eef”, “0?macro”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:21] GotoIf(“PJSIP/28-00031eef”, “1?pjsipua”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx_builtins.c: Goto (macro-autoanswer,s,24)
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:24] Set(“PJSIP/28-00031eef”, “AOR=29”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:25] Set(“PJSIP/28-00031eef”, “CONTACT=29;@07ee6ec9735d83cd5a812c94e7f40413”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:26] Set(“PJSIP/28-00031eef”, “USERAGENT=Yealink SIP-T46S 66.86.0.160”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:27] ExecIf(“PJSIP/28-00031eef”, “0?Set(USERAGENT=)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:28] ExecIf(“PJSIP/28-00031eef”, “0?Set(PAGE_VOL=;volume=)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:29] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=ring-answer)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:30] ExecIf(“PJSIP/28-00031eef”, “0?Set(CALLINFO=sip:broadworks.net;answer-after=0)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:31] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=http://example.com;info=alert-autoanswer)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:32] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=Intercom)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:33] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=Alert-Info: Auto Answer)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:34] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=http://www.sangoma.com;info=external)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:35] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=Direct-Intercom)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:36] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=ring-answer)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:37] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=http://www.sangoma.com;info=external)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:38] ExecIf(“PJSIP/28-00031eef”, “0?Set(ALERTINFO=Direct-Intercom)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@macro-autoanswer:39] ExecIf(“PJSIP/28-00031eef”, “1?Set(__SIP_URI_OPTIONS=intercom=true)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:22] Set(“PJSIP/28-00031eef”, “_DOPTIONS=A(custom/beep)b(autoanswer^s^1(Ring Answer,;answer-after=0))”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:23] ChanIsAvail(“PJSIP/28-00031eef”, “PJSIP/29,s”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:24] ExecIf(“PJSIP/28-00031eef”, “0?Set(AVAILORIGCHAN=PJSIP/29)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:25] GotoIf(“PJSIP/28-00031eef”, “1?continue”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx_builtins.c: Goto (ext-intercom,*8029,30)
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:30] NoOp(“PJSIP/28-00031eef”, “Continuing with page”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:31] GotoIf(“PJSIP/28-00031eef”, “0?godial”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:32] Set(“PJSIP/28-00031eef”, “CONNECTEDLINE(name,i)=Norstone - Test”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:33] Set(“PJSIP/28-00031eef”, “CONNECTEDLINE(num)=29”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [*8029@ext-intercom:34] Dial(“PJSIP/28-00031eef”, “PJSIP/29/sip:[email protected]:5060;x-ast-orig-host=192.168.254.138:5060,5,IA(custom/beep)b(autoanswer^s^1(Ring Answer,;answer-after=0))”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] app_stack.c: PJSIP/29-00031ef1 Internal Gosub(autoanswer,s,1(Ring Answer,;answer-after=0)) start
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@autoanswer:1] GosubIf(“PJSIP/29-00031ef1”, “1?func-set-sipheader,s,1(Alert-Info,Ring Answer)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-set-sipheader:1] NoOp(“PJSIP/29-00031ef1”, “Sip Add Header function called. Adding Alert-Info = Ring Answer”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-set-sipheader:2] Set(“PJSIP/29-00031ef1”, “HASH(__SIPHEADERS,Alert-Info)=Ring Answer”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-set-sipheader:3] Return(“PJSIP/29-00031ef1”, “”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@autoanswer:2] GosubIf(“PJSIP/29-00031ef1”, “1?func-set-sipheader,s,1(Call-Info,;answer-after=0)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-set-sipheader:1] NoOp(“PJSIP/29-00031ef1”, “Sip Add Header function called. Adding Call-Info = ;answer-after=0”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-set-sipheader:2] Set(“PJSIP/29-00031ef1”, “HASH(__SIPHEADERS,Call-Info)=;answer-after=0”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-set-sipheader:3] Return(“PJSIP/29-00031ef1”, “”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@autoanswer:3] Gosub(“PJSIP/29-00031ef1”, “func-apply-sipheaders,s,1()”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(“PJSIP/29-00031ef1”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(“PJSIP/29-00031ef1”, “Applying SIP Headers to channel PJSIP/29-00031ef1”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“PJSIP/29-00031ef1”, “TECH=PJSIP”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:4] Set(“PJSIP/29-00031ef1”, “SIPHEADERKEYS=Call-Info,Alert-Info”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:5] While(“PJSIP/29-00031ef1”, “1”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:6] Set(“PJSIP/29-00031ef1”, “sipheader=;answer-after=0”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(“PJSIP/29-00031ef1”, “0?SIPRemoveHeader(Call-Info:)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf(“PJSIP/29-00031ef1”, “0?Set(PJSIP_HEADER(remove,Call-Info)=)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf(“PJSIP/29-00031ef1”, “0?Set(sipheader=http://127.0.0.1;info=;answer-after=0)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf(“PJSIP/29-00031ef1”, “0?Set(sipheader=http://127.0.0.1;answer-after=0)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf(“PJSIP/29-00031ef1”, “0?SIPAddHeader(Call-Info:;answer-after=0)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf(“PJSIP/29-00031ef1”, “1?Set(PJSIP_HEADER(add,Call-Info)=;answer-after=0)”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile(“PJSIP/29-00031ef1”, “”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:5] While(“PJSIP/29-00031ef1”, “1”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:6] Set(“PJSIP/29-00031ef1”, “sipheader=Ring Answer”) in new stack
[2024-12-20 14:40:08] VERBOSE[28869][C-00012342] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(“PJSIP/29-00031ef1”, “0?SIPRemoveHeader(Alert-Info:)”) in new stack