Arch Linux

Creak

Member

Registered: 2013-10-23

Posts: 89

[SOLVED] systemd is take a while to start httpd

Hi!

I've just installed LAMP and I noticed that apache is taking a while to start. I remember it took some time on Debian, but not that much.
Is it normal? (I may have done something wrong, or it may be something to do to improve apache startup time)

Here are my figures:

~$ time systemctl stop httpd.service 

real	0m20.115s
user	0m0.000s
sys	0m0.000s

~$ time systemctl start httpd.service 

real	1m1.760s
user	0m0.000s
sys	0m0.000s

~$ time systemctl restart httpd.service 

real	1m21.681s
user	0m0.000s
sys	0m0.000s

One minute is almost the time my PC takes to boot entirely

The other question is: does systemd start apache in parallel of the other services, so that we don't lose to much time during the PC boot?

Thanks.

Last edited by Creak (2014-03-09 02:51:24)

JASN

Member

Registered: 2009-04-17

Posts: 18

Re: [SOLVED] systemd is take a while to start httpd

Wow, that's a suspiciously long time.

$ time sudo systemctl restart httpd

real    0m1.836s
user    0m0.000s
sys     0m0.003s

Just tried my system, less than 2 seconds while doing x264 re-encoding. Have you tried journalctl -n? There are log entries for the Apache restart in there, might be interesting what yours says.

Also are you using any network ressources that might not be available? So Apache has to wait for something to time-out?

Creak

Member

Registered: 2013-10-23

Posts: 89

Re: [SOLVED] systemd is take a while to start httpd

Here is what I've got:

fév 06 08:53:58 slibar systemd[1]: Stopping Apache Web Server...
fév 06 08:54:18 slibar apachectl[6018]: httpd: Could not reliably determine the server's fully qualified domain name, using fe80::a2f3:c1ff:fe1d:f5d for ServerName
fév 06 08:54:18 slibar systemd[1]: Starting Apache Web Server...
fév 06 08:54:39 slibar apachectl[6024]: httpd: Could not reliably determine the server's fully qualified domain name, using fe80::a2f3:c1ff:fe1d:f5d for ServerName
fév 06 08:54:46 slibar dbus[230]: [system] Activating via systemd: service name='org.freedesktop.ModemManager1' unit='dbus-org.freedesktop.ModemManager1.service'
fév 06 08:54:46 slibar dbus[230]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.ModemManager1.service': Unit dbus-org.freedesktop.ModemManager1.service failed to load: No such file or directory.
fév 06 08:54:50 slibar systemd[1]: PID file /run/httpd/httpd.pid not readable (yet?) after start.
fév 06 08:55:21 slibar systemd[1]: Started Apache Web Server.

JASN

Member

Registered: 2009-04-17

Posts: 18

Re: [SOLVED] systemd is take a while to start httpd

Hm, very odd.

Try "httpd -e debug" as root or sudo. This will start Apache with the debug level output to the shell. Have a look at what's in there.

Creak

Member

Registered: 2013-10-23

Posts: 89

Re: [SOLVED] systemd is take a while to start httpd

Using "httpd -e debug", it's still taking some time, but it's faster (30 seconds):

~$ time httpd -e debug
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_file_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_dbm_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_anon_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_dbd_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_default_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_host_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_groupfile_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_user_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_dbm_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_owner_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authnz_ldap_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_default_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module auth_basic_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module auth_digest_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module file_cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module disk_cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module mem_cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dbd_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dumpio_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module reqtimeout_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ext_filter_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module include_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module filter_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module substitute_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module deflate_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ldap_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module log_config_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module log_forensic_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module logio_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module env_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module mime_magic_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cern_meta_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module expires_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module headers_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ident_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module usertrack_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module unique_id_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module setenvif_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module version_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_connect_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_ftp_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_http_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_scgi_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_ajp_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_balancer_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ssl_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module mime_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dav_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module status_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module autoindex_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module asis_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module info_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module suexec_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cgi_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cgid_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dav_fs_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module vhost_alias_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module negotiation_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dir_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module imagemap_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module actions_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module speling_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module userdir_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module alias_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module rewrite_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module php5_module
httpd: Could not reliably determine the server's fully qualified domain name, using fe80::a2f3:c1ff:fe1d:f5d for ServerName

real	0m30.704s
user	0m0.060s
sys	0m0.007s

It takes a lot of time to display the last line "Could not reliably determine the server's ..." though. Don't know what I should put as ServerName for a local server only.

Last edited by Creak (2014-02-07 04:20:42)

korn36

Member

Registered: 2014-01-14

Posts: 111

Re: [SOLVED] systemd is take a while to start httpd

Using "httpd -e debug", it's still taking some time, but it's faster (30 seconds):

~$ time httpd -e debug
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_file_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_dbm_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_anon_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_dbd_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authn_default_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_host_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_groupfile_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_user_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_dbm_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_owner_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authnz_ldap_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module authz_default_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module auth_basic_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module auth_digest_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module file_cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module disk_cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module mem_cache_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dbd_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dumpio_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module reqtimeout_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ext_filter_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module include_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module filter_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module substitute_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module deflate_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ldap_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module log_config_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module log_forensic_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module logio_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module env_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module mime_magic_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cern_meta_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module expires_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module headers_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ident_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module usertrack_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module unique_id_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module setenvif_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module version_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_connect_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_ftp_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_http_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_scgi_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_ajp_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module proxy_balancer_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module ssl_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module mime_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dav_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module status_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module autoindex_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module asis_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module info_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module suexec_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cgi_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module cgid_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dav_fs_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module vhost_alias_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module negotiation_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module dir_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module imagemap_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module actions_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module speling_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module userdir_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module alias_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module rewrite_module
[Thu Feb 06 23:22:55 2014] [debug] mod_so.c(246): loaded module php5_module
httpd: Could not reliably determine the server's fully qualified domain name, using fe80::a2f3:c1ff:fe1d:f5d for ServerName

real	0m30.704s
user	0m0.060s
sys	0m0.007s

It takes a lot of time to display the last line "Could not reliably determine the server's ..." though. Don't know what I should put as ServerName for a local server only.

Try your local IPv4 IP address. Or "localhost".

Last edited by korn36 (2014-02-09 09:51:15)

Creak

Member

Registered: 2013-10-23

Posts: 89

Re: [SOLVED] systemd is take a while to start httpd

Thanks korn36, it's far better:

~$ time systemctl restart httpd.service 

real	0m21.517s
user	0m0.000s
sys	0m0.000s

I won 1 min, but I'm still 20 second behind JASN's times.

korn36

Member

Registered: 2014-01-14

Posts: 111

Re: [SOLVED] systemd is take a while to start httpd

What does "httpd -e debug" display now?

Last edited by korn36 (2014-02-10 09:57:00)

Creak

Member

Registered: 2013-10-23

Posts: 89

Re: [SOLVED] systemd is take a while to start httpd

It displays the same but without the last line, and it takes far less time, but still 10 seconds.

~$ time httpd -e debug
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authn_file_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authn_dbm_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authn_anon_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authn_dbd_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authn_default_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authz_host_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authz_groupfile_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authz_user_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authz_dbm_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authz_owner_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authnz_ldap_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module authz_default_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module auth_basic_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module auth_digest_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module file_cache_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module cache_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module disk_cache_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module mem_cache_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module dbd_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module dumpio_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module reqtimeout_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module ext_filter_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module include_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module filter_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module substitute_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module deflate_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module ldap_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module log_config_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module log_forensic_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module logio_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module env_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module mime_magic_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module cern_meta_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module expires_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module headers_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module ident_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module usertrack_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module unique_id_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module setenvif_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module version_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_connect_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_ftp_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_http_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_scgi_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_ajp_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module proxy_balancer_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module ssl_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module mime_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module dav_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module status_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module autoindex_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module asis_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module info_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module suexec_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module cgi_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module cgid_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module dav_fs_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module vhost_alias_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module negotiation_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module dir_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module imagemap_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module actions_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module speling_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module userdir_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module alias_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module rewrite_module
[Mon Feb 10 09:13:55 2014] [debug] mod_so.c(246): loaded module php5_module

real	0m10.136s
user	0m0.087s
sys	0m0.010s

Is there another log file somewhere?

Thanks for your help!

korn36

Member

Registered: 2014-01-14

Posts: 111

Re: [SOLVED] systemd is take a while to start httpd

/tmp :: time httpd -e debug&>/dev/null

real	0m0.038s
user	0m0.017s
sys	0m0.010s

Hmm, your httpd start time is really long. What is the time with disabled php module?

Creak

Member

Registered: 2013-10-23

Posts: 89

Re: [SOLVED] systemd is take a while to start httpd

It's the same... It seems more like it's the initialization of the connection that is taking time.
I assume that's it because if I call "time httpd -e debug" while another instance is already launched, I get an error in the end but almost the same times you have:

$ time httpd -e debug
[Wed Mar 05 17:18:11 2014] [debug] mod_so.c(246): loaded module authn_file_module
[Wed Mar 05 17:18:11 2014] [debug] mod_so.c(246): loaded module authn_dbm_module
## I deleted some module loading lines here...
[Wed Mar 05 17:18:11 2014] [debug] mod_so.c(246): loaded module rewrite_module
[Wed Mar 05 17:18:11 2014] [debug] mod_so.c(246): loaded module php5_module
(98)Address already in use: make_sock: could not bind to address [::]:80
(98)Address already in use: make_sock: could not bind to address 0.0.0.0:80
no listening sockets available, shutting down
Unable to open logs

real	0m0.040s
user	0m0.023s
sys	0m0.003s

Creak

Member

Registered: 2013-10-23

Posts: 89

Re: [SOLVED] systemd is take a while to start httpd

Hi!

My problem was solved by updating to Apache 2.4. Don't know what was the culprit... Maybe a module was taking some time to be loaded (a lot of modules are commented out by default with the 2.4)