Ticket #1338: lighttpd.trace

File lighttpd.trace, 14.5 kB (added by zlib, 13 months ago)
Line 
110:54:31.316762 futex(0x822de5c, FUTEX_WAKE, 1) = 1
210:54:31.317110 futex(0x822de58, FUTEX_WAKE, 1) = 1
310:54:31.317170 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
410:54:31.317236 time(NULL)              = 1189331671
510:54:31.317299 futex(0x822d76c, FUTEX_WAKE, 1) = 1
610:54:31.317353 futex(0x822d768, FUTEX_WAKE, 1) = 1
710:54:31.317429 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=14, events=POLLIN}, {fd=-1}, {fd=-1}], 8, 1000) = 0
810:54:32.318462 time(NULL)              = 1189331672
910:54:32.318597 futex(0x822d76c, FUTEX_WAKE, 1) = 1
1010:54:32.318658 futex(0x822d768, FUTEX_WAKE, 1) = 1
1110:54:32.318724 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=14, events=POLLIN, revents=POLLIN}, {fd=-1}, {fd=-1}], 8, 1000) = 1
1210:54:32.720087 futex(0x822de5c, FUTEX_WAKE, 1) = 1
1310:54:32.720149 futex(0x822de58, FUTEX_WAKE, 1) = 1
1410:54:32.720213 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
1510:54:32.720289 read(14, "GET /css/style.css?2 HTTP/1.1\r\nHost: alpha.mingleville.com\r\nUser-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; en-GB; rv:1.8.1.6) Gecko/20070725 Firefox/2.0.0.6\r\nAccept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\r\nAccept-Language: en-gb,en;q=0.5\r\nAccept-Encoding: gzip,deflate\r\nAccept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\r\nKeep-Alive: 300\r\nConnection: keep-alive\r\nCookie: al=zlib%40blackbox.idlenet%3Aa855ca43f43a4b23ee085105a1f71850%3Aa4d06f74d04bbe9b4724adfe9d628b79%3A1189330946; __utma=233640322.549562856.1189289227.1189289227.1189329169.2; __utmz=233640322.1189289227.1.1.utmccn=(direct)|utmcsr=(direct)|utmcmd=(none); loginauto=T0RjPTo6YkhWamFXWmxjZz09OjozY2Q0Y2Q4Mjk5YTM3MGVlYzVmZTQwNGY2ZmFmMmVlNA%3D%3D; __utmb=233640322; sid=eM5EIu4UMZoVruE%2CmwFxX5BSEid; up=a855ca43f43a4b23ee085105a1f71850\r\nIf-Modified-Since: Sat, 25 Aug 2007 16:37:37 GMT\r\nIf-None-Match: \"-812456758\"\r\nAuthorization: Digest username=\"devChris\", realm=\"dev@mingleville\", nonce=\"46c3cd8436fa61c1a2c7e9d66a966edc\", uri=\"/css/style.css?2\", response=\"59e32b7f31754d9f18d9e3594d271d81\", qop=auth, nc=00000043, cnonce=\"16d4ab7b41701131\"\r\nCache-Control: max-age=0\r\n\r\n", 16384) = 1201
1610:54:32.720982 stat64("/etc/lighttpd/lighttpd-htdigest.user", {st_mode=S_IFREG|0644, st_size=115, ...}) = 0
1710:54:32.721130 open("/etc/lighttpd/lighttpd-htdigest.user", O_RDONLY|O_LARGEFILE) = 15
1810:54:32.721225 mmap2(NULL, 115, PROT_READ, MAP_SHARED, 15, 0) = 0xb4d5b000
1910:54:32.721313 close(15)               = 0
2010:54:32.721377 munmap(0xb4d5b000, 115) = 0
2110:54:32.721525 socket(PF_INET, SOCK_STREAM, IPPROTO_IP) = 15
2210:54:32.721620 fcntl64(15, F_SETFL, O_RDWR|O_NONBLOCK) = 0
2310:54:32.721680 connect(15, {sa_family=AF_INET, sin_port=htons(81), sin_addr=inet_addr("10.0.0.21")}, 16) = -1 EINPROGRESS (Operation now in progress)
2410:54:32.721906 time(NULL)              = 1189331672
2510:54:32.721964 futex(0x822d76c, FUTEX_WAKE, 1) = 1
2610:54:32.722027 futex(0x822d768, FUTEX_WAKE, 1) = 1
2710:54:32.722099 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN, revents=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLOUT, revents=POLLOUT}, {fd=-1}, {fd=14, events=POLLHUP}], 8, 1000) = 2
2810:54:32.722215 futex(0x822de5c, FUTEX_WAKE, 1) = 1
2910:54:32.722272 futex(0x822de58, FUTEX_WAKE, 1) = 1
3010:54:32.722326 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
3110:54:32.722397 accept(7, {sa_family=AF_INET, sin_port=htons(33072), sin_addr=inet_addr("10.0.0.21")}, [16]) = 16
3210:54:32.722535 fcntl64(16, F_SETFD, FD_CLOEXEC) = 0
3310:54:32.722595 fcntl64(16, F_SETFL, O_RDWR|O_NONBLOCK) = 0
3410:54:32.722653 accept(7, 0xbfe2a900, [112]) = -1 EAGAIN (Resource temporarily unavailable)
3510:54:32.722748 getsockopt(15, SOL_SOCKET, SO_ERROR, [0], [4]) = 0
3610:54:32.722900 read(16, 0x830b1f8, 16384) = -1 EAGAIN (Resource temporarily unavailable)
3710:54:32.722974 time(NULL)              = 1189331672
3810:54:32.723029 futex(0x822d76c, FUTEX_WAKE, 1) = 1
3910:54:32.723083 futex(0x822d768, FUTEX_WAKE, 1) = 1
4010:54:32.723188 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN|POLLOUT, revents=POLLOUT}, {fd=16, events=POLLIN}, {fd=14, events=POLLHUP}], 8, 1000) = 1
4110:54:32.723290 futex(0x822de5c, FUTEX_WAKE, 1) = 1
4210:54:32.723343 futex(0x822de58, FUTEX_WAKE, 1) = 1
4310:54:32.723396 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
4410:54:32.723455 writev(15, [{"GET /css/style.css?2 HTTP/1.1\r\nX-Forwarded-For: 10.0.0.3\r\nX-Host: alpha.mingleville.com\r\nX-Forwarded-Proto: http\r\nHost: alpha.mingleville.com\r\nUser-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; en-GB; rv:1.8.1.6) Gecko/20070725 Firefox/2.0.0.6\r\nAccept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\r\nAccept-Language: en-gb,en;q=0.5\r\nAccept-Encoding: gzip,deflate\r\nAccept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\r\nCookie: al=zlib%40blackbox.idlenet%3Aa855ca43f43a4b23ee085105a1f71850%3Aa4d06f74d04bbe9b4724adfe9d628b79%3A1189330946; __utma=233640322.549562856.1189289227.1189289227.1189329169.2; __utmz=233640322.1189289227.1.1.utmccn=(direct)|utmcsr=(direct)|utmcmd=(none); loginauto=T0RjPTo6YkhWamFXWmxjZz09OjozY2Q0Y2Q4Mjk5YTM3MGVlYzVmZTQwNGY2ZmFmMmVlNA%3D%3D; __utmb=233640322; sid=eM5EIu4UMZoVruE%2CmwFxX5BSEid; up=a855ca43f43a4b23ee085105a1f71850\r\nIf-Modified-Since: Sat, 25 Aug 2007 16:37:37 GMT\r\nIf-None-Match: \"-812456758\"\r\nAuthorization: Digest username=\"devChris\", realm=\"dev@mingleville\", nonce=\"46c3cd8436fa61c1a2c7e9d66a966edc\", uri=\"/css/style.css?2\", response=\"59e32b7f31754d9f18d9e3594d271d81\", qop=auth, nc=00000043, cnonce=\"16d4ab7b41701131\"\r\nCache-Control: max-age=0\r\n\r\n", 1243}], 1) = 1243
4510:54:32.723955 time(NULL)              = 1189331672
4610:54:32.724009 futex(0x822d76c, FUTEX_WAKE, 1) = 1
4710:54:32.724063 futex(0x822d768, FUTEX_WAKE, 1) = 1
4810:54:32.724123 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN, revents=POLLIN}, {fd=14, events=POLLHUP}], 8, 1000) = 1
4910:54:32.724216 futex(0x822de5c, FUTEX_WAKE, 1) = 1
5010:54:32.724270 futex(0x822de58, FUTEX_WAKE, 1) = 1
5110:54:32.724323 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
5210:54:32.724383 read(16, "GET /css/style.css?2 HTTP/1.1\r\nX-Forwarded-For: 10.0.0.3\r\nX-Host: alpha.mingleville.com\r\nX-Forwarded-Proto: http\r\nHost: alpha.mingleville.com\r\nUser-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; en-GB; rv:1.8.1.6) Gecko/20070725 Firefox/2.0.0.6\r\nAccept: text/xml,application/xml,application/xhtml+xml,text/html;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5\r\nAccept-Language: en-gb,en;q=0.5\r\nAccept-Encoding: gzip,deflate\r\nAccept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7\r\nCookie: al=zlib%40blackbox.idlenet%3Aa855ca43f43a4b23ee085105a1f71850%3Aa4d06f74d04bbe9b4724adfe9d628b79%3A1189330946; __utma=233640322.549562856.1189289227.1189289227.1189329169.2; __utmz=233640322.1189289227.1.1.utmccn=(direct)|utmcsr=(direct)|utmcmd=(none); loginauto=T0RjPTo6YkhWamFXWmxjZz09OjozY2Q0Y2Q4Mjk5YTM3MGVlYzVmZTQwNGY2ZmFmMmVlNA%3D%3D; __utmb=233640322; sid=eM5EIu4UMZoVruE%2CmwFxX5BSEid; up=a855ca43f43a4b23ee085105a1f71850\r\nIf-Modified-Since: Sat, 25 Aug 2007 16:37:37 GMT\r\nIf-None-Match: \"-812456758\"\r\nAuthorization: Digest username=\"devChris\", realm=\"dev@mingleville\", nonce=\"46c3cd8436fa61c1a2c7e9d66a966edc\", uri=\"/css/style.css?2\", response=\"59e32b7f31754d9f18d9e3594d271d81\", qop=auth, nc=00000043, cnonce=\"16d4ab7b41701131\"\r\nCache-Control: max-age=0\r\n\r\n", 16384) = 1243
5310:54:32.725015 stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1323, ...}) = 0
5410:54:32.725156 writev(16, [{"HTTP/1.1 304 Not Modified\r\nContent-Type: text/css\r\nETag: \"-812456758\"\r\nAccept-Ranges: bytes\r\nLast-Modified: Sat, 25 Aug 2007 16:37:37 GMT\r\nDate: Sun, 09 Sep 2007 09:54:32 GMT\r\nServer: lighttpd\r\n\r\n", 196}], 1) = 196
5510:54:32.725350 stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1323, ...}) = 0
5610:54:32.725508 write(3, "10.0.0.21 alpha.mingleville.com - [09/Sep/2007:10:54:32 +0100] \"GET /css/style.css?2 HTTP/1.1\" 304 0 \"-\" \"Mozilla/5.0 (Windows; U; Windows NT 5.1; en-GB; rv:1.8.1.6) Gecko/20070725 Firefox/2.0.0.6\"\n", 198) = 198
5710:54:32.725656 read(16, 0x830b1f8, 16384) = -1 EAGAIN (Resource temporarily unavailable)
5810:54:32.725727 time(NULL)              = 1189331672
5910:54:32.725782 futex(0x822d76c, FUTEX_WAKE, 1) = 1
6010:54:32.725838 futex(0x822d768, FUTEX_WAKE, 1) = 1
6110:54:32.725906 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN, revents=POLLIN}, {fd=16, events=POLLIN}, {fd=14, events=POLLHUP}], 8, 1000) = 1
6210:54:32.726006 futex(0x822de5c, FUTEX_WAKE, 1) = 1
6310:54:32.726061 futex(0x822de58, FUTEX_WAKE, 1) = 1
6410:54:32.726114 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
6510:54:32.726178 read(15, "HTTP/1.1 304 Not Modified\r\nContent-Type: text/css\r\nETag: \"-812456758\"\r\nAccept-Ranges: bytes\r\nLast-Modified: Sat, 25 Aug 2007 16:37:37 GMT\r\nDate: Sun, 09 Sep 2007 09:54:32 GMT\r\nServer: lighttpd\r\n\r\n", 16384) = 196
6610:54:32.726406 time(NULL)              = 1189331672
6710:54:32.726464 futex(0x822d76c, FUTEX_WAKE, 1) = 1
6810:54:32.726516 futex(0x822d768, FUTEX_WAKE, 1) = 1
6910:54:32.726577 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN}, {fd=-1}], 8, 1000) = 0
7010:54:33.727241 futex(0x822de5c, FUTEX_WAKE, 1) = 1
7110:54:33.727349 futex(0x822de58, FUTEX_WAKE, 1) = 1
7210:54:33.727408 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
7310:54:33.727473 time(NULL)              = 1189331673
7410:54:33.727570 futex(0x822d76c, FUTEX_WAKE, 1) = 1
7510:54:33.727625 futex(0x822d768, FUTEX_WAKE, 1) = 1
7610:54:33.727688 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN}, {fd=-1}], 8, 1000) = 0
7710:54:34.728087 futex(0x822de5c, FUTEX_WAKE, 1) = 1
7810:54:34.728181 futex(0x822de58, FUTEX_WAKE, 1) = 1
7910:54:34.728236 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
8010:54:34.728300 time(NULL)              = 1189331674
8110:54:34.728404 futex(0x822d76c, FUTEX_WAKE, 1) = 1
8210:54:34.728459 futex(0x822d768, FUTEX_WAKE, 1) = 1
8310:54:34.728522 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN}, {fd=-1}], 8, 1000) = 0
8410:54:35.728935 futex(0x822de5c, FUTEX_WAKE, 1) = 1
8510:54:35.729032 futex(0x822de58, FUTEX_WAKE, 1) = 1
8610:54:35.729089 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
8710:54:35.729153 time(NULL)              = 1189331675
8810:54:35.729249 futex(0x822d76c, FUTEX_WAKE, 1) = 1
8910:54:35.729304 futex(0x822d768, FUTEX_WAKE, 1) = 1
9010:54:35.729368 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN}, {fd=-1}], 8, 1000) = 0
9110:54:36.729785 futex(0x822de5c, FUTEX_WAKE, 1) = 1
9210:54:36.729888 futex(0x822de58, FUTEX_WAKE, 1) = 1
9310:54:36.729945 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
9410:54:36.730010 time(NULL)              = 1189331676
9510:54:36.730106 futex(0x822d76c, FUTEX_WAKE, 1) = 1
9610:54:36.730163 futex(0x822d768, FUTEX_WAKE, 1) = 1
9710:54:36.730226 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN}, {fd=-1}], 8, 1000) = 0
9810:54:37.730637 futex(0x822de5c, FUTEX_WAKE, 1) = 1
9910:54:37.730740 futex(0x822de58, FUTEX_WAKE, 1) = 1
10010:54:37.730799 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
10110:54:37.730863 time(NULL)              = 1189331677
10210:54:37.730960 futex(0x822d76c, FUTEX_WAKE, 1) = 1
10310:54:37.731014 futex(0x822d768, FUTEX_WAKE, 1) = 1
10410:54:37.731078 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN}, {fd=16, events=POLLIN}, {fd=-1}], 8, 1000) = 0
10510:54:38.731529 futex(0x822de5c, FUTEX_WAKE, 1) = 1
10610:54:38.731642 futex(0x822de58, FUTEX_WAKE, 1) = 1
10710:54:38.731701 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
10810:54:38.731766 time(NULL)              = 1189331678
10910:54:38.731892 shutdown(16, 1 /* send */) = 0
11010:54:38.732016 close(16)               = 0
11110:54:38.732096 futex(0x822d76c, FUTEX_WAKE, 1) = 1
11210:54:38.732152 futex(0x822d768, FUTEX_WAKE, 1) = 1
11310:54:38.732218 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=15, events=POLLIN, revents=POLLIN}, {fd=-1}, {fd=-1}], 8, 1000) = 1
11410:54:38.732325 futex(0x822de5c, FUTEX_WAKE, 1) = 1
11510:54:38.732380 futex(0x822de58, FUTEX_WAKE, 1) = 1
11610:54:38.732434 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
11710:54:38.732506 read(15, "", 16384)     = 0
11810:54:38.732623 close(15)               = 0
11910:54:38.732762 setsockopt(14, SOL_TCP, TCP_CORK, [1], 4) = 0
12010:54:38.732841 writev(14, [{"HTTP/1.1 304 Not Modified\r\nContent-Type: text/css\r\nETag: \"-812456758\"\r\nAccept-Ranges: bytes\r\nLast-Modified: Sat, 25 Aug 2007 16:37:37 GMT\r\nDate: Sun, 09 Sep 2007 09:54:32 GMT\r\nServer: lighttpd\r\nTransfer-Encoding: chunked\r\n\r\n", 224}, {"0\r\n\r\n", 5}], 2) = 229
12110:54:38.732993 setsockopt(14, SOL_TCP, TCP_CORK, [0], 4) = 0
12210:54:38.733120 stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1323, ...}) = 0
12310:54:38.733268 write(11, "10.0.0.3 alpha.mingleville.com devChris [09/Sep/2007:10:54:38 +0100] \"GET /css/style.css?2 HTTP/1.1\" 304 5 \"-\" \"Mozilla/5.0 (Windows; U; Windows NT 5.1; en-GB; rv:1.8.1.6) Gecko/20070725 Firefox/2.0.0.6\"\n", 204) = 204
12410:54:38.733472 read(14, 0x830b1f8, 16384) = -1 EAGAIN (Resource temporarily unavailable)
12510:54:38.733546 time(NULL)              = 1189331678
12610:54:38.733601 futex(0x822d76c, FUTEX_WAKE, 1) = 1
12710:54:38.733659 futex(0x822d768, FUTEX_WAKE, 1) = 1
12810:54:38.733727 poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}, {fd=6, events=POLLIN}, {fd=7, events=POLLIN}, {fd=8, events=POLLIN}, {fd=14, events=POLLIN}, {fd=-1}, {fd=-1}], 8, 1000) = 0
12910:54:39.734323 futex(0x822de5c, FUTEX_WAKE, 1) = 1
13010:54:39.734416 futex(0x822de58, FUTEX_WAKE, 1) = 1
13110:54:39.734475 futex(0x822d6f0, FUTEX_WAKE, 1) = 1
13210:54:39.734556 read(14, 0x830b1f8, 16384) = -1 EAGAIN (Resource temporarily unavailable)
13310:54:39.734639 time(NULL)              = 1189331679
13410:54:39.734733 futex(0x822d76c, FUTEX_WAKE, 1) = 1
13510:54:39.734789 futex(0x822d768, FUTEX_WAKE, 1) = 1
13610:54:39.734852 poll( <unfinished ...>