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>