Queues ring no agents & FreePBX "Apply Settings" presistant

I posted this on the PIAF forums two days ago but have had little help. So sorry for the re-post.

The biggest concern is that queues will not ring any agents, period. This has been working, however, it does not now. Additionally and probably related, the “Apply Settings” button in FreePBX will not go away. When you apply settings all seems normal, but if you refresh the page, or navigate to another section of FreePBX, the “Apply Settings” button comes back.
I believe the problem began when I issued a pawwd-ari. Attempting to change the password, I didn’t realize that the script would actually issue a amportal restart. Because were on a live system, I Ctrl-C when the script attempted to do a graceful restart of asterisk, thus not completing.

Updated Issues Found:
BLF/Hints also not working, see post 3 for update.
AstAssistant no longer connects.

1)Hardware Description.
Intel P4, 2048MB RAM, 3 80GB hdd in raid 5.

2)Research:
I looked through PIAF, FreePBX, Trixbox and Elastix forums for someone with similar issues. Though no one has reported such claims from my findings. I also tried generic searches in Google.

3)Evidence
The following is a log of a Queue call in which ext 996 is its only member. Note, I am dialing the queue (ext 1491) from extension 996. Calls are set to NOT skip busy agents.

Executing [1491@from-internal:1] Macro("SIP/996-00000003", "user-callerid,") in new stack -- Executing [s@macro-user-callerid:1] Set("SIP/996-00000003", "AMPUSER=996") in new stack -- Executing [s@macro-user-callerid:2] GotoIf("SIP/996-00000003", "0?report") in new stack -- Executing [s@macro-user-callerid:3] ExecIf("SIP/996-00000003", "1?Set(REALCALLERIDNUM=996)") in new stack -- Executing [s@macro-user-callerid:4] Set("SIP/996-00000003", "AMPUSER=996") in new stack -- Executing [s@macro-user-callerid:5] Set("SIP/996-00000003", "AMPUSERCIDNAME=Shane Maynard") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("SIP/996-00000003", "0?report") in new stack -- Executing [s@macro-user-callerid:7] Set("SIP/996-00000003", "AMPUSERCID=922") in new stack -- Executing [s@macro-user-callerid:8] Set("SIP/996-00000003", "CALLERID(all)="Shane Maynard" <922>") in new stack -- Executing [s@macro-user-callerid:9] GotoIf("SIP/996-00000003", "0?limit") in new stack -- Executing [s@macro-user-callerid:10] ExecIf("SIP/996-00000003", "0?Set(GROUP(concurrency_limit)=996)") in new stack -- Executing [s@macro-user-callerid:11] GosubIf("SIP/996-00000003", "7?sub-ccss,s,1(from-internal,1491)") in new stack -- Executing [s@sub-ccss:1] ExecIf("SIP/996-00000003", "0?Return()") in new stack -- Executing [s@sub-ccss:2] Set("SIP/996-00000003", "CCSS_SETUP=TRUE") in new stack -- Executing [s@sub-ccss:3] GosubIf("SIP/996-00000003", "0?monitor_config,1(from-internal,1491):monitor_default,1(from-internal,1491)") in new stack -- Executing [monitor_default@sub-ccss:1] GotoIf("SIP/996-00000003", "0?is_exten") in new stack -- Executing [monitor_default@sub-ccss:2] StackPop("SIP/996-00000003", "") in new stack -- Executing [monitor_default@sub-ccss:3] Return("SIP/996-00000003", "FALSE") in new stack -- Executing [s@macro-user-callerid:12] ExecIf("SIP/996-00000003", "0?Set(CHANNEL(language)=)") in new stack -- Executing [s@macro-user-callerid:13] GotoIf("SIP/996-00000003", "0?continue") in new stack -- Executing [s@macro-user-callerid:14] Set("SIP/996-00000003", "__TTL=64") in new stack -- Executing [s@macro-user-callerid:15] GotoIf("SIP/996-00000003", "1?continue") in new stack -- Goto (macro-user-callerid,s,26) -- Executing [s@macro-user-callerid:26] Set("SIP/996-00000003", "CALLERID(number)=922") in new stack -- Executing [s@macro-user-callerid:27] Set("SIP/996-00000003", "CALLERID(name)=Shane Maynard") in new stack -- Executing [s@macro-user-callerid:28] Set("SIP/996-00000003", "CHANNEL(language)=en") in new stack -- Executing [1491@from-internal:2] Answer("SIP/996-00000003", "") in new stack -- Executing [1491@from-internal:3] Macro("SIP/996-00000003", "blkvm-set,reset") in new stack -- Executing [s@macro-blkvm-set:1] ExecIf("SIP/996-00000003", "1?Set(__BLKVM_CHANNEL=SIP/996-00000003)") in new stack -- Executing [s@macro-blkvm-set:2] Set("SIP/996-00000003", "SHARED(BLKVM,SIP/996-00000003)=TRUE") in new stack -- Executing [s@macro-blkvm-set:3] Set("SIP/996-00000003", "GOSUB_RETVAL=TRUE") in new stack -- Executing [s@macro-blkvm-set:4] MacroExit("SIP/996-00000003", "") in new stack -- Executing [1491@from-internal:4] ExecIf("SIP/996-00000003", "1?Set(_DIAL_OPTIONS=trM(auto-blkvm))") in new stack -- Executing [1491@from-internal:5] Set("SIP/996-00000003", "__NODEST=1491") in new stack -- Executing [1491@from-internal:6] Gosub("SIP/996-00000003", "sub-record-check,s,1(q,1491,dontcare)") in new stack -- Executing [s@sub-record-check:1] GotoIf("SIP/996-00000003", "1?check") in new stack -- Goto (sub-record-check,s,3) -- Executing [s@sub-record-check:3] Set("SIP/996-00000003", "MON_FMT=wav") in new stack -- Executing [s@sub-record-check:4] GotoIf("SIP/996-00000003", "1?next") in new stack -- Goto (sub-record-check,s,7) -- Executing [s@sub-record-check:7] ExecIf("SIP/996-00000003", "0?Return()") -- Executing [s@sub-record-check:8] GotoIf("SIP/996-00000003", "0?q,1") in n -- Executing [s@sub-record-check:9] Set("SIP/996-00000003", "__REC_STATUS=IN -- Executing [s@sub-record-check:10] ExecIf("SIP/996-00000003", "1?Set(__REC -- Executing [s@sub-record-check:11] Set("SIP/996-00000003", "NOW=1333990116 -- Executing [s@sub-record-check:12] Set("SIP/996-00000003", "__DAY=09") in -- Executing [s@sub-record-check:13] Set("SIP/996-00000003", "__MONTH=04") i -- Executing [s@sub-record-check:14] Set("SIP/996-00000003", "__YEAR=2012") -- Executing [s@sub-record-check:15] Set("SIP/996-00000003", "__TIMESTR=2012 -- Executing [s@sub-record-check:16] Set("SIP/996-00000003", "__FROMEXTEN=99 -- Executing [s@sub-record-check:17] Set("SIP/996-00000003", "__CALLFILENAME -- Executing [s@sub-record-check:18] Goto("SIP/996-00000003", "q,1") in new -- Goto (sub-record-check,q,1) -- Executing [q@sub-record-check:1] GosubIf("SIP/996-00000003", "0?recq,1(q, -- Executing [q@sub-record-check:2] Return("SIP/996-00000003", "") in new st -- Executing [1491@from-internal:7] QueueLog("SIP/996-00000003", "1491,13339 -- Executing [1491@from-internal:8] Queue("SIP/996-00000003", "1491,t,,") in -- Started music on hold, class 'default', on SIP/996-00000003

Also running a /var/lib/asterisk/bin/retrieve_conf produces the following:

root@pbx:~ $ /var/lib/asterisk/bin/retrieve_conf Added to globals: ASTETCDIR = /etc/asterisk Added to globals: ASTMODDIR = /usr/lib/asterisk/modules Added to globals: ASTVARLIBDIR = /var/lib/asterisk Added to globals: ASTAGIDIR = /var/lib/asterisk/agi-bin Added to globals: ASTSPOOLDIR = /var/spool/asterisk Added to globals: ASTRUNDIR = /var/run/asterisk Added to globals: ASTLOGDIR = /var/log/asterisk Added to globals: CWINUSEBUSY = true Added to globals: AMPMGRUSER = admin Added to globals: AMPMGRPASS = amp111 Added to globals: AMPDBENGINE = mysql Added to globals: AMPDBHOST = localhost Added to globals: AMPDBNAME = asterisk Added to globals: AMPDBUSER = asteriskuser Added to globals: AMPDBPASS = amp109 Added to globals: VMX_CONTEXT = from-internal Added to globals: VMX_PRI = 1 Added to globals: VMX_TIMEDEST_CONTEXT = Added to globals: VMX_TIMEDEST_EXT = dovm Added to globals: VMX_TIMEDEST_PRI = 1 Added to globals: VMX_LOOPDEST_CONTEXT = Added to globals: VMX_LOOPDEST_EXT = dovm Added to globals: VMX_LOOPDEST_PRI = 1 Added to globals: MIXMON_DIR = Added to globals: MIXMON_POST = Notice: no AMP Users defined Please update your modules and reload Asterisk by browsing to your server.

amportal a dbug

[CODE]
==> /var/log/asterisk/freepbx_dbug <==
2012-Apr-09 21:03:27 /var/www/html/admin/libraries/php-asmanager.php:159
[Undefined Error]: Comments starting with ‘#’ are deprecated in /etc/asterisk/phpagi.conf on line 6

2012-Apr-09 21:03:27 /var/www/html/admin/libraries/php-asmanager.php:159
[Undefined Error]: Comments starting with ‘#’ are deprecated in /etc/asterisk/phpagi.conf on line 6

2012-Apr-09 21:03:27 /var/lib/asterisk/bin/retrieve_conf:72
[WARNING]: symlink(): File exists

2012-Apr-09 21:03:27 /var/www/html/admin/modules/dahdiconfig/functions.inc.php:1233
[WARNING]: fopen(/etc/modprobe.d/dahdi.conf): failed to open stream: Permission denied

2012-Apr-09 21:03:27 /var/www/html/admin/modules/dahdiconfig/functions.inc.php:1235
[WARNING]: fwrite() expects parameter 1 to be resource, boolean given

2012-Apr-09 21:03:27 /var/www/html/admin/modules/dahdiconfig/functions.inc.php:1236
[WARNING]: fwrite() expects parameter 1 to be resource, boolean given

2012-Apr-09 21:03:27 /var/www/html/admin/modules/dahdiconfig/functions.inc.php:1237
[WARNING]: fwrite() expects parameter 1 to be resource, boolean given

2012-Apr-09 21:03:27 /var/www/html/admin/modules/dahdiconfig/functions.inc.php:1273
[WARNING]: fwrite() expects parameter 1 to be resource, boolean given

2012-Apr-09 21:03:27 /var/www/html/admin/modules/dahdiconfig/functions.inc.php:1274
[WARNING]: fclose() expects parameter 1 to be resource, boolean given

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:80
[NOTICE]: Undefined index: strategy

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:81
[NOTICE]: Undefined index: grptime

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:82
[NOTICE]: Undefined index: grplist

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:83
[NOTICE]: Undefined index: postdest

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:85
[NOTICE]: Undefined index: annmsg_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:86
[NOTICE]: Undefined index: dring

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:88
[NOTICE]: Undefined index: needsconf

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:89
[NOTICE]: Undefined index: remotealert_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:90
[NOTICE]: Undefined index: toolate_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:91
[NOTICE]: Undefined index: ringing

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:92
[NOTICE]: Undefined index: pre_ring

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:80
[NOTICE]: Undefined index: strategy

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:81
[NOTICE]: Undefined index: grptime

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:82
[NOTICE]: Undefined index: grplist

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:83
[NOTICE]: Undefined index: postdest

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:85
[NOTICE]: Undefined index: annmsg_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:86
[NOTICE]: Undefined index: dring

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:88
[NOTICE]: Undefined index: needsconf

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:89
[NOTICE]: Undefined index: remotealert_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:90
[NOTICE]: Undefined index: toolate_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:91
[NOTICE]: Undefined index: ringing

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:92
[NOTICE]: Undefined index: pre_ring

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:80
[NOTICE]: Undefined index: strategy

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:81
[NOTICE]: Undefined index: grptime

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:82
[NOTICE]: Undefined index: grplist

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:83
[NOTICE]: Undefined index: postdest

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:85
[NOTICE]: Undefined index: annmsg_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:86
[NOTICE]: Undefined index: dring

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:88
[NOTICE]: Undefined index: needsconf

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:89
[NOTICE]: Undefined index: remotealert_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:90
[NOTICE]: Undefined index: toolate_id

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:91
[NOTICE]: Undefined index: ringing

2012-Apr-09 21:03:28 /var/www/html/admin/modules/findmefollow/functions.inc.php:92
[NOTICE]: Undefined index: pre_ring

2012-Apr-09 21:03:30 /var/www/html/admin/modules/sipsettings/functions.inc.php:162
[NOTICE]: Undefined variable: interim_settings

2012-Apr-09 21:03:30 /var/www/html/admin/modules/sipsettings/functions.inc.php:174
[NOTICE]: Undefined variable: interim_settings

2012-Apr-09 21:03:30 /var/www/html/admin/modules/sipsettings/functions.inc.php:175
[NOTICE]: Undefined variable: interim_settings

2012-Apr-09 21:03:30 /var/www/html/admin/modules/sipsettings/functions.inc.php:176
[NOTICE]: Undefined variable: interim_settings

2012-Apr-09 21:03:30 /var/www/html/admin/modules/sipsettings/functions.inc.php:231
[NOTICE]: Undefined variable: sip_settings

2012-Apr-09 21:03:30 /var/www/html/admin/modules/customcontexts/functions.inc.php:52
[NOTICE]: Undefined variable: results

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4322
[NOTICE]: Undefined index: 126

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4323
[NOTICE]: Undefined index: 126

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4322
[NOTICE]: Undefined index: 127

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4323
[NOTICE]: Undefined index: 127

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4322
[NOTICE]: Undefined index: 132

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4323
[NOTICE]: Undefined index: 132

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4322
[NOTICE]: Undefined index: 310

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4323
[NOTICE]: Undefined index: 310

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4322
[NOTICE]: Undefined index: 311

2012-Apr-09 21:03:30 /var/www/html/admin/modules/core/functions.inc.php:4323
[NOTICE]: Undefined index: 311
[/CODE]

Also get this when I run a sip show subscriptions. Notice, we have 30 sip extensions all Aastra 57i.

pbx*CLI> sip show subscriptions Peer User Call ID Extension Last state Type Mailbox Expiry 192.168.6.64 995 MjNkZmViNmIxZDI -- <none> mwi 995@defaul 000120 1 active SIP subscription

Bump