2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:1 f:0 0872B620, pos 0872B620, size: 366 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter: l:0 f:0 s:366
2011/09/29 07:44:01 [debug] 14365#0: *1 http cacheable: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream process upstream
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe read upstream: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe preread: 3873
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 01
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 06
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 01
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 99
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record length: 39168
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #0 086E16B0
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 086E16B0 3864
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 0872C548:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #1 0872C548
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 0872C548 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 0872D550:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #2 0872D550
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 0872D550 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 0872E558:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #3 0872E558
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 0872E558 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 0872F560:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #4 0872F560
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 0872F560 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 08730568:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #5 08730568
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 08730568 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 08731570:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #6 08731570
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 08731570 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 08732578:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #7 08732578
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 08732578 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 08733580:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 1:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #8 08733580
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 08733580 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe downstream ready
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 086E15C8, pos 086E16B0, size: 3864 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 0872C548, pos 0872C548, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 0872D550, pos 0872D550, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 0872E558, pos 0872E558, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 0872F560, pos 0872F560, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 08730568, pos 08730568, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 08731570, pos 08731570, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 08732578, pos 08732578, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf in s:1 t:1 f:0 08733580, pos 08733580, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe length: -1
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write downstream: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 086E16B0 3864
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 0872C548 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 0872D550 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:0872B874, f:1
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" 0872B838
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: B76F1008:270336
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip alloc: n:1 s:5824 a:8192 p:B76F1008
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip alloc: n:32768 s:2 a:65536 p:B76F3008
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip alloc: n:32768 s:2 a:65536 p:B7703008
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip alloc: n:32768 s:2 a:65536 p:B7713008
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip alloc: n:16384 s:4 a:65536 p:B7723008
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BC84
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B840 ni:086E16B0 ai:3864
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 08734588:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:086E16B0 no:08734588 ai:3864 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:086E25C8 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B840 pos:086E16B0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BC8C
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B8B8 ni:0872C548 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:0872C548 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:0872D548 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B8B8 pos:0872C548
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 0872D550 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 0872E558 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 0872F560 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:0872B964, f:1
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" 0872BCD0
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BCE0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B930 ni:0872D550 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:0872D550 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:0872E550 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B930 pos:0872D550
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BCE8
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B9A8 ni:0872E558 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:0872E558 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:0872F558 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872B9A8 pos:0872E558
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 0872F560 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 08730568 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 08731570 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:0872BA54, f:1
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" 0872BCF0
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD00
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BA20 ni:0872F560 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:0872F560 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:08730560 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BA20 pos:0872F560
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD08
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BA98 ni:08730568 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:08730568 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:08731568 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BA98 pos:08730568
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 08731570 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 08732578 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 08733580 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:0872BB44, f:1
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" 0872BD10
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD20
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BB10 ni:08731570 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:08731570 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:08732570 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BB10 pos:08731570
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD28
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BB88 ni:08732578 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:08732578 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:08733578 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BB88 pos:08732578
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write buf ls:1 08733580 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:0872BC34, f:0
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" 0872BC34
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD30
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BC00 ni:08733580 ai:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:08733580 no:08734588 ai:4096 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:08734580 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BC00 pos:08733580
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:00000000, f:0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe read upstream: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 9:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 2536
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 9:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 readv() not ready (11: Resource temporarily unavailable)
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: -2
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08733580, pos 08733580, size: 2536 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08731570, pos 08731570, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08732578, pos 08732578, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872F560, pos 0872F560, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08730568, pos 08730568, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872D550, pos 0872D550, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872E558, pos 0872E558, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 086E15C8, pos 086E15C8, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872C548, pos 0872C548, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe length: -1
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write downstream: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write busy: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write: out:00000000, f:0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe read upstream: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08733580, pos 08733580, size: 2536 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08731570, pos 08731570, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08732578, pos 08732578, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872F560, pos 0872F560, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08730568, pos 08730568, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872D550, pos 0872D550, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872E558, pos 0872E558, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 086E15C8, pos 086E15C8, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872C548, pos 0872C548, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe length: -1
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer del: 12: 3036708358
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer add: 12: 60000:3036709099
2011/09/29 07:44:01 [debug] 14365#0: posted event 00000000
2011/09/29 07:44:01 [debug] 14365#0: worker cycle
2011/09/29 07:44:01 [debug] 14365#0: accept mutex locked
2011/09/29 07:44:01 [debug] 14365#0: epoll timer: 60000
2011/09/29 07:44:01 [debug] 14365#0: epoll: fd:12 ev:0004 d:086F8655
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: timer delta: 11
2011/09/29 07:44:01 [debug] 14365#0: posted events 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: posted event 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream request: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream dummy handler
2011/09/29 07:44:01 [debug] 14365#0: posted event 00000000
2011/09/29 07:44:01 [debug] 14365#0: worker cycle
2011/09/29 07:44:01 [debug] 14365#0: accept mutex locked
2011/09/29 07:44:01 [debug] 14365#0: epoll timer: 59989
2011/09/29 07:44:01 [debug] 14365#0: epoll: fd:12 ev:0005 d:086F8655
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 087115CC
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: timer delta: 40
2011/09/29 07:44:01 [debug] 14365#0: posted events 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: posted event 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 0871E5D4
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream request: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream dummy handler
2011/09/29 07:44:01 [debug] 14365#0: posted event 087115CC
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 087115CC
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream request: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream process upstream
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe read upstream: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 9:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 16
2011/09/29 07:44:01 [debug] 14365#0: *1 readv: 9:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe recv chain: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08733580, pos 08733580, size: 2552 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08731570, pos 08731570, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08732578, pos 08732578, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872F560, pos 0872F560, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 08730568, pos 08730568, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872D550, pos 0872D550, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872E558, pos 0872E558, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 086E15C8, pos 086E15C8, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe buf free s:0 t:1 f:0 0872C548, pos 0872C548, size: 0 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe length: -1
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf #9 08733580
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 01
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 03
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 01
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 08
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record byte: 00
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi record length: 8
2011/09/29 07:44:01 [debug] 14365#0: *1 http fastcgi sent end request
2011/09/29 07:44:01 [debug] 14365#0: *1 input buf 08733580 2536
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 08731570
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 08732578
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 0872F560
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 08730568
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 0872D550
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 0872E558
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086E15C8
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 0872C548
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write downstream: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write downstream flush in
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" 0872BC34
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD40
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BC00 ni:08733580 ai:2536
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:08733580 no:08734588 ai:2536 ao:4096 fl:0 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:08733F68 no:08734588 ai:0 ao:4096 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BC00 pos:08733580
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 pipe write downstream done
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer: 12, old: 3036709099, new: 3036709150
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream exit: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 finalize http upstream request: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 finalize http fastcgi request
2011/09/29 07:44:01 [debug] 14365#0: *1 free rr peer 1 0
2011/09/29 07:44:01 [debug] 14365#0: *1 close http upstream connection: 12
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086DA5B0, unused: 88
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer del: 12: 3036709099
2011/09/29 07:44:01 [debug] 14365#0: *1 reusable connection: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 http upstream temp fd: -1
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/administration.php/sf_guard_group?" BFEEF108
2011/09/29 07:44:01 [debug] 14365#0: *1 http gzip filter
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in: 0872BD7C
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BD48 ni:00000000 ai:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:00000000 no:08734588 ai:0 ao:4096 fl:4 redo:0
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:00000000 no:08735588 ai:0 ao:0 rc:0
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BD48 pos:00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 086E15C8:4096
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate in: ni:00000000 no:086E15C8 ai:0 ao:4096 fl:4 redo:1
2011/09/29 07:44:01 [debug] 14365#0: *1 deflate out: ni:00000000 no:086E1DAD ai:0 ao:2075 rc:1
2011/09/29 07:44:01 [debug] 14365#0: *1 gzip in_buf:0872BD48 pos:00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: B76F1008
2011/09/29 07:44:01 [debug] 14365#0: *1 http chunk: 10
2011/09/29 07:44:01 [debug] 14365#0: *1 http chunk: 4096
2011/09/29 07:44:01 [debug] 14365#0: *1 http chunk: 2029
2011/09/29 07:44:01 [debug] 14365#0: *1 write old buf t:1 f:0 0872B620, pos 0872B620, size: 366 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:1 f:0 0872BE58, pos 0872BE58, size: 6 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:0 f:0 00000000, pos 080CAFE4, size: 10 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:1 f:0 08734588, pos 08734588, size: 4096 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:1 f:0 086E15C8, pos 086E15C8, size: 2029 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:0 f:0 00000000, pos 080BF4DC, size: 7 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter: l:1 f:1 s:6514
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter limit 0
2011/09/29 07:44:01 [debug] 14365#0: *1 writev: 6514
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/administration.php/sf_guard_group?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http finalize request: 0, "/administration.php/sf_guard_group?" a:1, c:1
2011/09/29 07:44:01 [debug] 14365#0: *1 set http keepalive handler
2011/09/29 07:44:01 [debug] 14365#0: *1 http close request
2011/09/29 07:44:01 [debug] 14365#0: *1 http log handler
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 08734588
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 08733580
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086E15C8
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086E05C0, unused: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 0872B540, unused: 1426
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer add: 11: 5000:3036654150
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086E0310
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086DFF08
2011/09/29 07:44:01 [debug] 14365#0: *1 hc free: 00000000 0
2011/09/29 07:44:01 [debug] 14365#0: *1 hc busy: 00000000 0
2011/09/29 07:44:01 [debug] 14365#0: *1 reusable connection: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 08711598
2011/09/29 07:44:01 [debug] 14365#0: posted event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 http keepalive handler
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 086DFF08:1024
2011/09/29 07:44:01 [debug] 14365#0: *1 recv: fd:11 -1 of 1024
2011/09/29 07:44:01 [debug] 14365#0: *1 recv() not ready (11: Resource temporarily unavailable)
2011/09/29 07:44:01 [debug] 14365#0: posted event 00000000
2011/09/29 07:44:01 [debug] 14365#0: worker cycle
2011/09/29 07:44:01 [debug] 14365#0: accept mutex locked
2011/09/29 07:44:01 [debug] 14365#0: epoll timer: 5000
2011/09/29 07:44:01 [debug] 14366#0: timer delta: 499
2011/09/29 07:44:01 [debug] 14366#0: posted events 00000000
2011/09/29 07:44:01 [debug] 14366#0: worker cycle
2011/09/29 07:44:01 [debug] 14366#0: accept mutex lock failed: 0
2011/09/29 07:44:01 [debug] 14366#0: epoll timer: 500
2011/09/29 07:44:01 [debug] 14367#0: timer delta: 500
2011/09/29 07:44:01 [debug] 14367#0: posted events 00000000
2011/09/29 07:44:01 [debug] 14367#0: worker cycle
2011/09/29 07:44:01 [debug] 14367#0: accept mutex lock failed: 0
2011/09/29 07:44:01 [debug] 14367#0: epoll timer: 500
2011/09/29 07:44:01 [debug] 14368#0: timer delta: 500
2011/09/29 07:44:01 [debug] 14368#0: posted events 00000000
2011/09/29 07:44:01 [debug] 14368#0: worker cycle
2011/09/29 07:44:01 [debug] 14368#0: accept mutex lock failed: 0
2011/09/29 07:44:01 [debug] 14368#0: epoll timer: 500
2011/09/29 07:44:01 [debug] 14365#0: epoll: fd:11 ev:0005 d:086F85F0
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 0871E5A0
2011/09/29 07:44:01 [debug] 14365#0: timer delta: 197
2011/09/29 07:44:01 [debug] 14365#0: posted events 0871E5A0
2011/09/29 07:44:01 [debug] 14365#0: posted event 0871E5A0
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 0871E5A0
2011/09/29 07:44:01 [debug] 14365#0: *1 http empty handler
2011/09/29 07:44:01 [debug] 14365#0: posted event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 http keepalive handler
2011/09/29 07:44:01 [debug] 14365#0: *1 recv: fd:11 441 of 1024
2011/09/29 07:44:01 [debug] 14365#0: *1 reusable connection: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 086E0310:680
2011/09/29 07:44:01 [debug] 14365#0: *1 posix_memalign: 086E05C0:4096 @16
2011/09/29 07:44:01 [debug] 14365#0: *1 http process request line
2011/09/29 07:44:01 [debug] 14365#0: *1 http request line: "GET /css/blueprint/print.css HTTP/1.1"
2011/09/29 07:44:01 [debug] 14365#0: *1 http uri: "/css/blueprint/print.css"
2011/09/29 07:44:01 [debug] 14365#0: *1 http args: ""
2011/09/29 07:44:01 [debug] 14365#0: *1 http exten: "css"
2011/09/29 07:44:01 [debug] 14365#0: *1 http process request header line
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Host: 10.128.50.101"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "User-Agent: Mozilla/5.0 (Windows NT 5.1; rv:7.0) Gecko/20100101 Firefox/7.0"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Accept: text/css,*/*;q=0.1"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Accept-Language: es-es,es;q=0.8,en-us;q=0.5,en;q=0.3"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Accept-Encoding: gzip, deflate"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Connection: keep-alive"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Referer: http://10.128.50.101/administration.php/sf_guard_group"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header: "Cookie: zera=vmlib90drktmrpmo3gdra6hi12; has_js=1"
2011/09/29 07:44:01 [debug] 14365#0: *1 http header done
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer del: 11: 3036654150
2011/09/29 07:44:01 [debug] 14365#0: *1 generic phase: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 rewrite phase: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 test location: "/404.html"
2011/09/29 07:44:01 [debug] 14365#0: *1 test location: "/sf/"
2011/09/29 07:44:01 [debug] 14365#0: *1 test location: ~ ".+\.(js|htc|ico|gif|jpg|png|css)$"
2011/09/29 07:44:01 [debug] 14365#0: *1 using configuration ".+\.(js|htc|ico|gif|jpg|png|css)$"
2011/09/29 07:44:01 [debug] 14365#0: *1 http cl:-1 max:1048576
2011/09/29 07:44:01 [debug] 14365#0: *1 rewrite phase: 3
2011/09/29 07:44:01 [debug] 14365#0: *1 post rewrite phase: 4
2011/09/29 07:44:01 [debug] 14365#0: *1 generic phase: 5
2011/09/29 07:44:01 [debug] 14365#0: *1 generic phase: 6
2011/09/29 07:44:01 [debug] 14365#0: *1 generic phase: 7
2011/09/29 07:44:01 [debug] 14365#0: *1 access phase: 8
2011/09/29 07:44:01 [debug] 14365#0: *1 access phase: 9
2011/09/29 07:44:01 [debug] 14365#0: *1 post access phase: 10
2011/09/29 07:44:01 [debug] 14365#0: *1 content phase: 11
2011/09/29 07:44:01 [debug] 14365#0: *1 content phase: 12
2011/09/29 07:44:01 [debug] 14365#0: *1 content phase: 13
2011/09/29 07:44:01 [debug] 14365#0: *1 content phase: 14
2011/09/29 07:44:01 [debug] 14365#0: *1 content phase: 15
2011/09/29 07:44:01 [debug] 14365#0: *1 content phase: 16
2011/09/29 07:44:01 [debug] 14365#0: *1 http filename: "/var/www/appname/web/css/blueprint/print.css"
2011/09/29 07:44:01 [debug] 14365#0: *1 add cleanup: 086E0BEC
2011/09/29 07:44:01 [debug] 14365#0: *1 http static fd: 12
2011/09/29 07:44:01 [debug] 14365#0: *1 http set discard body
2011/09/29 07:44:01 [debug] 14365#0: *1 HTTP/1.1 200 OK
Server: nginx/1.1.4
Date: Thu, 29 Sep 2011 11:44:01 GMT
Content-Type: text/css
Content-Length: 1285
Last-Modified: Wed, 28 Sep 2011 15:47:21 GMT
Connection: keep-alive
Expires: Thu, 31 Dec 2037 23:55:55 GMT
Cache-Control: max-age=315360000
Accept-Ranges: bytes

2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:1 f:0 086E0CFC, pos 086E0CFC, size: 289 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter: l:0 f:0 s:289
2011/09/29 07:44:01 [debug] 14365#0: *1 http output filter "/css/blueprint/print.css?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: "/css/blueprint/print.css?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http postpone filter "/css/blueprint/print.css?" BFEEF03C
2011/09/29 07:44:01 [debug] 14365#0: *1 write old buf t:1 f:0 086E0CFC, pos 086E0CFC, size: 289 file: 0, size: 0
2011/09/29 07:44:01 [debug] 14365#0: *1 write new buf t:0 f:1 00000000, pos 00000000, size: 0 file: 0, size: 1285
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter: l:1 f:0 s:1574
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter limit 0
2011/09/29 07:44:01 [debug] 14365#0: *1 writev: 289
2011/09/29 07:44:01 [debug] 14365#0: *1 sendfile: @0 1285
2011/09/29 07:44:01 [debug] 14365#0: *1 sendfile: 1285, @0 1285:1285
2011/09/29 07:44:01 [debug] 14365#0: *1 http write filter 00000000
2011/09/29 07:44:01 [debug] 14365#0: *1 http copy filter: 0 "/css/blueprint/print.css?"
2011/09/29 07:44:01 [debug] 14365#0: *1 http finalize request: 0, "/css/blueprint/print.css?" a:1, c:1
2011/09/29 07:44:01 [debug] 14365#0: *1 set http keepalive handler
2011/09/29 07:44:01 [debug] 14365#0: *1 http close request
2011/09/29 07:44:01 [debug] 14365#0: *1 http log handler
2011/09/29 07:44:01 [debug] 14365#0: *1 run cleanup: 086E0BEC
2011/09/29 07:44:01 [debug] 14365#0: *1 file cleanup: fd:12
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086E05C0, unused: 1631
2011/09/29 07:44:01 [debug] 14365#0: *1 event timer add: 11: 5000:3036654347
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086E0310
2011/09/29 07:44:01 [debug] 14365#0: *1 free: 086DFF08
2011/09/29 07:44:01 [debug] 14365#0: *1 hc free: 00000000 0
2011/09/29 07:44:01 [debug] 14365#0: *1 hc busy: 00000000 0
2011/09/29 07:44:01 [debug] 14365#0: *1 reusable connection: 1
2011/09/29 07:44:01 [debug] 14365#0: *1 post event 08711598
2011/09/29 07:44:01 [debug] 14365#0: posted event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 delete posted event 08711598
2011/09/29 07:44:01 [debug] 14365#0: *1 http keepalive handler
2011/09/29 07:44:01 [debug] 14365#0: *1 malloc: 086DFF08:1024
2011/09/29 07:44:01 [debug] 14365#0: *1 recv: fd:11 -1 of 1024
2011/09/29 07:44:01 [debug] 14365#0: *1 recv() not ready (11: Resource temporarily unavailable)
2011/09/29 07:44:01 [debug] 14365#0: posted event 00000000
2011/09/29 07:44:01 [debug] 14365#0: worker cycle
2011/09/29 07:44:01 [debug] 14365#0: accept mutex locked
2011/09/29 07:44:01 [debug] 14365#0: epoll timer: 5000
2011/09/29 07:44:01 [debug] 14365#0: epoll: fd:6 ev:0001 d:086F8528
2011/09/29 07:44:01 [debug] 14365#0: post event 08711530
2011/09/29 07:44:01 [debug] 14365#0: timer delta: 10
2011/09/29 07:44:01 [debug] 14365#0: posted event 08711530
2011/09/29 07:44:01 [debug] 14365#0: delete posted event 08711530
2011/09/29 07:44:01 [debug] 14365#0: accept on 0.0.0.0:80, ready: 0
2011/09/29 07:44:01 [debug] 14365#0: posix_memalign: 086E0310:256 @16
2011/09/29 07:44:01 [debug] 14365#0: *4 accept: 10.35.9.129 fd:12
2011/09/29 07:44:01 [debug] 14365#0: *4 event timer add: 12: 60000:3036709357
2011/09/29 07:44:01 [debug] 14365#0: *4 epoll add event: fd:12 op:1 ev:80000001
2011/09/29 07:44:01 [debug] 14365#0: posted event 00000000
2011/09/29 07:44:01 [debug] 14365#0: posted events 00000000
2011/09/29 07:44:01 [debug] 14365#0: worker cycle
2011/09/29 07:44:01 [debug] 14365#0: accept mutex locked
2011/09/29 07:44:01 [debug] 14365#0: epoll timer: 4990
2011/09/29 07:44:01 [debug] 14365#0: epoll: fd:6 ev:0001 d:086F8528
2011/09/29 07:44:01 [debug] 14365#0: post event 08711530
2011/09/29 07:44:01 [debug] 14365#0: timer delta: 8
2011/09/29 07:44:01 [debug] 14365#0: posted event 08711530
2011/09/29 07:44:01 [debug] 14365#0: delete posted event 08711530
2011/09/29 07:44:01 [debug] 14365#0: accept on 0.0.0.0:80, ready: 0
2011/09/29 07:44:01 [debug] 14365#0: posix_memalign: 086E0440:256 @16
2011/09/29 07:44:01 [debug] 14365#0: *5 accept: 10.35.9.129 fd:13
2011/09/29 07:44:01 [debug] 14365#0: *5 event timer add: 13: 60000:3036709365
2011/09/29 07:44:01 [debug] 14365#0: *5 epoll add event: fd:13 op:1 ev:80000001
2011/09/29 07:44:01 [debug] 14365#0: posted event 00000000
2011/09/29 07:44:01 [debug] 14365#0: posted events 00000000
2011/09/29 07:44:01 [debug] 14365#0: worker cycle
2011/09/29 07:44:01 [debug] 14365#0: accept mutex locked
2011/09/29 07:44:01 [debug] 14365#0: epoll timer: 4982
2011/09/29 07:44:01 [debug] 14365#0: epoll: fd:12 ev:0001 d:086F8654
2011/09/29 07:44:01 [debug] 14365#0: *4 post event 087115CC
2011/09/29 07:44:01 [debug] 14365#0: timer delta: 5
2011/09/29 07:44:01 [debug] 14365#0: posted events 087115CC
2011/09/29 07:44:01 [debug] 14365#0: posted event 087115CC
2011/09/29 07:44:01 [debug] 14365#0: *4 delete posted event 087115CC
2011/09/29 07:44:01 [debug] 14365#0: *4 malloc: 086E0548:680
2011/09/29 07:44:01 [debug] 14365#0: *4 malloc: 086E07F8:1024
2011/09/29 07:44:01 [debug] 14365#0: *4 posix_memalign: 086E0C00:4096 @16
2011/09/29 07:44:01 [debug] 14365#0: *4 http process request line
2011/09/29 07:44:01 [debug] 14365#0: *4 recv: fd:12 458 of 1024
2011/09/29 07:44:01 [debug] 14365#0: *4 http request line: "GET /css/administration/modules/dashboard.css HTTP/1.1"
2011/09/29 07:44:01 [debug] 14365#0: *4 http uri: "/css/administration/modules/dashboard.css"
2011/09/29 07:44:01 [debug] 14365#0: *4 http args: ""
2011/09/29 07:44:01 [debug] 14365#0: *4 http exten: "css"
2011/09/29 07:44:01 [debug] 14365#0: *4 http process request header line
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Host: 10.128.50.101"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "User-Agent: Mozilla/5.0 (Windows NT 5.1; rv:7.0) Gecko/20100101 Firefox/7.0"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Accept: text/css,*/*;q=0.1"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Accept-Language: es-es,es;q=0.8,en-us;q=0.5,en;q=0.3"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Accept-Encoding: gzip, deflate"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Accept-Charset: ISO-8859-1,utf-8;q=0.7,*;q=0.7"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Connection: keep-alive"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Referer: http://10.128.50.101/administration.php/sf_guard_group"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header: "Cookie: zera=vmlib90drktmrpmo3gdra6hi12; has_js=1"
2011/09/29 07:44:01 [debug] 14365#0: *4 http header done
2011/09/29 07:44:01 [debug] 14365#0: *4 event timer del: 12: 3036709357
2011/09/29 07:44:01 [debug] 14365#0: *4 generic phase: 0
2011/09/29 07:44:01 [debug] 14365#0: *4 rewrite phase: 1
2011/09/29 07:44:01 [debug] 14365#0: *4 test location: "/404.html"
2011/09/29 07:44:01 [debug] 14365#0: *4 test location: "/sf/"
2011/09/29 07:44:01 [debug] 14365#0: *4 test location: ~ ".+\.(js|htc|ico|gif|jpg|png|css)$"
2011/09/29 07:44:01 [debug] 14365#0: *4 using configuration ".+\.(js|htc|ico|gif|jpg|png|css)$"
2011/09/29 07:44:01 [debug] 14365#0: *4 http cl:-1 max:1048576
2011/09/29 07:44:01 [debug] 14365#0: *4 rewrite phase: 3
2011/09/29 07:44:01 [debug] 14365#0: *4 post rewrite phase: 4
2011/09/29 07:44:01 [debug] 14365#0: *4 generic phase: 5
2011/09/29 07:44:01 [debug] 14365#0: *4 generic phase: 6
2011/09/29 07:44:01 [debug] 14365#0: *4 generic phase: 7
2011/09/29 07:44:01 [debug] 14365#0: *4 access phase: 8
2011/09/29 07:44:01 [debug] 14365#0: *4 access phase: 9
2011/09/29 07:44:01 [debug] 14365#0: *4 post access phase: 10
2011/09/29 07:44:01 [debug] 14365#0: *4 content phase: 11
2011/09/29 07:44:01 [debug] 14365#0: *4 content phase: 12
2011/09/29 07:44:01 [debug] 14365#0: *4 content phase: 13
2011/09/29 07:44:01 [debug] 14365#0: *4 content phase: 14
2011/09/29 07:44:01 [debug] 14365#0: *4 content phase: 15
2011/09/29 07:44:01 [debug] 14365#0: *4 content phase: 16
2011/09/29 07:44:01 [debug] 14365#0: *4 http filename: "/var/www/appname/web/css/administration/modules/dashboard.css"
2011/09/29 07:44:01 [debug] 14365#0: *4 add cleanup: 086E123C
2011/09/29 07:44:01 [debug] 14365#0: *4 http static fd: 14
2011/09/29 07:44:01 [debug] 14365#0: *4 http set discard body
2011/09/29 07:44:01 [debug] 14365#0: *4 HTTP/1.1 200 OK
Server: nginx/1.1.4
Date: Thu, 29 Sep 2011 11:44:01 GMT
Content-Type: text/css
Content-Length: 3785
Last-Modified: Wed, 28 Sep 2011 15:47:21 GMT
Connection: keep-alive
Expires: Thu, 31 Dec 2037 23:55:55 GMT
Cache-Control: max-age=315360000
Accept-Ranges: bytes