Apache restart errors

davorg

• June 19, 2018 12:52

I have same error. I have CloudLinux which is up to date. I need to restart apache and everything is ok then for next 2 or 3 days: Error Log: [2018-06-19 19:11:44 +0200] warn [cpanellogd] The webserver failed to resume normal operations and is not running at /usr/local/cpanel/Cpanel/HttpUtils/ApRestart.pm line 498. at /usr/local/cpanel/Cpanel/HttpUtils/ApRestart.pm line 369. Cpanel::HttpUtils::ApRestart::__ANON__(__CPANEL_HIDDEN__...) called at /usr/local/cpanel/3rdparty/perl/526/lib64/perl5/cpanel_lib/Try/Tiny.pm line 120 Try::Tiny::try(CODE(0x215a138), Try::Tiny::Catch=REF(0x2159cf0)) called at /usr/local/cpanel/Cpanel/HttpUtils/ApRestart.pm line 372 Cpanel::HttpUtils::ApRestart::_wait_for_and_verify_normal_operations(GLOB(0x215a378), "/run/apache2/httpd.pid") called at /usr/local/cpanel/Cpanel/HttpUtils/ApRestart.pm line 214 Cpanel::HttpUtils::ApRestart::__ANON__() called at /usr/local/cpanel/3rdparty/perl/526/lib64/perl5/cpanel_lib/Try/Tiny.pm line 99 eval {...} called at /usr/local/cpanel/3rdparty/perl/526/lib64/perl5/cpanel_lib/Try/Tiny.pm line 90 Try::Tiny::try(CODE(0x210ce50), Try::Tiny::Catch=REF(0xd729d8)) called at /usr/local/cpanel/Cpanel/HttpUtils/ApRestart.pm line 221 Cpanel::HttpUtils::ApRestart::safeaprestart() called at /usr/local/cpanel/Cpanel/Logd.pm line 2417 Cpanel::Logd::_apache_restart() called at /usr/local/cpanel/Cpanel/Logd.pm line 1162 Cpanel::Logd::_flush_http_logs(HASH(0xd86330)) called at /usr/local/cpanel/Cpanel/Logd.pm line 390 Cpanel::Logd::scanbandwidth("", undef) called at libexec/cpanellogd.pl line 259 Any Idea?

• 

  cPanelLauren

  • June 20, 2018 15:04

  Hi @davorg When the issue with apache occurs what is in the Apache error log at: /etc/apache2/logs/error_log
  

  0
• 

  davorg

  • June 20, 2018 15:49

  Nothing special in this error_log: [Tue Jun 19 17:04:50.202659 2018] [:error] [pid 1099049:tid 140263330625280] [client 47.96.231.74:38950] [client 47.96.231.74] ModSecurity: Warning. Operator EQ matched 0 at REQUEST_HEADERS. [file "/etc/apache2/conf.d/modsec_vendor_configs/imunify360_full_apache/001_i360_1_generic.conf"> [line "114"> [id "77135155"> [rev "1"> [msg "Missing User Agent Header||MVN:REQUEST_HEADERS||MV:0||PC:536"> [severity "DEBUG"> [maturity "9"> [accuracy "9"> [tag "i360"> [tag "noshow"> [tag "o"> [hostname "www.bojanakrizanec.com"> [uri "/wp-content/plugins/easyrotator-for-wordpress/css.php"> [unique_id "WykbkvCJeIeL0LPlKOEGYQAAAA8"> [Tue Jun 19 17:14:24.004900 2018] [mpm_worker:notice] [pid 2151:tid 140264146614400] AH00297: SIGUSR1 received. Doing graceful restart [Tue Jun 19 17:14:34.174893 2018] [:notice] [pid 1098983:tid 140264146614400] [host vps01.gsistemi.co] mod_lsapi: Selfstarter 1098983 stopped [Tue Jun 19 17:14:37.138991 2018] [hostinglimits:notice] [pid 2151:tid 140264146614400] mod_hostinglimits: use Min UID 1000 [Tue Jun 19 17:14:37.139020 2018] [hostinglimits:notice] [pid 2151:tid 140264146614400] mod_hostinglimits: version 1.0-36. LVE mechanism enabled [Tue Jun 19 17:14:37.139026 2018] [hostinglimits:notice] [pid 2151:tid 140264146614400] mod_hostinglimits: found apr extention version 3 [Tue Jun 19 17:14:37.139048 2018] [hostinglimits:notice] [pid 2151:tid 140264146614400] mod_hostinglimits: apr_lve_environment_init_group_minuid check ok [Tue Jun 19 17:14:37.141017 2018] [ssl:warn] [pid 2151:tid 140264146614400] AH01909: proxy-subdomains-ssl-default-vhost.localhost:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 17:14:37.153218 2018] [ssl:warn] [pid 2151:tid 140264146614400] AH01909: snopje.si:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 17:14:37.156471 2018] [ssl:warn] [pid 2151:tid 140264146614400] AH01909: strohballenbau.snopje.si:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 17:14:37.212853 2018] [http2:info] [pid 2151:tid 140264146614400] AH03090: mod_http2 (v1.10.16, feats=CHPRIO+SHA256+INVHD+DWINS, nghttp2 1.20.0), initializing... [Tue Jun 19 17:14:37.213260 2018] [lsapi:notice] [pid 2151:tid 140264146614400] mod_lsapi: version 1.1-27 with CRIU support. Connection pool mode is switched off [Tue Jun 19 17:14:37.226249 2018] [:notice] [pid 1132214:tid 140264146614400] [host vps01.gsistemi.co] mod_lsapi: Selfstarter 1132214 started
  

  0
• 

  cPanelLauren

  • June 20, 2018 16:09

  This portion of the log file you're showing is from 2 hours prior to the issue reported at 19:11 can you show the relevant log entries at 2018-06-19 19:11:44 Thanks!

  0
• 

  davorg

  • June 20, 2018 16:16

  Sorry wrong copy / paste. -- [Tue Jun 19 19:02:17.999673 2018] [autoindex:error] [pid 1133249:tid 140263414552320] [client 66.249.64.17:55162] AH01276: Cannot serve directory /home/tomasic201501/public_html/: No matching DirectoryIndex (index.php,index.php5,index.php4,index.php3,index.perl,index.pl,index.plx,index.ppl,index.cgi,index.jsp,index.js,index.jp,index.phtml,index.shtml,index.xhtml,index.html,index.htm,index.wml,Default.html,Default.htm,default.html,default.htm,home.html,home.htm) found, and server-generated directory index forbidden by Options directive [Tue Jun 19 19:09:51.607656 2018] [:error] [pid 1133249:tid 140263515326208] [client 91.193.254.113:54948] [client 91.193.254.113] ModSecurity: Warning. Operator EQ matched 0 at REQUEST_HEADERS. [file "/etc/apache2/conf.d/modsec_vendor_configs/imunify360_full_apache/001_i360_1_generic.conf"> [line "103"> [id "77134894"> [rev "2"> [msg "Request Missing a Host Header||MVN:REQUEST_HEADERS||MV:0||PC:481"> [severity "DEBUG"> [maturity "9"> [accuracy "9"> [tag "i360"> [tag "noshow"> [tag "o"> [hostname "139.162.170.117"> [uri "/"> [unique_id "Wyk431ftk8Vdlo9UIjgv-wAAAAE"> [Tue Jun 19 19:11:22.968761 2018] [mpm_worker:notice] [pid 2151:tid 140264146614400] AH00297: SIGUSR1 received. Doing graceful restart [Tue Jun 19 19:11:33.150055 2018] [:notice] [pid 1132214:tid 140264146614400] [host vps01.gsistemi.co] mod_lsapi: Selfstarter 1132214 stopped [Tue Jun 19 19:13:34.340614 2018] [hostinglimits:notice] [pid 1161165:tid 140068278294656] mod_hostinglimits: use Min UID 1000 [Tue Jun 19 19:13:34.340742 2018] [hostinglimits:notice] [pid 1161165:tid 140068278294656] mod_hostinglimits: version 1.0-36. LVE mechanism enabled [Tue Jun 19 19:13:34.340755 2018] [hostinglimits:notice] [pid 1161165:tid 140068278294656] mod_hostinglimits: found apr extention version 3 [Tue Jun 19 19:13:34.340774 2018] [hostinglimits:notice] [pid 1161165:tid 140068278294656] mod_hostinglimits: apr_lve_environment_init_group_minuid check ok [Tue Jun 19 19:13:34.342934 2018] [ssl:warn] [pid 1161165:tid 140068278294656] AH01909: proxy-subdomains-ssl-default-vhost.localhost:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 19:13:34.356119 2018] [ssl:warn] [pid 1161165:tid 140068278294656] AH01909: snopje.si:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 19:13:34.359657 2018] [ssl:warn] [pid 1161165:tid 140068278294656] AH01909: strohballenbau.snopje.si:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 19:13:34.388928 2018] [:notice] [pid 1161165:tid 140068278294656] ModSecurity for Apache/2.9.2 (ModSecurity: Open Source Web Application Firewall) configured. [Tue Jun 19 19:13:34.388980 2018] [:notice] [pid 1161165:tid 140068278294656] ModSecurity: APR compiled version="1.6.3"; loaded version="1.6.3" [Tue Jun 19 19:13:34.388995 2018] [:notice] [pid 1161165:tid 140068278294656] ModSecurity: PCRE compiled version="8.32 "; loaded version="8.32 2012-11-30" [Tue Jun 19 19:13:34.389005 2018] [:notice] [pid 1161165:tid 140068278294656] ModSecurity: LUA compiled version="Lua 5.1" [Tue Jun 19 19:13:34.389013 2018] [:notice] [pid 1161165:tid 140068278294656] ModSecurity: LIBXML compiled version="2.9.7" [Tue Jun 19 19:13:34.389021 2018] [:notice] [pid 1161165:tid 140068278294656] ModSecurity: Status engine is currently disabled, enable it by set SecStatusEngine to On. [Tue Jun 19 19:13:34.389762 2018] [suexec:notice] [pid 1161165:tid 140068278294656] AH01232: suEXEC mechanism enabled (wrapper: /usr/sbin/suexec) [Tue Jun 19 19:13:36.384911 2018] [hostinglimits:notice] [pid 1161169:tid 140068278294656] mod_hostinglimits: use Min UID 1000 [Tue Jun 19 19:13:36.384974 2018] [hostinglimits:notice] [pid 1161169:tid 140068278294656] mod_hostinglimits: version 1.0-36. LVE mechanism enabled [Tue Jun 19 19:13:36.384983 2018] [hostinglimits:notice] [pid 1161169:tid 140068278294656] mod_hostinglimits: found apr extention version 3 [Tue Jun 19 19:13:36.384993 2018] [hostinglimits:notice] [pid 1161169:tid 140068278294656] mod_hostinglimits: apr_lve_environment_init_group_minuid check ok [Tue Jun 19 19:13:36.387204 2018] [ssl:warn] [pid 1161169:tid 140068278294656] AH01909: proxy-subdomains-ssl-default-vhost.localhost:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 19:13:36.399336 2018] [ssl:warn] [pid 1161169:tid 140068278294656] AH01909: snopje.si:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 19:13:36.402736 2018] [ssl:warn] [pid 1161169:tid 140068278294656] AH01909: strohballenbau.snopje.si:443:0 server certificate does NOT include an ID which matches the server name [Tue Jun 19 19:13:36.461756 2018] [http2:info] [pid 1161169:tid 140068278294656] AH03090: mod_http2 (v1.10.16, feats=CHPRIO+SHA256+INVHD+DWINS, nghttp2 1.20.0), initializing... [Tue Jun 19 19:13:36.462559 2018] [lsapi:notice] [pid 1161169:tid 140068278294656] mod_lsapi: version 1.1-27 with CRIU support. Connection pool mode is switched off [Tue Jun 19 19:13:36.478132 2018] [:notice] [pid 1161172:tid 140068278294656] [host vps01.gsistemi.co] mod_lsapi: Selfstarter 1161172 started [Tue Jun 19 19:13:36.555198 2018] [mpm_worker:notice] [pid 1161169:tid 140068278294656] AH00292: Apache/2.4.33 (cPanel) OpenSSL/1.0.2o mod_bwlimited/1.4 configured -- resuming normal operations [Tue Jun 19 19:13:36.555269 2018] [core:notice] [pid 1161169:tid 140068278294656] AH00094: Command line: '/usr/sbin/httpd' [Tue Jun 19 19:22:28.297782 2018] [autoindex:error] [pid 1161238:tid 140067414673152] [client 66.249.64.21:41393] AH01276: Cannot serve directory /home/lepabe13/public_html/: No matching DirectoryIndex (index.php,index.php5,index.php4,index.php3,index.perl,index.pl,index.plx,index.ppl,index.cgi,index.jsp,index.js,index.jp,index.phtml,index.shtml,index.xhtml,index.html,index.htm,index.wml,Default.html,Default.htm,default.html,default.htm,home.html,home.htm) found, and server-generated directory index forbidden by Options directive
  

  0
• 

  cPanelLauren

  • June 20, 2018 16:24

  Hi @davorg Thanks for that! It looks like at the same time that cpanellogd error occurred your webserver was restarting: [Tue Jun 19 19:11:22.968761 2018] [mpm_worker:notice] [pid 2151:tid 140264146614400] AH00297: SIGUSR1 received. Doing graceful restart
  And it seems to have taken some time to restart which would explain why cpanellogd wasn't able to retrieve log file data. Is the issue you're running into still occurring or was this the only instance which you see the error in error log? Thanks!

  0
• 

  davorg

  • June 20, 2018 16:35

  It occurring every 3 or 4 days at different times. Apache is running but is not serving web pages. First occurrence has been on 15. may 2018. I have 10 cPanel servers mostly on VPS, but this is only with error.

  0
• 

  cPanelLauren

  • June 20, 2018 16:41

  Hi @davorg This is hard to troubleshoot without being able to take an indepth look at the logs. Can you please open a ticket with us using the link in my signature? Once the ticket is open please let us know the ticket ID here so that we can follow up on this thread with the outcome. Thanks!

  0

Please sign in to leave a comment.