[SOLVED] Rebooted FreePBX and now exentsion are giving ' the person at extension. . ."

freepbx
Tags: #<Tag:0x00007f7029306330>

(James B. Byrne) #1

A: We restored from a recent FreePBX full backup and restarted the system. This cleared the problem.

Q:
We have a FreePBX system that has been running for two years. Last week we shut it down to clone the HDD as we suspected that the drive was about to fail from the smartctl reports. This turned out to be an error in interpretation due to the way Seagate report raw error rates.

However, after restarting the system we began to experience intermittent cut outs to audio reception on the extensions. We have made no direct changes to any of the configuration files, everything has been handled through the web interface. In any case there were no changes made there either since the last restart of Asterisk before the reboot.

After the reboot we also had problems with the fax lines not picking up. This was traced back to a corrupted astdb.sqlite3 database that was dealt with through the web interface by simply resubmitting the device and applying the configuration.

This morning in an attempt to clear up any residual sqlite3 problems we shut down asterisk and renamed astdb.sqlite3, and restarted asterisk to recreate the database from scratch. This asterisk did do. However, it also brought on the symptom where none of the internal extensions can accept calls, either internal or external. Outgoing calls are not affected.

This has killed our pbx. We have run fwconsol stop and fwconsole start but nothing has changed insofar as we can see.

This is the output fromfwconsole start:
fwconsole start
Running FreePBX startup…
Taking too long? Customize the chown command, See http://wiki.freepbx.org/display/FOP/FreePBX+Chown+Conf
Setting Permissions…
Setting base permissions…Done
Setting specific permissions…
27381 [============================]
Finished setting permissions
Running Asterisk pre from Dahdiconfig module
Wanrouter: No valid Sangoma Hardware found, if you have no Sangoma cards this is OK
Starting DAHDi for Digium Cards
DAHDi Started
Running Asterisk pre from Firewall module
Running Asterisk pre from Sysadmin module
Running Sysadmin Hooks
Restarting fail2ban
fail2ban Restarted
Updating License Information for 15423705
Checking Vpn server
Starting Asterisk…
[============================] 34 secs
Asterisk Started
Running Asterisk post from Dahdiconfig module
Running Asterisk post from Endpoint module
Running Asterisk post from Pagingpro module
Running Asterisk post from Restapps module
Starting RestApps Server…
[>---------------------------] 4 secs
Started RestApps Server. PID is 9940
Running Asterisk post from Ucpnode module
Starting UCP Node Server…
[>---------------------------] 9 secs
Started UCP Node Server. PID is 10017
Running Asterisk post from Vqplus module
RestApps is not licensed.
Running Asterisk post from Xmpp module
[>---------------------------] < 1 secStarting Chat Server…
[>---------------------------] 7 secs
Started Chat Server. PID is 10272
Running Asterisk post from Zulu module
This product is not licensed

Any help is appreciated:

cat asterisk.extensions.debug.2020-06-12.txt | pastebin

title: Automatic Pastebin from FreePBX Distro 6
name: root@voinet09.hamilton.harte-lyne.ca
private: 1
expire: 0
https://pastebin.freepbx.org/view/740368dc

cat asterisk.extensions.call.full.record.2020-06-12.txt | pastebin

title: Automatic Pastebin from FreePBX Distro 6
name: root@voinet09.hamilton.harte-lyne.ca
private: 1
expire: 0
https://pastebin.freepbx.org/view/03641730


(Communication Technologies) #2

https://wiki.freepbx.org/display/SUP/Providing+Great+Debug


#3

Important extension data is stored in astdb. You should be able to get most of it back by going to each of your extensions and re-saving, then applying the config. Users’ DND and call forward settings will be lost.


(James B. Byrne) #4

pastebin posted:

https://pastebin.freepbx.org/view/740368dc
https://pastebin.freepbx.org/view/03641730

(James B. Byrne) #5

When I update an extension from the devices page on the web interface then this happens:

[2020-06-12 12:14:59] VERBOSE[9689] tcptls.c: TLS/SSL certificate ok
[2020-06-12 12:14:59] VERBOSE[9689] tcptls.c: TLS/SSL certificate ok
[2020-06-12 12:15:00] VERBOSE[9689] config.c: Parsing '/etc/asterisk/sip_notify.conf': Found
[2020-06-12 12:15:00] VERBOSE[9689] config.c: Parsing '/etc/asterisk/sip_notify.conf': Found
[2020-06-12 12:15:00] VERBOSE[9689] config.c: Parsing '/etc/asterisk/sip_notify_custom.conf': Found
[2020-06-12 12:15:00] VERBOSE[9689] config.c: Parsing '/etc/asterisk/sip_notify_custom.conf': Found
[2020-06-12 12:15:00] VERBOSE[9689] config.c: Parsing '/etc/asterisk/sip_notify_additional.conf': Found
[2020-06-12 12:15:00] VERBOSE[9689] config.c: Parsing '/etc/asterisk/sip_notify_additional.conf': Found

And processing stops.

I have etckeeper installed so I can checkout an earlier configuration and see if that changes anything.


(James B. Byrne) #6

Checking out /etc/from prior to the HDD clone does not change the behaviour. The person at extension . . . plays regardless. I have located where in the call sequence the problem manifests but there no other information.

[2020-06-12 12:49:31] VERBOSE[18918][C-00000003] pbx_builtins.c: Goto (macro-get-vmcontext,s,200)

[2020-06-12 12:49:31] VERBOSE[18918][C-00000003] pbx.c: Executing [s@macro-get-vmcontext:200] Set(“SIP/41712-00000003”, “VMCONTEXT=default”) in new stack

[2020-06-12 12:49:31] VERBOSE[18918][C-00000003] pbx.c: Executing [s@macro-get-vmcontext:200] Set(“SIP/41712-00000003”, “VMCONTEXT=default”) in new stack

[2020-06-12 12:49:31] VERBOSE[18918][C-00000003] pbx.c: Executing [vmx@macro-vm:8] Set(“SIP/41712-00000003”, “MODE=unavail”) in new stack

[2020-06-12 12:49:31] VERBOSE[18918][C-00000003] pbx.c: Executing [vmx@macro-vm:8] Set(“SIP/41712-00000003”, “MODE=unavail”) in new stack

[2020-06-12 12:49:31] VERBOSE[18918][C-00000003] pbx.c: Executing [vmx@macro-vm:9] NoOp(“SIP/41712-00000003”, “MODE IS: unavail”) in new stack


#7

Processing of what? Did you go through and re-save all the extensions? If you do database show at the Asterisk CLI do you see a listing of AMPUSER and DEVICE keys, among others?


(James B. Byrne) #8
# asterisk -r
Asterisk 13.19.1, Copyright (C) 1999 - 2014, Digium, Inc. and others.
Created by Mark Spencer <markster@digium.com>
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'core show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'core show license' for details.
=========================================================================
Connected to Asterisk 13.19.1 currently running on voinet09 (pid = 16866)
voinet09*CLI> database show
/AMPUSER/41710/answermode                         : disabled                 
/AMPUSER/41710/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41710/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41711/answermode                         : disabled                 
/AMPUSER/41711/followme/annmsg                    :                          
/AMPUSER/41711/followme/dring                     :                          
/AMPUSER/41711/followme/grppre                    :                          
/AMPUSER/41711/followme/postdest                  : ext-local,vmu41711,1     
/AMPUSER/41711/followme/remotealertmsg            :                          
/AMPUSER/41711/followme/ringing                   : Ring                     
/AMPUSER/41711/followme/rvolume                   : 0                        
/AMPUSER/41711/followme/strategy                  : ringallv2-prim           
/AMPUSER/41711/followme/toolatemsg                :                          
/AMPUSER/41711/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15-16
/AMPUSER/41711/outroute_hash                      : restrictedroute-fb975d0ada0ab5ee43469a98eb69ec73
/AMPUSER/41712/answermode                         : disabled                 
/AMPUSER/41712/followme/annmsg                    :                          
/AMPUSER/41712/followme/dring                     :                          
/AMPUSER/41712/followme/grppre                    :                          
/AMPUSER/41712/followme/postdest                  : ext-local,41712,dest     
/AMPUSER/41712/followme/remotealertmsg            :                          
/AMPUSER/41712/followme/ringing                   : Ring                     
/AMPUSER/41712/followme/rvolume                   :                          
/AMPUSER/41712/followme/strategy                  : ringallv2-prim           
/AMPUSER/41712/followme/toolatemsg                :                          
/AMPUSER/41712/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41712/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
. . .
/DEVICE/41710/default_user                        : 41710                    
/DEVICE/41710/dial                                : SIP/41710                
/DEVICE/41710/type                                : adhoc                    
/DEVICE/41711/default_user                        : 41711                    
/DEVICE/41711/dial                                : SIP/41711                
/DEVICE/41711/type                                : adhoc                    
/DEVICE/41712/default_user                        : 41712                    
/DEVICE/41712/dial                                : SIP/41712                
/DEVICE/41712/type                                : adhoc                    
/IAX/Registry/4570                                : 127.0.0.1:4570:120       
/IAX/Registry/4571                                : 127.0.0.1:4571:120       
/SIP/Registry/41711                               : 192.168.6.111:4425:3600:41711:sip:41711@192.168.6.111:4425;transport=tls;line=mx64ede8
/SIP/Registry/41712                               : 192.168.6.112:4285:3600:41712:sip:41712@192.168.6.112:4285;transport=tls;line=lribn4wt
/SIP/Registry/41713                               : 192.168.6.113:4456:3600:41713:sip:41713@192.168.6.113:4456;transport=tls;line=53lyd75r
/SIP/Registry/41714                               : 192.168.6.114:3766:3600:41714:sip:41714@192.168.6.114:3766;transport=tls;line=vrq1lv2d
/SIP/Registry/41715                               : 192.168.6.115:4377:3600:41715:sip:41715@192.168.6.115:4377;transport=tls;line=dl5vgag2
/SIP/Registry/41716                               : 192.168.6.116:3127:3600:41716:sip:41716@192.168.6.116:3127;transport=tls;line=ljlo09wd
/SIP/Registry/41717                               : 192.168.6.117:4330:3600:41717:sip:41717@192.168.6.117:4330;transport=tls;line=qyb7ieoe
/SIP/Registry/41718                               : 192.168.6.118:3207:3600:41718:sip:41718@192.168.6.118:3207;transport=tls;line=oqx96an3
/SIP/Registry/41719                               : 192.168.6.119:4510:3600:41719:sip:41719@192.168.6.119:4510;transport=tls;line=ysqtj947
/SIP/Registry/41721                               : 192.168.6.121:4283:3600:41721:sip:41721@192.168.6.121:4283;transport=tls;line=4klwn6vn
/SIP/Registry/90017                               : 99.226.129.44:50139:600:90017:sip:90017@192.168.0.10:50139;transport=tls;registering_acc=harte-lyne_ca

I am only configuring 41710,11 and 12 at the moment since that is what I am using for testing. I do not understand what /AMPUSER/41712/answermode : disabled means but I suspect that it is not good.


#9

The main thing that stands out to me is that 41710 is not registered.


(James B. Byrne) #10

That extension is simply not connected to the LAN at the moment. There are a number of other extensions that are also disconnected. This has never been a problem before.

The hang that occurs when the Apply button is pressed occurs here:
[2020-06-12 13:48:27] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify_additional.conf': Found
It may be that this is not a hang at all and I am misinterpreting what tail /var/log/asterisk/full is telling me. I could be that the file is parsed successfully and that there is noting else to do. But generally, after this point asterisk goes out and polls the extensions and this is not being logged.

The contents of /etc/asterisk/sip_notify_additional.conf are:

# cat /etc/asterisk/sip_notify_additional.conf
;--------------------------------------------------------------------------------;
;          Do NOT edit this file as it is auto-generated by FreePBX.             ;
;--------------------------------------------------------------------------------;
; For information on adding additional paramaters to this file, please visit the ;
; FreePBX.org wiki page, or ask on IRC. This file was created by the new FreePBX ;
; BMO - Big Module Object. Any similarity in naming with BMO from Adventure Time ;
; is totally deliberate.                                                         ;
;--------------------------------------------------------------------------------;
[aastra-check-cfg]
Event=>check-sync

[aastra-xml]
Event=>aastra-xml

[cisco-check-cfg]
Event=>check-sync

[cortelco-check-cfg]
Event=>check-sync

[digium-check-cfg]
Event=>check-sync

[grandstream-check-cfg]
Event=>check-sync

[htek-check-cfg]
Event=>check-sync

[linksys-cold-restart]
Event=>reboot_now

[linksys-warm-restart]
Event=>restart_now

[obihai-check-cfg]
Event=>sync

[polycom-check-cfg]
Event=>check-sync

[polycom-reboot]
Event=>check-sync

[sangoma-check-cfg]
Event=>check-sync

[sync-noreboot-sangoma]
Event=>check-sync\;reboot=false

[sync-reboot-sangoma]
Event=>check-sync\;reboot=true

[sync-hints-sangoma]
Event=>server_restart

[reboot-sangoma]
Event=>reboot

[sipura-check-cfg]
Event=>resync

[reboot-snom]
Event=>reboot

[spa-reboot]
Event=>reboot

[reboot-yealink]

#11

Typing fwconsole r --verbose in SSH is the equivalent of the apply button and may provide more telling output.


(James B. Byrne) #12
[2020-06-12 14:18:14] ERROR[27079] config_options.c: Unable to load config file 'acl.conf'

I cannot find any reference to this file. Nor is one contained in the git archives for /etc

. . .

[2020-06-12 14:18:14] ERROR[27079] config_options.c: Unable to load config file 'acl.conf'
. . .
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/meetme_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/meetme_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cel_custom.so' (Customizable Comma Separated Values CEL Backend)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cel_custom.so' (Customizable Comma Separated Values CEL Backend)
[2020-06-12 14:18:24] ERROR[27079] cel_custom.c: Unable to load cel_custom.conf. Not logging CEL to custom CSVs.
[2020-06-12 14:18:24] ERROR[27079] cel_custom.c: Unable to load cel_custom.conf. Not logging CEL to custom CSVs.
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cdr_custom.so' (Customizable Comma Separated Values CDR Backend)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cdr_custom.so' (Customizable Comma Separated Values CDR Backend)
[2020-06-12 14:18:24] ERROR[27079] cdr_custom.c: Unable to load cdr_custom.conf. Not logging custom CSV CDRs.
[2020-06-12 14:18:24] ERROR[27079] cdr_custom.c: Unable to load cdr_custom.conf. Not logging custom CSV CDRs.
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cel_manager.so' (Asterisk Manager Interface CEL Backend)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cel_manager.so' (Asterisk Manager Interface CEL Backend)
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_general_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_general_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_general_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_general_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_custom_post.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_custom_post.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cel_odbc.so' (ODBC CEL backend)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'cel_odbc.so' (ODBC CEL backend)
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_odbc.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_odbc.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_odbc_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/cel_odbc_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] cel_odbc.c: Found CEL table cel@asteriskcdrdb.
[2020-06-12 14:18:24] VERBOSE[27079] cel_odbc.c: Found CEL table cel@asteriskcdrdb.
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_minivm.so' (Mini VoiceMail (A minimal Voicemail e-mail System))
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_minivm.so' (Mini VoiceMail (A minimal Voicemail e-mail System))
[2020-06-12 14:18:24] WARNING[27079] app_minivm.c: Failed to load configuration file. Module activated with default settings.
[2020-06-12 14:18:24] WARNING[27079] app_minivm.c: Failed to load configuration file. Module activated with default settings.
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'res_clialiases.so' (CLI Aliases)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'res_clialiases.so' (CLI Aliases)
[2020-06-12 14:18:24] ERROR[27079] res_clialiases.c: res_clialiases configuration file 'cli_aliases.conf' not found
[2020-06-12 14:18:24] ERROR[27079] res_clialiases.c: res_clialiases configuration file 'cli_aliases.conf' not found
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'codec_dahdi.so' (Generic DAHDI Transcoder Codec Translator)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'codec_dahdi.so' (Generic DAHDI Transcoder Codec Translator)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_playback.so' (Sound File Playback Application)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_playback.so' (Sound File Playback Application)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_flite.so' (Flite TTS Interface)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_flite.so' (Flite TTS Interface)
[2020-06-12 14:18:24] WARNING[27079] app_flite.c: Flite: Unable to read config file flite.conf. Using default settings
[2020-06-12 14:18:24] WARNING[27079] app_flite.c: Flite: Unable to read config file flite.conf. Using default settings
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_voicemail.so' (Comedian Mail (Voicemail System))
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_voicemail.so' (Comedian Mail (Voicemail System))
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/voicemail.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/voicemail.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/vm_general.inc': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/vm_general.inc': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/vm_email.inc': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/vm_email.inc': Found
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_queue.so' (True Call Queueing)
[2020-06-12 14:18:24] VERBOSE[27079] loader.c: Reloading module 'app_queue.so' (True Call Queueing)
[2020-06-12 14:18:24] NOTICE[27079] app_queue.c: queuerules.conf has not changed since it was last loaded. Not taking any action.
[2020-06-12 14:18:24] NOTICE[27079] app_queue.c: queuerules.conf has not changed since it was last loaded. Not taking any action.
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_general_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_general_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_custom_general.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_custom_general.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_additional.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_post_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] config.c: Parsing '/etc/asterisk/queues_post_custom.conf': Found
[2020-06-12 14:18:24] VERBOSE[27079] asterisk.c: Remote UNIX connection disconnected
[2020-06-12 14:18:24] VERBOSE[27079] asterisk.c: Remote UNIX connection disconnected
[2020-06-12 14:18:24] VERBOSE[17055] tcptls.c: TLS/SSL ECDH initialized (secp256r1), faster PFS cipher-suites enabled
[2020-06-12 14:18:24] VERBOSE[17055] tcptls.c: TLS/SSL ECDH initialized (secp256r1), faster PFS cipher-suites enabled
[2020-06-12 14:18:24] VERBOSE[17055] tcptls.c: TLS/SSL certificate ok
[2020-06-12 14:18:24] VERBOSE[17055] tcptls.c: TLS/SSL certificate ok
[2020-06-12 14:18:25] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify.conf': Found
[2020-06-12 14:18:25] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify.conf': Found
[2020-06-12 14:18:25] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify_custom.conf': Found
[2020-06-12 14:18:25] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify_custom.conf': Found
[2020-06-12 14:18:25] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify_additional.conf': Found
[2020-06-12 14:18:25] VERBOSE[17055] config.c: Parsing '/etc/asterisk/sip_notify_additional.conf': Found

(Lorne Gaetz) #13

You’re missing AstDB entries still. A healthy extension will have at least 2 dozen ampuser entries, and critically will have an AMPUSER/xxxx/device entry, i.e.:

> database show ampuser 6005
/AMPUSER/6005/answermode                          : disabled
/AMPUSER/6005/cfringtimer                         : 0
/AMPUSER/6005/cidname                             : Lorne
/AMPUSER/6005/cidnum                              : 6005
/AMPUSER/6005/concurrency_limit                   : 3
/AMPUSER/6005/cwtone                              :
/AMPUSER/6005/device                              : 6005&996005&906005
/AMPUSER/6005/dictate/email                       :
/AMPUSER/6005/dictate/enabled                     : disabled
/AMPUSER/6005/dictate/format                      : ogg
/AMPUSER/6005/dictate/from                        : ZGljdGF0ZUBmcmVlcGJ4Lm9yZw==
/AMPUSER/6005/followme/annmsg                     :
/AMPUSER/6005/followme/changecid                  : default
/AMPUSER/6005/followme/ddial                      : DIRECT
/AMPUSER/6005/followme/dring                      :
/AMPUSER/6005/followme/fixedcid                   :
/AMPUSER/6005/followme/grpconf                    : DISABLED
/AMPUSER/6005/followme/grplist                    : 6005-9208868134#
/AMPUSER/6005/followme/grppre                     :
/AMPUSER/6005/followme/grptime                    : 20
/AMPUSER/6005/followme/postdest                   : ext-local,6005,dest
/AMPUSER/6005/followme/prering                    : 7
/AMPUSER/6005/followme/remotealertmsg             :
/AMPUSER/6005/followme/ringing                    : Ring
/AMPUSER/6005/followme/rvolume                    :
/AMPUSER/6005/followme/strategy                   : ringallv2-prim
/AMPUSER/6005/followme/toolatemsg                 :
/AMPUSER/6005/hint                                : PJSIP/6005&PJSIP/906005&PJSIP/996005&Custom:DND6005,CustomPresence:6005
/AMPUSER/6005/intercom                            : enabled
/AMPUSER/6005/intercom/override                   : reject
/AMPUSER/6005/language                            :
/AMPUSER/6005/noanswer                            :
/AMPUSER/6005/novmpw                              : yes
/AMPUSER/6005/novmstar                            : yes
/AMPUSER/6005/outboundcid                         :
/AMPUSER/6005/outroute                            : restrictedroute-1-2-3
/AMPUSER/6005/outroute_hash                       : restrictedroute-453e406dcee4d18174d4ff623f52dcd8
/AMPUSER/6005/password                            :
/AMPUSER/6005/queues/qnostate                     : usestate
/AMPUSER/6005/recording                           :
/AMPUSER/6005/recording/in/external               : yes
/AMPUSER/6005/recording/in/internal               : yes
/AMPUSER/6005/recording/ondemand                  : enabled
/AMPUSER/6005/recording/out/external              : yes
/AMPUSER/6005/recording/out/internal              : yes
/AMPUSER/6005/recording/priority                  : 10
/AMPUSER/6005/ringtimer                           : 0
/AMPUSER/6005/rvolume                             :
/AMPUSER/6005/vmx/busy/state                      : blocked
/AMPUSER/6005/vmx/busy/vmxopts/timeout            :
/AMPUSER/6005/vmx/temp/state                      : blocked
/AMPUSER/6005/vmx/temp/vmxopts/timeout            :
/AMPUSER/6005/vmx/unavail/state                   : blocked
/AMPUSER/6005/vmx/unavail/vmxopts/timeout         :
/AMPUSER/6005/voicemail                           : default
55 results found.

(James B. Byrne) #14

So, how does one regenerate the entire astdb.sqlite from FreePBX?

I tried this:

fwconsole util resetastdb

                                                                                    
  [Exception]                                                                       
  Bug: Explicitly know about FreePBX\Console\Command\, asked for FreePBX\Console\C  
  ommand\FreePBX, but /var/www/html/admin/libraries/Console/FreePBX.php (or FreePB  
  X.class.php) doesn't exist                                                        
                                                                                    

util [<args>]...

In /var/www/html/admin/libraries/Console/Util.class.php I find this:

. . .
		case "resetastdb":
			FreePBX::Core()->devices2astdb();
			FreePBX::Core()->users2astdb();
		break;
		default:
			$output->writeln('Invalid argument');
		break;
. . .

But, as reported there is no such file:

ll /var/www/html/admin/libraries/Console/FreePBX*
ls: cannot access /var/www/html/admin/libraries/Console/FreePBX*: No such file or directory

(Lorne Gaetz) #15

If editing the extension and resubmitting without changes doesn’t do it, then deleting and recreating the extension will.


(James B. Byrne) #16

Ok, I submitted one user from the user application page and applied the configuration. This evidently recreated astdb.conf entries for all the users:

voinet09*CLI> database show ampuser
/AMPUSER/41710/answermode                         : disabled                 
/AMPUSER/41710/cfringtimer                        : 0                        
/AMPUSER/41710/cidname                            : Reception                
/AMPUSER/41710/cidnum                             : 41710                    
/AMPUSER/41710/concurrency_limit                  : 0                        
/AMPUSER/41710/dictate/email                      :                          
/AMPUSER/41710/dictate/enabled                    : disabled                 
/AMPUSER/41710/dictate/format                     : ogg                      
/AMPUSER/41710/dictate/from                       : ZGljdGF0ZUBmcmVlcGJ4Lm9yZw==
/AMPUSER/41710/followme/annmsg                    :                          
/AMPUSER/41710/followme/changecid                 : default                  
/AMPUSER/41710/followme/ddial                     : EXTENSION                
/AMPUSER/41710/followme/dring                     :                          
/AMPUSER/41710/followme/fixedcid                  :                          
/AMPUSER/41710/followme/grpconf                   : DISABLED                 
/AMPUSER/41710/followme/grplist                   : 41710                    
/AMPUSER/41710/followme/grppre                    :                          
/AMPUSER/41710/followme/grptime                   : 20                       
/AMPUSER/41710/followme/postdest                  : ext-local,41710,dest     
/AMPUSER/41710/followme/prering                   : 7                        
/AMPUSER/41710/followme/remotealertmsg            :                          
/AMPUSER/41710/followme/ringing                   : Ring                     
/AMPUSER/41710/followme/rvolume                   :                          
/AMPUSER/41710/followme/strategy                  : ringallv2-prim           
/AMPUSER/41710/followme/toolatemsg                :                          
/AMPUSER/41710/intercom                           : enabled                  
/AMPUSER/41710/intercom/override                  : reject                   
/AMPUSER/41710/language                           :                          
/AMPUSER/41710/noanswer                           :                          
/AMPUSER/41710/outboundcid                        :                          
/AMPUSER/41710/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41710/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41710/password                           : 4171010                  
/AMPUSER/41710/queues/qnostate                    : usestate                 
/AMPUSER/41710/recording                          :                          
/AMPUSER/41710/recording/in/external              : dontcare                 
/AMPUSER/41710/recording/in/internal              : dontcare                 
/AMPUSER/41710/recording/ondemand                 : disabled                 
/AMPUSER/41710/recording/out/external             : dontcare                 
/AMPUSER/41710/recording/out/internal             : dontcare                 
/AMPUSER/41710/recording/priority                 : 0                        
/AMPUSER/41710/ringtimer                          : 0                        
/AMPUSER/41710/rvolume                            :                          
/AMPUSER/41710/voicemail                          : novm                     
/AMPUSER/41711/answermode                         : disabled                 
/AMPUSER/41711/cfringtimer                        : 0                        
/AMPUSER/41711/cidname                            : Alyce K Lyne             
/AMPUSER/41711/cidnum                             : 41711                    
/AMPUSER/41711/concurrency_limit                  : 0                        
/AMPUSER/41711/dictate/email                      :                          
/AMPUSER/41711/dictate/enabled                    : disabled                 
/AMPUSER/41711/dictate/format                     : ogg                      
/AMPUSER/41711/dictate/from                       : ZGljdGF0ZUBmcmVlcGJ4Lm9yZw==
/AMPUSER/41711/followme/annmsg                    :                          
/AMPUSER/41711/followme/changecid                 : default                  
/AMPUSER/41711/followme/ddial                     : EXTENSION                
/AMPUSER/41711/followme/dring                     :                          
/AMPUSER/41711/followme/fixedcid                  :                          
/AMPUSER/41711/followme/grpconf                   : DISABLED                 
/AMPUSER/41711/followme/grplist                   : 41711                    
/AMPUSER/41711/followme/grppre                    :                          
/AMPUSER/41711/followme/grptime                   : 20                       
/AMPUSER/41711/followme/postdest                  : ext-local,vmu41711,1     
/AMPUSER/41711/followme/prering                   : 0                        
/AMPUSER/41711/followme/remotealertmsg            :                          
/AMPUSER/41711/followme/ringing                   : Ring                     
/AMPUSER/41711/followme/rvolume                   :                          
/AMPUSER/41711/followme/strategy                  : ringallv2-prim           
/AMPUSER/41711/followme/toolatemsg                :                          
/AMPUSER/41711/intercom                           : enabled                  
/AMPUSER/41711/intercom/override                  : reject                   
/AMPUSER/41711/language                           :                          
/AMPUSER/41711/noanswer                           :                          
/AMPUSER/41711/outboundcid                        :                          
/AMPUSER/41711/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15-16
/AMPUSER/41711/outroute_hash                      : restrictedroute-fb975d0ada0ab5ee43469a98eb69ec73
/AMPUSER/41711/password                           : 4171111                  
/AMPUSER/41711/queues/qnostate                    : usestate                 
/AMPUSER/41711/recording                          :                          
/AMPUSER/41711/recording/in/external              : dontcare                 
/AMPUSER/41711/recording/in/internal              : dontcare                 
/AMPUSER/41711/recording/ondemand                 : disabled                 
/AMPUSER/41711/recording/out/external             : dontcare                 
/AMPUSER/41711/recording/out/internal             : dontcare                 
/AMPUSER/41711/recording/priority                 : 0                        
/AMPUSER/41711/ringtimer                          : 0                        
/AMPUSER/41711/rvolume                            :                          
/AMPUSER/41711/voicemail                          : default                  
/AMPUSER/41712/answermode                         : disabled                 
/AMPUSER/41712/followme/annmsg                    :                          
/AMPUSER/41712/followme/dring                     :                          
/AMPUSER/41712/followme/grppre                    :                          
/AMPUSER/41712/followme/postdest                  : ext-local,41712,dest     
/AMPUSER/41712/followme/remotealertmsg            :                          
/AMPUSER/41712/followme/ringing                   : Ring                     
/AMPUSER/41712/followme/rvolume                   :                          
/AMPUSER/41712/followme/strategy                  : ringallv2-prim           
/AMPUSER/41712/followme/toolatemsg                :                          
/AMPUSER/41712/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41712/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41713/answermode                         : disabled                 
/AMPUSER/41713/followme/annmsg                    :                          
/AMPUSER/41713/followme/dring                     :                          
/AMPUSER/41713/followme/grppre                    :                          
/AMPUSER/41713/followme/postdest                  : ext-local,41713,dest     
/AMPUSER/41713/followme/remotealertmsg            :                          
/AMPUSER/41713/followme/ringing                   : Ring                     
/AMPUSER/41713/followme/rvolume                   :                          
/AMPUSER/41713/followme/strategy                  : ringallv2-prim           
/AMPUSER/41713/followme/toolatemsg                :                          
/AMPUSER/41713/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41713/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41714/answermode                         : disabled                 
/AMPUSER/41714/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41714/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41715/answermode                         : disabled                 
/AMPUSER/41715/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41715/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41716/answermode                         : disabled                 
/AMPUSER/41716/followme/annmsg                    :                          
/AMPUSER/41716/followme/dring                     :                          
/AMPUSER/41716/followme/grppre                    :                          
/AMPUSER/41716/followme/postdest                  : ext-local,41716,dest     
/AMPUSER/41716/followme/remotealertmsg            :                          
/AMPUSER/41716/followme/ringing                   : Ring                     
/AMPUSER/41716/followme/rvolume                   :                          
/AMPUSER/41716/followme/strategy                  : ringallv2-prim           
/AMPUSER/41716/followme/toolatemsg                :                          
/AMPUSER/41716/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41716/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41717/answermode                         : disabled                 
/AMPUSER/41717/followme/annmsg                    :                          
/AMPUSER/41717/followme/dring                     :                          
/AMPUSER/41717/followme/grppre                    :                          
/AMPUSER/41717/followme/postdest                  : ext-local,41717,dest     
/AMPUSER/41717/followme/remotealertmsg            :                          
/AMPUSER/41717/followme/ringing                   : Ring                     
/AMPUSER/41717/followme/rvolume                   :                          
/AMPUSER/41717/followme/strategy                  : ringallv2-prim           
/AMPUSER/41717/followme/toolatemsg                :                          
/AMPUSER/41717/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41717/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41718/answermode                         : disabled                 
/AMPUSER/41718/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41718/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41719/answermode                         : disabled                 
/AMPUSER/41719/followme/annmsg                    :                          
/AMPUSER/41719/followme/dring                     :                          
/AMPUSER/41719/followme/grppre                    :                          
/AMPUSER/41719/followme/postdest                  : ext-local,vmu41719,1     
/AMPUSER/41719/followme/remotealertmsg            :                          
/AMPUSER/41719/followme/ringing                   : Ring                     
/AMPUSER/41719/followme/rvolume                   :                          
/AMPUSER/41719/followme/strategy                  : ringallv2-prim           
/AMPUSER/41719/followme/toolatemsg                :                          
/AMPUSER/41719/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41719/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41720/answermode                         : disabled                 
/AMPUSER/41720/followme/annmsg                    :                          
/AMPUSER/41720/followme/dring                     :                          
/AMPUSER/41720/followme/grppre                    :                          
/AMPUSER/41720/followme/postdest                  : ext-local,vmu41720,1     
/AMPUSER/41720/followme/remotealertmsg            :                          
/AMPUSER/41720/followme/ringing                   : Ring                     
/AMPUSER/41720/followme/rvolume                   :                          
/AMPUSER/41720/followme/strategy                  : ringallv2-prim           
/AMPUSER/41720/followme/toolatemsg                :                          
/AMPUSER/41720/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41720/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41721/answermode                         : disabled                 
/AMPUSER/41721/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41721/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41722/answermode                         : disabled                 
/AMPUSER/41722/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41722/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41723/answermode                         : disabled                 
/AMPUSER/41723/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41723/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41724/answermode                         : disabled                 
/AMPUSER/41724/followme/annmsg                    :                          
/AMPUSER/41724/followme/dring                     :                          
/AMPUSER/41724/followme/grppre                    :                          
/AMPUSER/41724/followme/postdest                  : ext-local,41724,dest     
/AMPUSER/41724/followme/remotealertmsg            :                          
/AMPUSER/41724/followme/ringing                   : Ring                     
/AMPUSER/41724/followme/rvolume                   :                          
/AMPUSER/41724/followme/strategy                  : ringallv2-prim           
/AMPUSER/41724/followme/toolatemsg                :                          
/AMPUSER/41724/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15-16
/AMPUSER/41724/outroute_hash                      : restrictedroute-fb975d0ada0ab5ee43469a98eb69ec73
/AMPUSER/4570/answermode                          : disabled                 
/AMPUSER/4570/device                              : 4570                     
/AMPUSER/4570/outroute                            : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/4570/outroute_hash                       : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/4571/answermode                          : disabled                 
/AMPUSER/4571/device                              : 4571                     
/AMPUSER/4571/outroute                            : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/4571/outroute_hash                       : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
198 results found.

However, the problem with being unable to connect to any extension remains.


(Lorne Gaetz) #17

Still not seeing a device entry in ampuser, without that there is no way to route a call to a phone.


(James B. Byrne) #18

I only listed ampusers to keep the text to a reasonable amount. Here is a representative user / extension pair:

CLI> database show ampuser 41710
/AMPUSER/41710/answermode                         : disabled                 
/AMPUSER/41710/cfringtimer                        : 0                        
/AMPUSER/41710/cidname                            : Reception                
/AMPUSER/41710/cidnum                             : 41710                    
/AMPUSER/41710/concurrency_limit                  : 0                        
/AMPUSER/41710/dictate/email                      :                          
/AMPUSER/41710/dictate/enabled                    : disabled                 
/AMPUSER/41710/dictate/format                     : ogg                      
/AMPUSER/41710/dictate/from                       : ZGljdGF0ZUBmcmVlcGJ4Lm9yZw==
/AMPUSER/41710/followme/annmsg                    :                          
/AMPUSER/41710/followme/changecid                 : default                  
/AMPUSER/41710/followme/ddial                     : EXTENSION                
/AMPUSER/41710/followme/dring                     :                          
/AMPUSER/41710/followme/fixedcid                  :                          
/AMPUSER/41710/followme/grpconf                   : DISABLED                 
/AMPUSER/41710/followme/grplist                   : 41710                    
/AMPUSER/41710/followme/grppre                    :                          
/AMPUSER/41710/followme/grptime                   : 20                       
/AMPUSER/41710/followme/postdest                  : ext-local,41710,dest     
/AMPUSER/41710/followme/prering                   : 7                        
/AMPUSER/41710/followme/remotealertmsg            :                          
/AMPUSER/41710/followme/ringing                   : Ring                     
/AMPUSER/41710/followme/rvolume                   :                          
/AMPUSER/41710/followme/strategy                  : ringallv2-prim           
/AMPUSER/41710/followme/toolatemsg                :                          
/AMPUSER/41710/intercom                           : enabled                  
/AMPUSER/41710/intercom/override                  : reject                   
/AMPUSER/41710/language                           :                          
/AMPUSER/41710/noanswer                           :                          
/AMPUSER/41710/outboundcid                        :                          
/AMPUSER/41710/outroute                           : restrictedroute-2-3-4-5-6-7-8-10-14-15
/AMPUSER/41710/outroute_hash                      : restrictedroute-b21c639e50e125f6cb7570b0f93ddaea
/AMPUSER/41710/password                           : 4171010                  
/AMPUSER/41710/queues/qnostate                    : usestate                 
/AMPUSER/41710/recording                          :                          
/AMPUSER/41710/recording/in/external              : dontcare                 
/AMPUSER/41710/recording/in/internal              : dontcare                 
/AMPUSER/41710/recording/ondemand                 : disabled                 
/AMPUSER/41710/recording/out/external             : dontcare                 
/AMPUSER/41710/recording/out/internal             : dontcare                 
/AMPUSER/41710/recording/priority                 : 0                        
/AMPUSER/41710/ringtimer                          : 0                        
/AMPUSER/41710/rvolume                            :                          
/AMPUSER/41710/voicemail                          : novm                     
44 results found.
CLI> database show device 41710
/DEVICE/41710/default_user                        : 41710                    
/DEVICE/41710/dial                                : SIP/41710                
/DEVICE/41710/type                                : adhoc
3 results found.

(Lorne Gaetz) #19

This is the database entry to which I refer, the one all of your examples lack:

/AMPUSER/6005/device : 6005&996005&906005

(James B. Byrne) #20

Who or what is user 6005?