Hi Leute, ich habe hier Performanceprobleme mit einer Webanwendung (langsame Reaktionszeiten 2-4 Sekunden immer) und ich würde gerne Apache als Schuldigen ausschließen.
time curl -H "Host: our-shop-domain" http://localhost:7080/ real 0m2.295s user 0m0.008s sys 0m0.022s Mit strace sehe ich die zeitliche Lücke, wo scheinbar nichts passiert. Wie ist das zu erklären? Um 13:12:56.4 kommt der GET Request Um 13:12:59.4 tut sich erstmal etwas. Ich würde mich über eure Hilfe freuen. Beste Grüße Stefan [pid 31765] 13:12:56.448808 read(49, "GET / HTTP/1.0\r\nHost: unique.plz"..., 8000) = 584 [pid 31765] 13:12:56.449043 stat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 [pid 31765] 13:12:56.449205 open("/var/www/vhosts/.htaccess", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) [pid 31765] 13:12:56.449331 lstat("/var/www/vhosts/useren-shop-domain.tld", {st_mode=S_IFDIR|0710, st_size=4096, ...}) = 0 [pid 31765] 13:12:56.449453 open("/var/www/vhosts/useren-shop-domain.tld/.htaccess", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) [pid 31765] 13:12:56.449568 lstat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 [pid 31765] 13:12:56.449689 open("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/.htaccess", O_RDONLY|O_CLOEXEC) = 50 [pid 31765] 13:12:56.449811 fstat(50, {st_mode=S_IFREG|0644, st_size=6529, ...}) = 0 [pid 31765] 13:12:56.449922 read(50, "################################"..., 4096) = 4096 [pid 31765] 13:12:56.450333 read(50, "pera mobile|palmos|webos|googleb"..., 4096) = 2433 [pid 31765] 13:12:56.450805 read(50, "", 4096) = 0 [pid 31765] 13:12:56.451002 close(50) = 0 [pid 31765] 13:12:56.451172 stat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 [pid 31765] 13:12:56.451302 stat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 [pid 31765] 13:12:56.451447 stat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/index.php", {st_mode=S_IFREG|0644, st_size=2599, ...}) = 0 [pid 31765] 13:12:56.451602 stat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/index.php", {st_mode=S_IFREG|0644, st_size=2599, ...}) = 0 [pid 31765] 13:12:56.451808 fcntl(39, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.451925 fcntl(39, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.452037 fcntl(39, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.452145 fcntl(39, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.452249 fcntl(44, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.452355 write(41, "/var/www/cgi-bin/cgi_wrapper/cgi"..., 13160) = 13160 [pid 31733] 13:12:56.452512 <... poll resumed> ) = 1 ([{fd=40, revents=POLLIN}]) [pid 31765] 13:12:56.452595 read(42, <unfinished ...> [pid 31733] 13:12:56.452662 read(40, "/var/www/cgi-bin/cgi_wrapper/cgi"..., 13160) = 13160 [pid 31733] 13:12:56.452811 fcntl(39, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31733] 13:12:56.452947 fcntl(39, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31733] 13:12:56.453095 unlink("/var/lib/apache2/fcgid/sock/31733.33") = -1 ENOENT (No such file or directory) [pid 31733] 13:12:56.453242 socket(PF_LOCAL, SOCK_STREAM, 0) = 41 [pid 31733] 13:12:56.453371 umask(077) = 022 [pid 31733] 13:12:56.453490 bind(41, {sa_family=AF_LOCAL, sun_path="/var/lib/apache2/fcgid/sock/31733.33"}, 110) = 0 [pid 31733] 13:12:56.453676 umask(022) = 077 [pid 31733] 13:12:56.453792 chmod("/var/lib/apache2/fcgid/sock/31733.33", 0700) = 0 [pid 31733] 13:12:56.453923 listen(41, 5) = 0 [pid 31733] 13:12:56.454042 geteuid() = 33 [pid 31733] 13:12:56.454157 fcntl(41, F_GETFD) = 0 [pid 31733] 13:12:56.454270 fcntl(41, F_SETFD, FD_CLOEXEC) = 0 [pid 31733] 13:12:56.454391 dup(2) = 42 [pid 31733] 13:12:56.454577 fcntl(42, F_GETFD) = 0 [pid 31733] 13:12:56.454745 fcntl(42, F_SETFD, 0) = 0 [pid 31733] 13:12:56.454867 dup(2) = 45 [pid 31733] 13:12:56.454986 fcntl(45, F_GETFD) = 0 [pid 31733] 13:12:56.455097 fcntl(45, F_SETFD, 0) = 0 [pid 31733] 13:12:56.455235 dup(41) = 46 [pid 31733] 13:12:56.455355 fcntl(46, F_GETFD) = 0 [pid 31733] 13:12:56.455491 fcntl(46, F_SETFD, 0) = 0 [pid 31733] 13:12:56.455620 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7f8e68dfaa50) = 32162 [pid 31733] 13:12:56.457247 close(46) = 0 [pid 31733] 13:12:56.457376 close(45) = 0 [pid 31733] 13:12:56.457557 close(42) = 0 [pid 31733] 13:12:56.457681 close(41) = 0 [pid 31733] 13:12:56.457806 fcntl(39, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31733] 13:12:56.457938 fcntl(39, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31733] 13:12:56.458078 write(43, "p", 1 <unfinished ...> [pid 31765] 13:12:56.458236 <... read resumed> "p", 1) = 1 [pid 31733] 13:12:56.458291 <... write resumed> ) = 1 [pid 31765] 13:12:56.458337 fcntl(44, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0} <unfinished ...> [pid 31733] 13:12:56.458411 poll([{fd=40, events=POLLIN}], 1, 3000 <unfinished ...> [pid 31765] 13:12:56.458479 <... fcntl resumed> ) = 0 [pid 31765] 13:12:56.458549 fcntl(39, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.458672 fcntl(39, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:56.458845 socket(PF_LOCAL, SOCK_STREAM, 0) = 50 [pid 31765] 13:12:56.458980 connect(50, {sa_family=AF_LOCAL, sun_path="/var/lib/apache2/fcgid/sock/31733.33"}, 110) = 0 [pid 31765] 13:12:56.459119 fcntl(50, F_GETFL) = 0x2 (flags O_RDWR) [pid 31765] 13:12:56.459233 fcntl(50, F_SETFL, O_RDWR|O_NONBLOCK) = 0 [pid 31765] 13:12:56.459347 writev(50, [{"\1\1\0\1\0\10\0\0", 8}, {"\0\1\0\0\0\0\0\0", 8}, {"\1\4\0\1\5\235\0\0", 8}, {"\22\0HTTP_AUTHORIZATION\0216PP_CUSTOM_"..., 1437}, {"\1\4\0\1\0\0\0\0", 8}, {"\1\5\0\1\0\0\0\0", 8}], 6) = 1477 [pid 31765] 13:12:56.459522 read(50, 0x7f8e67845048, 8192) = -1 EAGAIN (Resource temporarily unavailable) [pid 31765] 13:12:56.459652 poll([{fd=50, events=POLLIN}], 1, 45000 <unfinished ...> [pid 31733] 13:12:56.465314 <... poll resumed> ) = ? ERESTART_RESTARTBLOCK (Interrupted by signal) [pid 31733] 13:12:56.465414 --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=31985, si_status=0, si_utime=136, si_stime=88} --- [pid 31733] 13:12:56.465498 restart_syscall(<... resuming interrupted call ...> <unfinished ...> [pid 31730] 13:12:56.524113 <... select resumed> ) = 0 (Timeout) [pid 31730] 13:12:56.524218 wait4(-1, 0x7ffea19293f4, WNOHANG|WSTOPPED, NULL) = 0 [pid 31730] 13:12:56.524370 select(0, NULL, NULL, NULL, {1, 0}) = 0 (Timeout) [pid 31730] 13:12:57.525731 wait4(-1, 0x7ffea19293f4, WNOHANG|WSTOPPED, NULL) = 0 [pid 31730] 13:12:57.525906 select(0, NULL, NULL, NULL, {1, 0}) = 0 (Timeout) [pid 31730] 13:12:58.527241 wait4(-1, 0x7ffea19293f4, WNOHANG|WSTOPPED, NULL) = 0 [pid 31730] 13:12:58.527359 select(0, NULL, NULL, NULL, {1, 0} <unfinished ...> [pid 31765] 13:12:59.405886 <... poll resumed> ) = 1 ([{fd=50, revents=POLLIN}]) [pid 31765] 13:12:59.406008 read(50, "\1\6\0\1\1d\4\0Expires: Thu, 19 Nov 198"..., 8192) = 8192 [pid 31765] 13:12:59.406265 read(50, "Bitte geben Sie eine g\\u00fcltig"..., 8192) = 8192 [pid 31765] 13:12:59.406399 read(50, "g-cart\"></i>\t\t\t<span>Sie haben k"..., 8192) = 8192 [pid 31765] 13:12:59.406524 read(50, "><div class=\"menu-wrapper\" colum"..., 8192) = 8192 [pid 31765] 13:12:59.406641 read(50, "href=\"http://useren-shop-domain.tld"..., 8192) = 8192 [pid 31765] 13:12:59.406824 read(50, "\t\t\t\t\t<div class=\"slider\">\n\t\t\t\t\t\t"..., 8192) = 8192 [pid 31765] 13:12:59.406937 read(50, " jQuery(window).on('orientati"..., 8192) = 8192 [pid 31765] 13:12:59.407048 read(50, "><span id='ajax_wishlist_loading"..., 8192) = 8192 [pid 31765] 13:12:59.407157 read(50, "t\"></i></div>\n\t\t\t\t\t\t<div class ="..., 8192) = 8192 [pid 31765] 13:12:59.407293 read(50, ": true,\n\t\t\tinfiniteSlider: false"..., 8192) = 8192 [pid 31765] 13:12:59.407401 read(50, "' style='display:none'>Test</a>\n"..., 8192) = 8192 [pid 31765] 13:12:59.407514 read(50, "Test</a>\n\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t\t</"..., 8192) = 8192 [pid 31765] 13:12:59.407622 read(50, "pan><span class=\"shipping-cost-d"..., 8192) = 8192 [pid 31765] 13:12:59.407731 read(50, "4 omega\">\r\n\t\t<a href=\"#\" title=\""..., 8192) = 8192 [pid 31765] 13:12:59.407836 read(50, "=\"button btn-post\" title=\"weiter"..., 8192) = 8192 [pid 31765] 13:12:59.407941 read(50, " <div class=\"ca-item-"..., 8192) = 8192 [pid 31765] 13:12:59.408051 read(50, "div>\r\n </div>\r\n "..., 8192) = 8192 [pid 31765] 13:12:59.408192 brk(0x7f8e6a848000) = 0x7f8e6a848000 [pid 31765] 13:12:59.413538 writev(49, [{"HTTP/1.1 200 OK\r\nDate: Fri, 22 J"..., 516}, {"\37\213\10\0\0\0\0\0\0\3", 10}, {"\354}[w\3338\262\356\263\263\326\374\7\214zz\313\236\230\242$\337\342\304\366\214\235\373$N2\261"..., 8096}, {"\253\6\207c\221\221<\340\31\227E]\0343yYEWfY\32\305\340\232\331\314\253\244(\262\24\7"..., 5679}], 4) = 14301 [pid 31765] 13:12:59.413796 read(50, "erkonto\">Mein Benutzerkonto</a><"..., 8192) = 4856 [pid 31765] 13:12:59.419115 writev(49, [{"\354=\333R\33I\226\317\356\210\375\207\264f\326\202\261\256\210\2331fW`\260\31\33\233\5\333\335\323"..., 8096}, {"HH\257\2d\321\240\3669\212\315\314Bd@\371\376\324\222\306pK\247)Z\6\267k}\216\34\236"..., 3253}], 2) = 11349 [pid 31765] 13:12:59.419212 read(50, 0x7f8e667fd048, 8192) = -1 EAGAIN (Resource temporarily unavailable) [pid 31765] 13:12:59.419294 poll([{fd=50, events=POLLIN}], 1, 45000) = 1 ([{fd=50, revents=POLLIN|POLLHUP}]) [pid 31765] 13:12:59.456599 read(50, "\1\6\0\1\0\5\3\0html>\0\0\0\1\3\0\1\0\10\0\0\0\0\0\0\000198", 8192) = 32 [pid 31765] 13:12:59.456777 close(50) = 0 [pid 31765] 13:12:59.456926 fcntl(39, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:59.457059 fcntl(39, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 [pid 31765] 13:12:59.457219 brk(0x7f8e6a808000) = 0x7f8e6a808000 [pid 31765] 13:12:59.457408 writev(49, [{"\313(\311\315\261\3\0", 7}, {"\252\275\267\7u1\2\0", 8}], 2) = 15 [pid 31765] 13:12:59.457653 write(22, "2003:62:4a5b:2700:544a:4c62:7311"..., 216) = 216 [pid 31765] 13:12:59.457813 times({tms_utime=10, tms_stime=4, tms_cutime=0, tms_cstime=0}) = 2232326703 [pid 31765] 13:12:59.457942 shutdown(49, SHUT_WR) = 0 [pid 31765] 13:12:59.458075 poll([{fd=49, events=POLLIN}], 1, 2000) = 1 ([{fd=49, revents=POLLIN|POLLHUP}]) [pid 31765] 13:12:59.458188 read(49, "", 512) = 0 [pid 31765] 13:12:59.458294 close(49) = 0 [pid 31765] 13:12:59.458411 read(8, 0x7ffea1929347, 1) = -1 EAGAIN (Resource temporarily unavailable) [pid 31765] 13:12:59.458524 fcntl(47, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0} <unfinished ...> [pid 31733] 13:12:59.461588 <... restart_syscall resumed> ) = 0 [pid 31733] 13:12:59.461661 poll([{fd=40, events=POLLIN}], 1, 3000 <unfinished ...> [pid 31739] 13:12:59.488870 <... epoll_wait resumed> {{EPOLLIN, {u32=1756586736, u64=140249618670320}}}, 2, 10000) = 1 [pid 31739] 13:12:59.488965 accept4(5, {sa_family=AF_INET6, sin6_port=htons(39025), inet_pton(AF_INET6, "server-v6-addresse", &sin6_addr), sin6_flowinfo=0, sin6_scope_id=0}, [28], SOCK_CLOEXEC) = 49 [pid 31739] 13:12:59.489186 fcntl(47, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0} <unfinished ...> [pid 31746] 13:12:59.489323 <... fcntl resumed> ) = 0 [pid 31739] 13:12:59.489359 <... fcntl resumed> ) = 0 [pid 31746] 13:12:59.489418 epoll_wait(48, <unfinished ...> [pid 31739] 13:12:59.489472 getsockname(49, {sa_family=AF_INET6, sin6_port=htons(7080), inet_pton(AF_INET6, "server-v6-addresse", &sin6_addr), sin6_flowinfo=0, sin6_scope_id=0}, [28]) = 0 [pid 31739] 13:12:59.489618 fcntl(49, F_GETFL) = 0x2 (flags O_RDWR) [pid 31739] 13:12:59.489727 fcntl(49, F_SETFL, O_RDWR|O_NONBLOCK) = 0 [pid 31739] 13:12:59.489854 read(49, "GET /media/css/753d75e7ed04e7211"..., 8000) = 585 [pid 31739] 13:12:59.490083 stat("/var/www/vhosts/useren-shop-domain.tld/useren-shop-domain.tld/media/css/753d75e7ed04e721120a02d7ba91647f.css", {st_mode=S_IFREG|0666, st_size=541450, ...}) = --------------------------------------------------------------------- To unsubscribe, e-mail: users-de-unsubscr...@httpd.apache.org For additional commands, e-mail: users-de-h...@httpd.apache.org