perusio/chive-nginx — Issue #1: 404 on /privileges
Author: Fidelix
Created: 2012-02-01 23:40:58+00:00
State: open

```
2012/02/02 00:35:45 [error] 12910#0: *146 open() "/var/www/chive/privileges/users/YW5iaWVudEAl/schemata" failed (2: No such file or directory), client: 187.79.4.177, server: chive.domain.net, request: "POST /privileges/users/YW5iaWVudEAl/schemata HTTP/1.1", host: "chive.anbient.net", referrer: "http://chive.domain.net/
```

This is an Ajax request when trying to edit the specific database privileges for an user.

Debugged output:

```
2012/02/02 00:39:49 [debug] 13096#0: *874 event timer del: 132: 1328139649037
2012/02/02 00:39:49 [debug] 13096#0: *874 generic phase: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 rewrite phase: 1
2012/02/02 00:39:49 [debug] 13096#0: *874 test location: "/"
2012/02/02 00:39:49 [debug] 13096#0: *874 test location: "favicon.ico"
2012/02/02 00:39:49 [debug] 13096#0: *874 test location: "/priv/chive/yii"
2012/02/02 00:39:49 [debug] 13096#0: *874 test location: ~ "^(?.*)$"
2012/02/02 00:39:49 [debug] 13096#0: *874 test location: ~ "/priv/.+\.(?:css|gif|htc|js|jpe?g|png|swf)$"
2012/02/02 00:39:49 [debug] 13096#0: *874 using configuration "/"
2012/02/02 00:39:49 [debug] 13096#0: *874 http cl:0 max:10485760
2012/02/02 00:39:49 [debug] 13096#0: *874 rewrite phase: 3
2012/02/02 00:39:49 [debug] 13096#0: *874 upload-progress: get_tracking_id
2012/02/02 00:39:49 [debug] 13096#0: *874 upload-progress: get_tracking_id no header found
2012/02/02 00:39:49 [debug] 13096#0: *874 upload-progress: get_tracking_id no id found
2012/02/02 00:39:49 [debug] 13096#0: *874 trackuploads no id found in POST upload req
2012/02/02 00:39:49 [debug] 13096#0: *874 rewrite phase: 4
2012/02/02 00:39:49 [debug] 13096#0: *874 post rewrite phase: 5
2012/02/02 00:39:49 [debug] 13096#0: *874 generic phase: 6
2012/02/02 00:39:49 [debug] 13096#0: *874 generic phase: 7
2012/02/02 00:39:49 [debug] 13096#0: *874 generic phase: 8
2012/02/02 00:39:49 [debug] 13096#0: *874 limit zone: 48FB9A64 1
2012/02/02 00:39:49 [debug] 13096#0: *874 add cleanup: 00000000014BABC8
2012/02/02 00:39:49 [debug] 13096#0: *874 access phase: 9
2012/02/02 00:39:49 [debug] 13096#0: *874 access phase: 10
2012/02/02 00:39:49 [debug] 13096#0: *874 access phase: 11
2012/02/02 00:39:49 [debug] 13096#0: *874 post access phase: 12
2012/02/02 00:39:49 [debug] 13096#0: *874 try files phase: 13
2012/02/02 00:39:49 [debug] 13096#0: *874 content phase: 14
2012/02/02 00:39:49 [debug] 13096#0: *874 content phase: 15
2012/02/02 00:39:49 [debug] 13096#0: *874 content phase: 16
2012/02/02 00:39:49 [debug] 13096#0: *874 content phase: 17
2012/02/02 00:39:49 [debug] 13096#0: *874 content phase: 18
2012/02/02 00:39:49 [debug] 13096#0: *874 content phase: 19
2012/02/02 00:39:49 [debug] 13096#0: *874 http filename: "/var/www/chive/privileges/users/YW5iaWVudEAl/schemata"
2012/02/02 00:39:49 [debug] 13096#0: *874 add cleanup: 00000000014BAC28
2012/02/02 00:39:49 [error] 13096#0: *874 open() "/var/www/chive/privileges/users/YW5iaWVudEAl/schemata" failed (2: No such file or directory), client: 187.79.4.177, server: chive.domain.com, request: "POST /privileges/users/YW5iaWVudEAl/schemata HTTP/1.1", host: "chive.domain.com", referrer: "http://chive.domain.com/"
2012/02/02 00:39:49 [debug] 13096#0: *874 http finalize request: 404, "/privileges/users/YW5iaWVudEAl/schemata?" a:1, c:1
2012/02/02 00:39:49 [debug] 13096#0: *874 http special response: 404, "/privileges/users/YW5iaWVudEAl/schemata?"
2012/02/02 00:39:49 [debug] 13096#0: *874 http set discard body
2012/02/02 00:39:49 [debug] 13096#0: *874 uploadprogress error-tracker error: 404
2012/02/02 00:39:49 [debug] 13096#0: *874 uploadprogress error-tracker not tracking in this location
2012/02/02 00:39:49 [debug] 13096#0: *874 xslt filter header
2012/02/02 00:39:49 [debug] 13096#0: *874 posix_memalign: 00000000014BAED0:4096 @16
2012/02/02 00:39:49 [debug] 13096#0: *874 HTTP/1.1 404 Not Found
Server: nginx
Date: Wed, 01 Feb 2012 23:39:49 GMT
Content-Type: text/html
Transfer-Encoding: chunked
Connection: keep-alive
Keep-Alive: timeout=10
Vary: Accept-Encoding
Content-Encoding: gzip

2012/02/02 00:39:49 [debug] 13096#0: *874 write new buf t:1 f:0 00000000014BAEF0, pos 00000000014BAEF0, size: 226 file: 0, size: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 http write filter: l:0 f:0 s:226
2012/02/02 00:39:49 [debug] 13096#0: *874 http output filter "/privileges/users/YW5iaWVudEAl/schemata?"
2012/02/02 00:39:49 [debug] 13096#0: *874 http copy filter: "/privileges/users/YW5iaWVudEAl/schemata?"
2012/02/02 00:39:49 [debug] 13096#0: *874 image filter
2012/02/02 00:39:49 [debug] 13096#0: *874 xslt filter body
2012/02/02 00:39:49 [debug] 13096#0: *874 http postpone filter "/privileges/users/YW5iaWVudEAl/schemata?" 00000000014BAE80
2012/02/02 00:39:49 [debug] 13096#0: *874 http gzip filter
2012/02/02 00:39:49 [debug] 13096#0: *874 malloc: 00000000016AB5C0:12288
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip alloc: n:1 s:5936 a:8192 p:00000000016AB5C0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip alloc: n:512 s:2 a:1024 p:00000000016AD5C0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip alloc: n:512 s:2 a:1024 p:00000000016AD9C0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip alloc: n:512 s:2 a:1024 p:00000000016ADDC0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip alloc: n:256 s:4 a:1024 p:00000000016AE1C0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip in: 00000000014BAEB0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip in_buf:00000000014BADE0 ni:00000000006D0740 ai:116
2012/02/02 00:39:49 [debug] 13096#0: *874 malloc: 00000000014BBEE0:8192
2012/02/02 00:39:49 [debug] 13096#0: *874 deflate in: ni:00000000006D0740 no:00000000014BBEE0 ai:116 ao:8192 fl:0 redo:0
2012/02/02 00:39:49 [debug] 13096#0: *874 deflate out: ni:00000000006D07B4 no:00000000014BBEE0 ai:0 ao:8192 rc:0
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip in_buf:00000000014BADE0 pos:00000000006D0740
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip in: 00000000014BB050
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip in_buf:00000000014BAE30 ni:00000000006D0180 ai:46
2012/02/02 00:39:49 [debug] 13096#0: *874 deflate in: ni:00000000006D0180 no:00000000014BBEE0 ai:46 ao:8192 fl:4 redo:0
2012/02/02 00:39:49 [debug] 13096#0: *874 deflate out: ni:00000000006D01AE no:00000000014BBF4B ai:0 ao:8085 rc:1
2012/02/02 00:39:49 [debug] 13096#0: *874 gzip in_buf:00000000014BAE30 pos:00000000006D0180
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 00000000016AB5C0
2012/02/02 00:39:49 [debug] 13096#0: *874 http chunk: 10
2012/02/02 00:39:49 [debug] 13096#0: *874 http chunk: 115
2012/02/02 00:39:49 [debug] 13096#0: *874 write old buf t:1 f:0 00000000014BAEF0, pos 00000000014BAEF0, size: 226 file: 0, size: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 write new buf t:1 f:0 00000000014BB1B0, pos 00000000014BB1B0, size: 4 file: 0, size: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 write new buf t:0 f:0 0000000000000000, pos 00000000006D4388, size: 10 file: 0, size: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 write new buf t:1 f:0 00000000014BBEE0, pos 00000000014BBEE0, size: 115 file: 0, size: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 write new buf t:0 f:0 0000000000000000, pos 00000000004AE0C8, size: 7 file: 0, size: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 http write filter: l:1 f:1 s:362
2012/02/02 00:39:49 [debug] 13096#0: *874 http write filter limit 0
2012/02/02 00:39:49 [debug] 13096#0: *874 writev: 362
2012/02/02 00:39:49 [debug] 13096#0: *874 http write filter 0000000000000000
2012/02/02 00:39:49 [debug] 13096#0: *874 http copy filter: 0 "/privileges/users/YW5iaWVudEAl/schemata?"
2012/02/02 00:39:49 [debug] 13096#0: *874 http finalize request: 0, "/privileges/users/YW5iaWVudEAl/schemata?" a:1, c:1
2012/02/02 00:39:49 [debug] 13096#0: *874 set http keepalive handler
2012/02/02 00:39:49 [debug] 13096#0: *874 http close request
2012/02/02 00:39:49 [debug] 13096#0: *874 http log handler
2012/02/02 00:39:49 [debug] 13096#0: *874 run cleanup: 00000000014BABC8
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 00000000014BBEE0
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 0000000000000000
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 00000000014B9EC0, unused: 0
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 00000000014BAED0, unused: 3176
2012/02/02 00:39:49 [debug] 13096#0: *874 event timer add: 132: 10000:1328139599051
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 00000000016B7220
2012/02/02 00:39:49 [debug] 13096#0: *874 free: 00000000014B9AB0
2012/02/02 00:39:49 [debug] 13096#0: *874 hc free: 0000000000000000 0
2012/02/02 00:39:49 [debug] 13096#0: *874 hc busy: 0000000000000000 0
2012/02/02 00:39:49 [debug] 13096#0: *874 tcp_nodelay
2012/02/02 00:39:49 [debug] 13096#0: *874 reusable connection: 1
2012/02/02 00:39:49 [debug] 13096#0: *874 post event 00000000015D8990
2012/02/02 00:39:49 [debug] 13096#0: *874 delete posted event 00000000015D8990
2012/02/02 00:39:49 [debug] 13096#0: *874 http keepalive handler
2012/02/02 00:39:49 [debug] 13096#0: *874 malloc: 00000000016B7220:1024
2012/02/02 00:39:49 [debug] 13096#0: *874 recv: fd:132 -1 of 1024
2012/02/02 00:39:49 [debug] 13096#0: *874 recv() not ready (11: Resource temporarily unavailable)
```