Problems after restore PBX settings backup on the new server

Hi there,

We set up a FreePBX 14.0.1rc1.7 installation on virtual machine and pre customized it for a real server - extensions, settings, audio messages, gateways. We then back up data and move it to the fresh installation, restoring /etc configs and “PBX data”. The backup restored successfully, however after server reboot we encounter two serious problems:

  1. Asterisk server does not start at startup (red Could not connect to asterisk in the web panel).

May 23 03:49:58 freepbx fwconsole: Setting Permissions…
May 23 03:50:02 freepbx chronyd[712]: Selected source 97.107.128.58
May 23 03:50:13 freepbx fwconsole: Collecting Files…Done
May 23 03:50:13 freepbx fwconsole: 0/67438 [>---------------------------] 0%
May 23 03:50:16 freepbx fwconsole: 67438/67438 [============================] 100%
May 23 03:50:16 freepbx fwconsole: Finished setting permissions
May 23 03:50:16 freepbx fwconsole: Removing dangling symlink /home/asterisk/.node/bin/npm-cache which points to a file that no longer exists
May 23 03:50:16 freepbx fwconsole: Wanrouter: No valid Sangoma Hardware found, if you have no Sangoma cards this is OK
May 23 03:50:16 freepbx fwconsole: Starting DAHDi for Digium Cards
May 23 03:50:16 freepbx systemd: Starting LSB: DAHDI kernel modules…
May 23 03:50:16 freepbx dahdi: Loading DAHDI hardware modules:
May 23 03:50:16 freepbx kernel: dahdi: loading out-of-tree module taints kernel.
May 23 03:50:16 freepbx kernel: dahdi: module verification failed: signature and/or required key missing - tainting kernel
May 23 03:50:16 freepbx kernel: dahdi: Version: 2.11.1
May 23 03:50:16 freepbx kernel: dahdi: Telephony Interface Registered on major 196
May 23 03:50:16 freepbx dahdi: wct4xxp: [ OK ]
May 23 03:50:16 freepbx dahdi: wcte43x: [ OK ]
May 23 03:50:16 freepbx dahdi: wcte12xp: [ OK ]
May 23 03:50:16 freepbx dahdi: wcte13xp: [ OK ]
May 23 03:50:16 freepbx dahdi: wct1xxp: [ OK ]
May 23 03:50:16 freepbx dahdi: wcte11xp: [ OK ]
May 23 03:50:16 freepbx dahdi: r1t1: [ OK ]
May 23 03:50:16 freepbx dahdi: rxt1: [ OK ]
May 23 03:50:16 freepbx dahdi: wctdm24xxp: [ OK ]
May 23 03:50:16 freepbx dahdi: wcaxx: [ OK ]
May 23 03:50:16 freepbx dahdi: wcfxo: [ OK ]
May 23 03:50:16 freepbx dahdi: wctdm: [ OK ]
May 23 03:50:16 freepbx dahdi: rcbfx: [ OK ]
May 23 03:50:16 freepbx dahdi: wcb4xxp: [ OK ]
May 23 03:50:16 freepbx kernel: dahdi_transcode: Loaded.
May 23 03:50:16 freepbx dahdi: wctc4xxp: [ OK ]
May 23 03:50:16 freepbx dahdi: xpp_usb: [ OK ]
May 23 03:50:16 freepbx kernel: INFO-xpp: revision Unknown MAX_XPDS=64 (8*8)
May 23 03:50:16 freepbx kernel: INFO-xpp: FEATURE: with PROTOCOL_DEBUG
May 23 03:50:16 freepbx kernel: INFO-xpp: FEATURE: with sync_tick() from DAHDI
May 23 03:50:16 freepbx kernel: INFO-xpp_usb: revision Unknown
May 23 03:50:16 freepbx kernel: usbcore: registered new interface driver xpp_usb
May 23 03:50:16 freepbx dahdi: Running dahdi_cfg: [ OK ]
May 23 03:50:17 freepbx systemd: Started LSB: DAHDI kernel modules.
May 23 03:50:17 freepbx fwconsole: DAHDi Started
May 23 03:50:17 freepbx systemd: Starting IPv4 firewall with iptables…
May 23 03:50:17 freepbx kernel: nf_conntrack version 0.5.0 (65536 buckets, 262144 max)
May 23 03:50:17 freepbx iptables.init: iptables: Applying firewall rules: [ OK ]
May 23 03:50:17 freepbx systemd: Started IPv4 firewall with iptables.
May 23 03:50:17 freepbx systemd: Starting IPv6 firewall with ip6tables…
May 23 03:50:17 freepbx kernel: ip6_tables: © 2000-2006 Netfilter Core Team
May 23 03:50:17 freepbx ip6tables.init: ip6tables: Applying firewall rules: [ OK ]
May 23 03:50:17 freepbx systemd: Started IPv6 firewall with ip6tables.
May 23 03:50:17 freepbx systemd: Stopping LSB: Start/Stop fail2ban…
May 23 03:50:17 freepbx fwconsole: Running Sysadmin Hooks
May 23 03:50:17 freepbx fwconsole: Restarting fail2ban
May 23 03:50:22 freepbx fail2ban: Stopping fail2ban: [ OK ]
May 23 03:50:22 freepbx systemd: Starting LSB: Start/Stop fail2ban…
May 23 03:50:22 freepbx fail2ban: Ensuring logfiles are present
May 23 03:50:22 freepbx fail2ban: Starting fail2ban:
May 23 03:50:23 freepbx fail2ban: [ OK ]
May 23 03:50:23 freepbx systemd: Started LSB: Start/Stop fail2ban.
May 23 03:50:23 freepbx fwconsole: fail2ban Restarted
May 23 03:50:23 freepbx fwconsole: Updating License Information for 94939191
May 23 03:50:28 freepbx php: Unparseable output from getservices - [“Exception: Asterisk is not connected in file /var/www/html/admin/libraries/php-asmanager.php on line 236”,“Stack trace:”," 1. Exception->() /var/www/html/admin/libraries/php-asmanager.php:236"," 2. AGI_AsteriskManager->send_request() /var/www/html/admin/modules/firewall/Smart.class.php:446"," 3. FreePBX\modules\Firewall\Smart->getPjsipContacts() /var/www/html/admin/modules/firewall/Smart.class.php:437"," 4. FreePBX\modules\Firewall\Smart->getRegistrations() /var/www/html/admin/modules/firewall/Smart.class.php:69"," 5. FreePBX\modules\Firewall\Smart->getAllPorts() /var/www/html/admin/modules/firewall/Firewall.class.php:964"," 6. FreePBX\modules\Firewall->getSmartPorts() /var/www/html/admin/modules/firewall/bin/getservices:22"] - returned 1
May 23 03:50:28 freepbx php: Unable to see safemode in services… Sleeping 5 seconds and retrying
May 23 03:50:29 freepbx fwconsole: Starting Asterisk…
May 23 03:50:29 freepbx fwconsole: [>---------------------------] < 1 sec
May 23 03:50:29 freepbx fwconsole: [->--------------------------] < 1 sec
May 23 03:50:29 freepbx fwconsole: [–>-------------------------] < 1 sec
May 23 03:50:29 freepbx fwconsole: [—>------------------------] < 1 sec
May 23 03:50:30 freepbx kernel: Bluetooth: Core ver 2.21
May 23 03:50:30 freepbx kernel: NET: Registered protocol family 31
May 23 03:50:30 freepbx kernel: Bluetooth: HCI device and connection manager initialized
May 23 03:50:30 freepbx kernel: Bluetooth: HCI socket layer initialized
May 23 03:50:30 freepbx kernel: Bluetooth: L2CAP socket layer initialized
May 23 03:50:30 freepbx kernel: Bluetooth: SCO socket layer initialized
May 23 03:50:30 freepbx fwconsole: [---->-----------------------] < 1 sec
May 23 03:50:30 freepbx fwconsole: [------------------------->–] 1 sec
May 23 03:50:30 freepbx fwconsole: Asterisk Started
May 23 03:50:30 freepbx fwconsole: [PDOException]
May 23 03:50:30 freepbx fwconsole: SQLSTATE[42S22]: Column not found: 1054 Unknown column 'calendar_group_id’
May 23 03:50:30 freepbx fwconsole: in 'field list’
May 23 03:50:30 freepbx fwconsole: start [–pre] [–post] [–skipchown] [–] []…
May 23 03:50:30 freepbx systemd: freepbx.service: main process exited, code=exited, status=1/FAILURE
May 23 03:50:31 freepbx systemd: Failed to start FreePBX VoIP Server.
May 23 03:50:31 freepbx systemd: Unit freepbx.service entered failed state.
May 23 03:50:31 freepbx systemd: freepbx.service failed.
May 23 03:50:31 freepbx systemd: Reached target Multi-User System.
May 23 03:50:31 freepbx systemd: Starting Multi-User System.
May 23 03:50:31 freepbx systemd: Started Stop Read-Ahead Data Collection 10s After Completed Startup.
May 23 03:50:31 freepbx systemd: Starting Stop Read-Ahead Data Collection 10s After Completed Startup.
May 23 03:50:31 freepbx systemd: Starting Update UTMP about System Runlevel Changes…
May 23 03:50:31 freepbx systemd: Started Update UTMP about System Runlevel Changes.

fwconsole started it however, with error SQLSTATE[42S22]: Column not found: 1054 Unknown column ‘calendar_group_id’

I did not found any info on ‘calendar_group_id’

  1. Configuration no longer apply when asterisk is started manually

[2017-May-23 04:27:55] [ERROR] (bin/retrieve_conf:355) - /var/lib/asterisk/agi-bin/areminder failed to copy from module directory
[2017-May-23 04:27:55] [ERROR] (bin/retrieve_conf:355) - /var/lib/asterisk/agi-bin/calllimit failed to copy from module directory
[2017-May-23 04:27:55] [ERROR] (bin/retrieve_conf:355) - /var/lib/asterisk/agi-bin/enc failed to copy from module directory
[2017-May-23 04:27:56] [ERROR] (bin/retrieve_conf:355) - /var/lib/asterisk/agi-bin/enc failed to copy from module directory
[2017-May-23 04:27:57] [CRITICAL] (BMO/Notifications.class.php:507) - [NOTIFICATION]-[freepbx]-[RCONFFAIL] - retrieve_conf failed, config not applied (Reload failed because retrieve_conf encountered an error: 1)

We did chown and this did not help. Directories exist and contains files with correct permissions.

Any ideas how to fix this? Should we add this field to database? How to point what and why fail to copy? Thanks!