Hi Renato,<div><br></div><div>Before it crashes, the number of TCP connections is really small. ~30 connections. It has nothing to do with the traffic volume.<br><br><div class="gmail_quote">On Wed, Dec 15, 2010 at 6:51 PM, Renato Farias <span dir="ltr"><<a href="mailto:renato@luren.com.br">renato@luren.com.br</a>></span> wrote:<br>

<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex;">Hi blamer,<br><br>Can you see how many connection is opened (ESTABILISHED, TIME_WAIT, SYN_SENT), three months ago I had same issue, my server cannot open new connection after 15K.<br>

<br>Cya<br><br>Renato<br><br><div class="gmail_quote"><div><div></div><div class="h5">
On Wed, Dec 15, 2010 at 11:47 AM, Varnish <span dir="ltr"><<a href="mailto:varnish-bugs@varnish-cache.org" target="_blank">varnish-bugs@varnish-cache.org</a>></span> wrote:<br></div></div><blockquote class="gmail_quote" style="margin:0pt 0pt 0pt 0.8ex;border-left:1px solid rgb(204, 204, 204);padding-left:1ex">

<div><div></div><div class="h5">
<div>#835: Varnish stops receiving incoming connections, but the process is still up<br>
----------------------+-----------------------------------------------------<br>
 Reporter:  blamer    |       Owner:  phk<br>
     Type:  defect    |      Status:  new<br>
 Priority:  high      |   Milestone:  Varnish 2.1 release<br>
Component:  varnishd  |     Version:  2.1.4<br>
 Severity:  major     |    Keywords:  broken pipe, freeze, crash<br>
----------------------+-----------------------------------------------------<br>
<br>
</div>Comment(by blamer):<br>
<div><div></div><div><br>
 System:<br>
 {{{<br>
 Linux myh0stz 2.6.26-2-sparc64-smp #1 SMP Fri Sep 17 02:49:30 UTC 2010<br>
 sparc64 GNU/Linux<br>
 32 Cores<br>
 8 GB RAM<br>
 1000 MBit<br>
 Plently of disk space (> 100 gb free)<br>
 Debian Sparc<br>
 Varnish was compiled from 2.1.4 source<br>
 }}}<br>
<br>
 Symptom: At random moments (the resources of the servers are free in those<br>
 moments), varnishd does not allow connections. It's like nothing is opened<br>
 on those sockets. It just freezes. I strace-d it (strace -p PID -f -t)<br>
 (last 500 lines):<br>
 {{{<br>
 [pid 18629] 18:18:12 clock_gettime(CLOCK_REALTIME, {1291997892,<br>
 856942092}) = 0<br>
 [pid 18629] 18:18:12 poll([{fd=14, events=POLLIN}], 1, 50 <unfinished ...><br>
 [pid 18618] 18:18:12 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:12 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:12 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:12 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:12 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:12 clock_gettime(CLOCK_REALTIME, {1291997892,<br>
 871675208}) = 0<br>
 [pid 18619] 18:18:12 epoll_wait(10,  <unfinished ...><br>
 [pid 18629] 18:18:12 <... poll resumed> ) = 0 (Timeout)<br>
 [pid 18629] 18:18:12 ioctl(14, 0x8004667e, 0xf19d43bc) = 0<br>
 [pid 18629] 18:18:12 write(4, "\355\235 \10"..., 4) = 4<br>
 [pid 18619] 18:18:12 <... epoll_wait resumed> {{EPOLLIN, {u32=565332,<br>
 u64=2428082451382272}}}, 100, -1) = 1<br>
 [pid 18629] 18:18:12 futex(0xf19db18c, FUTEX_WAIT_PRIVATE, 25621, NULL<br>
 <unfinished ...><br>
 [pid 18619] 18:18:12 read(3, "\355\235 \10"..., 400) = 4<br>
 [pid 18619] 18:18:12 epoll_ctl(10, EPOLL_CTL_MOD, 14,<br>
 {EPOLLIN|EPOLLPRI|EPOLLONESHOT|0x2000, {u32=3986497544,<br>
 u64=17121876577064321024}}) = 0<br>
 [pid 18619] 18:18:12 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:12 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:12 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:12 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:12 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:12 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:12 clock_gettime(CLOCK_REALTIME, {1291997892,<br>
 972535516}) = 0<br>
 [pid 18619] 18:18:12 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893, 73349872})<br>
 = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 174123604}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18620] 18:18:13 <... poll resumed> ) = 0 (Timeout)<br>
 [pid 18620] 18:18:13 clock_gettime(CLOCK_REALTIME,  <unfinished ...><br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=3998392328,<br>
 u64=17172964285337305088}}}, 100, -1) = 1<br>
 [pid 18620] 18:18:13 <... clock_gettime resumed> {1291997893, 195829832})<br>
 = 0<br>
 [pid 18619] 18:18:13 read(15,  <unfinished ...><br>
 [pid 18620] 18:18:13 poll([{fd=5, events=POLLIN}], 1, 1000 <unfinished<br>
 ...><br>
 [pid 18619] 18:18:13 <... read resumed> "GET /wp-<br>
</div></div> content/themes/XXXXXXXX/"..., 8191) = 589<br>
<div> [pid 18619] 18:18:13 futex(0xf7b3f18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf7b3f188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18624] 18:18:13 <... futex resumed> ) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18624] 18:18:13 futex(0xf7a10984, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18624] 18:18:13 ioctl(15, 0x8004667e, 0xf7b3842c) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 197972548}) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 198420916}) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 198734648}) = 0<br>
 [pid 18624] 18:18:13 writev(15, [{"HTTP/1.1"..., 8}, {" "..., 1},<br>
 {"404"..., 3}, {" "..., 1}, {"Not Found"..., 9}, {"\r\n"..., 2}, {"Server:<br>
 Microsoft-IIS/7.5"..., 25}, {"\r\n"..., 2}, {"X-Pingback:<br>
</div> <a href="http://www.XXXXXXXX" target="_blank">http://www.XXXXXXXX</a>."..., 46}, {"\r\n"..., 2}, {"Expires: Wed, 11 Jan 1984<br>
<div><div></div><div> 05:00:0"..., 38}, {"\r\n"..., 2}, {"Last-Modified: Fri, 10 Dec 2010 1"...,<br>
 44}, {"\r\n"..., 2}, {"Cache-Control: no-cache, must-rev"..., 51},<br>
 {"\r\n"..., 2}, {"Pragma: no-cache"..., 16}, {"\r\n"..., 2}, {"Vary:<br>
 Accept-Encoding"..., 21}, {"\r\n"..., 2}, {"Content-Encoding: gzip"...,<br>
 22}, {"\r\n"..., 2}, {"Content-Type: text/html; charset="..., 38},<br>
 {"\r\n"..., 2}, {"Content-Length: 17208"..., 21}, {"\r\n"..., 2}, {"Date:<br>
 Fri, 10 Dec 2010 16:18:13 G"..., 35}, {"\r\n"..., 2}, {"X-Varnish:<br>
 1052092382 1052083617"..., 32}, {"\r\n"..., 2}, {"Age: 1073"..., 9},<br>
 {"\r\n"..., 2}, ...], 38) = 17700<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 200894048}) = 0<br>
 [pid 18624] 18:18:13 poll([{fd=15, events=POLLIN}], 1, 50 <unfinished ...><br>
 [pid 18612] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18612] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 240571564}) = 0<br>
 [pid 18612] 18:18:13 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18617] 18:18:13 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18617] 18:18:13 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18617] 18:18:13 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4033866460) = 0<br>
 [pid 18617] 18:18:13 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18617] 18:18:13 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18615] 18:18:13 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18615] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 250373144}) = 0<br>
 [pid 18615] 18:18:13 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18615] 18:18:13 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4050643676) = 0<br>
 [pid 18615] 18:18:13 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18615] 18:18:13 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18624] 18:18:13 <... poll resumed> ) = 0 (Timeout)<br>
 [pid 18624] 18:18:13 ioctl(15, 0x8004667e, 0xf7b383bc) = 0<br>
 [pid 18624] 18:18:13 write(4, "\356R\240\10"..., 4 <unfinished ...><br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=565332,<br>
 u64=2428082451382272}}}, 100, -1) = 1<br>
 [pid 18624] 18:18:13 <... write resumed> ) = 4<br>
 [pid 18619] 18:18:13 read(3,  <unfinished ...><br>
 [pid 18624] 18:18:13 futex(0xf7b3f18c, FUTEX_WAIT_PRIVATE, 25917, NULL<br>
 <unfinished ...><br>
 [pid 18619] 18:18:13 <... read resumed> "\356R\240\10"..., 400) = 4<br>
 [pid 18619] 18:18:13 epoll_ctl(10, EPOLL_CTL_MOD, 15,<br>
 {EPOLLIN|EPOLLPRI|EPOLLONESHOT|0x2000, {u32=3998392328,<br>
 u64=17172964285337305088}}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 274913284}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 375723208}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18625] 18:18:13 <... read resumed> "1"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11, "0"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11, "6"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11, "f"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11, "\r"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11, "\n"..., 1) = 1<br>
</div></div> [pid 18625] 18:18:13 read(11, "<a href="http://www.XXXXXXXX.ro/video%5C" target="_blank">http://www.XXXXXXXX.ro/video\</a>">Vi"...,<br>
<div><div></div><div> 4207) = 4207<br>
 [pid 18625] 18:18:13 read(11, "\r"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11, "\n"..., 1) = 1<br>
 [pid 18625] 18:18:13 read(11,  <unfinished ...><br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=3986497544,<br>
 u64=17121876577064321024}}}, 100, -1) = 1<br>
 [pid 18619] 18:18:13 read(14, "GET /img/wp-content/uploads/2010/"...,<br>
 8191) = 703<br>
 [pid 18619] 18:18:13 futex(0xf19db18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf19db188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18629] 18:18:13 <... futex resumed> ) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18629] 18:18:13 futex(0xf7a109b4, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18629] 18:18:13 ioctl(14, 0x8004667e, 0xf19d442c) = 0<br>
 [pid 18629] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 471524104}) = 0<br>
 [pid 18629] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 472037492}) = 0<br>
 [pid 18629] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 472340392}) = 0<br>
 [pid 18629] 18:18:13 writev(14, [{"HTTP/1.1"..., 8}, {" "..., 1},<br>
 {"200"..., 3}, {" "..., 1}, {"OK"..., 2}, {"\r\n"..., 2}, {"Server:<br>
 Microsoft-IIS/7.5"..., 25}, {"\r\n"..., 2}, {"Content-Disposition: inline;<br>
 file"..., 71}, {"\r\n"..., 2}, {"Last-Modified: Fri, 10 Dec 2010 1"...,<br>
 44}, {"\r\n"..., 2}, {"Content-Type: image/jpeg"..., 24}, {"\r\n"..., 2},<br>
 {"Content-Length: 34330"..., 21}, {"\r\n"..., 2}, {"Date: Fri, 10 Dec 2010<br>
 16:18:13 G"..., 35}, {"\r\n"..., 2}, {"X-Varnish: 1052092383<br>
 1052054539"..., 32}, {"\r\n"..., 2}, {"Age: 4457"..., 9}, {"\r\n"..., 2},<br>
 {"Via: 1.1 varnish"..., 16}, {"\r\n"..., 2}, {"Connection: keep-alive"...,<br>
 22}, {"\r\n"..., 2}, {"\r\n"..., 2},<br>
 {"\377\330\377\340\0\20JFIF\0\1\1\1\0\226\0\226\0\0\377\333\0C\0\10\6\6\7\6\5\10\7"...,<br>
 34330}], 28) = 34668<br>
 [pid 18629] 18:18:13 clock_gettime(CLOCK_REALTIME,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18629] 18:18:13 <... clock_gettime resumed> {1291997893, 475416560})<br>
 = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1 <unfinished ...><br>
 [pid 18629] 18:18:13 poll([{fd=14, events=POLLIN}], 1, 50 <unfinished ...><br>
 [pid 18618] 18:18:13 <... write resumed> ) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 476985560}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10, {{EPOLLIN, {u32=3998392328,<br>
 u64=17172964285337305088}}}, 100, -1) = 1<br>
 [pid 18619] 18:18:13 read(15, "HEAD / HTTP/1.1\r\nX-Forwarded-For:"...,<br>
 8191) = 102<br>
 [pid 18619] 18:18:13 futex(0xf7b3f18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf7b3f188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18624] 18:18:13 <... futex resumed> ) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18624] 18:18:13 futex(0xf7a10984, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18624] 18:18:13 ioctl(15, 0x8004667e, 0xf7b3842c) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 495145448}) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 495574520}) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 495897344}) = 0<br>
 [pid 18624] 18:18:13 writev(15, [{"HTTP/1.1"..., 8}, {" "..., 1},<br>
 {"200"..., 3}, {" "..., 1}, {"OK"..., 2}, {"\r\n"..., 2}, {"Server:<br>
 Microsoft-IIS/7.5"..., 25}, {"\r\n"..., 2}, {"Last-Modified: Tue, 03 Aug<br>
 2010 0"..., 44}, {"\r\n"..., 2}, {"ETag: \"40125-0-48ce652c74380\""...,<br>
 29}, {"\r\n"..., 2}, {"Vary: Accept-Encoding"..., 21}, {"\r\n"..., 2},<br>
 {"Content-Type: text/html"..., 23}, {"\r\n"..., 2}, {"Content-Length:<br>
 0"..., 17}, {"\r\n"..., 2}, {"Date: Fri, 10 Dec 2010 16:18:13 G"..., 35},<br>
 {"\r\n"..., 2}, {"X-Varnish: 1052092384 1052090630"..., 32}, {"\r\n"...,<br>
 2}, {"Age: 236"..., 8}, {"\r\n"..., 2}, {"Via: 1.1 varnish"..., 16},<br>
 {"\r\n"..., 2}, {"Connection: keep-alive"..., 22}, {"\r\n"..., 2},<br>
 {"\r\n"..., 2}], 29) = 313<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 497661528}) = 0<br>
 [pid 18624] 18:18:13 poll([{fd=15, events=POLLIN}], 1, 50 <unfinished ...><br>
 [pid 18629] 18:18:13 <... poll resumed> ) = 0 (Timeout)<br>
 [pid 18629] 18:18:13 ioctl(14, 0x8004667e, 0xf19d43bc) = 0<br>
 [pid 18629] 18:18:13 write(4, "\355\235 \10"..., 4) = 4<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=565332,<br>
 u64=2428082451382272}}}, 100, -1) = 1<br>
 [pid 18629] 18:18:13 futex(0xf19db18c, FUTEX_WAIT_PRIVATE, 25623, NULL<br>
 <unfinished ...><br>
 [pid 18619] 18:18:13 read(3, "\355\235 \10"..., 400) = 4<br>
 [pid 18619] 18:18:13 epoll_ctl(10, EPOLL_CTL_MOD, 14,<br>
 {EPOLLIN|EPOLLPRI|EPOLLONESHOT|0x2000, {u32=3986497544,<br>
 u64=17121876577064321024}}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18624] 18:18:13 <... poll resumed> ) = 0 (Timeout)<br>
 [pid 18624] 18:18:13 ioctl(15, 0x8004667e, 0xf7b383bc) = 0<br>
 [pid 18624] 18:18:13 write(4, "\356R\240\10"..., 4 <unfinished ...><br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=565332,<br>
 u64=2428082451382272}}}, 100, -1) = 1<br>
 [pid 18624] 18:18:13 <... write resumed> ) = 4<br>
 [pid 18619] 18:18:13 read(3,  <unfinished ...><br>
 [pid 18624] 18:18:13 futex(0xf7b3f18c, FUTEX_WAIT_PRIVATE, 25919, NULL<br>
 <unfinished ...><br>
 [pid 18619] 18:18:13 <... read resumed> "\356R\240\10"..., 400) = 4<br>
 [pid 18619] 18:18:13 epoll_ctl(10, EPOLL_CTL_MOD, 15,<br>
 {EPOLLIN|EPOLLPRI|EPOLLONESHOT|0x2000, {u32=3998392328,<br>
 u64=17172964285337305088}}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 577819076}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 678596784}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10, {{EPOLLIN, {u32=3986497544,<br>
 u64=17121876577064321024}}}, 100, -1) = 1<br>
 [pid 18619] 18:18:13 read(14, "GET /stiri HTTP/1.1\r\nUser-Agent: "...,<br>
 8191) = 773<br>
 [pid 18619] 18:18:13 futex(0xf19db18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf19db188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18629] 18:18:13 <... futex resumed> ) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18629] 18:18:13 futex(0xf7a109b4, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18629] 18:18:13 ioctl(14, 0x8004667e, 0xf19d442c) = 0<br>
 [pid 18629] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 738793608}) = 0<br>
 [pid 18629] 18:18:13 futex(0xf19db18c, FUTEX_WAIT_PRIVATE, 25625, NULL<br>
 <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 779390960}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 880271512}) = 0<br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... nanosleep resumed> NULL) = 0<br>
 [pid 18620] 18:18:13 <... poll resumed> ) = 1 ([{fd=5, revents=POLLIN}])<br>
 [pid 18618] 18:18:13 write(8, "R"..., 1 <unfinished ...><br>
 [pid 18620] 18:18:13 clock_gettime(CLOCK_REALTIME,  <unfinished ...><br>
 [pid 18618] 18:18:13 <... write resumed> ) = 1<br>
 [pid 18619] 18:18:13 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:13 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:13 read(7,  <unfinished ...><br>
 [pid 18620] 18:18:13 <... clock_gettime resumed> {1291997893, 980448784})<br>
 = 0<br>
 [pid 18619] 18:18:13 <... read resumed> "R"..., 1) = 1<br>
 [pid 18620] 18:18:13 accept(5,  <unfinished ...><br>
 [pid 18619] 18:18:13 clock_gettime(CLOCK_REALTIME,  <unfinished ...><br>
 [pid 18620] 18:18:13 <... accept resumed> {sa_family=AF_INET,<br>
</div></div> sin_port=htons(50619), sin_addr=inet_addr("x.y.z.36")}, [16]) = 17<br>
<div> [pid 18619] 18:18:13 <... clock_gettime resumed> {1291997893, 981728996})<br>
 = 0<br>
 [pid 18620] 18:18:13 futex(0xf7b3f18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf7b3f188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...><br>
 [pid 18619] 18:18:13 epoll_wait(10,  <unfinished ...><br>
 [pid 18620] 18:18:13 <... futex resumed> ) = 1<br>
 [pid 18624] 18:18:13 <... futex resumed> ) = 0<br>
 [pid 18620] 18:18:13 poll([{fd=5, events=POLLIN}], 1, 1000 <unfinished<br>
 ...><br>
 [pid 18624] 18:18:13 futex(0xf7a10984, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18624] 18:18:13 ioctl(17, 0x8004667e, 0xf7b3842c) = 0<br>
 [pid 18624] 18:18:13 poll([{fd=17, events=POLLIN}], 1, 50) = 1 ([{fd=17,<br>
 revents=POLLIN}])<br>
</div> [pid 18624] 18:18:13 read(17, "GET /wp-content/themes/XXXXXXXX/"..., 8191)<br>
<div><div></div><div> = 427<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 984534164}) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 984991888}) = 0<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 985292996}) = 0<br>
 [pid 18624] 18:18:13 writev(17, [{"HTTP/1.1"..., 8}, {" "..., 1},<br>
 {"200"..., 3}, {" "..., 1}, {"OK"..., 2}, {"\r\n"..., 2}, {"Server:<br>
 Microsoft-IIS/7.5"..., 25}, {"\r\n"..., 2}, {"Last-Modified: Tue, 16 Feb<br>
 2010 0"..., 44}, {"\r\n"..., 2}, {"ETag: \"46853-65c-47fb4c59bb740\""...,<br>
 31}, {"\r\n"..., 2}, {"Content-Type: image/gif"..., 23}, {"\r\n"..., 2},<br>
 {"Content-Length: 1628"..., 20}, {"\r\n"..., 2}, {"Date: Fri, 10 Dec 2010<br>
 16:18:13 G"..., 35}, {"\r\n"..., 2}, {"X-Varnish: 1052092386<br>
 1052083384"..., 32}, {"\r\n"..., 2}, {"Age: 1100"..., 9}, {"\r\n"..., 2},<br>
 {"Via: 1.1 varnish"..., 16}, {"\r\n"..., 2}, {"Connection: keep-alive"...,<br>
 22}, {"\r\n"..., 2}, {"\r\n"..., 2},<br>
 {"GIF89a\34\0$\0\367\0\0\"\37\210w\344\363\235\237\314\36\271\336XZ\250\0\215\303\307\361"...,<br>
 1628}], 28) = 1924<br>
 [pid 18624] 18:18:13 clock_gettime(CLOCK_REALTIME, {1291997893,<br>
 987145288}) = 0<br>
 [pid 18624] 18:18:13 poll([{fd=17, events=POLLIN}], 1, 50) = 0 (Timeout)<br>
 [pid 18624] 18:18:14 ioctl(17, 0x8004667e, 0xf7b383bc) = 0<br>
 [pid 18624] 18:18:14 write(4, "\367\244\200\10"..., 4 <unfinished ...><br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=565332,<br>
 u64=2428082451382272}}}, 100, -1) = 1<br>
 [pid 18624] 18:18:14 <... write resumed> ) = 4<br>
 [pid 18619] 18:18:14 read(3,  <unfinished ...><br>
 [pid 18624] 18:18:14 futex(0xf7b3f18c, FUTEX_WAIT_PRIVATE, 25921, NULL<br>
 <unfinished ...><br>
 [pid 18619] 18:18:14 <... read resumed> "\367\244\200\10"..., 400) = 4<br>
 [pid 18619] 18:18:14 epoll_ctl(10, EPOLL_CTL_ADD, 17,<br>
 {EPOLLIN|EPOLLPRI|EPOLLONESHOT|0x2000, {u32=4154753032,<br>
 u64=17844528395396841472}}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10, {{EPOLLIN, {u32=4154753032,<br>
 u64=17844528395396841472}}}, 100, -1) = 1<br>
 [pid 18619] 18:18:14 read(17, "GET /stiri HTTP/1.1\r\nUser-Agent: "...,<br>
 8191) = 773<br>
 [pid 18619] 18:18:14 futex(0xf19db18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf19db188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18629] 18:18:14 <... futex resumed> ) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18629] 18:18:14 futex(0xf7a109b4, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18629] 18:18:14 ioctl(17, 0x8004667e, 0xf19d442c) = 0<br>
 [pid 18629] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894, 47222624})<br>
 = 0<br>
 [pid 18629] 18:18:14 futex(0xf19db18c, FUTEX_WAIT_PRIVATE, 25627, NULL<br>
 <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894, 82163424})<br>
 = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 183055080}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18612] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18612] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 241243672}) = 0<br>
 [pid 18612] 18:18:14 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18617] 18:18:14 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18617] 18:18:14 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18617] 18:18:14 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4033866460) = 0<br>
 [pid 18617] 18:18:14 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18617] 18:18:14 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18615] 18:18:14 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18615] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 252058036}) = 0<br>
 [pid 18615] 18:18:14 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18615] 18:18:14 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4050643676) = 0<br>
 [pid 18615] 18:18:14 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18615] 18:18:14 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 283774800}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 384582084}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18620] 18:18:14 <... poll resumed> ) = 1 ([{fd=5, revents=POLLIN}])<br>
 [pid 18620] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 419035140}) = 0<br>
 [pid 18620] 18:18:14 accept(5, {sa_family=AF_INET, sin_port=htons(50630),<br>
</div></div> sin_addr=inet_addr("x.y.z.36")}, [16]) = 18<br>
<div><div></div><div> [pid 18620] 18:18:14 futex(0xf7b3f18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf7b3f188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18624] 18:18:14 <... futex resumed> ) = 0<br>
 [pid 18620] 18:18:14 poll([{fd=5, events=POLLIN}], 1, 1000 <unfinished<br>
 ...><br>
 [pid 18624] 18:18:14 futex(0xf7a10984, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18624] 18:18:14 ioctl(18, 0x8004667e, 0xf7b3842c) = 0<br>
 [pid 18624] 18:18:14 poll([{fd=18, events=POLLIN}], 1, 50) = 1 ([{fd=18,<br>
 revents=POLLIN}])<br>
 [pid 18624] 18:18:14 read(18, "GET /stiri HTTP/1.1\r\nUser-Agent: "...,<br>
 8191) = 773<br>
 [pid 18624] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 421629696}) = 0<br>
 [pid 18624] 18:18:14 futex(0xf7b3f18c, FUTEX_WAIT_PRIVATE, 25923, NULL<br>
 <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 485429080}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 586203652}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 687050580}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 787847056}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 888672272}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:14 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:14 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:14 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:14 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:14 clock_gettime(CLOCK_REALTIME, {1291997894,<br>
 989458320}) = 0<br>
 [pid 18619] 18:18:14 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895, 90264196})<br>
 = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18611] 18:18:15 <... poll resumed> ) = 1 ([{fd=6, revents=POLLIN}])<br>
 [pid 18611] 18:18:15 read(6, "ping\n"..., 8191) = 5<br>
 [pid 18611] 18:18:15 time(NULL)         = 1291997895<br>
 [pid 18611] 18:18:15 writev(9, [{"200 19      \n"..., 13}, {"PONG<br>
 1291997895 1.0"..., 19}, {"\n"..., 1}], 3) = 33<br>
 [pid 18611] 18:18:15 poll([{fd=6, events=POLLIN}], 1, -1 <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 191048264}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18612] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18612] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 241947668}) = 0<br>
 [pid 18612] 18:18:15 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18617] 18:18:15 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18617] 18:18:15 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18617] 18:18:15 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4033866460) = 0<br>
 [pid 18617] 18:18:15 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18617] 18:18:15 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18615] 18:18:15 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18615] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 253632384}) = 0<br>
 [pid 18615] 18:18:15 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18615] 18:18:15 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4050643676) = 0<br>
 [pid 18615] 18:18:15 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18615] 18:18:15 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 291949320}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 392767872}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18620] 18:18:15 <... poll resumed> ) = 0 (Timeout)<br>
 [pid 18620] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 423866840}) = 0<br>
 [pid 18620] 18:18:15 poll([{fd=5, events=POLLIN}], 1, 1000 <unfinished<br>
 ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 493554528}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 594343716}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 695131520}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 795928848}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 896786468}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:15 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:15 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:15 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:15 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:15 clock_gettime(CLOCK_REALTIME, {1291997895,<br>
 997543276}) = 0<br>
 [pid 18619] 18:18:15 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:16 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:16 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:16 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:16 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:16 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896, 98361332})<br>
 = 0<br>
 [pid 18619] 18:18:16 epoll_wait(10,  <unfinished ...><br>
 [pid 18618] 18:18:16 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:16 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:16 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:16 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:16 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896,<br>
 199182492}) = 0<br>
 [pid 18619] 18:18:16 epoll_wait(10,  <unfinished ...><br>
 [pid 18612] 18:18:16 <... nanosleep resumed> NULL) = 0<br>
 [pid 18612] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896,<br>
 242623312}) = 0<br>
 [pid 18612] 18:18:16 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18617] 18:18:16 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18617] 18:18:16 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18617] 18:18:16 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4033866460) = 0<br>
 [pid 18617] 18:18:16 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18617] 18:18:16 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18615] 18:18:16 <... nanosleep resumed> {1, 0}) = 0<br>
 [pid 18615] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896,<br>
 255275216}) = 0<br>
 [pid 18615] 18:18:16 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0<br>
 [pid 18615] 18:18:16 rt_sigaction(SIGCHLD, NULL, {0xf7f30798, [],<br>
 SA_NOCLDSTOP}, 0, 4050643676) = 0<br>
 [pid 18615] 18:18:16 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0<br>
 [pid 18615] 18:18:16 nanosleep({1, 0},  <unfinished ...><br>
 [pid 18618] 18:18:16 <... nanosleep resumed> NULL) = 0<br>
 [pid 18618] 18:18:16 write(8, "R"..., 1) = 1<br>
 [pid 18619] 18:18:16 <... epoll_wait resumed> {{EPOLLIN, {u32=570960,<br>
 u64=2452254527324160}}}, 100, -1) = 1<br>
 [pid 18618] 18:18:16 nanosleep({0, 100000000},  <unfinished ...><br>
 [pid 18619] 18:18:16 read(7, "R"..., 1) = 1<br>
 [pid 18619] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896,<br>
 299975276}) = 0<br>
 [pid 18619] 18:18:16 epoll_wait(10,  <unfinished ...><br>
 [pid 18620] 18:18:16 <... poll resumed> ) = 1 ([{fd=5, revents=POLLIN}])<br>
 [pid 18620] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896,<br>
 315826092}) = 0<br>
 [pid 18620] 18:18:16 accept(5, {sa_family=AF_INET, sin_port=htons(42033),<br>
</div></div> sin_addr=inet_addr("x.y.z.86")}, [16]) = 19<br>
<div> [pid 18620] 18:18:16 futex(0xf19db18c, FUTEX_WAKE_OP_PRIVATE, 1, 1,<br>
 0xf19db188, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1<br>
 [pid 18629] 18:18:16 <... futex resumed> ) = 0<br>
 [pid 18620] 18:18:16 poll([{fd=5, events=POLLIN}], 1, 1000 <unfinished<br>
 ...><br>
 [pid 18629] 18:18:16 futex(0xf7a109b4, FUTEX_WAKE_PRIVATE, 1) = 0<br>
 [pid 18629] 18:18:16 ioctl(19, 0x8004667e, 0xf19d442c) = 0<br>
 [pid 18629] 18:18:16 poll([{fd=19, events=POLLIN}], 1, 50) = 1 ([{fd=19,<br>
 revents=POLLIN}])<br>
</div> [pid 18629] 18:18:16 read(19, "GET / HTTP/1.1\r\nHost: www.Xspo"..., 8191)<br>
<div><div></div><div> = 99<br>
 [pid 18629] 18:18:16 clock_gettime(CLOCK_REALTIME, {1291997896,<br>
 318403888}) = 0<br>
 [pid 18629] 18:18:16 futex(0xf19db18c, FUTEX_WAIT_PRIVATE, 25629, NULL<br>
 <unfinished ...><br>
 [pid 18611] 18:18:16 <... poll resumed> ) = 1 ([{fd=6, revents=POLLHUP}])<br>
 [pid 18611] 18:18:16 close(6)           = 0<br>
 [pid 18611] 18:18:16 close(9)           = 0<br>
 [pid 18611] 18:18:16 close(5)           = 0<br>
 [pid 18611] 18:18:16 write(1, "Child dies"..., 10) = -1 EPIPE (Broken<br>
 pipe)<br>
 [pid 18611] 18:18:16 --- SIGPIPE (Broken pipe) @ 0 (0) ---<br>
 [pid 18611] 18:18:16 exit_group(1)      = ?<br>
 Process 18611 detached<br>
 [pid 18612] 18:18:16 <... nanosleep resumed> 0) = ? ERESTART_RESTARTBLOCK<br>
 (To be restarted)<br>
 [pid 18614] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18615] 18:18:16 <... nanosleep resumed> 0xf16fec68) = ?<br>
 ERESTART_RESTARTBLOCK (To be restarted)<br>
 [pid 18616] 18:18:16 <... nanosleep resumed> 0) = ? ERESTART_RESTARTBLOCK<br>
 (To be restarted)<br>
 [pid 18617] 18:18:16 <... nanosleep resumed> 0xf06fec68) = ?<br>
 ERESTART_RESTARTBLOCK (To be restarted)<br>
 [pid 18618] 18:18:16 <... nanosleep resumed> 0) = ? ERESTART_RESTARTBLOCK<br>
 (To be restarted)<br>
 [pid 18619] 18:18:16 <... epoll_wait resumed> ef6feb20, 100, -1) = -1<br>
 EINTR (Interrupted system call)<br>
 [pid 18620] 18:18:16 <... poll resumed> ) = 1 ([{fd=5, revents=POLLNVAL}])<br>
 [pid 18622] 18:18:16 <... read resumed> 0xf7b59108, 8191) = -1 EINTR<br>
 (Interrupted system call)<br>
 [pid 18623] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18624] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18625] 18:18:16 <... read resumed> 0xf7b2839a, 1) = -1 EINTR<br>
 (Interrupted system call)<br>
 [pid 18626] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18627] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18628] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18629] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 [pid 18630] 18:18:16 <... futex resumed> ) = ? ERESTARTSYS (To be<br>
 restarted)<br>
 Process 18611 detached<br>
 Process 18984 detached<br>
 }}}<br>
 All I can see is the SIGPIPE and the ERESTARTSYS (those two things do not<br>
 appear until the freeze).<br>
<br>
</div></div> Varnish default conf: -f /srv/varnish/conf/XXXXXXXX.vcl -s malloc,1024M -a<br>
<div><div></div><div> <a href="http://0.0.0.0:8080" target="_blank">0.0.0.0:8080</a><br>
<br>
 VCL:<br>
 {{{<br>
 backend default {<br>
     .host = "XX.YY.ZZ.WW";<br>
     .port = "80";<br>
 }<br>
<br>
<br>
 sub vcl_recv {<br>
         if (req.url ~ "cgi-bin") {<br>
                 return (pipe);<br>
         }<br>
<br>
     if (req.http.Accept-Encoding) {<br>
                 if (req.http.Accept-Encoding ~ "gzip") {<br>
                                 set req.http.Accept-Encoding = "gzip";<br>
                 } elsif (req.http.Accept-Encoding ~ "deflate") {<br>
                                 set req.http.Accept-Encoding = "deflate";<br>
                 } else {<br>
                                 # unkown algorithm<br>
                                 remove req.http.Accept-Encoding;<br>
                 }<br>
         }<br>
<br>
     if (req.http.Accept-Language) {<br>
         remove req.http.Accept-Language;<br>
     }<br>
<br>
     if (req.http.User-Agent) {<br>
         remove req.http.User-Agent;<br>
     }<br>
<br>
     if (req.http.Host ~ "<a href="http://live.XXXXXXXX.ro" target="_blank">live.XXXXXXXX.ro</a>" || req.http.Host ~<br>
 "<a href="http://live2.XXXXXXXX.ro" target="_blank">live2.XXXXXXXX.ro</a>") {<br>
         return (pipe);<br>
     }<br>
<br>
     if (req.request != "GET" && req.request != "HEAD") {<br>
         return (pass);<br>
     }<br>
<br>
     if (req.url ~ "\.(png|gif|jpg|swf)" || req.url ~ "/img/" || req.url ~<br>
 "\.(js|css)") {<br>
<br>
<br>
         remove req.http.cookie;<br>
         return (lookup);<br>
     }<br>
<br>
     if (<br>
         !(req.url ~ "wp-(login|admin)") &&<br>
         !(req.http.Cookie ~ "wordpress_logged_in")<br>
     ) {<br>
         remove req.http.cookie;<br>
         return (lookup);<br>
     } else {<br>
         return (pass);<br>
     }<br>
<br>
<br>
<br>
<br>
     if (req.http.Cookie ~ "wordpress_logged_in") {<br>
         return (pass);<br>
     } else {<br>
         return (lookup);<br>
     }<br>
 }<br>
<br>
 sub vcl_fetch {<br>
<br>
     if (req.http.Host ~ "<a href="http://live.XXXXXXX.ro" target="_blank">live.XXXXXXX.ro</a>" || req.http.Host ~<br>
 "<a href="http://live2.XXXXXXXX.ro" target="_blank">live2.XXXXXXXX.ro</a>") {<br>
         return(pass);<br>
     }<br>
<br>
         if (beresp.http.Content-Type ~ "text/html") {<br>
                 //set beresp.http.Cache-Control = "no-store, no-cache,<br>
 must-revalidate, post-check=0, pre-check=0";<br>
                 //set beresp.http.Pragma = "no-cache";<br>
         }<br>
<br>
     if (!(req.url ~ "wp-(login|admin)")) {<br>
         #remove beresp.http.set-cookie;<br>
     }<br>
<br>
     if (req.url ~ "\.(png|gif|jpg|swf)" || req.url ~ "/img/" ||<br>
 beresp.http.Content-Type ~ "javascript" || beresp.http.Content-Type ~<br>
 "css") {<br>
         remove beresp.http.set-cookie;<br>
         //log "request-ul se preteaza: " beresp.http.Content-Type;<br>
         set beresp.ttl = 7200s;<br>
         return (deliver);<br>
     } else {<br>
         set beresp.ttl = 240s;<br>
     }<br>
<br>
 }<br>
 }}}<br>
 I cannot link any request to the crash event.<br>
<br>
--<br>
</div></div>Ticket URL: <<a href="http://www.varnish-cache.org/trac/ticket/835#comment:1" target="_blank">http://www.varnish-cache.org/trac/ticket/835#comment:1</a>><br>
</div></div><div><div></div><div><div><div></div><div class="h5">Varnish <<a href="http://varnish-cache.org/" target="_blank">http://varnish-cache.org/</a>><br>
The Varnish HTTP Accelerator<br>
<br></div></div>
_______________________________________________<br>
varnish-bugs mailing list<br>
<a href="mailto:varnish-bugs@varnish-cache.org" target="_blank">varnish-bugs@varnish-cache.org</a><br>
<a href="http://www.varnish-cache.org/lists/mailman/listinfo/varnish-bugs" target="_blank">http://www.varnish-cache.org/lists/mailman/listinfo/varnish-bugs</a><br>
</div></div></blockquote></div><br><br clear="all"><br>-- <br><br style="font-family:verdana,sans-serif"><span style="font-family:verdana,sans-serif">Att,</span><br style="font-family:verdana,sans-serif"><font color="#888888"><br style="font-family:verdana,sans-serif">


<span style="font-family:verdana,sans-serif">Renato Farias</span><br><br>
</font></blockquote></div><br></div>