2012/04/24 12:55:27 [debug] 20116#0: *19042 run cleanup: 00000000020266B0
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 00000000025C2220
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 00000000020256E0, unused: 1
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 0000000001FB1C80, unused: 0
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 000000000279E020, unused: 0
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 0000000001E81D90, unused: 3236
2012/04/24 12:55:27 [debug] 20116#0: *19042 event timer add: 6: 65000:1335264992303
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 0000000001E40E70
2012/04/24 12:55:27 [debug] 20116#0: *19042 free: 0000000001E2EFF0
2012/04/24 12:55:27 [debug] 20116#0: *19042 hc free: 0000000000000000 0
2012/04/24 12:55:27 [debug] 20116#0: *19042 hc busy: 0000000000000000 0
2012/04/24 12:55:27 [debug] 20116#0: *19042 reusable connection: 1
2012/04/24 12:55:27 [debug] 20116#0: *19042 post event 00000000022743C0
2012/04/24 12:55:27 [debug] 20116#0: *19042 delete posted event 00000000022743C0
2012/04/24 12:55:27 [debug] 20116#0: *19042 http keepalive handler
2012/04/24 12:55:27 [debug] 20116#0: *19042 malloc: 0000000001E2EFF0:32768
2012/04/24 12:55:27 [debug] 20116#0: *19042 recv: fd:6 -1 of 32768
2012/04/24 12:55:27 [debug] 20116#0: *19042 recv() not ready (11: Resource temporarily unavailable)
2012/04/24 12:56:28 [debug] 20116#0: *19042 post event 00000000022743C0
2012/04/24 12:56:28 [debug] 20116#0: *19042 post event 0000000002849E60
2012/04/24 12:56:28 [debug] 20116#0: *19042 delete posted event 0000000002849E60
2012/04/24 12:56:28 [debug] 20116#0: *19042 http empty handler
2012/04/24 12:56:28 [debug] 20116#0: *19042 delete posted event 00000000022743C0
2012/04/24 12:56:28 [debug] 20116#0: *19042 http keepalive handler
2012/04/24 12:56:28 [debug] 20116#0: *19042 recv: fd:6 0 of 32768
2012/04/24 12:56:28 [info] 20116#0: *19042 client 79.18.207.187 closed keepalive connection
2012/04/24 12:56:28 [debug] 20116#0: *19042 close http connection: 6
2012/04/24 12:56:28 [debug] 20116#0: *19042 event timer del: 6: 1335264992303
2012/04/24 12:56:28 [debug] 20116#0: *19042 reusable connection: 0
2012/04/24 12:56:28 [debug] 20116#0: *19042 free: 0000000001E2EFF0
2012/04/24 12:56:28 [debug] 20116#0: *19042 free: 0000000000000000
2012/04/24 12:56:28 [debug] 20116#0: *19042 free: 0000000002666BD0, unused: 0
2012/04/24 12:56:28 [debug] 20116#0: *19042 free: 0000000001EEE3A0, unused: 112
2012/04/24 12:56:28 [debug] 20116#0: post event 0000000002274150
2012/04/24 12:56:28 [debug] 20116#0: delete posted event 0000000002274150
2012/04/24 12:56:28 [debug] 20116#0: accept on 88.198.31.7:80, ready: 1
2012/04/24 12:56:28 [debug] 20116#0: posix_memalign: 0000000001E26E30:256 @16
2012/04/24 12:56:28 [debug] 20116#0: *19044 accept: 79.18.207.187 fd:6
2012/04/24 12:56:28 [debug] 20116#0: *19044 event timer add: 6: 60000:1335265048776
2012/04/24 12:56:28 [debug] 20116#0: *19044 epoll add event: fd:6 op:1 ev:80000001
2012/04/24 12:56:28 [debug] 20116#0: accept() not ready (11: Resource temporarily unavailable)
2012/04/24 12:56:28 [debug] 20116#0: *19044 post event 00000000022743C0
2012/04/24 12:56:28 [debug] 20116#0: *19044 delete posted event 00000000022743C0
2012/04/24 12:56:28 [debug] 20116#0: *19044 malloc: 0000000001E40E70:1312
2012/04/24 12:56:28 [debug] 20116#0: *19044 posix_memalign: 0000000002666BD0:256 @16
2012/04/24 12:56:28 [debug] 20116#0: *19044 malloc: 0000000001E2EFF0:32768
2012/04/24 12:56:28 [debug] 20116#0: *19044 posix_memalign: 00000000020256E0:4096 @16
2012/04/24 12:56:28 [debug] 20116#0: *19044 http process request line
2012/04/24 12:56:28 [debug] 20116#0: *19044 recv: fd:6 603 of 32768
2012/04/24 12:56:28 [debug] 20116#0: *19044 http request line: "GET /nicaragua/the-laguna HTTP/1.1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http uri: "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http args: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http exten: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http process request header line
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Host: domain.com"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "User-Agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Accept-Language: en-us,en;q=0.5"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Accept-Encoding: gzip, deflate"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Connection: keep-alive"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Referer: http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header: "Cookie: __utma=8906214.683635022.1335222685.1335257267.1335262935.3; __utmz=8906214.1335222685.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); sifrFetch=true; __utmc=8906214; __utmb=8906214.4.10.1335262935; has_js=1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http header done
2012/04/24 12:56:28 [debug] 20116#0: *19044 event timer del: 6: 1335265048776
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 0
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 1
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script value: "Cache"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script set $nocache_details
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map started
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map: "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0" ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "GET"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex: "^(?:GET|HEAD|POST|PUT|DELETE|OPTIONS)$"
2012/04/24 12:56:28 [notice] 20116#0: *19044 "^(?:GET|HEAD|POST|PUT|DELETE|OPTIONS)$" matches "GET", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map started
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map: "" ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "hosting"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "robots.txt"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "progress"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "(?:delete.+from|insert.+into|select.+from|union.+select|onload|\.php.+src|system\(.+|document\.cookie|\;|\.\.\/)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/(?:autocomplete|ajax|ahah)/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "(?:.*)/x-progress-id:(?:\w*)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 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))$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "(?:cgi-bin|vti-bin|wp-content)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "(?:calendar|event|validation|aggregator|vote_up_down|captcha)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "\.r\.(?:jpe?g|png|gif)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/(?:.+)/files/styles/adaptive/(?:.+)$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/(?:external|system|files/imagecache|files/styles)/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/sites/.*/files/backup_migrate/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/sites/.*/files/config_.*"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/sites/.*/files/private/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/sites/.*/private/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/files/private/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "files/advagg_(?:css|js)/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "\.css$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "\.(?:js|htc)$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "\.json$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^.+\.(?:jpe?g|gif|png|ico|bmp|svg|swf|pdf|docx?|xlsx?|pptx?|tiff?|txt|rtf|cgi|bat|pl|dll|aspx?|exe|class|otf|ttf|woff|eot)$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^.+\.(?:avi|mpe?g|mov|wmv|mp3|mp4|m4a|ogg|ogv|flv|wav|midi|zip|tar|t?gz|rar)$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/(?:cross-?domain)\.xml$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/(?:modules|libraries)/(?:contrib/)?(?:ad|tinybrowser|f?ckeditor|tinymce|wysiwyg_spellcheck|ecc|civicrm|fbconnect|radioactivity)/.*\.php$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/sites/.*/(?:modules|libraries)/(?:tinybrowser|f?ckeditor|tinymce)/.*\.(?:html?|xml)$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/sites/.*/files/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "\.xml$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/(?:.*/)?(?:user|cart|checkout|logout|flag)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "/(?:node/[0-9]+/edit|node/add|comment/reply|approve|users)"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/(?<esi>esi/.*)$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^/(?:core/)?(?:boost_stats|update|authorize|rtoc|xmlrpc)\.php$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: ~ "^.+\.php$"
2012/04/24 12:56:28 [debug] 20116#0: *19044 using configuration "/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http cl:-1 max:104857600
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 3
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 4
2012/04/24 12:56:28 [debug] 20116#0: *19044 posix_memalign: 0000000001FB1C80:4096 @16
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex: "wget"
2012/04/24 12:56:28 [notice] 20116#0: *19044 "wget" does not match "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 post rewrite phase: 5
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 6
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 7
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 8
2012/04/24 12:56:28 [debug] 20116#0: *19044 add cleanup: 00000000020266B0
2012/04/24 12:56:28 [debug] 20116#0: *19044 limit zone: ED4041EC 1
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 9
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 10
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 11
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 12
2012/04/24 12:56:28 [debug] 20116#0: *19044 post access phase: 13
2012/04/24 12:56:28 [debug] 20116#0: *19044 try files phase: 14
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 trying to use file: "/nicaragua/the-laguna" "/var/aegir/platforms/pressflow-625/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 add cleanup: 0000000001FB1D90
2012/04/24 12:56:28 [debug] 20116#0: *19044 malloc: 00000000023FF470:136
2012/04/24 12:56:28 [debug] 20116#0: *19044 malloc: 0000000002793D90:56
2012/04/24 12:56:28 [debug] 20116#0: *19044 cached open file: /var/aegir/platforms/pressflow-625/nicaragua/the-laguna, fd:-1, c:0, e:2, u:1
2012/04/24 12:56:28 [debug] 20116#0: *19044 trying to use file: "@cache" "/var/aegir/platforms/pressflow-625@cache"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "@cache"
2012/04/24 12:56:28 [debug] 20116#0: *19044 using location: @cache "/nicaragua/the-laguna?"
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 3
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 4
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "GET"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script value: "POST"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script equal
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script equal: no
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex: "nocache=1"
2012/04/24 12:56:28 [notice] 20116#0: *19044 "nocache=1" does not match "", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex: "OctopusNoCacheID"
2012/04/24 12:56:28 [notice] 20116#0: *19044 "OctopusNoCacheID" does not match "__utma=8906214.683635022.1335222685.1335257267.1335262935.3; __utmz=8906214.1335222685.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); sifrFetch=true; __utmc=8906214; __utmb=8906214.4.10.1335262935; has_js=1", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map started
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 post rewrite phase: 5
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 6
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 7
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 8
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 9
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 10
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 11
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 12
2012/04/24 12:56:28 [debug] 20116#0: *19044 post access phase: 13
2012/04/24 12:56:28 [debug] 20116#0: *19044 try files phase: 14
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map started
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map: "Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0" "normal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "/cache/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "normal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "domain.com"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "_"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: ".html"
2012/04/24 12:56:28 [debug] 20116#0: *19044 trying to use file: "/cache/normal/domain.com/nicaragua/the-laguna_.html" "/var/aegir/platforms/pressflow-625/cache/normal/domain.com/nicaragua/the-laguna_.html"
2012/04/24 12:56:28 [debug] 20116#0: *19044 add cleanup: 0000000001FB21D0
2012/04/24 12:56:28 [debug] 20116#0: *19044 malloc: 0000000001FB1B60:136
2012/04/24 12:56:28 [debug] 20116#0: *19044 malloc: 0000000001EFE170:96
2012/04/24 12:56:28 [debug] 20116#0: *19044 cached open file: /var/aegir/platforms/pressflow-625/cache/normal/domain.com/nicaragua/the-laguna_.html, fd:-1, c:0, e:2, u:1
2012/04/24 12:56:28 [debug] 20116#0: *19044 trying to use file: "@drupal" "/var/aegir/platforms/pressflow-625@drupal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "@cache"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "@drupal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 using location: @drupal "/nicaragua/the-laguna?"
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 3
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 4
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex: "^/(.*)$"
2012/04/24 12:56:28 [notice] 20116#0: *19044 "^/(.*)$" matches "/nicaragua/the-laguna", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script args
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "q="
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script capture: "nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex end
2012/04/24 12:56:28 [notice] 20116#0: *19044 rewritten data: "/index.php", args: "q=nicaragua/the-laguna", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 post rewrite phase: 5
2012/04/24 12:56:28 [debug] 20116#0: *19044 uri changes: 9
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "hosting"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "robots.txt"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "progress"
2012/04/24 12:56:28 [debug] 20116#0: *19044 test location: "index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 using configuration "=/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http cl:-1 max:104857600
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 3
2012/04/24 12:56:28 [debug] 20116#0: *19044 rewrite phase: 4
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script value: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script set $nocache
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "Cache"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script regex: "(?:OctopusNCookie|Args|Skip)"
2012/04/24 12:56:28 [notice] 20116#0: *19044 "(?:OctopusNCookie|Args|Skip)" does not match "Cache", client: 79.18.207.187, server: domain.com, request: "GET /nicaragua/the-laguna HTTP/1.1", host: "domain.com", referrer: "http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script if: false
2012/04/24 12:56:28 [debug] 20116#0: *19044 post rewrite phase: 5
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 6
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 7
2012/04/24 12:56:28 [debug] 20116#0: *19044 generic phase: 8
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 9
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 10
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 11
2012/04/24 12:56:28 [debug] 20116#0: *19044 access phase: 12
2012/04/24 12:56:28 [debug] 20116#0: *19044 post access phase: 13
2012/04/24 12:56:28 [debug] 20116#0: *19044 try files phase: 14
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 trying to use file: "/index.php" "/var/aegir/platforms/pressflow-625/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 add cleanup: 0000000001FB2458
2012/04/24 12:56:28 [debug] 20116#0: *19044 cached open file: /var/aegir/platforms/pressflow-625/index.php, fd:16, c:1, e:0, u:3
2012/04/24 12:56:28 [debug] 20116#0: *19044 try file uri: "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 upload-progress: ngx_http_uploadprogress_content_handler
2012/04/24 12:56:28 [debug] 20116#0: *19044 http init upstream, client timer: 0
2012/04/24 12:56:28 [debug] 20116#0: *19044 epoll add event: fd:6 op:3 ev:80000005
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map started
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http map: "/nicaragua/the-laguna" "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 parse header: "Cookie: __utma=8906214.683635022.1335222685.1335257267.1335262935.3; __utmz=8906214.1335222685.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); sifrFetch=true; __utmc=8906214; __utmb=8906214.4.10.1335262935; has_js=1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "normal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "domain.com"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "GET"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 http cache key: "normaldomain.comGET/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 parse header: "Cookie: __utma=8906214.683635022.1335222685.1335257267.1335262935.3; __utmz=8906214.1335222685.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); sifrFetch=true; __utmc=8906214; __utmb=8906214.4.10.1335262935; has_js=1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:28 [debug] 20116#0: *19044 add cleanup: 0000000001FB2B90
2012/04/24 12:56:28 [debug] 20116#0: *19044 http file cache exists: -5 e:0
2012/04/24 12:56:28 [debug] 20116#0: *19044 cache file: "/var/lib/nginx/speed/23/4e/d8/9445bf0e8a880f45a646785746d84e23"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream cache: -5
2012/04/24 12:56:28 [debug] 20116#0: *19044 posix_memalign: 0000000001E81D90:4096 @16
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SCRIPT_FILENAME"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/var/aegir/platforms/pressflow-625"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SCRIPT_FILENAME: /var/aegir/platforms/pressflow-625/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "QUERY_STRING"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "q=nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "QUERY_STRING: q=nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "REQUEST_METHOD"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "GET"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "REQUEST_METHOD: GET"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "CONTENT_TYPE"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "CONTENT_TYPE: "
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "CONTENT_LENGTH"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "CONTENT_LENGTH: "
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SCRIPT_NAME"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SCRIPT_NAME: /index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "REQUEST_URI"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "REQUEST_URI: /nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "DOCUMENT_URI"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "DOCUMENT_URI: /index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "DOCUMENT_ROOT"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "/var/aegir/platforms/pressflow-625"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "DOCUMENT_ROOT: /var/aegir/platforms/pressflow-625"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SERVER_PROTOCOL"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "HTTP/1.1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SERVER_PROTOCOL: HTTP/1.1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "GATEWAY_INTERFACE"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "CGI/1.1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "GATEWAY_INTERFACE: CGI/1.1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SERVER_SOFTWARE"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "ApacheSolaris/"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "1.0.15"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SERVER_SOFTWARE: ApacheSolaris/1.0.15"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "REMOTE_ADDR"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "79.18.207.187"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "REMOTE_ADDR: 79.18.207.187"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "REMOTE_PORT"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "59003"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "REMOTE_PORT: 59003"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SERVER_ADDR"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "88.198.31.7"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SERVER_ADDR: 88.198.31.7"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SERVER_PORT"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "80"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SERVER_PORT: 80"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "SERVER_NAME"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "domain.com"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "SERVER_NAME: domain.com"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "USER_DEVICE"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script var: "normal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "USER_DEVICE: normal"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "REDIRECT_STATUS"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http script copy: "200"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "REDIRECT_STATUS: 200"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_HOST: domain.com"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_USER_AGENT: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.7; rv:11.0) Gecko/20100101 Firefox/11.0"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_ACCEPT: text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_ACCEPT_LANGUAGE: en-us,en;q=0.5"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_ACCEPT_ENCODING: gzip, deflate"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_CONNECTION: keep-alive"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_REFERER: http://domain.com/nicaragua/the-isletas"
2012/04/24 12:56:28 [debug] 20116#0: *19044 fastcgi param: "HTTP_COOKIE: __utma=8906214.683635022.1335222685.1335257267.1335262935.3; __utmz=8906214.1335222685.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); sifrFetch=true; __utmc=8906214; __utmb=8906214.4.10.1335262935; has_js=1"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http cleanup add: 0000000001FB2C60
2012/04/24 12:56:28 [debug] 20116#0: *19044 get rr peer, try: 1
2012/04/24 12:56:28 [debug] 20116#0: *19044 socket 18
2012/04/24 12:56:28 [debug] 20116#0: *19044 epoll add connection: fd:18 ev:80000005
2012/04/24 12:56:28 [debug] 20116#0: *19044 connect to 127.0.0.1:9090, fd:18 #19045
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream connect: -2
2012/04/24 12:56:28 [debug] 20116#0: *19044 event timer add: 18: 60000:1335265048782
2012/04/24 12:56:28 [debug] 20116#0: *19044 http finalize request: -4, "/index.php?q=nicaragua/the-laguna" a:1, c:4
2012/04/24 12:56:28 [debug] 20116#0: *19044 http request count:4 blk:0
2012/04/24 12:56:28 [debug] 20116#0: *19044 http finalize request: -4, "/index.php?q=nicaragua/the-laguna" a:1, c:3
2012/04/24 12:56:28 [debug] 20116#0: *19044 http request count:3 blk:0
2012/04/24 12:56:28 [debug] 20116#0: *19044 http finalize request: -4, "/index.php?q=nicaragua/the-laguna" a:1, c:2
2012/04/24 12:56:28 [debug] 20116#0: *19044 http request count:2 blk:0
2012/04/24 12:56:28 [debug] 20116#0: *19044 post event 0000000002849E60
2012/04/24 12:56:28 [debug] 20116#0: *19044 post event 0000000002849EC8
2012/04/24 12:56:28 [debug] 20116#0: *19044 delete posted event 0000000002849EC8
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream send request handler
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream send request
2012/04/24 12:56:28 [debug] 20116#0: *19044 chain writer buf fl:0 s:1152
2012/04/24 12:56:28 [debug] 20116#0: *19044 chain writer in: 0000000001E82300
2012/04/24 12:56:28 [debug] 20116#0: *19044 writev: 1152
2012/04/24 12:56:28 [debug] 20116#0: *19044 chain writer out: 0000000000000000
2012/04/24 12:56:28 [debug] 20116#0: *19044 event timer del: 18: 1335265048782
2012/04/24 12:56:28 [debug] 20116#0: *19044 event timer add: 18: 3600000:1335268588783
2012/04/24 12:56:28 [debug] 20116#0: *19044 delete posted event 0000000002849E60
2012/04/24 12:56:28 [debug] 20116#0: *19044 http run request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream check client, write event:1, "/index.php"
2012/04/24 12:56:28 [debug] 20116#0: *19044 http upstream recv(): -1 (11: Resource temporarily unavailable)
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 0000000002274428
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 0000000002849EC8
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 0000000002849EC8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream dummy handler
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 0000000002274428
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream process header
2012/04/24 12:56:29 [debug] 20116#0: *19044 malloc: 00000000025C2220:131072
2012/04/24 12:56:29 [debug] 20116#0: *19044 recv: fd:18 13328 of 130975
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 06
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 1F
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: F8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record length: 8184
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "X-Powered-By: PHP/5.3.10-1~dotdeb.1"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "X-Cookie-Domain: .domain.com"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "X-Backend: C"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "X-Purge-Level: 6"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "X-Allow-Redis: YES"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "X-Drupal-Cache: MISS"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Last-Modified: Tue, 24 Apr 2012 10:56:28 +0000"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "ETag: "1335264988""
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Content-type: text/html; charset=utf-8"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Expires: Sun, 19 Nov 1978 05:00:00 GMT"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Cache-Control: must-revalidate"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Content-Length: 87363"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Connection: close"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Content-Encoding: gzip"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header: "Vary: Accept-Encoding"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi parser: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi header done
2012/04/24 12:56:29 [debug] 20116#0: *19044 http script var: "normal"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http script var: "MISS"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:29 [debug] 20116#0: *19044 http script var: "/nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http script var: "Cache"
2012/04/24 12:56:29 [debug] 20116#0: *19044 uploadprogress error-tracker error: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 xslt filter header
2012/04/24 12:56:29 [debug] 20116#0: *19044 HTTP/1.1 200 OK
Server: nginx
Date: Tue, 24 Apr 2012 10:56:29 GMT
Content-Type: text/html; charset=utf-8
Connection: keep-alive
X-Cookie-Domain: .domain.com
X-Backend: C
X-Purge-Level: 6
X-Allow-Redis: YES
Last-Modified: Tue, 24 Apr 2012 10:56:28 +0000
ETag: "1335264988"
Expires: Thu, 01 Jan 1970 00:00:01 GMT
Cache-Control: no-cache
Content-Length: 87363
Content-Encoding: gzip
Vary: Accept-Encoding
X-Engine: Barracuda 1.0 ET
X-Device: normal
X-Speed-Cache: MISS
X-Speed-Cache-Key: /nicaragua/the-laguna
X-NoCache: Cache

2012/04/24 12:56:29 [debug] 20116#0: *19044 write new buf t:1 f:0 0000000001E82908, pos 0000000001E82908, size: 612 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter: l:0 f:0 s:612
2012/04/24 12:56:29 [debug] 20116#0: *19044 http script var: ""
2012/04/24 12:56:29 [debug] 20116#0: *19044 http file cache set header
2012/04/24 12:56:29 [debug] 20116#0: *19044 http cacheable: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream process upstream
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe read upstream: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe preread: 12898
2012/04/24 12:56:29 [debug] 20116#0: *19044 readv: 1:117647
2012/04/24 12:56:29 [debug] 20116#0: *19044 readv() not ready (11: Resource temporarily unavailable)
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe recv chain: -2
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe buf free s:0 t:1 f:0 00000000025C2220, pos 00000000025C242F, size: 12898 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe write downstream: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe write busy: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe write: out:0000000000000000, f:0
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe read upstream: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe buf free s:0 t:1 f:0 00000000025C2220, pos 00000000025C242F, size: 12898 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer del: 18: 1335268588783
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer add: 18: 3600000:1335268589336
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 0000000002849EC8
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 0000000002849EC8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream dummy handler
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 0000000002274428
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 0000000002849EC8
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 0000000002849EC8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream dummy handler
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 0000000002274428
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream process upstream
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe read upstream: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 readv: 1:117647
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe recv chain: 40
2012/04/24 12:56:29 [debug] 20116#0: *19044 readv: 1:117607
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe recv chain: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe buf free s:0 t:1 f:0 00000000025C2220, pos 00000000025C242F, size: 12938 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 input buf #0 00000000025C242F
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 06
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 14
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 05
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 03
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record length: 5125
2012/04/24 12:56:29 [debug] 20116#0: *19044 posix_memalign: 000000000279E020:4096 @16
2012/04/24 12:56:29 [debug] 20116#0: *19044 input buf #0 00000000025C4289
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 06
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 0A
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 06
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record length: 10
2012/04/24 12:56:29 [debug] 20116#0: *19044 input buf #0 00000000025C5699
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 03
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 01
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 08
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record byte: 00
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi record length: 8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http fastcgi sent end request
2012/04/24 12:56:29 [debug] 20116#0: *19044 input buf 00000000025C5699 10
2012/04/24 12:56:29 [debug] 20116#0: *19044 add cleanup: 000000000279E0D8
2012/04/24 12:56:29 [debug] 20116#0: *19044 hashed path: /var/lib/nginx/fastcgi/6/14/0000000146
2012/04/24 12:56:29 [debug] 20116#0: *19044 temp fd:-1
2012/04/24 12:56:29 [debug] 20116#0: *19044 temp file: "/var/lib/nginx/fastcgi/6"
2012/04/24 12:56:29 [debug] 20116#0: *19044 temp file: "/var/lib/nginx/fastcgi/6/14"
2012/04/24 12:56:29 [debug] 20116#0: *19044 hashed path: /var/lib/nginx/fastcgi/6/14/0000000146
2012/04/24 12:56:29 [debug] 20116#0: *19044 temp fd:19
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe write downstream: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe write downstream flush out
2012/04/24 12:56:29 [debug] 20116#0: *19044 http output filter "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http copy filter: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 image filter
2012/04/24 12:56:29 [debug] 20116#0: *19044 xslt filter body
2012/04/24 12:56:29 [debug] 20116#0: *19044 http postpone filter "/index.php?q=nicaragua/the-laguna" 000000000279E188
2012/04/24 12:56:29 [debug] 20116#0: *19044 write old buf t:1 f:0 0000000001E82908, pos 0000000001E82908, size: 612 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 write new buf t:0 f:1 00000000025C2220, pos 00000000025C242F, size: 7762 file: 527, size: 7762
2012/04/24 12:56:29 [debug] 20116#0: *19044 write new buf t:0 f:1 00000000025C2220, pos 00000000025C4289, size: 5125 file: 8289, size: 5125
2012/04/24 12:56:29 [debug] 20116#0: *19044 write new buf t:0 f:1 00000000025C2220, pos 00000000025C5699, size: 10 file: 13414, size: 10
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter: l:0 f:0 s:13509
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter limit 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 tcp_nopush
2012/04/24 12:56:29 [debug] 20116#0: *19044 writev: 612
2012/04/24 12:56:29 [debug] 20116#0: *19044 sendfile: @527 12897
2012/04/24 12:56:29 [debug] 20116#0: *19044 sendfile: 12348, @527 12348:12897
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter 000000000279E1C8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http copy filter: -2 "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 pipe write downstream done
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer: 18, old: 1335268589336, new: 1335268589410
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer add: 6: 60000:1335265049410
2012/04/24 12:56:29 [debug] 20116#0: *19044 http file cache update
2012/04/24 12:56:29 [debug] 20116#0: *19044 http file cache rename: "/var/lib/nginx/fastcgi/6/14/0000000146" to "/var/lib/nginx/speed/23/4e/d8/9445bf0e8a880f45a646785746d84e23"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream exit: 0000000000000000
2012/04/24 12:56:29 [debug] 20116#0: *19044 finalize http upstream request: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 finalize http fastcgi request
2012/04/24 12:56:29 [debug] 20116#0: *19044 free rr peer 1 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 close http upstream connection: 18
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer del: 18: 1335268589336
2012/04/24 12:56:29 [debug] 20116#0: *19044 reusable connection: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http upstream temp fd: 19
2012/04/24 12:56:29 [debug] 20116#0: *19044 http output filter "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http copy filter: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 image filter
2012/04/24 12:56:29 [debug] 20116#0: *19044 xslt filter body
2012/04/24 12:56:29 [debug] 20116#0: *19044 http postpone filter "/index.php?q=nicaragua/the-laguna" 000000000279E1B8
2012/04/24 12:56:29 [debug] 20116#0: *19044 write old buf t:0 f:1 00000000025C2220, pos 00000000025C4289, size: 5125 file: 12875, size: 539
2012/04/24 12:56:29 [debug] 20116#0: *19044 write old buf t:0 f:1 00000000025C2220, pos 00000000025C5699, size: 10 file: 13414, size: 10
2012/04/24 12:56:29 [debug] 20116#0: *19044 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter: l:1 f:0 s:549
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter limit 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter 000000000279E1C8
2012/04/24 12:56:29 [debug] 20116#0: *19044 http copy filter: -2 "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http finalize request: -2, "/index.php?q=nicaragua/the-laguna" a:1, c:1
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer: 6, old: 1335265049410, new: 1335265049410
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 0000000002849E60
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 0000000002849E60
2012/04/24 12:56:29 [debug] 20116#0: *19044 http run request: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http writer handler: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http output filter "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http copy filter: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 image filter
2012/04/24 12:56:29 [debug] 20116#0: *19044 xslt filter body
2012/04/24 12:56:29 [debug] 20116#0: *19044 http postpone filter "/index.php?q=nicaragua/the-laguna" 0000000000000000
2012/04/24 12:56:29 [debug] 20116#0: *19044 write old buf t:0 f:1 00000000025C2220, pos 00000000025C4289, size: 5125 file: 12875, size: 539
2012/04/24 12:56:29 [debug] 20116#0: *19044 write old buf t:0 f:1 00000000025C2220, pos 00000000025C5699, size: 10 file: 13414, size: 10
2012/04/24 12:56:29 [debug] 20116#0: *19044 write old buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter: l:1 f:0 s:549
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter limit 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 sendfile: @12875 549
2012/04/24 12:56:29 [debug] 20116#0: *19044 sendfile: 549, @12875 549:549
2012/04/24 12:56:29 [debug] 20116#0: *19044 http write filter 0000000000000000
2012/04/24 12:56:29 [debug] 20116#0: *19044 http copy filter: 0 "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http writer output filter: 0, "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http writer done: "/index.php?q=nicaragua/the-laguna"
2012/04/24 12:56:29 [debug] 20116#0: *19044 http finalize request: 0, "/index.php?q=nicaragua/the-laguna" a:1, c:1
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer del: 6: 1335265049410
2012/04/24 12:56:29 [debug] 20116#0: *19044 set http keepalive handler
2012/04/24 12:56:29 [debug] 20116#0: *19044 http close request
2012/04/24 12:56:29 [debug] 20116#0: *19044 http log handler
2012/04/24 12:56:29 [debug] 20116#0: *19044 run cleanup: 000000000279E0D8
2012/04/24 12:56:29 [debug] 20116#0: *19044 file cleanup: fd:19
2012/04/24 12:56:29 [debug] 20116#0: *19044 run cleanup: 0000000001FB2B90
2012/04/24 12:56:29 [debug] 20116#0: *19044 run cleanup: 0000000001FB2458
2012/04/24 12:56:29 [debug] 20116#0: *19044 close cached open file: /var/aegir/platforms/pressflow-625/index.php, fd:16, c:0, u:3, 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 run cleanup: 00000000020266B0
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 00000000025C2220
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 00000000020256E0, unused: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 0000000001FB1C80, unused: 2
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 0000000001E81D90, unused: 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 000000000279E020, unused: 3225
2012/04/24 12:56:29 [debug] 20116#0: *19044 event timer add: 6: 65000:1335265054547
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 0000000001E40E70
2012/04/24 12:56:29 [debug] 20116#0: *19044 free: 0000000001E2EFF0
2012/04/24 12:56:29 [debug] 20116#0: *19044 hc free: 0000000000000000 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 hc busy: 0000000000000000 0
2012/04/24 12:56:29 [debug] 20116#0: *19044 reusable connection: 1
2012/04/24 12:56:29 [debug] 20116#0: *19044 post event 00000000022743C0
2012/04/24 12:56:29 [debug] 20116#0: *19044 delete posted event 00000000022743C0
2012/04/24 12:56:29 [debug] 20116#0: *19044 http keepalive handler
2012/04/24 12:56:29 [debug] 20116#0: *19044 malloc: 0000000001E2EFF0:32768
2012/04/24 12:56:29 [debug] 20116#0: *19044 recv: fd:6 -1 of 32768
2012/04/24 12:56:29 [debug] 20116#0: *19044 recv() not ready (11: Resource temporarily unavailable)
2012/04/24 12:57:34 [debug] 20116#0: *19044 event timer del: 6: 1335265054547
2012/04/24 12:57:34 [debug] 20116#0: *19044 http keepalive handler
2012/04/24 12:57:34 [debug] 20116#0: *19044 close http connection: 6
2012/04/24 12:57:34 [debug] 20116#0: *19044 reusable connection: 0
2012/04/24 12:57:34 [debug] 20116#0: *19044 free: 0000000001E2EFF0
2012/04/24 12:57:34 [debug] 20116#0: *19044 free: 0000000000000000
2012/04/24 12:57:34 [debug] 20116#0: *19044 free: 0000000001E26E30, unused: 0
2012/04/24 12:57:34 [debug] 20116#0: *19044 free: 0000000002666BD0, unused: 112