The provision process exited with errors

[Nirjonadda]

Getting error from EasyApache 4 with v84.0.1 and The provision process exited with errors with enable/disable any Extension.

Provision process started.
[2019-10-11 19:15:33 +0600] info [xml-api] ---> Package ea-php73-php-psr.x86_64 0:0.7.0-2.2.7.cpanel will be installed
[2019-10-11 19:15:33 +0600] info [xml-api] --> Finished Dependency Resolution
[2019-10-11 19:15:33 +0600] info [xml-api] ================================================================================
[2019-10-11 19:15:33 +0600] info [xml-api]  Package             Arch      Version                Repository           Size
[2019-10-11 19:15:33 +0600] info [xml-api] ================================================================================
[2019-10-11 19:15:33 +0600] info [xml-api] Installing:
[2019-10-11 19:15:33 +0600] info [xml-api]  ea-php73-php-psr    x86_64    0.7.0-2.2.7.cpanel     EA4-experimental     40 k
[2019-10-11 19:15:33 +0600] info [xml-api] Transaction Summary
[2019-10-11 19:15:33 +0600] info [xml-api] ================================================================================
[2019-10-11 19:15:33 +0600] info [xml-api] Install  1 Package
[2019-10-11 19:15:33 +0600] info [xml-api] Total download size: 40 k
[2019-10-11 19:15:33 +0600] info [xml-api] Installed size: 251 k
[2019-10-11 19:15:33 +0600] info [xml-api] Downloading packages:
[2019-10-11 19:15:33 +0600] info [xml-api] Running transaction check
[2019-10-11 19:15:33 +0600] info [xml-api] Running transaction test
[2019-10-11 19:15:33 +0600] info [xml-api] Transaction test succeeded
[2019-10-11 19:15:33 +0600] info [xml-api] Running transaction
[2019-10-11 19:15:33 +0600] info [xml-api]   Installing : ea-php73-php-psr-0.7.0-2.2.7.cpanel.x86_64                   1/1Purging all relevant cached command results
[2019-10-11 19:15:33 +0600] info [xml-api] Removing:  /root/.cpanel/datastore/_usr_sbin_httpd_-v
[2019-10-11 19:15:33 +0600] info [xml-api] Removing:  /root/.cpanel/datastore/_usr_sbin_httpd_-l
[2019-10-11 19:15:33 +0600] info [xml-api] Removing:  /root/.cpanel/datastore/_usr_sbin_httpd_-V
[2019-10-11 19:15:33 +0600] info [xml-api] Rebuilding global cache
[2019-10-11 19:15:33 +0600] info [xml-api] Building global cache for cpanel...[Fri Oct 11 19:15:28.136241 2019] [so:warn] [pid 28393:tid 139967969966208] AH01574: module version_module is already loaded, skipping
[2019-10-11 19:15:33 +0600] info [xml-api] Done
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php54” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php55” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php56” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php70” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php71” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php72” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ensuring current entry for “ea-php73” is correct …
[2019-10-11 19:15:33 +0600] info [xml-api] Built /etc/apache2/conf/httpd.conf OK
[2019-10-11 19:15:33 +0600] info [xml-api] Nothing to do under ea4 (this script has been deprecated under ea4).
[2019-10-11 19:15:33 +0600] info [xml-api] Fix mailman RPM directories …
[2019-10-11 19:15:33 +0600] info [xml-api]  … PID 28417
[2019-10-11 19:15:33 +0600] info [xml-api] Fix mailing list perms …
[2019-10-11 19:15:33 +0600] info [xml-api]  … PID 28419
[2019-10-11 19:15:33 +0600] info [xml-api] Aligning modsec config to Whostmgr
[2019-10-11 19:15:33 +0600] info [xml-api] - Whostmgr version 11.84.0.1
[2019-10-11 19:15:33 +0600] info [xml-api] - Whostmgr supports conf.d/modsec location
[2019-10-11 19:15:33 +0600] info [xml-api] - No change necessary
[2019-10-11 19:15:33 +0600] info [xml-api] Waiting for “httpd” to restart gracefully …[Fri Oct 11 19:15:30.452280 2019] [so:warn] [pid 28431:tid 139841905301632] AH01574: module version_module is already loaded, skipping
[2019-10-11 19:15:33 +0600] info [xml-api] waiting for “httpd” to initialize ………finished.
[2019-10-11 19:15:33 +0600] info [xml-api] Service Status
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as root with PID 3551 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/local/cpanel/bin/splitlogs --dir=/etc/apache2/logs/domlogs --main=na.nirjonmela.com --suffix=-bytes_log) is running as root with PID 26948 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/local/cpanel/bin/splitlogs --dir=/etc/apache2/logs/domlogs --main=na.nirjonmela.com --mainout=/etc/apache2/logs/access_log) is running as root with PID 26949 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 26950 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 26951 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 26953 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (Passenger watchdog) is running as root with PID 26955 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (Passenger core) is running as root with PID 26958 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 26990 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 27028 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 27133 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 27152 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api]     httpd (/usr/sbin/httpd -k start) is running as nobody with PID 27209 (systemd+/proc check method).
[2019-10-11 19:15:33 +0600] info [xml-api] Startup Log
[2019-10-11 19:15:33 +0600] info [xml-api]     Oct 03 18:45:48 na.mysite.com systemd[1]: Starting Apache web server managed by cPanel EasyApache...
[2019-10-11 19:15:33 +0600] info [xml-api]     Oct 03 18:45:49 na.mysite.com restartsrv_httpd[2073]: [Thu Oct 03 18:45:49.735205 2019] [so:warn] [pid 2240:tid 47412334470208] AH01574: module version_module is already loaded, skipping
[2019-10-11 19:15:33 +0600] info [xml-api]     Oct 03 18:45:56 na.mysite.com systemd[1]: Can't open PID file /run/apache2/httpd.pid (yet?) after start: No such file or directory
[2019-10-11 19:15:33 +0600] info [xml-api]     Oct 03 18:45:59 na.mysite.com systemd[1]: Started Apache web server managed by cPanel EasyApache.
[2019-10-11 19:15:33 +0600] info [xml-api]     Oct 08 05:29:30 na.mysite.com p0f[2035]: [!] WARNING: User-initiated shutdown.
[2019-10-11 19:15:33 +0600] info [xml-api] Log Messages
[2019-10-11 19:15:33 +0600] info [xml-api]     [Fri Oct 11 19:10:02.356474 2019] [mpm_event:notice] [pid 3551:tid 47412334470208] AH00489: Apache/2.4.41 (cPanel) OpenSSL/1.0.2t mod_bwlimited/1.4 mod_fcgid/2.3.9 mod_cpanel/1.4 Phusion_Passenger/5.3.7 configured -- resuming normal operations
[2019-10-11 19:15:33 +0600] info [xml-api]     [Fri Oct 11 18:05:05.952929 2019] [:error] [pid 13427:tid 47412879550208] [client 91.121.209.213:34000] [client 91.121.209.213] ModSecurity: Access denied with code 403 (phase 1). Matched phrase "/.env" at REQUEST_URI. [file "/etc/apache2/conf.d/modsec_vendor_configs/comodo_apache/02_Global_Generic.conf"] [line "122"] [id "210492"] [rev "3"] [severity "CRITICAL"] [tag "CWAF"] [tag "Generic"] [hostname "mysite.com"] [uri "/.env"] [unique_id "XaBv8S@X8lUf--UZ7PXriwAAAJY"]
[2019-10-11 19:15:33 +0600] info [xml-api]     [Fri Oct 11 17:58:03.252901 2019] [:error] [pid 31843:tid 47412877448960] [client 91.121.209.213:34000] [client 91.121.209.213] ModSecurity: Access denied with code 403 (phase 1). Matched phrase "/.env" at REQUEST_URI. [file "/etc/apache2/conf.d/modsec_vendor_configs/comodo_apache/02_Global_Generic.conf"] [line "122"] [id "210492"] [rev "3"] [severity "CRITICAL"] [tag "CWAF"] [tag "Generic"] [hostname "na.mysite.com"] [uri "/.env"] [unique_id "XaBuS3a1RBTmzNI5FeFLFQAAARU"]
[2019-10-11 19:15:33 +0600] info [xml-api]     [Fri Oct 11 17:40:03.860918 2019] [:error] [pid 30389:tid 47412845930240] [client 45.132.105.114:49388] [client 45.132.105.114] ModSecurity: Warning. String match "Invalid URI in request" at WEBSERVER_ERROR_LOG. [file "/etc/apache2/conf.d/modsec_vendor_configs/comodo_apache/12_HTTP_Protocol.conf"] [line "14"] [id "210210"] [rev "2"] [msg "COMODO WAF: Apache Error: Invalid URI in Request.||www.mysite.com|F|4"] [data "GET www.mysite.com HTTP/1.0"] [severity "WARNING"] [tag "CWAF"] [tag "Protocol"] [hostname "www.mysite.com"] [uri "/400.shtml"] [unique_id "XaBqEz1AQdeJAYeMlK7MUQAAAEY"]
[2019-10-11 19:15:33 +0600] info [xml-api] httpd restarted successfully.
[2019-10-11 19:15:33 +0600] info [xml-api] Setting permissions for.....nadda …
[2019-10-11 19:15:33 +0600] info [xml-api] cptktxtyb2ud7po2 …
[2019-10-11 19:15:33 +0600] info [xml-api] Skipping cptktxtyb2ud7po2 because of an error: User cptktxtyb2ud7po2 has no “main_domain” in userdata! at /usr/local/cpanel/Cpanel/FileProtect/Sync.pm line 65.
[2019-10-11 19:15:33 +0600] info [xml-api] ...Done
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php54” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php55” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php56” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php70” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php71” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ignoring current entry for “ea-php72” …
[2019-10-11 19:15:33 +0600] info [xml-api] Ensuring current entry for “ea-php73” is correct …
[2019-10-11 19:15:33 +0600] info [xml-api] Processing ea-php73 …
[2019-10-11 19:15:33 +0600] info [xml-api]     … moving zend_extension and extension directives from php.ini to php.d/zzzzzzz-pecl.ini …
[2019-10-11 19:15:33 +0600] info [xml-api] Service Status
[2019-10-11 19:15:33 +0600] info [xml-api] apache_php_fpm restarted successfully.
[2019-10-11 19:15:33 +0600] info [xml-api] 
[2019-10-11 19:15:33 +0600] info [xml-api]   Verifying  : ea-php73-php-psr-0.7.0-2.2.7.cpanel.x86_64                   1/1
[2019-10-11 19:15:33 +0600] info [xml-api] Installed:
[2019-10-11 19:15:33 +0600] info [xml-api]   ea-php73-php-psr.x86_64 0:0.7.0-2.2.7.cpanel                                 
[2019-10-11 19:15:33 +0600] info [xml-api] Finished Transaction
[2019-10-11 19:15:33 +0600] info [xml-api] Leaving Shell

Provision process finished.

This line are red color.

[2019-10-11 19:15:33 +0600] info [xml-api]     [Fri Oct 11 17:40:03.860918 2019] [:error] [pid 30389:tid 47412845930240] [client 45.132.105.114:49388] [client 45.132.105.114] ModSecurity: Warning. String match "Invalid URI in request" at WEBSERVER_ERROR_LOG. [file "/etc/apache2/conf.d/modsec_vendor_configs/comodo_apache/12_HTTP_Protocol.conf"] [line "14"] [id "210210"] [rev "2"] [msg "COMODO WAF: Apache Error: Invalid URI in Request.||www.mysite.com|F|4"] [data "GET www.mysite.com HTTP/1.0"] [severity "WARNING"] [tag "CWAF"] [tag "Protocol"] [hostname "www.mysite.com"] [uri "/400.shtml"] [unique_id "XaBqEz1AQdeJAYeMlK7MUQAAAEY"]

 

[Nirjonadda]

This server error log hepened if enabled snuffleupagus Protective PHP Hardening Extension.

 

[cPanelLauren]

I'm having some trouble understanding the issue here. Based on that log file the provisioning process was successful. The provisioning process includes a restart to apache - the error you're noting is an error from the excerpts of the apache error log. This is unrelated to the porovisioning process

 

[cetiner]

How can i remove this snuffleupagus? If i google abt it, i find just this sesame street. pffff

 

[cPanelLauren]

lol

I think you mean scl-snuffleupagus? Which is part of

Experimental Repository Change Log | cPanel & WHM Documentation

This document lists the changes and updates to the EasyApache 4 Experimental Repository.

docs.cpanel.net

This is a module available in the experimental repo for EasyApache, it's a PHP Hardening Module available for PHP 7.0 - 7.3

Available Packages
Name        : ea-php73-php-snuffleupagus
Arch        : x86_64
Version     : 0.5.0
Release     : 5.5.12.cpanel
Size        : 181 k
Repo        : EA4-experimental/7/x86_64
Summary     : Protective PHP Hardening Extension
URL         : https://snuffleupagus.readthedocs.io/
License     : PHP
Description : Snuffleupagus is a PHP7+ module designed to drastically raise the cost of attacks against websites. This is achieved by killing entire bug classes and providing a powerful
            : virtual-patching system, allowing the administrator to fix specific vulnerabilities without having to touch the PHP code.

Package names would be:

ea-php70-php-snuffleupagus.x86_64 : Protective PHP Hardening Extension
ea-php71-php-snuffleupagus.x86_64 : Protective PHP Hardening Extension
ea-php72-php-snuffleupagus.x86_64 : Protective PHP Hardening Extension
ea-php73-php-snuffleupagus.x86_64 : Protective PHP Hardening Extension