hi, i just applied all modules and os updates to my FreePBX 14 distro. i purchased pagepro and have a scheduled page to sound a chime several times during the day. This was working fine before i applied the patches but the next day, not. I have a paging gateway (valcom) registering on extention 5004. If i dial 5004 from and handset, i hear my voice over the paging system…so i think that is working right. also, as you can see below, at 6:30am (one of the scheduled times), the pbx seems to play the scheduled sound…but we don’t hear anything.
I would really appreciate some help on this.
thanks
[2019-05-09 06:30:02] VERBOSE[21243] pbx_spool.c: Attempting call on Local/5001@from-internal for application Playback(silence/1) (Retry 1)
[2019-05-09 06:30:02] VERBOSE[21243] dial.c: Called 5001@from-internal
[2019-05-09 06:30:02] VERBOSE[21243] dial.c: Local/5001@from-internal-0000004b;1 answered
[2019-05-09 06:30:02] VERBOSE[21243] file.c: <Local/5001@from-internal-0000004b;1> Playing ‘silence/1.slin16’ (language ‘en’)
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@from-internal:1] Goto(“Local/5001@from-internal-0000004b;2”, “app-pagegroups,5001,1”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx_builtins.c: Goto (app-pagegroups,5001,1)
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:1] Macro(“Local/5001@from-internal-0000004b;2”, “user-callerid,”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:1] Set(“Local/5001@from-internal-0000004b;2”, “TOUCH_MONITOR=1557397802.1301”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:2] Set(“Local/5001@from-internal-0000004b;2”, “AMPUSER=5001”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“Local/5001@from-internal-0000004b;2”, “0?report”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“Local/5001@from-internal-0000004b;2”, “1?Set(REALCALLERIDNUM=5001)”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:5] Set(“Local/5001@from-internal-0000004b;2”, “AMPUSER=”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“Local/5001@from-internal-0000004b;2”, “0?limit”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:7] Set(“Local/5001@from-internal-0000004b;2”, “AMPUSERCIDNAME=”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“Local/5001@from-internal-0000004b;2”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“Local/5001@from-internal-0000004b;2”, “1?report”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx_builtins.c: Goto (macro-user-callerid,s,16)
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:16] NoOp(“Local/5001@from-internal-0000004b;2”, “Macro Depth is 1”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:17] GotoIf(“Local/5001@from-internal-0000004b;2”, “1?report2:macroerror”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“Local/5001@from-internal-0000004b;2”, “0?continue”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:19] ExecIf(“Local/5001@from-internal-0000004b;2”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:20] Set(“Local/5001@from-internal-0000004b;2”, “__TTL=64”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:21] GotoIf(“Local/5001@from-internal-0000004b;2”, “1?continue”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:37] Set(“Local/5001@from-internal-0000004b;2”, “CALLERID(number)=5001”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:38] Set(“Local/5001@from-internal-0000004b;2”, “CALLERID(name)=Page Group to ring tone at 4pm etc”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:39] GotoIf(“Local/5001@from-internal-0000004b;2”, “0?cnum”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:40] Set(“Local/5001@from-internal-0000004b;2”, “CDR(cnam)=Page Group to ring tone at 4pm etc”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:41] Set(“Local/5001@from-internal-0000004b;2”, “CDR(cnum)=5001”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [s@macro-user-callerid:42] Set(“Local/5001@from-internal-0000004b;2”, “CHANNEL(language)=en”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:2] Set(“Local/5001@from-internal-0000004b;2”, “_PAGEGROUP=5001”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:3] Set(“Local/5001@from-internal-0000004b;2”, “ANNOUNCE_COUNT=1”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:4] GotoIf(“Local/5001@from-internal-0000004b;2”, “1?:busy”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:5] Set(“Local/5001@from-internal-0000004b;2”, “DEVICE_STATE(Custom:PAGE5001)=INUSE”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:6] Gosub(“Local/5001@from-internal-0000004b;2”, “app-paging,ssetup,1()”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:1] Set(“Local/5001@from-internal-0000004b;2”, “_SIPURI=”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:2] Set(“Local/5001@from-internal-0000004b;2”, “_ALERTINFO=Ring Answer”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:3] Set(“Local/5001@from-internal-0000004b;2”, “_CALLINFO=;answer-after=0”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:4] Set(“Local/5001@from-internal-0000004b;2”, “_SIPURI=intercom=true”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:5] Set(“Local/5001@from-internal-0000004b;2”, “_DTIME=5”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:6] Set(“Local/5001@from-internal-0000004b;2”, “_ANSWERMACRO=”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:7] Set(“Local/5001@from-internal-0000004b;2”, “PAGE_CONF=1557397802500”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [ssetup@app-paging:8] Return(“Local/5001@from-internal-0000004b;2”, “”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:7] Set(“Local/5001@from-internal-0000004b;2”, “PAGEMODE=PAGE”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:8] Set(“Local/5001@from-internal-0000004b;2”, “PAGE_MEMBERS=5004”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:9] Set(“Local/5001@from-internal-0000004b;2”, “PAGE_CONF_OPTS=”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:10] Set(“Local/5001@from-internal-0000004b;2”, “ANNOUNCEMENT=custom/Chime-3-Quiet”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:11] Set(“Local/5001@from-internal-0000004b;2”, “STREAM=NONE”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:12] AGI(“Local/5001@from-internal-0000004b;2”, “page.agi”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/page.agi
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] res_agi.c: <Local/5001@from-internal-0000004b;2>AGI Script page.agi completed, returning 0
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:13] Set(“Local/5001@from-internal-0000004b;2”, “CONFBRIDGE(user,template)=page_user_duplex”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:14] Set(“Local/5001@from-internal-0000004b;2”, “CONFBRIDGE(user,admin)=yes”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:15] Set(“Local/5001@from-internal-0000004b;2”, “CONFBRIDGE(user,marked)=yes”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:16] Answer(“Local/5001@from-internal-0000004b;2”, “”) in new stack
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] pbx.c: Executing [5001@app-pagegroups:17] ConfBridge(“Local/5001@from-internal-0000004b;2”, “1557397802500,admin_menu”) in new stack
[2019-05-09 06:30:02] VERBOSE[21286][C-00000353] bridge_channel.c: Channel CBAnn/1557397802500-0000004e;2 joined ‘softmix’ base-bridge <373a4a25-e870-4eca-ba72-cb89f4a33c89>
[2019-05-09 06:30:02] VERBOSE[21245][C-00000353] bridge_channel.c: Channel Local/5001@from-internal-0000004b;2 joined ‘softmix’ base-bridge <373a4a25-e870-4eca-ba72-cb89f4a33c89>
[2019-05-09 06:30:03] VERBOSE[21245][C-00000353] bridge_channel.c: Channel Local/5001@from-internal-0000004b;2 left ‘softmix’ base-bridge <373a4a25-e870-4eca-ba72-cb89f4a33c89>
[2019-05-09 06:30:03] VERBOSE[21286][C-00000353] bridge_channel.c: Channel CBAnn/1557397802500-0000004e;2 left ‘softmix’ base-bridge <373a4a25-e870-4eca-ba72-cb89f4a33c89>
[2019-05-09 06:30:03] VERBOSE[21245][C-00000353] pbx.c: Executing [h@app-pagegroups:1] ExecIf(“Local/5001@from-internal-0000004b;2”, “1?Set(DEVICE_STATE(Custom:PAGE5001)=NOT_INUSE)”) in new stack
[2019-05-09 06:30:03] VERBOSE[21245][C-00000353] pbx.c: Executing [h@app-pagegroups:2] GosubIf(“Local/5001@from-internal-0000004b;2”, “0?record-page,1()”) in new stack
[2019-05-09 06:30:03] VERBOSE[21245][C-00000353] pbx.c: Executing [h@app-pagegroups:3] ExecIf(“Local/5001@from-internal-0000004b;2”, “0?System(rm .sln)”) in new stack
[2019-05-09 06:30:03] VERBOSE[21245][C-00000353] pbx.c: Executing [h@app-pagegroups:4] ExecIf(“Local/5001@from-internal-0000004b;2”, “0?System(rm -f /var/spool/asterisk/outgoing/)”) in new stack
[2019-05-09 06:30:03] NOTICE[21243] pbx_spool.c: Call completed to Local/5001@from-internal