hostmaster.log

2013/12/11 21:17:36 [debug] 1516#0: epoll add event: fd:7 op:1 ev:00000001
2013/12/11 21:17:43 [debug] 1516#0: post event 0000000000FAA540
2013/12/11 21:17:43 [debug] 1516#0: delete posted event 0000000000FAA540
2013/12/11 21:17:43 [debug] 1516#0: accept on 0.0.0.0:80, ready: 0
2013/12/11 21:17:43 [debug] 1516#0: posix_memalign: 0000000000D355C0:256 @16
2013/12/11 21:17:43 [debug] 1516#0: *23 accept: 79.133.217.246 fd:9
2013/12/11 21:17:43 [debug] 1516#0: *23 event timer add: 9: 60000:1386796723459
2013/12/11 21:17:43 [debug] 1516#0: *23 epoll add event: fd:9 op:1 ev:80000001
2013/12/11 21:17:43 [debug] 1516#0: *23 post event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *23 delete posted event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F91CA0:1296
2013/12/11 21:17:43 [debug] 1516#0: *23 posix_memalign: 0000000000F921C0:256 @16
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F5E410:32768
2013/12/11 21:17:43 [debug] 1516#0: *23 posix_memalign: 0000000000D4DBA0:4096 @16
2013/12/11 21:17:43 [debug] 1516#0: *23 http process request line
2013/12/11 21:17:43 [debug] 1516#0: *23 recv: fd:9 388 of 32768
2013/12/11 21:17:43 [debug] 1516#0: *23 http request line: "GET /home HTTP/1.1"
2013/12/11 21:17:43 [debug] 1516#0: *23 http uri: "/home"
2013/12/11 21:17:43 [debug] 1516#0: *23 http args: ""
2013/12/11 21:17:43 [debug] 1516#0: *23 http exten: ""
2013/12/11 21:17:43 [debug] 1516#0: *23 http process request header line
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "Host: gardennuts.com"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "Connection: Keep-Alive"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "User-Agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.8; rv:22.0) Gecko/20100101 Firefox/22.0"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "Accept: text/html, application/xml;q=0.9, application/xhtml+xml, image/png, image/webp, image/jpeg, image/gif, image/x-xbitmap, */*;q=0.1"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "Accept-Language: en"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "Accept-Encoding: gzip, deflate"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header: "Referer: http://gardennuts.com/"
2013/12/11 21:17:43 [debug] 1516#0: *23 http header done
2013/12/11 21:17:43 [debug] 1516#0: *23 event timer del: 9: 1386796723459
2013/12/11 21:17:43 [debug] 1516#0: *23 generic phase: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 rewrite phase: 1
2013/12/11 21:17:43 [debug] 1516#0: *23 using configuration ""
2013/12/11 21:17:43 [debug] 1516#0: *23 http cl:-1 max:1048576
2013/12/11 21:17:43 [debug] 1516#0: *23 rewrite phase: 3
2013/12/11 21:17:43 [debug] 1516#0: *23 post rewrite phase: 4
2013/12/11 21:17:43 [debug] 1516#0: *23 generic phase: 5
2013/12/11 21:17:43 [debug] 1516#0: *23 generic phase: 6
2013/12/11 21:17:43 [debug] 1516#0: *23 generic phase: 7
2013/12/11 21:17:43 [debug] 1516#0: *23 limit zone: 01E96763 1
2013/12/11 21:17:43 [debug] 1516#0: *23 add cleanup: 0000000000D4E840
2013/12/11 21:17:43 [debug] 1516#0: *23 access phase: 8
2013/12/11 21:17:43 [debug] 1516#0: *23 access phase: 9
2013/12/11 21:17:43 [debug] 1516#0: *23 access phase: 10
2013/12/11 21:17:43 [debug] 1516#0: *23 post access phase: 11
2013/12/11 21:17:43 [debug] 1516#0: *23 try files phase: 12
2013/12/11 21:17:43 [debug] 1516#0: *23 content phase: 13
2013/12/11 21:17:43 [debug] 1516#0: *23 content phase: 14
2013/12/11 21:17:43 [debug] 1516#0: *23 content phase: 15
2013/12/11 21:17:43 [debug] 1516#0: *23 content phase: 16
2013/12/11 21:17:43 [debug] 1516#0: *23 content phase: 17
2013/12/11 21:17:43 [debug] 1516#0: *23 http filename: "/var/www/nginx-default/home.gz"
2013/12/11 21:17:43 [debug] 1516#0: *23 add cleanup: 0000000000D4E888
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F922D0:144
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F92370:31
2013/12/11 21:17:43 [debug] 1516#0: *23 cached open file: /var/www/nginx-default/home.gz, fd:-1, c:0, e:2, u:1
2013/12/11 21:17:43 [debug] 1516#0: *23 content phase: 18
2013/12/11 21:17:43 [debug] 1516#0: *23 http filename: "/var/www/nginx-default/home"
2013/12/11 21:17:43 [debug] 1516#0: *23 add cleanup: 0000000000D4E8E0
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F923A0:144
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F92440:28
2013/12/11 21:17:43 [debug] 1516#0: *23 cached open file: /var/www/nginx-default/home, fd:-1, c:0, e:2, u:1
2013/12/11 21:17:43 [error] 1516#0: *23 open() "/var/www/nginx-default/home" failed (2: No such file or directory), client: 79.133.217.246, server: gardennuts.com, request: "GET /home HTTP/1.1", host: "gardennuts.com", referrer: "http://gardennuts.com/"
2013/12/11 21:17:43 [debug] 1516#0: *23 http finalize request: 404, "/home?" a:1, c:1
2013/12/11 21:17:43 [debug] 1516#0: *23 http special response: 404, "/home?"
2013/12/11 21:17:43 [debug] 1516#0: *23 http set discard body
2013/12/11 21:17:43 [debug] 1516#0: *23 xslt filter header
2013/12/11 21:17:43 [debug] 1516#0: *23 HTTP/1.1 404 Not Found
Server: nginx/1.1.19
Date: Wed, 11 Dec 2013 21:17:43 GMT
Content-Type: text/html
Transfer-Encoding: chunked
Connection: keep-alive
Vary: Accept-Encoding
Content-Encoding: gzip

2013/12/11 21:17:43 [debug] 1516#0: *23 write new buf t:1 f:0 0000000000D4EA90, pos 0000000000D4EA90, size: 209 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 http write filter: l:0 f:0 s:209
2013/12/11 21:17:43 [debug] 1516#0: *23 posix_memalign: 0000000000D3DAB0:4096 @16
2013/12/11 21:17:43 [debug] 1516#0: *23 http output filter "/home?"
2013/12/11 21:17:43 [debug] 1516#0: *23 http copy filter: "/home?"
2013/12/11 21:17:43 [debug] 1516#0: *23 image filter
2013/12/11 21:17:43 [debug] 1516#0: *23 xslt filter body
2013/12/11 21:17:43 [debug] 1516#0: *23 http postpone filter "/home?" 0000000000D4EB78
2013/12/11 21:17:43 [debug] 1516#0: *23 http gzip filter
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000001943F90:12288
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip alloc: n:1 s:5936 a:8192 p:0000000001943F90
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip alloc: n:512 s:2 a:1024 p:0000000001945F90
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip alloc: n:512 s:2 a:1024 p:0000000001946390
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip alloc: n:512 s:2 a:1024 p:0000000001946790
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip alloc: n:256 s:4 a:1024 p:0000000001946B90
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip in: 0000000000D3DBE8
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip in_buf:0000000000D3DAD0 ni:00000000006BE7A0 ai:116
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000001633350:8192
2013/12/11 21:17:43 [debug] 1516#0: *23 deflate in: ni:00000000006BE7A0 no:0000000001633350 ai:116 ao:8192 fl:0 redo:0
2013/12/11 21:17:43 [debug] 1516#0: *23 deflate out: ni:00000000006BE814 no:0000000001633350 ai:0 ao:8192 rc:0
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip in_buf:0000000000D3DAD0 pos:00000000006BE7A0
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip in: 0000000000D3DBF8
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip in_buf:0000000000D3DB20 ni:00000000006BE100 ai:53
2013/12/11 21:17:43 [debug] 1516#0: *23 deflate in: ni:00000000006BE100 no:0000000001633350 ai:53 ao:8192 fl:4 redo:0
2013/12/11 21:17:43 [debug] 1516#0: *23 deflate out: ni:00000000006BE135 no:00000000016333BF ai:0 ao:8081 rc:1
2013/12/11 21:17:43 [debug] 1516#0: *23 gzip in_buf:0000000000D3DB20 pos:00000000006BE100
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000001943F90
2013/12/11 21:17:43 [debug] 1516#0: *23 http chunk: 10
2013/12/11 21:17:43 [debug] 1516#0: *23 http chunk: 119
2013/12/11 21:17:43 [debug] 1516#0: *23 write old buf t:1 f:0 0000000000D4EA90, pos 0000000000D4EA90, size: 209 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 write new buf t:1 f:0 0000000000D3DD58, pos 0000000000D3DD58, size: 4 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 write new buf t:0 f:0 0000000000000000, pos 00000000006C24C8, size: 10 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 write new buf t:1 f:0 0000000001633350, pos 0000000001633350, size: 119 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 write new buf t:0 f:0 0000000000000000, pos 000000000049DD98, size: 7 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 http write filter: l:1 f:1 s:349
2013/12/11 21:17:43 [debug] 1516#0: *23 http write filter limit 0
2013/12/11 21:17:43 [debug] 1516#0: *23 writev: 349
2013/12/11 21:17:43 [debug] 1516#0: *23 http write filter 0000000000000000
2013/12/11 21:17:43 [debug] 1516#0: *23 http copy filter: 0 "/home?"
2013/12/11 21:17:43 [debug] 1516#0: *23 http finalize request: 0, "/home?" a:1, c:1
2013/12/11 21:17:43 [debug] 1516#0: *23 set http keepalive handler
2013/12/11 21:17:43 [debug] 1516#0: *23 http close request
2013/12/11 21:17:43 [debug] 1516#0: *23 http log handler
2013/12/11 21:17:43 [debug] 1516#0: *23 run cleanup: 0000000000D4E840
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000001633350
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000000000
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000D4DBA0, unused: 8
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000D3DAB0, unused: 2725
2013/12/11 21:17:43 [debug] 1516#0: *23 event timer add: 9: 65000:1386796728461
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000F91CA0
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000F5E410
2013/12/11 21:17:43 [debug] 1516#0: *23 hc free: 0000000000000000 0
2013/12/11 21:17:43 [debug] 1516#0: *23 hc busy: 0000000000000000 0
2013/12/11 21:17:43 [debug] 1516#0: *23 tcp_nodelay
2013/12/11 21:17:43 [debug] 1516#0: *23 reusable connection: 1
2013/12/11 21:17:43 [debug] 1516#0: *23 post event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *23 delete posted event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *23 http keepalive handler
2013/12/11 21:17:43 [debug] 1516#0: *23 malloc: 0000000000F5E410:32768
2013/12/11 21:17:43 [debug] 1516#0: *23 recv: fd:9 -1 of 32768
2013/12/11 21:17:43 [debug] 1516#0: *23 recv() not ready (11: Resource temporarily unavailable)
2013/12/11 21:17:43 [debug] 1516#0: *23 post event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *23 delete posted event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *23 http keepalive handler
2013/12/11 21:17:43 [debug] 1516#0: *23 recv: fd:9 0 of 32768
2013/12/11 21:17:43 [info] 1516#0: *23 client 79.133.217.246 closed keepalive connection
2013/12/11 21:17:43 [debug] 1516#0: *23 close http connection: 9
2013/12/11 21:17:43 [debug] 1516#0: *23 event timer del: 9: 1386796728461
2013/12/11 21:17:43 [debug] 1516#0: *23 reusable connection: 0
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000F5E410
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000000000
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000D355C0, unused: 8
2013/12/11 21:17:43 [debug] 1516#0: *23 free: 0000000000F921C0, unused: 112
2013/12/11 21:17:43 [debug] 1516#0: post event 0000000000FAA540
2013/12/11 21:17:43 [debug] 1516#0: delete posted event 0000000000FAA540
2013/12/11 21:17:43 [debug] 1516#0: accept on 0.0.0.0:80, ready: 0
2013/12/11 21:17:43 [debug] 1516#0: posix_memalign: 0000000000D355C0:256 @16
2013/12/11 21:17:43 [debug] 1516#0: *24 accept: 63.155.48.181 fd:9
2013/12/11 21:17:43 [debug] 1516#0: *24 event timer add: 9: 60000:1386796723778
2013/12/11 21:17:43 [debug] 1516#0: *24 epoll add event: fd:9 op:1 ev:80000001
2013/12/11 21:17:43 [debug] 1516#0: *24 post event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *24 delete posted event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000F91CA0:1296
2013/12/11 21:17:43 [debug] 1516#0: *24 posix_memalign: 0000000000F921C0:256 @16
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000F5E410:32768
2013/12/11 21:17:43 [debug] 1516#0: *24 posix_memalign: 0000000000D3DAB0:4096 @16
2013/12/11 21:17:43 [debug] 1516#0: *24 http process request line
2013/12/11 21:17:43 [debug] 1516#0: *24 recv: fd:9 655 of 32768
2013/12/11 21:17:43 [debug] 1516#0: *24 http request line: "GET / HTTP/1.1"
2013/12/11 21:17:43 [debug] 1516#0: *24 http uri: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 http args: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http exten: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http process request header line
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Host: aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Connection: keep-alive"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Cache-Control: max-age=0"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/31.0.1650.63 Safari/537.36"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Accept-Encoding: gzip,deflate,sdch"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Accept-Language: en-US,en;q=0.8"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header: "Cookie: SESS926c91e0b2a34d58f86039a78ec14fcc=52rc5mpkln89h1ch1dfedv05v3; has_js=1; __utma=164703230.1712519080.1384111300.1386634287.1386795689.5; __utmb=164703230.3.10.1386795689; __utmc=164703230; __utmz=164703230.1384111300.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2013/12/11 21:17:43 [debug] 1516#0: *24 http header done
2013/12/11 21:17:43 [debug] 1516#0: *24 event timer del: 9: 1386796723778
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 rewrite phase: 1
2013/12/11 21:17:43 [debug] 1516#0: *24 http script value: "Cache"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script set $nocache_details
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "GET"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script regex: "^(?:GET|HEAD|POST|PUT|DELETE|OPTIONS)$"
2013/12/11 21:17:43 [notice] 1516#0: *24 "^(?:GET|HEAD|POST|PUT|DELETE|OPTIONS)$" matches "GET", client: 63.155.48.181, server: customfinewoodwork.com, request: "GET / HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if: false
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http map started
2013/12/11 21:17:43 [debug] 1516#0: *24 http map: "" ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if: false
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "(/\..*|settings\.php$|\.(?:git|htaccess|engine|inc|info|install|module|profile|pl|po|sh|.*sql|theme|tpl(?:\.php)?|xtmpl)$|^(?:Entries.*|Repository|Root|Tag|Template))$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "\.r\.(?:jpe?g|png|gif)"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "/(?:.+)/files/styles/adaptive/(?:.+)$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "/(?:external|system|files/imagecache|files/styles)/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/sites/.*/files/backup_migrate/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/sites/.*/files/private/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/sites/.*/private/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "/files/private/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "wysiwyg_fields/(?:plugins|scripts)/.*\.(?:js|css)"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "files/advagg_(?:css|js)/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "\.css$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "\.(?:js|htc)$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "\.json$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^.+\.(?:jpe?g|gif|png|ico|bmp|svg|swf|pdf|docx?|xlsx?|pptx?|tiff?|txt|rtf|cgi|bat|pl|dll|aspx?|class|otf|ttf|woff|eot|less)$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^.+\.(?:avi|mpe?g|mov|wmv|mp3|mp4|m4a|ogg|ogv|flv|wav|midi|zip|tar|t?gz|rar|dmg|exe)$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "/(?:cross-?domain)\.xml$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "/(?:modules|libraries)/(?:contrib/)?(?:ad|tinybrowser|f?ckeditor|tinymce|wysiwyg_spellcheck|ecc|civicrm|fbconnect|radioactivity)/.*\.php$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/sites/.*/(?:modules|libraries)/(?:contrib/)?(?:tinybrowser|f?ckeditor|tinymce)/.*\.(?:html?|xml)$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/sites/.*/files/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "\.xml$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/(?:.*/)?(?:admin|user|cart|checkout|logout|flag|comment/reply)"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/(?:.*/)?(?:node/[0-9]+/edit|node/add|approve)"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^/(?:boost_stats|update|authorize|xmlrpc)\.php$"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: ~ "^.+\.php$"
2013/12/11 21:17:43 [debug] 1516#0: *24 using configuration "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 http cl:-1 max:1048576
2013/12/11 21:17:43 [debug] 1516#0: *24 rewrite phase: 3
2013/12/11 21:17:43 [debug] 1516#0: *24 post rewrite phase: 4
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 5
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 6
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 7
2013/12/11 21:17:43 [debug] 1516#0: *24 limit zone: 1C07110A 1
2013/12/11 21:17:43 [debug] 1516#0: *24 add cleanup: 0000000000D3E880
2013/12/11 21:17:43 [debug] 1516#0: *24 access phase: 8
2013/12/11 21:17:43 [debug] 1516#0: *24 access phase: 9
2013/12/11 21:17:43 [debug] 1516#0: *24 access phase: 10
2013/12/11 21:17:43 [debug] 1516#0: *24 post access phase: 11
2013/12/11 21:17:43 [debug] 1516#0: *24 try files phase: 12
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 trying to use file: "/" "/var/aegir/platforms/customers-1.0/"
2013/12/11 21:17:43 [debug] 1516#0: *24 add cleanup: 0000000000D3E8E0
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000FBDD50:144
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000FBDDF0:36
2013/12/11 21:17:43 [debug] 1516#0: *24 cached open file: /var/aegir/platforms/customers-1.0/, fd:-1, c:0, e:0, u:1
2013/12/11 21:17:43 [debug] 1516#0: *24 trying to use file: "@cache" "/var/aegir/platforms/customers-1.0@cache"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "@cache"
2013/12/11 21:17:43 [debug] 1516#0: *24 using location: @cache "/?"
2013/12/11 21:17:43 [debug] 1516#0: *24 rewrite phase: 3
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "GET"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script value: "POST"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script equal
2013/12/11 21:17:43 [debug] 1516#0: *24 http script equal: no
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if: false
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http script regex: "nocache=1"
2013/12/11 21:17:43 [notice] 1516#0: *24 "nocache=1" does not match "", client: 63.155.48.181, server: customfinewoodwork.com, request: "GET / HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if: false
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http map started
2013/12/11 21:17:43 [debug] 1516#0: *24 posix_memalign: 0000000000D4DBA0:4096 @16
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "SESS926c91e0b2a34d58f86039a78ec14fcc=52rc5mpkln89h1ch1dfedv05v3; has_js=1; __utma=164703230.1712519080.1384111300.1386634287.1386795689.5; __utmb=164703230.3.10.1386795689; __utmc=164703230; __utmz=164703230.1384111300.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2013/12/11 21:17:43 [debug] 1516#0: *24 http regex set $session_id to "52rc5mpkln89h1ch1dfedv05v3;"
2013/12/11 21:17:43 [debug] 1516#0: *24 http map: "SESS926c91e0b2a34d58f86039a78ec14fcc=52rc5mpkln89h1ch1dfedv05v3; has_js=1; __utma=164703230.1712519080.1384111300.1386634287.1386795689.5; __utmb=164703230.3.10.1386795689; __utmc=164703230; __utmz=164703230.1384111300.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)" "52rc5mpkln89h1ch1dfedv05v3;"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "52rc5mpkln89h1ch1dfedv05v3;"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script value: "DrupalCookie"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script set $nocache_details
2013/12/11 21:17:43 [debug] 1516#0: *24 http finalize request: 405, "/?" a:1, c:2
2013/12/11 21:17:43 [debug] 1516#0: *24 http special response: 405, "/?"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "@cache"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "@drupal"
2013/12/11 21:17:43 [debug] 1516#0: *24 using location: @drupal "/?"
2013/12/11 21:17:43 [debug] 1516#0: *24 rewrite phase: 3
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if: false
2013/12/11 21:17:43 [debug] 1516#0: *24 http script regex: "^/(.*)$"
2013/12/11 21:17:43 [notice] 1516#0: *24 "^/(.*)$" matches "/", client: 63.155.48.181, server: customfinewoodwork.com, request: "GET / HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script copy: "/index.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script args
2013/12/11 21:17:43 [debug] 1516#0: *24 http script copy: "q="
2013/12/11 21:17:43 [debug] 1516#0: *24 http script capture: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http script regex end
2013/12/11 21:17:43 [notice] 1516#0: *24 rewritten data: "/index.php", args: "q=", client: 63.155.48.181, server: customfinewoodwork.com, request: "GET / HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 post rewrite phase: 4
2013/12/11 21:17:43 [debug] 1516#0: *24 uri changes: 9
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "favicon.ico"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "robots.txt"
2013/12/11 21:17:43 [debug] 1516#0: *24 test location: "index.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 using configuration "=/index.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 http cl:-1 max:1048576
2013/12/11 21:17:43 [debug] 1516#0: *24 rewrite phase: 3
2013/12/11 21:17:43 [debug] 1516#0: *24 http script value: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http script set $nocache
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "DrupalCookie"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script regex: "(?:Args|Skip)"
2013/12/11 21:17:43 [notice] 1516#0: *24 "(?:Args|Skip)" does not match "DrupalCookie", client: 63.155.48.181, server: customfinewoodwork.com, request: "GET / HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if
2013/12/11 21:17:43 [debug] 1516#0: *24 http script if: false
2013/12/11 21:17:43 [debug] 1516#0: *24 post rewrite phase: 4
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 5
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 6
2013/12/11 21:17:43 [debug] 1516#0: *24 generic phase: 7
2013/12/11 21:17:43 [debug] 1516#0: *24 access phase: 8
2013/12/11 21:17:43 [debug] 1516#0: *24 access phase: 9
2013/12/11 21:17:43 [debug] 1516#0: *24 access phase: 10
2013/12/11 21:17:43 [debug] 1516#0: *24 post access phase: 11
2013/12/11 21:17:43 [debug] 1516#0: *24 try files phase: 12
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "/index.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 trying to use file: "/index.php" "/var/aegir/platforms/customers-1.0/index.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 add cleanup: 0000000000D3EA78
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000FBDE20:144
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000FBDEC0:45
2013/12/11 21:17:43 [debug] 1516#0: *24 cached open file: /var/aegir/platforms/customers-1.0/index.php, fd:11, c:1, e:0, u:1
2013/12/11 21:17:43 [debug] 1516#0: *24 try file uri: "/index.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 http init upstream, client timer: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 epoll add event: fd:9 op:3 ev:80000005
2013/12/11 21:17:43 [debug] 1516#0: *24 http map started
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/31.0.1650.63 Safari/537.36"
2013/12/11 21:17:43 [debug] 1516#0: *24 http map: "Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/31.0.1650.63 Safari/537.36" ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http map started
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 http map: "/" "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 parse header: "Cookie: SESS926c91e0b2a34d58f86039a78ec14fcc=52rc5mpkln89h1ch1dfedv05v3; has_js=1; __utma=164703230.1712519080.1384111300.1386634287.1386795689.5; __utmb=164703230.3.10.1386795689; __utmc=164703230; __utmz=164703230.1384111300.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "aegir.projectzenonline.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "GET"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "52rc5mpkln89h1ch1dfedv05v3;"
2013/12/11 21:17:43 [debug] 1516#0: *24 http cache key: "aegir.projectzenonline.comGET/52rc5mpkln89h1ch1dfedv05v3;"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: ""
2013/12/11 21:17:43 [debug] 1516#0: *24 add cleanup: 0000000000D4E7E8
2013/12/11 21:17:43 [debug] 1516#0: *24 http file cache exists: 0 e:1
2013/12/11 21:17:43 [debug] 1516#0: *24 cache file: "/var/lib/nginx/speed/dc/9b/af/fb79e55446e0b165fac18669a6af9bdc"
2013/12/11 21:17:43 [debug] 1516#0: *24 add cleanup: 0000000000D4E840
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000FBDF00:144
2013/12/11 21:17:43 [debug] 1516#0: *24 malloc: 0000000000FBDFA0:63
2013/12/11 21:17:43 [debug] 1516#0: *24 cached open file: /var/lib/nginx/speed/dc/9b/af/fb79e55446e0b165fac18669a6af9bdc, fd:13, c:1, e:0, u:1
2013/12/11 21:17:43 [debug] 1516#0: *24 http file cache fd: 13
2013/12/11 21:17:43 [debug] 1516#0: *24 read: 13, 0000000000D4E8C8, 289, 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http upstream cache: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 01
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 06
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 00
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 01
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 00
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: B1
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 07
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record byte: 00
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi record length: 177
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi parser: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi header: "Status: 302 Moved Temporarily"
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi parser: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 posix_memalign: 00000000015D1E00:4096 @16
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi header: "X-Powered-By: PHP/5.3.10-1ubuntu3.6"
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi parser: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi header: "Location: http://aegir.projectzenonline.com/install.php"
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi parser: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi header: "Cache-Control: no-cache"
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi parser: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi header: "Content-type: text/html"
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi parser: 1
2013/12/11 21:17:43 [debug] 1516#0: *24 http fastcgi header done
2013/12/11 21:17:43 [debug] 1516#0: *24 http file cache send: /var/lib/nginx/speed/dc/9b/af/fb79e55446e0b165fac18669a6af9bdc
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "HIT"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "52rc5mpkln89h1ch1dfedv05v3;"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "/"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "DrupalCookie"
2013/12/11 21:17:43 [debug] 1516#0: *24 http script var: "customfinewoodwork.com"
2013/12/11 21:17:43 [debug] 1516#0: *24 xslt filter header
2013/12/11 21:17:43 [debug] 1516#0: *24 HTTP/1.1 302 Moved Temporarily
Server: nginx/1.1.19
Date: Wed, 11 Dec 2013 21:17:43 GMT
Content-Type: text/html
Transfer-Encoding: chunked
Connection: close
X-Powered-By: PHP/5.3.10-1ubuntu3.6
Location: http://aegir.projectzenonline.com/install.php
Cache-Control: no-cache
X-Engine: Aegir
X-Speed-Cache: HIT
X-Speed-Cache-UID: 52rc5mpkln89h1ch1dfedv05v3;
X-Speed-Cache-Key: /
X-NoCache: DrupalCookie
X-Server-Name: customfinewoodwork.com

2013/12/11 21:17:43 [debug] 1516#0: *24 write new buf t:1 f:0 00000000015D20B8, pos 00000000015D20B8, size: 455 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http write filter: l:0 f:0 s:455
2013/12/11 21:17:43 [debug] 1516#0: *24 http output filter "/index.php?q="
2013/12/11 21:17:43 [debug] 1516#0: *24 http copy filter: "/index.php?q="
2013/12/11 21:17:43 [debug] 1516#0: *24 image filter
2013/12/11 21:17:43 [debug] 1516#0: *24 xslt filter body
2013/12/11 21:17:43 [debug] 1516#0: *24 http postpone filter "/index.php?q=" 00007FFFDA308CC0
2013/12/11 21:17:43 [debug] 1516#0: *24 http chunk: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 write old buf t:1 f:0 00000000015D20B8, pos 00000000015D20B8, size: 455 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 write new buf t:0 f:0 0000000000000000, pos 000000000049DD9A, size: 5 file: 0, size: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http write filter: l:1 f:0 s:460
2013/12/11 21:17:43 [debug] 1516#0: *24 http write filter limit 0
2013/12/11 21:17:43 [debug] 1516#0: *24 writev: 460
2013/12/11 21:17:43 [debug] 1516#0: *24 http write filter 0000000000000000
2013/12/11 21:17:43 [debug] 1516#0: *24 http copy filter: 0 "/index.php?q="
2013/12/11 21:17:43 [debug] 1516#0: *24 http finalize request: 0, "/index.php?q=" a:1, c:4
2013/12/11 21:17:43 [debug] 1516#0: *24 http request count:4 blk:0
2013/12/11 21:17:43 [debug] 1516#0: *24 http finalize request: -4, "/index.php?q=" a:1, c:3
2013/12/11 21:17:43 [debug] 1516#0: *24 http request count:3 blk:0
2013/12/11 21:17:43 [debug] 1516#0: *24 http finalize request: -4, "/index.php?q=" a:1, c:2
2013/12/11 21:17:43 [debug] 1516#0: *24 http request count:2 blk:0
2013/12/11 21:17:43 [debug] 1516#0: *24 http finalize request: -4, "/index.php?q=" a:1, c:1
2013/12/11 21:17:43 [debug] 1516#0: *24 event timer add: 9: 5000:1386796668780
2013/12/11 21:17:43 [debug] 1516#0: *24 http lingering close handler
2013/12/11 21:17:43 [debug] 1516#0: *24 recv: fd:9 -1 of 4096
2013/12/11 21:17:43 [debug] 1516#0: *24 recv() not ready (11: Resource temporarily unavailable)
2013/12/11 21:17:43 [debug] 1516#0: *24 lingering read: -2
2013/12/11 21:17:43 [debug] 1516#0: *24 event timer: 9, old: 1386796668780, new: 1386796668780
2013/12/11 21:17:43 [debug] 1516#0: *24 post event 0000000000F7E560
2013/12/11 21:17:43 [debug] 1516#0: *24 delete posted event 0000000000F7E560
2013/12/11 21:17:43 [debug] 1516#0: *24 http empty handler
2013/12/11 21:17:43 [debug] 1516#0: *24 post event 0000000000F7E560
2013/12/11 21:17:43 [debug] 1516#0: *24 delete posted event 0000000000F7E560
2013/12/11 21:17:43 [debug] 1516#0: *24 http empty handler
2013/12/11 21:17:43 [debug] 1516#0: *24 post event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *24 post event 0000000000F7E560
2013/12/11 21:17:43 [debug] 1516#0: *24 delete posted event 0000000000F7E560
2013/12/11 21:17:43 [debug] 1516#0: *24 http empty handler
2013/12/11 21:17:43 [debug] 1516#0: *24 delete posted event 0000000000FAA610
2013/12/11 21:17:43 [debug] 1516#0: *24 http lingering close handler
2013/12/11 21:17:43 [debug] 1516#0: *24 recv: fd:9 0 of 4096
2013/12/11 21:17:43 [debug] 1516#0: *24 lingering read: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 http request count:1 blk:0
2013/12/11 21:17:43 [debug] 1516#0: *24 http close request
2013/12/11 21:17:43 [debug] 1516#0: *24 http log handler
2013/12/11 21:17:43 [debug] 1516#0: *24 run cleanup: 0000000000D4E840
2013/12/11 21:17:43 [debug] 1516#0: *24 close cached open file: /var/lib/nginx/speed/dc/9b/af/fb79e55446e0b165fac18669a6af9bdc, fd:13, c:0, u:1, 0
2013/12/11 21:17:43 [debug] 1516#0: *24 run cleanup: 0000000000D4E7E8
2013/12/11 21:17:43 [debug] 1516#0: *24 http file cache cleanup
2013/12/11 21:17:43 [debug] 1516#0: *24 http file cache free, fd: 13
2013/12/11 21:17:43 [debug] 1516#0: *24 run cleanup: 0000000000D3EA78
2013/12/11 21:17:43 [debug] 1516#0: *24 close cached open file: /var/aegir/platforms/customers-1.0/index.php, fd:11, c:0, u:1, 0
2013/12/11 21:17:43 [debug] 1516#0: *24 run cleanup: 0000000000D3E880
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 0000000000D3DAB0, unused: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 0000000000D4DBA0, unused: 9
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 00000000015D1E00, unused: 2208
2013/12/11 21:17:43 [debug] 1516#0: *24 close http connection: 9
2013/12/11 21:17:43 [debug] 1516#0: *24 event timer del: 9: 1386796668780
2013/12/11 21:17:43 [debug] 1516#0: *24 reusable connection: 0
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 0000000000F5E410
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 0000000000F91CA0
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 0000000000D355C0, unused: 8
2013/12/11 21:17:43 [debug] 1516#0: *24 free: 0000000000F921C0, unused: 112
2013/12/11 21:17:44 [debug] 1516#0: post event 0000000000FAA540
2013/12/11 21:17:44 [debug] 1516#0: delete posted event 0000000000FAA540
2013/12/11 21:17:44 [debug] 1516#0: accept on 0.0.0.0:80, ready: 0
2013/12/11 21:17:44 [debug] 1516#0: posix_memalign: 0000000000D355C0:256 @16
2013/12/11 21:17:44 [debug] 1516#0: *25 accept: 63.155.48.181 fd:9
2013/12/11 21:17:44 [debug] 1516#0: *25 event timer add: 9: 60000:1386796724010
2013/12/11 21:17:44 [debug] 1516#0: *25 epoll add event: fd:9 op:1 ev:80000001
2013/12/11 21:17:44 [debug] 1516#0: *25 post event 0000000000FAA610
2013/12/11 21:17:44 [debug] 1516#0: *25 delete posted event 0000000000FAA610
2013/12/11 21:17:44 [debug] 1516#0: *25 malloc: 0000000000FBDFF0:1296
2013/12/11 21:17:44 [debug] 1516#0: *25 posix_memalign: 0000000000F91CA0:256 @16
2013/12/11 21:17:44 [debug] 1516#0: *25 malloc: 0000000000F5E410:32768
2013/12/11 21:17:44 [debug] 1516#0: *25 posix_memalign: 0000000000D4DBA0:4096 @16
2013/12/11 21:17:44 [debug] 1516#0: *25 http process request line
2013/12/11 21:17:44 [debug] 1516#0: *25 recv: fd:9 666 of 32768
2013/12/11 21:17:44 [debug] 1516#0: *25 http request line: "GET /install.php HTTP/1.1"
2013/12/11 21:17:44 [debug] 1516#0: *25 http uri: "/install.php"
2013/12/11 21:17:44 [debug] 1516#0: *25 http args: ""
2013/12/11 21:17:44 [debug] 1516#0: *25 http exten: "php"
2013/12/11 21:17:44 [debug] 1516#0: *25 http process request header line
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Host: aegir.projectzenonline.com"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Connection: keep-alive"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Cache-Control: max-age=0"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/31.0.1650.63 Safari/537.36"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Accept-Encoding: gzip,deflate,sdch"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Accept-Language: en-US,en;q=0.8"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header: "Cookie: SESS926c91e0b2a34d58f86039a78ec14fcc=52rc5mpkln89h1ch1dfedv05v3; has_js=1; __utma=164703230.1712519080.1384111300.1386634287.1386795689.5; __utmb=164703230.3.10.1386795689; __utmc=164703230; __utmz=164703230.1384111300.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none)"
2013/12/11 21:17:44 [debug] 1516#0: *25 http header done
2013/12/11 21:17:44 [debug] 1516#0: *25 event timer del: 9: 1386796724010
2013/12/11 21:17:44 [debug] 1516#0: *25 generic phase: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 rewrite phase: 1
2013/12/11 21:17:44 [debug] 1516#0: *25 http script value: "Cache"
2013/12/11 21:17:44 [debug] 1516#0: *25 http script set $nocache_details
2013/12/11 21:17:44 [debug] 1516#0: *25 http script var
2013/12/11 21:17:44 [debug] 1516#0: *25 http script var: "GET"
2013/12/11 21:17:44 [debug] 1516#0: *25 http script regex: "^(?:GET|HEAD|POST|PUT|DELETE|OPTIONS)$"
2013/12/11 21:17:44 [notice] 1516#0: *25 "^(?:GET|HEAD|POST|PUT|DELETE|OPTIONS)$" matches "GET", client: 63.155.48.181, server: customfinewoodwork.com, request: "GET /install.php HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:44 [debug] 1516#0: *25 http script if
2013/12/11 21:17:44 [debug] 1516#0: *25 http script if: false
2013/12/11 21:17:44 [debug] 1516#0: *25 http script var
2013/12/11 21:17:44 [debug] 1516#0: *25 http map started
2013/12/11 21:17:44 [debug] 1516#0: *25 http map: "" ""
2013/12/11 21:17:44 [debug] 1516#0: *25 http script var: ""
2013/12/11 21:17:44 [debug] 1516#0: *25 http script if
2013/12/11 21:17:44 [debug] 1516#0: *25 http script if: false
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: "/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: "favicon.ico"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: "robots.txt"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: "index.php"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "(/\..*|settings\.php$|\.(?:git|htaccess|engine|inc|info|install|module|profile|pl|po|sh|.*sql|theme|tpl(?:\.php)?|xtmpl)$|^(?:Entries.*|Repository|Root|Tag|Template))$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "\.r\.(?:jpe?g|png|gif)"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "/(?:.+)/files/styles/adaptive/(?:.+)$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "/(?:external|system|files/imagecache|files/styles)/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/sites/.*/files/backup_migrate/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/sites/.*/files/private/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/sites/.*/private/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "/files/private/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "wysiwyg_fields/(?:plugins|scripts)/.*\.(?:js|css)"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "files/advagg_(?:css|js)/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "\.css$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "\.(?:js|htc)$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "\.json$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^.+\.(?:jpe?g|gif|png|ico|bmp|svg|swf|pdf|docx?|xlsx?|pptx?|tiff?|txt|rtf|cgi|bat|pl|dll|aspx?|class|otf|ttf|woff|eot|less)$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^.+\.(?:avi|mpe?g|mov|wmv|mp3|mp4|m4a|ogg|ogv|flv|wav|midi|zip|tar|t?gz|rar|dmg|exe)$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "/(?:cross-?domain)\.xml$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "/(?:modules|libraries)/(?:contrib/)?(?:ad|tinybrowser|f?ckeditor|tinymce|wysiwyg_spellcheck|ecc|civicrm|fbconnect|radioactivity)/.*\.php$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/sites/.*/(?:modules|libraries)/(?:contrib/)?(?:tinybrowser|f?ckeditor|tinymce)/.*\.(?:html?|xml)$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/sites/.*/files/"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "\.xml$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/(?:.*/)?(?:admin|user|cart|checkout|logout|flag|comment/reply)"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/(?:.*/)?(?:node/[0-9]+/edit|node/add|approve)"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^/(?:boost_stats|update|authorize|xmlrpc)\.php$"
2013/12/11 21:17:44 [debug] 1516#0: *25 test location: ~ "^.+\.php$"
2013/12/11 21:17:44 [debug] 1516#0: *25 using configuration "^.+\.php$"
2013/12/11 21:17:44 [debug] 1516#0: *25 http cl:-1 max:1048576
2013/12/11 21:17:44 [debug] 1516#0: *25 rewrite phase: 3
2013/12/11 21:17:44 [debug] 1516#0: *25 post rewrite phase: 4
2013/12/11 21:17:44 [debug] 1516#0: *25 generic phase: 5
2013/12/11 21:17:44 [debug] 1516#0: *25 generic phase: 6
2013/12/11 21:17:44 [debug] 1516#0: *25 generic phase: 7
2013/12/11 21:17:44 [debug] 1516#0: *25 limit zone: 1C07110A 1
2013/12/11 21:17:44 [debug] 1516#0: *25 add cleanup: 0000000000D4E970
2013/12/11 21:17:44 [debug] 1516#0: *25 access phase: 8
2013/12/11 21:17:44 [debug] 1516#0: *25 access phase: 9
2013/12/11 21:17:44 [debug] 1516#0: *25 access: B5309B3F 00000000 00000000
2013/12/11 21:17:44 [error] 1516#0: *25 access forbidden by rule, client: 63.155.48.181, server: customfinewoodwork.com, request: "GET /install.php HTTP/1.1", host: "aegir.projectzenonline.com"
2013/12/11 21:17:44 [debug] 1516#0: *25 http finalize request: 403, "/install.php?" a:1, c:1
2013/12/11 21:17:44 [debug] 1516#0: *25 http special response: 403, "/install.php?"
2013/12/11 21:17:44 [debug] 1516#0: *25 http set discard body
2013/12/11 21:17:44 [debug] 1516#0: *25 xslt filter header
2013/12/11 21:17:44 [debug] 1516#0: *25 posix_memalign: 0000000000D3DAB0:4096 @16
2013/12/11 21:17:44 [debug] 1516#0: *25 HTTP/1.1 403 Forbidden
Server: nginx/1.1.19
Date: Wed, 11 Dec 2013 21:17:44 GMT
Content-Type: text/html
Transfer-Encoding: chunked
Connection: keep-alive
Vary: Accept-Encoding
Content-Encoding: gzip

2013/12/11 21:17:44 [debug] 1516#0: *25 write new buf t:1 f:0 0000000000D3DAD0, pos 0000000000D3DAD0, size: 209 file: 0, size: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 http write filter: l:0 f:0 s:209
2013/12/11 21:17:44 [debug] 1516#0: *25 http output filter "/install.php?"
2013/12/11 21:17:44 [debug] 1516#0: *25 http copy filter: "/install.php?"
2013/12/11 21:17:44 [debug] 1516#0: *25 image filter
2013/12/11 21:17:44 [debug] 1516#0: *25 xslt filter body
2013/12/11 21:17:44 [debug] 1516#0: *25 http postpone filter "/install.php?" 0000000000D4EB70
2013/12/11 21:17:44 [debug] 1516#0: *25 http gzip filter
2013/12/11 21:17:44 [debug] 1516#0: *25 malloc: 0000000001633350:16384
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip alloc: n:1 s:5936 a:8192 p:0000000001633350
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip alloc: n:1024 s:2 a:2048 p:0000000001635350
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip alloc: n:1024 s:2 a:2048 p:0000000001635B50
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip alloc: n:1024 s:2 a:2048 p:0000000001636350
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip alloc: n:512 s:4 a:2048 p:0000000001636B50
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in: 0000000000D3DCC0
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in_buf:0000000000D4EB20 ni:00000000006BE720 ai:116
2013/12/11 21:17:44 [debug] 1516#0: *25 malloc: 0000000001943F90:8192
2013/12/11 21:17:44 [debug] 1516#0: *25 deflate in: ni:00000000006BE720 no:0000000001943F90 ai:116 ao:8192 fl:0 redo:0
2013/12/11 21:17:44 [debug] 1516#0: *25 deflate out: ni:00000000006BE794 no:0000000001943F90 ai:0 ao:8192 rc:0
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in_buf:0000000000D4EB20 pos:00000000006BE720
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in: 0000000000D3DCD0
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in_buf:0000000000D3DBA8 ni:00000000006BE100 ai:53
2013/12/11 21:17:44 [debug] 1516#0: *25 deflate in: ni:00000000006BE100 no:0000000001943F90 ai:53 ao:8192 fl:0 redo:0
2013/12/11 21:17:44 [debug] 1516#0: *25 deflate out: ni:00000000006BE135 no:0000000001943F90 ai:0 ao:8192 rc:0
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in_buf:0000000000D3DBA8 pos:00000000006BE100
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in: 0000000000D3DCE0
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in_buf:0000000000D3DBF8 ni:00000000006BE180 ai:402
2013/12/11 21:17:44 [debug] 1516#0: *25 deflate in: ni:00000000006BE180 no:0000000001943F90 ai:402 ao:8192 fl:4 redo:0
2013/12/11 21:17:44 [debug] 1516#0: *25 deflate out: ni:00000000006BE312 no:0000000001944037 ai:0 ao:8025 rc:1
2013/12/11 21:17:44 [debug] 1516#0: *25 gzip in_buf:0000000000D3DBF8 pos:00000000006BE180
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000001633350
2013/12/11 21:17:44 [debug] 1516#0: *25 http chunk: 10
2013/12/11 21:17:44 [debug] 1516#0: *25 http chunk: 175
2013/12/11 21:17:44 [debug] 1516#0: *25 write old buf t:1 f:0 0000000000D3DAD0, pos 0000000000D3DAD0, size: 209 file: 0, size: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 write new buf t:1 f:0 0000000000D3DE40, pos 0000000000D3DE40, size: 4 file: 0, size: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 write new buf t:0 f:0 0000000000000000, pos 00000000006C24C8, size: 10 file: 0, size: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 write new buf t:1 f:0 0000000001943F90, pos 0000000001943F90, size: 175 file: 0, size: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 write new buf t:0 f:0 0000000000000000, pos 000000000049DD98, size: 7 file: 0, size: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 http write filter: l:1 f:1 s:405
2013/12/11 21:17:44 [debug] 1516#0: *25 http write filter limit 0
2013/12/11 21:17:44 [debug] 1516#0: *25 writev: 405
2013/12/11 21:17:44 [debug] 1516#0: *25 http write filter 0000000000000000
2013/12/11 21:17:44 [debug] 1516#0: *25 http copy filter: 0 "/install.php?"
2013/12/11 21:17:44 [debug] 1516#0: *25 http finalize request: 0, "/install.php?" a:1, c:1
2013/12/11 21:17:44 [debug] 1516#0: *25 set http keepalive handler
2013/12/11 21:17:44 [debug] 1516#0: *25 http close request
2013/12/11 21:17:44 [debug] 1516#0: *25 http log handler
2013/12/11 21:17:44 [debug] 1516#0: *25 run cleanup: 0000000000D4E970
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000001943F90
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000000000000
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000000D4DBA0, unused: 0
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000000D3DAB0, unused: 2457
2013/12/11 21:17:44 [debug] 1516#0: *25 event timer add: 9: 65000:1386796729012
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000000FBDFF0
2013/12/11 21:17:44 [debug] 1516#0: *25 free: 0000000000F5E410
2013/12/11 21:17:44 [debug] 1516#0: *25 hc free: 0000000000000000 0
2013/12/11 21:17:44 [debug] 1516#0: *25 hc busy: 0000000000000000 0
2013/12/11 21:17:44 [debug] 1516#0: *25 tcp_nodelay
2013/12/11 21:17:44 [debug] 1516#0: *25 reusable connection: 1
2013/12/11 21:17:44 [debug] 1516#0: *25 post event 0000000000FAA610
2013/12/11 21:17:44 [debug] 1516#0: *25 delete posted event 0000000000FAA610
2013/12/11 21:17:44 [debug] 1516#0: *25 http keepalive handler
2013/12/11 21:17:44 [debug] 1516#0: *25 malloc: 0000000000F5E410:32768
2013/12/11 21:17:44 [debug] 1516#0: *25 recv: fd:9 -1 of 32768
2013/12/11 21:17:44 [debug] 1516#0: *25 recv() not ready (11: Resource temporarily unavailable)
2013/12/11 21:17:47 [debug] 1516#0: post event 0000000000FAA540
2013/12/11 21:17:47 [debug] 1516#0: delete posted event 0000000000FAA540
2013/12/11 21:17:47 [debug] 1516#0: accept on 0.0.0.0:80, ready: 0
2013/12/11 21:17:47 [debug] 1516#0: posix_memalign: 0000000000F91DB0:256 @16
2013/12/11 21:17:47 [debug] 1516#0: *26 accept: 91.207.7.189 fd:11
2013/12/11 21:17:47 [debug] 1516#0: *26 event timer add: 11: 60000:1386796727947
2013/12/11 21:17:47 [debug] 1516#0: *26 epoll add event: fd:11 op:1 ev:80000001
2013/12/11 21:17:47 [debug] 1516#0: *26 post event 0000000000FAA678
2013/12/11 21:17:47 [debug] 1516#0: *26 delete posted event 0000000000FAA678
2013/12/11 21:17:47 [debug] 1516#0: *26 malloc: 0000000000FBDFF0:1296
2013/12/11 21:17:47 [debug] 1516#0: *26 posix_memalign: 0000000000F91EC0:256 @16
2013/12/11 21:17:47 [debug] 1516#0: *26 malloc: 0000000000D4FBC0:32768
2013/12/11 21:17:47 [debug] 1516#0: *26 posix_memalign: 0000000000D3DAB0:4096 @16
2013/12/11 21:17:47 [debug] 1516#0: *26 http process request line
2013/12/11 21:17:47 [debug] 1516#0: *26 recv: fd:11 420 of 32768
2013/12/11 21:17:47 [debug] 1516#0: *26 http request line: "GET / HTTP/1.0"
2013/12/11 21:17:47 [debug] 1516#0: *26 http uri: "/"
2013/12/11 21:17:47 [debug] 1516#0: *26 http args: ""
2013/12/11 21:17:47 [debug] 1516#0: *26 http exten: ""
2013/12/11 21:17:47 [debug] 1516#0: *26 http process request header line
2013/12/11 21:17:47 [debug] 1516#0: *26 http header: "Accept: image/gif, image/jpeg, image/pjpeg, application/x-ms-application, application/vnd.ms-xpsdocument, application/xaml+xml, application/x-ms-xbap, application/vnd.ms-excel, application/vnd.ms-powerpoint, application/msword, application/x-shockwave-flash, */*"
2013/12/11 21:17:47 [debug] 1516#0: *26 http header: "User-Agent: Opera/9.80 (Windows NT 6.1; Win64; x64) Presto/2.12.388 Version/12.11"
2013/12/11 21:17:47 [debug] 1516#0: *26 http header: "Referer: http://gardennuts.com/"
2013/12/11 21:17:47 [debug] 1516#0: *26 http header: "Host: gardennuts.com"
2013/12/11 21:17:47 [debug] 1516#0: *26 http header done
2013/12/11 21:17:47 [debug] 1516#0: *26 event timer del: 11: 1386796727947
2013/12/11 21:17:47 [debug] 1516#0: *26 generic phase: 0
2013/12/11 21:17:47 [debug] 1516#0: *26 rewrite phase: 1
2013/12/11 21:17:47 [debug] 1516#0: *26 using configuration ""
2013/12/11 21:17:47 [debug] 1516#0: *26 http cl:-1 max:1048576
2013/12/11 21:17:47 [debug] 1516#0: *26 rewrite phase: 3
2013/12/11 21:17:47 [debug] 1516#0: *26 post rewrite phase: 4
2013/12/11 21:17:47 [debug] 1516#0: *26 generic phase: 5
2013/12/11 21:17:47 [debug] 1516#0: *26 generic phase: 6
2013/12/11 21:17:47 [debug] 1516#0: *26 generic phase: 7
2013/12/11 21:17:47 [debug] 1516#0: *26 limit zone: 5D2ADF34 1
2013/12/11 21:17:47 [debug] 1516#0: *26 add cleanup: 0000000000D3E728
2013/12/11 21:17:47 [debug] 1516#0: *26 access phase: 8
2013/12/11 21:17:47 [debug] 1516#0: *26 access phase: 9
2013/12/11 21:17:47 [debug] 1516#0: *26 access phase: 10
2013/12/11 21:17:47 [debug] 1516#0: *26 post access phase: 11
2013/12/11 21:17:47 [debug] 1516#0: *26 try files phase: 12
2013/12/11 21:17:47 [debug] 1516#0: *26 content phase: 13
2013/12/11 21:17:47 [debug] 1516#0: *26 content phase: 14
2013/12/11 21:17:47 [debug] 1516#0: *26 open index "/var/www/nginx-default/index.html"
2013/12/11 21:17:47 [debug] 1516#0: *26 add cleanup: 0000000000D3E778
2013/12/11 21:17:47 [debug] 1516#0: *26 malloc: 0000000000F91FD0:144
2013/12/11 21:17:47 [debug] 1516#0: *26 malloc: 0000000000F92070:34
2013/12/11 21:17:47 [debug] 1516#0: *26 cached open file: /var/www/nginx-default/index.html, fd:-1, c:0, e:2, u:1
2013/12/11 21:17:47 [debug] 1516#0: *26 open() "/var/www/nginx-default/index.html" failed (2: No such file or directory)
2013/12/11 21:17:47 [debug] 1516#0: *26 http index check dir: "/var/www/nginx-default"
2013/12/11 21:17:47 [debug] 1516#0: *26 add cleanup: 0000000000D3E7B0
2013/12/11 21:17:47 [debug] 1516#0: *26 malloc: 0000000000F920A0:144
2013/12/11 21:17:47 [debug] 1516#0: *26 malloc: 0000000000F92140:23
2013/12/11 21:17:47 [debug] 1516#0: *26 cached open file: /var/www/nginx-default, fd:-1, c:0, e:2, u:1
2013/12/11 21:17:47 [error] 1516#0: *26 "/var/www/nginx-default/index.html" is not found (2: No such file or directory), client: 91.207.7.189, server: gardennuts.com, request: "GET / HTTP/1.0", host: "gardennuts.com", referrer: "http://gardennuts.com/"
2013/12/11 21:17:47 [debug] 1516#0: *26 http finalize request: 404, "/?" a:1, c:1
2013/12/11 21:17:47 [debug] 1516#0: *26 http special response: 404, "/?"
2013/12/11 21:17:47 [debug] 1516#0: *26 http set discard body
2013/12/11 21:17:47 [debug] 1516#0: *26 xslt filter header
2013/12/11 21:17:47 [debug] 1516#0: *26 HTTP/1.1 404 Not Found
Server: nginx/1.1.19
Date: Wed, 11 Dec 2013 21:17:47 GMT
Content-Type: text/html
Content-Length: 169
Connection: close
Vary: Accept-Encoding

2013/12/11 21:17:47 [debug] 1516#0: *26 write new buf t:1 f:0 0000000000D3E848, pos 0000000000D3E848, size: 173 file: 0, size: 0
2013/12/11 21:17:47 [debug] 1516#0: *26 http write filter: l:0 f:0 s:173
2013/12/11 21:17:47 [debug] 1516#0: *26 http output filter "/?"
2013/12/11 21:17:47 [debug] 1516#0: *26 http copy filter: "/?"
2013/12/11 21:17:47 [debug] 1516#0: *26 image filter
2013/12/11 21:17:47 [debug] 1516#0: *26 xslt filter body
2013/12/11 21:17:47 [debug] 1516#0: *26 http postpone filter "/?" 0000000000D3EA20
2013/12/11 21:17:47 [debug] 1516#0: *26 write old buf t:1 f:0 0000000000D3E848, pos 0000000000D3E848, size: 173 file: 0, size: 0
2013/12/11 21:17:47 [debug] 1516#0: *26 write new buf t:0 f:0 0000000000000000, pos 00000000006BE7A0, size: 116 file: 0, size: 0
2013/12/11 21:17:47 [debug] 1516#0: *26 write new buf t:0 f:0 0000000000000000, pos 00000000006BE100, size: 53 file: 0, size: 0
2013/12/11 21:17:47 [debug] 1516#0: *26 http write filter: l:1 f:0 s:342
2013/12/11 21:17:47 [debug] 1516#0: *26 http write filter limit 0
2013/12/11 21:17:47 [debug] 1516#0: *26 writev: 342
2013/12/11 21:17:47 [debug] 1516#0: *26 http write filter 0000000000000000
2013/12/11 21:17:47 [debug] 1516#0: *26 http copy filter: 0 "/?"
2013/12/11 21:17:47 [debug] 1516#0: *26 http finalize request: 0, "/?" a:1, c:1
2013/12/11 21:17:47 [debug] 1516#0: *26 event timer add: 11: 5000:1386796672947
2013/12/11 21:17:47 [debug] 1516#0: *26 http lingering close handler
2013/12/11 21:17:47 [debug] 1516#0: *26 recv: fd:11 -1 of 4096
2013/12/11 21:17:47 [debug] 1516#0: *26 recv() not ready (11: Resource temporarily unavailable)
2013/12/11 21:17:47 [debug] 1516#0: *26 lingering read: -2
2013/12/11 21:17:47 [debug] 1516#0: *26 event timer: 11, old: 1386796672947, new: 1386796672947
2013/12/11 21:17:48 [debug] 1516#0: *26 post event 0000000000FAA678
2013/12/11 21:17:48 [debug] 1516#0: *26 delete posted event 0000000000FAA678
2013/12/11 21:17:48 [debug] 1516#0: *26 http lingering close handler
2013/12/11 21:17:48 [debug] 1516#0: *26 recv: fd:11 0 of 4096
2013/12/11 21:17:48 [debug] 1516#0: *26 lingering read: 0
2013/12/11 21:17:48 [debug] 1516#0: *26 http request count:1 blk:0
2013/12/11 21:17:48 [debug] 1516#0: *26 http close request
2013/12/11 21:17:48 [debug] 1516#0: *26 http log handler
2013/12/11 21:17:48 [debug] 1516#0: *26 posix_memalign: 0000000000D4DBA0:4096 @16
2013/12/11 21:17:48 [debug] 1516#0: *26 run cleanup: 0000000000D3E728
2013/12/11 21:17:48 [debug] 1516#0: *26 free: 0000000000D3DAB0, unused: 80
2013/12/11 21:17:48 [debug] 1516#0: *26 free: 0000000000D4DBA0, unused: 3610
2013/12/11 21:17:48 [debug] 1516#0: *26 close http connection: 11
2013/12/11 21:17:48 [debug] 1516#0: *26 event timer del: 11: 1386796672947
2013/12/11 21:17:48 [debug] 1516#0: *26 reusable connection: 0
2013/12/11 21:17:48 [debug] 1516#0: *26 free: 0000000000D4FBC0
2013/12/11 21:17:48 [debug] 1516#0: *26 free: 0000000000FBDFF0
2013/12/11 21:17:48 [debug] 1516#0: *26 free: 0000000000F91DB0, unused: 8
2013/12/11 21:17:48 [debug] 1516#0: *26 free: 0000000000F91EC0, unused: 112
2013/12/11 21:17:48 [debug] 1516#0: post event 0000000000FAA540
2013/12/11 21:17:48 [debug] 1516#0: delete posted event 0000000000FAA540
2013/12/11 21:17:48 [debug] 1516#0: accept on 0.0.0.0:80, ready: 0
2013/12/11 21:17:48 [debug] 1516#0: posix_memalign: 0000000000F92160:256 @16
2013/12/11 21:17:48 [debug] 1516#0: *27 accept: 91.207.7.189 fd:11
2013/12/11 21:17:48 [debug] 1516#0: *27 event timer add: 11: 60000:1386796728205
2013/12/11 21:17:48 [debug] 1516#0: *27 epoll add event: fd:11 op:1 ev:80000001
2013/12/11 21:17:48 [debug] 1516#0: *27 post event 0000000000FAA678
2013/12/11 21:17:48 [debug] 1516#0: *27 delete posted event 0000000000FAA678
2013/12/11 21:17:48 [debug] 1516#0: *27 malloc: 0000000000FBDFF0:1296
2013/12/11 21:17:48 [debug] 1516#0: *27 posix_memalign: 0000000000F91DB0:256 @16
2013/12/11 21:17:48 [debug] 1516#0: *27 malloc: 0000000000D4FBC0:32768
2013/12/11 21:17:48 [debug] 1516#0: *27 posix_memalign: 0000000000D4DBA0:4096 @16
2013/12/11 21:17:48 [debug] 1516#0: *27 http process request line
2013/12/11 21:17:48 [debug] 1516#0: *27 recv: fd:11 420 of 32768
2013/12/11 21:17:48 [debug] 1516#0: *27 http request line: "GET / HTTP/1.0"
2013/12/11 21:17:48 [debug] 1516#0: *27 http uri: "/"
2013/12/11 21:17:48 [debug] 1516#0: *27 http args: ""
2013/12/11 21:17:48 [debug] 1516#0: *27 http exten: ""
2013/12/11 21:17:48 [debug] 1516#0: *27 http process request header line
2013/12/11 21:17:48 [debug] 1516#0: *27 http header: "Accept: image/gif, image/jpeg, image/pjpeg, application/x-ms-application, application/vnd.ms-xpsdocument, application/xaml+xml, application/x-ms-xbap, application/vnd.ms-excel, application/vnd.ms-powerpoint, application/msword, application/x-shockwave-flash, */*"
2013/12/11 21:17:48 [debug] 1516#0: *27 http header: "User-Agent: Opera/9.80 (Windows NT 6.1; Win64; x64) Presto/2.12.388 Version/12.11"
2013/12/11 21:17:48 [debug] 1516#0: *27 http header: "Referer: http://gardennuts.com/"
2013/12/11 21:17:48 [debug] 1516#0: *27 http header: "Host: gardennuts.com"
2013/12/11 21:17:48 [debug] 1516#0: *27 http header done
2013/12/11 21:17:48 [debug] 1516#0: *27 event timer del: 11: 1386796728205
2013/12/11 21:17:48 [debug] 1516#0: *27 generic phase: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 rewrite phase: 1
2013/12/11 21:17:48 [debug] 1516#0: *27 using configuration ""
2013/12/11 21:17:48 [debug] 1516#0: *27 http cl:-1 max:1048576
2013/12/11 21:17:48 [debug] 1516#0: *27 rewrite phase: 3
2013/12/11 21:17:48 [debug] 1516#0: *27 post rewrite phase: 4
2013/12/11 21:17:48 [debug] 1516#0: *27 generic phase: 5
2013/12/11 21:17:48 [debug] 1516#0: *27 generic phase: 6
2013/12/11 21:17:48 [debug] 1516#0: *27 generic phase: 7
2013/12/11 21:17:48 [debug] 1516#0: *27 limit zone: 5D2ADF34 1
2013/12/11 21:17:48 [debug] 1516#0: *27 add cleanup: 0000000000D4E818
2013/12/11 21:17:48 [debug] 1516#0: *27 access phase: 8
2013/12/11 21:17:48 [debug] 1516#0: *27 access phase: 9
2013/12/11 21:17:48 [debug] 1516#0: *27 access phase: 10
2013/12/11 21:17:48 [debug] 1516#0: *27 post access phase: 11
2013/12/11 21:17:48 [debug] 1516#0: *27 try files phase: 12
2013/12/11 21:17:48 [debug] 1516#0: *27 content phase: 13
2013/12/11 21:17:48 [debug] 1516#0: *27 content phase: 14
2013/12/11 21:17:48 [debug] 1516#0: *27 open index "/var/www/nginx-default/index.html"
2013/12/11 21:17:48 [debug] 1516#0: *27 add cleanup: 0000000000D4E868
2013/12/11 21:17:48 [debug] 1516#0: *27 cached open file: /var/www/nginx-default/index.html, fd:-1, c:0, e:2, u:2
2013/12/11 21:17:48 [debug] 1516#0: *27 open() "/var/www/nginx-default/index.html" failed (2: No such file or directory)
2013/12/11 21:17:48 [debug] 1516#0: *27 http index check dir: "/var/www/nginx-default"
2013/12/11 21:17:48 [debug] 1516#0: *27 add cleanup: 0000000000D4E8A0
2013/12/11 21:17:48 [debug] 1516#0: *27 cached open file: /var/www/nginx-default, fd:-1, c:0, e:2, u:2
2013/12/11 21:17:48 [error] 1516#0: *27 "/var/www/nginx-default/index.html" is not found (2: No such file or directory), client: 91.207.7.189, server: gardennuts.com, request: "GET / HTTP/1.0", host: "gardennuts.com", referrer: "http://gardennuts.com/"
2013/12/11 21:17:48 [debug] 1516#0: *27 http finalize request: 404, "/?" a:1, c:1
2013/12/11 21:17:48 [debug] 1516#0: *27 http special response: 404, "/?"
2013/12/11 21:17:48 [debug] 1516#0: *27 http set discard body
2013/12/11 21:17:48 [debug] 1516#0: *27 xslt filter header
2013/12/11 21:17:48 [debug] 1516#0: *27 HTTP/1.1 404 Not Found
Server: nginx/1.1.19
Date: Wed, 11 Dec 2013 21:17:48 GMT
Content-Type: text/html
Content-Length: 169
Connection: close
Vary: Accept-Encoding

2013/12/11 21:17:48 [debug] 1516#0: *27 write new buf t:1 f:0 0000000000D4E938, pos 0000000000D4E938, size: 173 file: 0, size: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 http write filter: l:0 f:0 s:173
2013/12/11 21:17:48 [debug] 1516#0: *27 http output filter "/?"
2013/12/11 21:17:48 [debug] 1516#0: *27 http copy filter: "/?"
2013/12/11 21:17:48 [debug] 1516#0: *27 image filter
2013/12/11 21:17:48 [debug] 1516#0: *27 xslt filter body
2013/12/11 21:17:48 [debug] 1516#0: *27 http postpone filter "/?" 0000000000D4EB10
2013/12/11 21:17:48 [debug] 1516#0: *27 write old buf t:1 f:0 0000000000D4E938, pos 0000000000D4E938, size: 173 file: 0, size: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 write new buf t:0 f:0 0000000000000000, pos 00000000006BE7A0, size: 116 file: 0, size: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 write new buf t:0 f:0 0000000000000000, pos 00000000006BE100, size: 53 file: 0, size: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 http write filter: l:1 f:0 s:342
2013/12/11 21:17:48 [debug] 1516#0: *27 http write filter limit 0
2013/12/11 21:17:48 [debug] 1516#0: *27 writev: 342
2013/12/11 21:17:48 [debug] 1516#0: *27 http write filter 0000000000000000
2013/12/11 21:17:48 [debug] 1516#0: *27 http copy filter: 0 "/?"
2013/12/11 21:17:48 [debug] 1516#0: *27 http finalize request: 0, "/?" a:1, c:1
2013/12/11 21:17:48 [debug] 1516#0: *27 event timer add: 11: 5000:1386796673205
2013/12/11 21:17:48 [debug] 1516#0: *27 http lingering close handler
2013/12/11 21:17:48 [debug] 1516#0: *27 recv: fd:11 -1 of 4096
2013/12/11 21:17:48 [debug] 1516#0: *27 recv() not ready (11: Resource temporarily unavailable)
2013/12/11 21:17:48 [debug] 1516#0: *27 lingering read: -2
2013/12/11 21:17:48 [debug] 1516#0: *27 event timer: 11, old: 1386796673205, new: 1386796673205
2013/12/11 21:17:48 [debug] 1516#0: *27 post event 0000000000FAA678
2013/12/11 21:17:48 [debug] 1516#0: *27 delete posted event 0000000000FAA678
2013/12/11 21:17:48 [debug] 1516#0: *27 http lingering close handler
2013/12/11 21:17:48 [debug] 1516#0: *27 recv: fd:11 0 of 4096
2013/12/11 21:17:48 [debug] 1516#0: *27 lingering read: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 http request count:1 blk:0
2013/12/11 21:17:48 [debug] 1516#0: *27 http close request
2013/12/11 21:17:48 [debug] 1516#0: *27 http log handler
2013/12/11 21:17:48 [debug] 1516#0: *27 posix_memalign: 0000000000D3DAB0:4096 @16
2013/12/11 21:17:48 [debug] 1516#0: *27 run cleanup: 0000000000D4E818
2013/12/11 21:17:48 [debug] 1516#0: *27 free: 0000000000D4DBA0, unused: 80
2013/12/11 21:17:48 [debug] 1516#0: *27 free: 0000000000D3DAB0, unused: 3610
2013/12/11 21:17:48 [debug] 1516#0: *27 close http connection: 11
2013/12/11 21:17:48 [debug] 1516#0: *27 event timer del: 11: 1386796673205
2013/12/11 21:17:48 [debug] 1516#0: *27 reusable connection: 0
2013/12/11 21:17:48 [debug] 1516#0: *27 free: 0000000000D4FBC0
2013/12/11 21:17:48 [debug] 1516#0: *27 free: 0000000000FBDFF0
2013/12/11 21:17:48 [debug] 1516#0: *27 free: 0000000000F92160, unused: 8
2013/12/11 21:17:48 [debug] 1516#0: *27 free: 0000000000F91DB0, unused: 112