Cycle with SSI ON in nginx config
Georgi Georgiev
gogo at dirbg.com
Thu Jan 29 17:35:23 MSK 2009
Hi to all,
I'm trying to use memcache with nginx and if ssi set to on to add
additional info on cached pages .
So configuration is :
.........
server {
listen *:8080;
server_name blabla;
access_log off;
location / {
# add_header Content-Type "text/html; charset=utf-8";
ssi_types application/octet-stream text/html;
if ($request_method = POST) {
proxy_pass http://127.0.0.1:8010;
break;
}
set $memcached_key "$host:$request_uri";
ssi on;
memcached_pass 10.100.0.47:11211;
proxy_intercept_errors on;
default_type text/html;
error_page 404 502 403 = /_fall_ ;
}
location = /dyn {
internal;
proxy_set_header Referer $http_referer;
proxy_set_header Host $host;
proxy_set_header X-Real-IP $remote_addr;
proxy_set_header X-Forwarded-For $proxy_add_x_forwarded_for;
proxy_redirect off;
proxy_pass http://127.0.0.1:8010;
}
location = /_fall_ {
internal;
ssi on;
proxy_pass http://127.0.0.1:8010;
# proxy_pass http://127.0.0.1:8010$request_uri;
proxy_set_header Referer $http_referer;
proxy_set_header Host $host;
proxy_set_header X-Real-IP $remote_addr;
proxy_set_header X-Forwarded-For $proxy_add_x_forwarded_for;
proxy_redirect off;
client_max_body_size 10m;
client_body_buffer_size 128k;
proxy_connect_timeout 90;
proxy_send_timeout 90;
proxy_read_timeout 90;
proxy_buffer_size 4k;
proxy_buffers 4 32k;
proxy_busy_buffers_size 64k;
proxy_temp_file_write_size 64k;
}
}
.
When I put on php file
<!--# include virtual="blabla/dyn" -->
I see ssi cycle ...
Nginx debug :
Server: nginx/0.6.32
Date: Thu, 29 Jan 2009 12:54:53 GMT
Content-Type: text/html; charset=windows-1251
Transfer-Encoding: chunked
Connection: close
Expires: Thu, 19 Nov 1981 08:52:00 GMT
Cache-Control: no-store, no-cache, must-revalidate, post-check=0,
pre-check=0
Pragma: no-cache
Content-Encoding: gzip
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:1 f:0
0000000002115D20, pos 0000000002115D20, size: 333 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter: l:0 f:0 s:333
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream process upstream
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe read upstream: 1
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe preread: 3760
2009/01/29 14:54:53 [debug] 28499#0: *7 input buf #0
2009/01/29 14:54:53 [debug] 28499#0: *7 malloc: 0000000002116B30:32768
2009/01/29 14:54:53 [debug] 28499#0: *7 readv: 1:32768
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe recv chain: 5157
2009/01/29 14:54:53 [debug] 28499#0: *7 readv: 1:27611
2009/01/29 14:54:53 [debug] 28499#0: *7 readv() not ready (11: Resource
temporarily unavailable)
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe recv chain: -2
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe buf in s:1 t:1 f:0
00000000020FCD10, pos 00000000020FCE60, size: 3760 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe buf free s:0 t:1 f:0
0000000002116B30, pos 0000000002116B30, size: 5157 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write downstream: 1
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write busy: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write buf ls:1 00000000020FCE60
3760
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write: out:00000000020FCCE0,
f:0
2009/01/29 14:54:53 [debug] 28499#0: *7 http output filter "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 http ssi filter "/_fall_"
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0 state: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 parse: -2, looked: 0
00000000020FCE60-00000000020FDD10
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi out: 0000000002116080
00000000020FCE60
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter "/_fall_?"
00000000021160D0
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter out "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 malloc: 00007F659E377010:270336
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip alloc: n:1 s:5928 a:8192
p:00007F659E377010
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip alloc: n:32768 s:2 a:65536
p:00007F659E379010
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip alloc: n:32768 s:2 a:65536
p:00007F659E389010
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip alloc: n:32768 s:2 a:65536
p:00007F659E399010
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip alloc: n:16384 s:4 a:65536
p:00007F659E3A9010
2009/01/29 14:54:53 [debug] 28499#0: *7 http chunk: 10
2009/01/29 14:54:53 [debug] 28499#0: *7 write old buf t:1 f:0
0000000002115D20, pos 0000000002115D20, size: 333 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:1 f:0
0000000000000000, pos 00000000021161A0, size: 3 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:0 f:0
0000000000000000, pos 0000000000676448, size: 10 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:0 f:0
0000000000000000, pos 000000000046323D, size: 2 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter: l:0 f:0 s:348
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 0000000002116238
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:0000000002116080
ni:00000000020FCE60 ai:3760
2009/01/29 14:54:53 [debug] 28499#0: *7 malloc: 000000000211EB40:4096
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate in: ni:00000000020FCE60
no:000000000211EB40 ai:3760 ao:4096 fl:0 redo:0
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate out: ni:00000000020FDD10
no:000000000211EB40 ai:0 ao:4096 rc:0
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:0000000002116080
pos:00000000020FCE60
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: 0 "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write busy: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write: out:0000000000000000,
f:0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe read upstream: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe buf free s:0 t:1 f:0
0000000002116B30, pos 0000000002116B30, size: 5157 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe buf free s:0 t:1 f:0
00000000020FCD10, pos 00000000020FCD10, size: 0 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer: 15, old: 1233233783830,
new: 1233233783902
2009/01/29 14:54:53 [debug] 28499#0: posted event 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: worker cycle
2009/01/29 14:54:53 [debug] 28499#0: accept mutex locked
2009/01/29 14:54:53 [debug] 28499#0: epoll timer: 89928
2009/01/29 14:54:53 [debug] 28499#0: epoll: fd:15 ev:0005 d:00007F65A05301F1
2009/01/29 14:54:53 [debug] 28499#0: *7 post event 00007F659E4BD148
2009/01/29 14:54:53 [debug] 28499#0: *7 post event 00007F659E3BA148
2009/01/29 14:54:53 [debug] 28499#0: timer delta: 1
2009/01/29 14:54:53 [debug] 28499#0: posted events 00007F659E3BA148
2009/01/29 14:54:53 [debug] 28499#0: posted event 00007F659E3BA148
2009/01/29 14:54:53 [debug] 28499#0: *7 delete posted event 00007F659E3BA148
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream dummy handler
2009/01/29 14:54:53 [debug] 28499#0: posted event 00007F659E4BD148
2009/01/29 14:54:53 [debug] 28499#0: *7 delete posted event 00007F659E4BD148
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream process upstream
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe read upstream: 1
2009/01/29 14:54:53 [debug] 28499#0: *7 readv: 2:4096
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe recv chain: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe buf free s:0 t:1 f:0
0000000002116B30, pos 0000000002116B30, size: 5157 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe buf free s:0 t:1 f:0
00000000020FCD10, pos 00000000020FCD10, size: 0 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 input buf #1
2009/01/29 14:54:53 [debug] 28499#0: *7 free: 00000000020FCD10
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write downstream: 1
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write downstream flush in
2009/01/29 14:54:53 [debug] 28499#0: *7 http output filter "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 http ssi filter "/_fall_"
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0 state: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 parse: 0, looked: 0
0000000002116B30-0000000002117AE6
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi out: 0000000002116080
0000000002116B30
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter "/_fall_?"
00000000021160D0
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter out "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 0000000002116448
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:0000000002116080
ni:0000000002116B30 ai:4022
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate in: ni:0000000002116B30
no:000000000211EB40 ai:4022 ao:4096 fl:0 redo:0
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate out: ni:0000000002117AE6
no:000000000211EB40 ai:0 ao:4096 rc:0
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:0000000002116080
pos:0000000002116B30
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi include:
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 malloc: 00000000020FCD10:4096
2009/01/29 14:54:53 [debug] 28499#0: *7 http subrequest
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 generic phase: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 find location for
"/http://blablabla/dyn/calculate_minutes_ago.php"
2009/01/29 14:54:53 [debug] 28499#0: *7 find location: "/"
2009/01/29 14:54:53 [debug] 28499#0: *7 find location: = "/_fall_"
2009/01/29 14:54:53 [debug] 28499#0: *7 find location: = "/dyn"
2009/01/29 14:54:53 [debug] 28499#0: *7 find location for
"/http://blablabla/dyn/calculate_minutes_ago.php"
2009/01/29 14:54:53 [debug] 28499#0: *7 using configuration "/"
2009/01/29 14:54:53 [debug] 28499#0: *7 http cl:-1 max:1048576
2009/01/29 14:54:53 [debug] 28499#0: *7 generic phase: 2
2009/01/29 14:54:53 [debug] 28499#0: *7 http script var
2009/01/29 14:54:53 [debug] 28499#0: *7 http script var: "GET"
2009/01/29 14:54:53 [debug] 28499#0: *7 http script value: "POST"
2009/01/29 14:54:53 [debug] 28499#0: *7 http script equal
2009/01/29 14:54:53 [debug] 28499#0: *7 http script equal: no
2009/01/29 14:54:53 [debug] 28499#0: *7 http script if
2009/01/29 14:54:53 [debug] 28499#0: *7 http script if: false
2009/01/29 14:54:53 [debug] 28499#0: *7 http script complex value
2009/01/29 14:54:53 [debug] 28499#0: *7 http script var: "blablablall.css"
rel="styleshe"
2009/01/29 14:54:53 [debug] 28499#0: *7 http script copy: "blablabla:l.css"
rel="styleshe"
2009/01/29 14:54:53 [debug] 28499#0: *7 http script var:
"blablabla:/news.php?id=3916242"
2009/01/29 14:54:53 [debug] 28499#0: *7 http script set var
2009/01/29 14:54:53 [debug] 28499#0: *7 post rewrite phase: 3
2009/01/29 14:54:53 [debug] 28499#0: *7 generic phase: 4
2009/01/29 14:54:53 [debug] 28499#0: *7 http init upstream, client timer: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 http memcached request:
"blablabla:/news.php?id=3916242"
2009/01/29 14:54:53 [debug] 28499#0: *7 http cleanup add: 00000000020FD600
2009/01/29 14:54:53 [debug] 28499#0: *7 get rr peer, try: 1
2009/01/29 14:54:53 [debug] 28499#0: *7 socket 16
2009/01/29 14:54:53 [debug] 28499#0: *7 epoll add connection: fd:16
ev:80000005
2009/01/29 14:54:53 [debug] 28499#0: *7 connect to 10.100.0.47:11211, fd:16
#10
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream connect: -2
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer add: 16:
60000:1233233753903
2009/01/29 14:54:53 [debug] 28499#0: *7 http subrequest done
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0 state: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 parse: -2, looked: 0
0000000002117B3F-0000000002117F55
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi out: 0000000002116080
0000000002117B3F
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter "/_fall_?"
00000000021160D0
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: -2 "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 pipe write downstream done
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer: 15, old: 1233233783830,
new: 1233233783903
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream exit: 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 finalize http upstream request: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 finalize http proxy request
2009/01/29 14:54:53 [debug] 28499#0: *7 free rr peer 1 0
2009/01/29 14:54:53 [debug] 28499#0: *7 close http upstream connection: 15
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer del: 15: 1233233783830
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream temp fd: -1
2009/01/29 14:54:53 [debug] 28499#0: *7 http output filter "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 http ssi filter "/_fall_"
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi out: 00000000020FD6C0
0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter "/_fall_?"
00000000020FD710
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: -2 "/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 http finalize request: -2,
"/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer add: 14:
60000:1233233753903
2009/01/29 14:54:53 [debug] 28499#0: *7 http finalize non-active request:
"/_fall_?"
2009/01/29 14:54:53 [debug] 28499#0: posted event 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: worker cycle
2009/01/29 14:54:53 [debug] 28499#0: accept mutex locked
2009/01/29 14:54:53 [debug] 28499#0: epoll timer: 60000
2009/01/29 14:54:53 [debug] 28499#0: epoll: fd:16 ev:0004 d:00007F65A0530290
2009/01/29 14:54:53 [debug] 28499#0: *7 post event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: timer delta: 1
2009/01/29 14:54:53 [debug] 28499#0: posted events 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: posted event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 delete posted event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream send request handler
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream send request
2009/01/29 14:54:53 [debug] 28499#0: *7 chain writer buf fl:0 s:45
2009/01/29 14:54:53 [debug] 28499#0: *7 chain writer in: 00000000020FD730
2009/01/29 14:54:53 [debug] 28499#0: *7 writev: 45
2009/01/29 14:54:53 [debug] 28499#0: *7 chain writer out: 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer del: 16: 1233233753903
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer add: 16:
60000:1233233753904
2009/01/29 14:54:53 [debug] 28499#0: posted event 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: worker cycle
2009/01/29 14:54:53 [debug] 28499#0: accept mutex locked
2009/01/29 14:54:53 [debug] 28499#0: epoll timer: 59999
2009/01/29 14:54:53 [debug] 28499#0: epoll: fd:16 ev:0005 d:00007F65A0530290
2009/01/29 14:54:53 [debug] 28499#0: *7 post event 00007F659E4BD1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 post event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: timer delta: 0
2009/01/29 14:54:53 [debug] 28499#0: posted events 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: posted event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 delete posted event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream dummy handler
2009/01/29 14:54:53 [debug] 28499#0: posted event 00007F659E4BD1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 delete posted event 00007F659E4BD1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream process header
2009/01/29 14:54:53 [debug] 28499#0: *7 malloc: 000000000211FB50:4096
2009/01/29 14:54:53 [debug] 28499#0: *7 recv: fd:16 4096 of 4096
2009/01/29 14:54:53 [debug] 28499#0: *7 memcached: "VALUE
blablabla:/news.php?id=3916242 0 8584"
2009/01/29 14:54:53 [debug] 28499#0: *7 tcp_nodelay
2009/01/29 14:54:53 [debug] 28499#0: *7 memcached filter bytes:4042
size:4042 length:8591 rest:7
2009/01/29 14:54:53 [debug] 28499#0: *7 http upstream process non buffered
downstream
2009/01/29 14:54:53 [debug] 28499#0: *7 http output filter
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter:
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 http ssi filter
"/http://blablabla/dyn/calculate_minutes_ago.php"
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0 state: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 parse: -2, looked: 0
000000000211FB86-0000000002120B50
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi out: 00000000020FDBA0
000000000211FB86
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter
"/http://blablabla/dyn/calculate_minutes_ago.php?date=" 00000000020FDBF0
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter out
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 00000000020FDC00
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:00000000020FDBA0
ni:000000000211FB86 ai:4042
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate in: ni:000000000211FB86
no:000000000211EB40 ai:4042 ao:4096 fl:2 redo:0
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate out: ni:0000000002120B50
no:000000000211F854 ai:0 ao:748 rc:0
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:00000000020FDBA0
pos:000000000211FB86
2009/01/29 14:54:53 [debug] 28499#0: *7 http chunk: 3348
2009/01/29 14:54:53 [debug] 28499#0: *7 write old buf t:1 f:0
0000000002115D20, pos 0000000002115D20, size: 333 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write old buf t:1 f:0
0000000000000000, pos 00000000021161A0, size: 3 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write old buf t:0 f:0
0000000000000000, pos 0000000000676448, size: 10 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write old buf t:0 f:0
0000000000000000, pos 000000000046323D, size: 2 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:1 f:0
0000000000000000, pos 00000000020FDC80, size: 5 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:1 f:0
000000000211EB40, pos 000000000211EB40, size: 3348 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 malloc: 0000000002120B60:4096
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:0 f:0
0000000000000000, pos 000000000046323D, size: 2 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter: l:0 f:1 s:3703
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter limit 0
2009/01/29 14:54:53 [debug] 28499#0: *7 writev: 3703
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: 0
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 recv: fd:16 200 of 4096
2009/01/29 14:54:53 [debug] 28499#0: *7 memcached filter bytes:200 size:200
length:4549 rest:7
2009/01/29 14:54:53 [debug] 28499#0: *7 http output filter
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter:
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 http ssi filter
"/http://blablabla/dyn/calculate_minutes_ago.php"
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0 state: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 parse: -2, looked: 0
000000000211FB50-000000000211FC18
2009/01/29 14:54:53 [debug] 28499#0: *7 saved: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 ssi out: 00000000020FDBA0
000000000211FB50
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter
"/http://blablabla/dyn/calculate_minutes_ago.php?date=" 00000000020FDBF0
2009/01/29 14:54:53 [debug] 28499#0: *7 http postpone filter out
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 00000000020FDCF8
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:00000000020FDBA0
ni:000000000211FB50 ai:200
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate in: ni:000000000211FB50
no:000000000211EB40 ai:200 ao:4096 fl:2 redo:0
2009/01/29 14:54:53 [debug] 28499#0: *7 deflate out: ni:000000000211FC18
no:000000000211EB5B ai:0 ao:4069 rc:0
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in_buf:00000000020FDBA0
pos:000000000211FB50
2009/01/29 14:54:53 [debug] 28499#0: *7 http chunk: 27
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:1 f:0
0000000000000000, pos 0000000002120C00, size: 4 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:1 f:0
000000000211EB40, pos 000000000211EB40, size: 27 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 write new buf t:0 f:0
0000000000000000, pos 000000000046323D, size: 2 file: 0, size: 0
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter: l:0 f:1 s:33
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter limit 0
2009/01/29 14:54:53 [debug] 28499#0: *7 writev: 33
2009/01/29 14:54:53 [debug] 28499#0: *7 http write filter 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 gzip in: 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: *7 copy filter: 0
"/http://blablabla/dyn/calculate_minutes_ago.php?date="
2009/01/29 14:54:53 [debug] 28499#0: *7 recv: fd:16 -1 of 4096
2009/01/29 14:54:53 [debug] 28499#0: *7 recv() not ready (11: Resource
temporarily unavailable)
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer del: 14: 1233233753903
2009/01/29 14:54:53 [debug] 28499#0: *7 event timer: 16, old: 1233233753904,
new: 1233233753904
2009/01/29 14:54:53 [debug] 28499#0: posted event 0000000000000000
2009/01/29 14:54:53 [debug] 28499#0: worker cycle
2009/01/29 14:54:53 [debug] 28499#0: accept mutex locked
2009/01/29 14:54:53 [debug] 28499#0: epoll timer: 60000
2009/01/29 14:54:53 [debug] 28499#0: epoll: fd:16 ev:0004 d:00007F65A0530290
2009/01/29 14:54:53 [debug] 28499#0: *7 post event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: timer delta: 1
2009/01/29 14:54:53 [debug] 28499#0: posted events 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: posted event 00007F659E3BA1B0
2009/01/29 14:54:53 [debug] 28499#0: *7 delete posted event 00007F659E3BA1B0
So I can see some kind of cycle - like take 80-90% of page and returns
2009/01/29 14:54:53 [debug] 28499#0: *7 recv() not ready (11: Resource
temporarily unavailable)
And then loads page again and again
What could be the problem ?
Best Regards,
Georgi Georgiev
PS:
OS : Linux Debian Lenny
nxinx version 0.6.32
memcache : 1.2.4
php5-memcache 3.0.1 ( for client )
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://nginx.org/pipermail/nginx/attachments/20090129/81355331/attachment.html>
More information about the nginx
mailing list