After Module update, Paging now rings phones instead of beep/auto answer

Ran ‘fwconsole ma upgradeall’ on 10/6/18.

The morning of 10/8/18, staff initiated a page, the recipients phones rang instead of the beep and auto answer

Paging worked fine prior to the upgrade, no config changes were made to the phones (Cisco SPA 504G and 508G)

When comparing logs with a different, working PBX, I noticed this discrepancy.

PBX with good paging: "0?Set(ALERTINFO=Alert-Info: Auto Answer)") in new stack

PBX with broke paging: "0?Set(ALERTINFO=info=Auto Answer)") in new stack

I’ve tried:

  • rolling back the Paging and Intercom module, using all 5 previous versions

  • to rule a phone misconfig I reset one to factory, only configured proxy, extension, and password

  • FW console restart

  • PBX reboot

All else on this PBX seems fine.

PBX is in Device/user mode (client required queue agent phone login)

Current PBX Version:14.0.3.20

Current System Version:12.7.5-1807-1.sng7

Any help is greatly appreciated.

[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:1] Goto(“PJSIP/2299-0000000d”, “app-pagegroups,2464,1”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx_builtins.c: Goto (app-pagegroups,2464,1)
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:1] Macro(“PJSIP/2299-0000000d”, “user-callerid,”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:1] Set(“PJSIP/2299-0000000d”, “TOUCH_MONITOR=1539059196.116”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:2] Set(“PJSIP/2299-0000000d”, “AMPUSER=2299”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:3] GotoIf(“PJSIP/2299-0000000d”, “0?report”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/2299-0000000d”, “1?Set(REALCALLERIDNUM=2299)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:5] Set(“PJSIP/2299-0000000d”, “AMPUSER=2299”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:6] GotoIf(“PJSIP/2299-0000000d”, “0?limit”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:7] Set(“PJSIP/2299-0000000d”, “AMPUSERCIDNAME=NTG TEST”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:8] ExecIf(“PJSIP/2299-0000000d”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:9] GotoIf(“PJSIP/2299-0000000d”, “0?report”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:10] Set(“PJSIP/2299-0000000d”, “AMPUSERCID=2299”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:11] Set(“PJSIP/2299-0000000d”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:12] Set(“PJSIP/2299-0000000d”, “CALLERID(all)=“NTG TEST” <2299>”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:13] GotoIf(“PJSIP/2299-0000000d”, “0?limit”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/2299-0000000d”, “0?Set(GROUP(concurrency_limit)=2299)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:15] ExecIf(“PJSIP/2299-0000000d”, “0?Set(CHANNEL(language)=)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:16] NoOp(“PJSIP/2299-0000000d”, “Macro Depth is 1”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/2299-0000000d”, “1?report2:macroerror”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:18] GotoIf(“PJSIP/2299-0000000d”, “0?continue”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:19] ExecIf(“PJSIP/2299-0000000d”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:20] Set(“PJSIP/2299-0000000d”, “__TTL=64”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:21] GotoIf(“PJSIP/2299-0000000d”, “1?continue”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:37] Set(“PJSIP/2299-0000000d”, “CALLERID(number)=2299”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:38] Set(“PJSIP/2299-0000000d”, “CALLERID(name)=NTG TEST”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:39] GotoIf(“PJSIP/2299-0000000d”, “0?cnum”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:40] Set(“PJSIP/2299-0000000d”, “CDR(cnam)=NTG TEST”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:41] Set(“PJSIP/2299-0000000d”, “CDR(cnum)=2299”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:42] Set(“PJSIP/2299-0000000d”, “CHANNEL(language)=en”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:2] Set(“PJSIP/2299-0000000d”, “_PAGEGROUP=2464”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:3] GotoIf(“PJSIP/2299-0000000d”, “1?:busy”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:4] Set(“PJSIP/2299-0000000d”, “DEVICE_STATE(Custom:PAGE2464)=INUSE”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:5] Gosub(“PJSIP/2299-0000000d”, “app-paging,ssetup,1()”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:1] Set(“PJSIP/2299-0000000d”, “_SIPURI=”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:2] Set(“PJSIP/2299-0000000d”, “_ALERTINFO=Ring Answer”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:3] Set(“PJSIP/2299-0000000d”, “_CALLINFO=<uri>;answer-after=0”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:4] Set(“PJSIP/2299-0000000d”, “_SIPURI=intercom=true”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:5] Set(“PJSIP/2299-0000000d”, “_DTIME=5”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:6] Set(“PJSIP/2299-0000000d”, “_ANSWERMACRO=”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:7] Set(“PJSIP/2299-0000000d”, “PAGE_CONF=1539059196544”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:8] Return(“PJSIP/2299-0000000d”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:6] Set(“PJSIP/2299-0000000d”, “PAGEMODE=PAGE”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [246[email protected]:7] Set(“PJSIP/2299-0000000d”, “PAGE_MEMBERS=2299-4000-4001”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:8] Set(“PJSIP/2299-0000000d”, “PAGE_CONF_OPTS=”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:9] Set(“PJSIP/2299-0000000d”, “ANNOUNCEMENT=beep”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:10] AGI(“PJSIP/2299-0000000d”, “page.agi”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/page.agi
[2018-10-08 23:26:36] VERBOSE[7470] dial.c: Called [email protected]
[2018-10-08 23:26:36] VERBOSE[7471][C-0000002f] pbx.c: Executing [[email protected]:1] Wait(“Local/[email protected];2”, “1”) in new stack
[2018-10-08 23:26:36] VERBOSE[7475] dial.c: Called [email protected]
[2018-10-08 23:26:36] VERBOSE[7476][C-00000030] pbx.c: Executing [[email protected]:1] Wait(“Local/[email protected];2”, “1”) in new stack
[2018-10-08 23:26:36] VERBOSE[7473] dial.c: Called [email protected]/n
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:1] Macro(“Local/[email protected];2”, “autoanswer,4000”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:1] GotoIf(“Local/[email protected];2”, “1?knowndial”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx_builtins.c: Goto (macro-autoanswer,s,19)
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:19] Set(“Local/[email protected];2”, “DIAL=SIP/4000”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:20] ExecIf(“Local/[email protected];2”, “0?Set(DIAL=DAHDI/4000)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:21] GotoIf(“Local/[email protected];2”, “0?macro”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:22] GotoIf(“Local/[email protected];2”, “0?pjsipua”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:23] Set(“Local/[email protected];2”, “USERAGENT=Cisco/SPA525G2-7.5.6”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:24] Goto(“Local/[email protected];2”, “uafin”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx_builtins.c: Goto (macro-autoanswer,s,28)
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:28] ExecIf(“Local/[email protected];2”, “0?Set(USERAGENT=)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:29] ExecIf(“Local/[email protected];2”, “0?Set(PAGE_VOL=;volume=)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:30] ExecIf(“Local/[email protected];2”, “0?Set(ALERTINFO=ring-answer)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:31] ExecIf(“Local/[email protected];2”, “0?Set(CALLINFO=<sip:broadworks.net>;answer-after=0)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:32] ExecIf(“Local/[email protected];2”, “0?Set(ALERTINFO=<http://example.com>;info=alert-autoanswer)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:33] ExecIf(“Local/[email protected];2”, “0?Set(ALERTINFO=Intercom)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:34] ExecIf(“Local/[email protected];2”, “0?Set(ALERTINFO=info=Auto Answer)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:35] ExecIf(“Local/[email protected];2”, “0?Set(ALERTINFO=<http://www.sangoma.com>;info=external)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:36] ExecIf(“Local/[email protected];2”, “1?Set(__SIP_URI_OPTIONS=intercom=true)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:2] NoOp(“Local/[email protected];2”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:3] GotoIf(“Local/[email protected];2”, “1?doptions”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx_builtins.c: Goto (app-paging,PAGE4000,6)
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:6] ExecIf(“Local/[email protected];2”, “1?Set(_DOPTIONS=b(autoanswer^s^1(Ring Answer,<uri>;answer-after=0)))”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:7] Dial(“Local/[email protected];2”, “SIP/4000,5,A(beep)b(autoanswer^s^1(Ring Answer,<uri>;answer-after=0))”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] netsock2.c: Using SIP RTP TOS bits 184
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] netsock2.c: Using SIP RTP CoS mark 5
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] app_stack.c: SIP/4000-0000000c Internal Gosub(autoanswer,s,1(Ring Answer,<uri>;answer-after=0)) start
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:1] GosubIf(“SIP/4000-0000000c”, “1?func-set-sipheader,s,1(Alert-Info,Ring Answer)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:1] NoOp(“SIP/4000-0000000c”, “Sip Add Header function called. Adding Alert-Info = Ring Answer”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:2] Set(“SIP/4000-0000000c”, “HASH(_SIPHEADERS,Alert-Info)=Ring Answer”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:3] Return(“SIP/4000-0000000c”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:2] GosubIf(“SIP/4000-0000000c”, “1?func-set-sipheader,s,1(Call-Info,<uri>;answer-after=0)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] res_agi.c: <PJSIP/2299-0000000d>AGI Script page.agi completed, returning 0
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:11] Set(“PJSIP/2299-0000000d”, “CONFBRIDGE(user,template)=page_user_duplex”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:12] Set(“PJSIP/2299-0000000d”, “CONFBRIDGE(user,admin)=yes”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:13] Set(“PJSIP/2299-0000000d”, “CONFBRIDGE(user,marked)=yes”) in new stack
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:14] Answer(“PJSIP/2299-0000000d”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:1] NoOp(“SIP/4000-0000000c”, “Sip Add Header function called. Adding Call-Info = <uri>;answer-after=0”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:2] Set(“SIP/4000-0000000c”, “HASH(_SIPHEADERS,Call-Info)=<uri>;answer-after=0”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:3] Return(“SIP/4000-0000000c”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:3] Gosub(“SIP/4000-0000000c”, “func-apply-sipheaders,s,1()”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:1] ExecIf(“SIP/4000-0000000c”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:2] NoOp(“SIP/4000-0000000c”, “Applying SIP Headers to channel”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:3] Set(“SIP/4000-0000000c”, “SIPHEADERKEYS=Call-Info,Alert-Info”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:4] ExecIf(“SIP/4000-0000000c”, “0?Set(Rheader=1)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:5] While(“SIP/4000-0000000c”, “1”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:6] Set(“SIP/4000-0000000c”, “sipheader=<uri>;answer-after=0”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:7] ExecIf(“SIP/4000-0000000c”, “0?Set(Addheader=1)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:8] ExecIf(“SIP/4000-0000000c”, “0?SIPAddHeader(Call-Info:<uri>;answer-after=0)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:9] ExecIf(“SIP/4000-0000000c”, “0?Set(PJSIP_HEADER(add,Call-Info)=<uri>;answer-after=0)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:10] EndWhile(“SIP/4000-0000000c”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:5] While(“SIP/4000-0000000c”, “1”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:6] Set(“SIP/4000-0000000c”, “sipheader=Ring Answer”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:7] ExecIf(“SIP/4000-0000000c”, “0?Set(Addheader=1)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:8] ExecIf(“SIP/4000-0000000c”, “0?SIPAddHeader(Alert-Info:Ring Answer)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:9] ExecIf(“SIP/4000-0000000c”, “0?Set(PJSIP_HEADER(add,Alert-Info)=Ring Answer)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:10] EndWhile(“SIP/4000-0000000c”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:5] While(“SIP/4000-0000000c”, “0”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:11] ExecIf(“SIP/4000-0000000c”, “0?SIPRemoveHeader(Alert-Info:)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:12] ExecIf(“SIP/4000-0000000c”, “0?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:13] Return(“SIP/4000-0000000c”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:4] Return(“SIP/4000-0000000c”, “”) in new stack
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] app_stack.c: Spawn extension (from-internal, PAGE4000, 1) exited non-zero on ‘SIP/4000-0000000c’
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] app_stack.c: SIP/4000-0000000c Internal Gosub(autoanswer,s,1(Ring Answer,<uri>;answer-after=0)) complete GOSUB_RETVAL=
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] app_dial.c: Called SIP/4000
[2018-10-08 23:26:36] VERBOSE[7477][C-00000031] app_dial.c: SIP/4000-0000000c is ringing
[2018-10-08 23:26:36] VERBOSE[7473] dial.c: Local/[email protected];1 is ringing
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:15] ConfBridge(“PJSIP/2299-0000000d”, “1539059196544,admin_menu”) in new stack
[2018-10-08 23:26:36] VERBOSE[7480][C-0000002e] bridge_channel.c: Channel CBAnn/1539059196544-00000030;2 joined ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:36] VERBOSE[7461][C-0000002e] bridge_channel.c: Channel PJSIP/2299-0000000d joined ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:37] VERBOSE[7471][C-0000002f] pbx.c: Executing [[email protected]:2] Answer(“Local/[email protected];2”, “”) in new stack
[2018-10-08 23:26:37] VERBOSE[7470] dial.c: Local/[email protected];1 answered
[2018-10-08 23:26:37] VERBOSE[7476][C-00000030] pbx.c: Executing [[email protected]:2] Answer(“Local/[email protected];2”, “”) in new stack
[2018-10-08 23:26:37] VERBOSE[7475] dial.c: Local/[email protected];1 answered
[2018-10-08 23:26:37] VERBOSE[7475] file.c: <Local/[email protected];1> Playing ‘beep.slin16’ (language ‘en’)
[2018-10-08 23:26:37] VERBOSE[7476][C-00000030] pbx.c: Executing [[email protected]:3] Set(“Local/[email protected];2”, “CONFBRIDGE(user,template)=page_user_duplex”) in new stack
[2018-10-08 23:26:37] VERBOSE[7476][C-00000030] pbx.c: Executing [[email protected]:4] Set(“Local/[email protected];2”, “CONFBRIDGE(user,marked)=yes”) in new stack
[2018-10-08 23:26:37] VERBOSE[7476][C-00000030] pbx.c: Executing [[email protected]:5] ConfBridge(“Local/[email protected];2”, “1539059196544,”) in new stack
[2018-10-08 23:26:37] VERBOSE[7476][C-00000030] bridge_channel.c: Channel Local/[email protected];2 joined ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:37] VERBOSE[7471][C-0000002f] pbx.c: Executing [[email protected]:3] Set(“Local/[email protected];2”, “CONFBRIDGE(user,template)=page_user_duplex”) in new stack
[2018-10-08 23:26:37] VERBOSE[7471][C-0000002f] pbx.c: Executing [[email protected]:4] Set(“Local/[email protected];2”, “CONFBRIDGE(user,marked)=yes”) in new stack
[2018-10-08 23:26:37] VERBOSE[7471][C-0000002f] pbx.c: Executing [[email protected]:5] ConfBridge(“Local/[email protected];2”, “1539059196544,”) in new stack
[2018-10-08 23:26:37] VERBOSE[7471][C-0000002f] bridge_channel.c: Channel Local/[email protected];2 joined ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:37] VERBOSE[7461][C-0000002e] bridge_channel.c: Channel PJSIP/2299-0000000d left ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:37] VERBOSE[7461][C-0000002e] pbx.c: Executing [[email protected]:1] ExecIf(“PJSIP/2299-0000000d”, “1?Set(DEVICE_STATE(Custom:PAGE2464)=NOT_INUSE)”) in new stack
[2018-10-08 23:26:37] VERBOSE[8742] asterisk.c: Remote UNIX connection
[2018-10-08 23:26:37] VERBOSE[7484] asterisk.c: Remote UNIX connection disconnected
[2018-10-08 23:26:37] VERBOSE[7476][C-00000030] bridge_channel.c: Channel Local/[email protected];2 left ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:41] VERBOSE[7477][C-00000031] app_dial.c: Nobody picked up in 5000 ms
[2018-10-08 23:26:41] VERBOSE[7477][C-00000031] pbx.c: Executing [[email protected]:8] Hangup(“Local/[email protected];2”, “”) in new stack
[2018-10-08 23:26:41] VERBOSE[7477][C-00000031] pbx.c: Spawn extension (app-paging, PAGE4000, 8) exited non-zero on ‘Local/[email protected];2’
[2018-10-08 23:26:42] VERBOSE[7471][C-0000002f] bridge_channel.c: Channel Local/[email protected];2 left ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>
[2018-10-08 23:26:42] VERBOSE[7480][C-0000002e] bridge_channel.c: Channel CBAnn/1539059196544-00000030;2 left ‘softmix’ base-bridge <a62482d0-6965-41fa-9e31-d6a953fb9aab>

IIRC, there was a problem with the latest paging module. Downgrade back to your previous version until they get it fixed.

Check back through the forums from a couple of weeks ago and see if those issues look familiar.

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.