# Cannot PUT file with nginx-mogilefs-module

**URL:** <https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627>\
**Category:** NGINX\
**Created:** [September 27, 2010, 8:28am UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627 "2010-09-27T08:28:40Z")\
**Posts on this page:** 6\
**Page:** 1

<div class="post-metadata">

**Author:** ![casper\_the\_ghost](https://www.ruby-forum.com/letter_avatar_proxy/v4/letter/c/58956e/32.png) [@casper\_the\_ghost](https://www.ruby-forum.com/u/casper_the_ghost)\
**Post date:** [September 27, 2010, 8:28am UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627/1 "2010-09-27T08:28:40Z")

</div>

hi, I’m dai

I’m trying to PUT file to MogileFS with nginx-mogilefs-module 1.0.4,  
But I cannot.

I compiled with ‘–with-debug’ option, and the log seems  
“create\_close” request is not send to MogileFS tracker.

How can I use ?

## I sent HTTP-PUT request by this command

## curl --upload-file ~/install.log [http://127.0.0.1:81/testput/dabada.txt](http://127.0.0.1:81/testput/dabada.txt)

## This is Nginx Config file

server{  
listen 81;  
error\_log logs/error.log debug;  
location /testput/ {  
mogilefs\_tracker 127.0.0.1:7001;  
mogilefs\_domain test;  
mogilefs\_methods PUT GET;  
mogilefs\_pass {  
proxy\_pass $mogilefs\_path;  
proxy\_hide\_header Content-Type;  
proxy\_buffering off;  
}  
}  
}

## and This is Nginx error.log file

2010/09/27 15:04:31 [debug] 22519#0: epoll add event: fd:6 op:1  
ev:00000001  
2010/09/27 15:04:31 [debug] 22519#0: post event 000000000D0BAFA0  
2010/09/27 15:04:31 [debug] 22519#0: delete posted event  
000000000D0BAFA0  
2010/09/27 15:04:31 [debug] 22519#0: accept on 0.0.0.0:81, ready: 0  
2010/09/27 15:04:31 [debug] 22519#0: posix\_memalign:  
000000000CFE8990:256 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 accept: 127.0.0.1 fd:10  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 10:  
60000:1285567531241  
2010/09/27 15:04:31 [debug] 22519#0: \*1 epoll add event: fd:10 op:1  
ev:80000001  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0BB0D8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0BB0D8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 malloc: 000000000CFDD6B0:1248  
2010/09/27 15:04:31 [debug] 22519#0: \*1 posix\_memalign:  
000000000D03D210:256 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 malloc: 000000000CFD3340:1024  
2010/09/27 15:04:31 [debug] 22519#0: \*1 posix\_memalign:  
000000000CFDDBA0:4096 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http process request line  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 219 of 1024  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http request line: “PUT  
/testput/dabada.txt HTTP/1.1”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http uri: “/testput/dabada.txt”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http args: “”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http exten: “txt”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http process request header line  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http header: “User-Agent:  
curl/7.15.5 (x86\_64-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b  
zlib/1.2.3 libidn/0.6.5”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http header: “Host:  
127.0.0.1:81”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http header: “Accept: _/_”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http header: “Content-Length:  
37197”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http header: “Expect:  
100-continue”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http header done  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer del: 10:  
1285567531241  
2010/09/27 15:04:31 [debug] 22519#0: \*1 rewrite phase: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218042592/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218051760/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location: “/testput/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 using configuration “/testput/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http cl:37197 max:1048576  
2010/09/27 15:04:31 [debug] 22519#0: \*1 rewrite phase: 2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post rewrite phase: 3  
2010/09/27 15:04:31 [debug] 22519#0: \*1 generic phase: 4  
2010/09/27 15:04:31 [debug] 22519#0: \*1 generic phase: 5  
2010/09/27 15:04:31 [debug] 22519#0: \*1 access phase: 6  
2010/09/27 15:04:31 [debug] 22519#0: \*1 access phase: 7  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post access phase: 8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -5,  
“/testput/dabada.txt?” a:1, c:1  
2010/09/27 15:04:31 [debug] 22519#0: \*1 content phase: 9  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 send 100 Continue  
2010/09/27 15:04:31 [debug] 22519#0: \*1 send: fd:10 25 of 25  
2010/09/27 15:04:31 [debug] 22519#0: \*1 malloc: 000000000D016010:8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http read client request body  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 8192 of 8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http client request body recv  
8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 add cleanup: 000000000CFDE830  
2010/09/27 15:04:31 [debug] 22519#0: \*1 hashed path:  
/usr/local/nginx/client\_body\_temp/0000000001  
2010/09/27 15:04:31 [debug] 22519#0: \*1 temp fd:11  
2010/09/27 15:04:31 [warn] 22519#0: \*1 a client request body is buffered  
to a temporary file /usr/local/nginx/client\_body\_temp/0000000001,  
client: 127.0.0.1, server: , request:  
“PUT /testput/dabada.txt HTTP/1.1”, host: “127.0.0.1:81”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write: 11, 000000000D016010,  
8192, 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 8192 of 8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http client request body recv  
8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write: 11, 000000000D016010,  
8192, 8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 8192 of 8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http client request body recv  
8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write: 11, 000000000D016010,  
8192, 16384  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 8192 of 8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http client request body recv  
8192  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write: 11, 000000000D016010,  
8192, 24576  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 4429 of 4429  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http client request body recv  
4429  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http client request body rest 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write: 11, 000000000D016010,  
4429, 32768  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs body handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler state: 0,  
status: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 posix\_memalign:  
000000000CFDEBB0:4096 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http subrequest  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
“/testput/dabada.txt?” a:0, c:3  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http request count:3 blk:0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http posted request:  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 rewrite phase: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218042592/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218028368/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218023808/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 using configuration  
“/mogstored\_spare\_218023808/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http cl:37197 max:1048576  
2010/09/27 15:04:31 [debug] 22519#0: \*1 rewrite phase: 2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post rewrite phase: 3  
2010/09/27 15:04:31 [debug] 22519#0: \*1 generic phase: 4  
2010/09/27 15:04:31 [debug] 22519#0: \*1 generic phase: 5  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http init upstream, client  
timer: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 epoll add event: fd:10 op:3  
ev:80000005  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs request: “create\_open  
key=dabada.txt&domain=test”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http cleanup add:  
000000000CFDF7A0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 get rr peer, try: 1  
2010/09/27 15:04:31 [debug] 22519#0: \*1 socket 12  
2010/09/27 15:04:31 [debug] 22519#0: \*1 epoll add connection: fd:12  
ev:80000005  
2010/09/27 15:04:31 [debug] 22519#0: \*1 connect to 192.168.100.10:7001,  
fd:12 #2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream connect: -2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 12:  
60000:1285567531241  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
“/mogstored\_spare\_218023808/dabada.txt?” a:1, c:3  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http request count:3 blk:0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0D50E8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0D50E8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http run request:  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream check client,  
write event:1, “/mogstored\_spare\_218023808/dabada.txt”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream recv(): -1 (11:  
Resource temporarily unavailable)  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer buf fl:0 s:40  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer in:  
000000000CFDF7D8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 writev: 40  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer out:  
0000000000000000  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer del: 12:  
1285567531241  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 12:  
60000:1285567531241  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0BB140  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream dummy handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0BB140  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream process header  
2010/09/27 15:04:31 [debug] 22519#0: \*1 malloc: 000000000D018020:4096  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:12 81 of 4096  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs: “OK  
devid=5&fid=58&path=[http://192.168.100.11:7500/dev5/0/000/000/0000000058.fid^M](http://192.168.100.11:7500/dev5/0/000/000/0000000058.fid%5EM)”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs param: “devid”=“5”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs param: “fid”=“58”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs param:  
“path”=“[http://192.168.100.11:7500/dev5/0/000/000/0000000058.fid](http://192.168.100.11:7500/dev5/0/000/000/0000000058.fid)”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 tcp\_nodelay  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream process non  
buffered downstream  
2010/09/27 15:04:31 [debug] 22519#0: \*1 finalize http upstream request:  
0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 finalize mogilefs request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free rr peer 1 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 close http upstream connection:  
12  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer del: 12:  
1285567531241  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http output filter  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http copy filter:  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http postpone filter  
“/mogstored\_spare\_218023808/dabada.txt?” 00007FFFFD434D70  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write new buf t:0 f:0  
0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http write filter: l:0 f:0 s:0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http copy filter: 0  
“/mogstored\_spare\_218023808/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: 0,  
“/mogstored\_spare\_218023808/dabada.txt?” a:1, c:2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs finish phase handler:  
state=1, status=0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http wake parent request:  
“/testput/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http posted request:  
“/testput/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 content phase: 9  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler state: 1,  
status: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 posix\_memalign:  
000000000CFD7A80:4096 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http subrequest  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
“/testput/dabada.txt?” a:0, c:2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http request count:2 blk:0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http posted request:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 rewrite phase: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218042592/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 test location:  
“/mogstored\_spare\_218028368/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 using configuration  
“/mogstored\_spare\_218028368/”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http cl:37197 max:1048576  
2010/09/27 15:04:31 [debug] 22519#0: \*1 rewrite phase: 2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post rewrite phase: 3  
2010/09/27 15:04:31 [debug] 22519#0: \*1 generic phase: 4  
2010/09/27 15:04:31 [debug] 22519#0: \*1 generic phase: 5  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http script var:  
“[http://192.168.100.11:7500/dev5/0/000/000/0000000058.fid](http://192.168.100.11:7500/dev5/0/000/000/0000000058.fid)”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http init upstream, client  
timer: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http script copy: "Host: "  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http script var:  
“192.168.100.11:7500”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http script copy: "  
"  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http script copy: "Connection:  
close  
"  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header: “User-Agent:  
curl/7.15.5 (x86\_64-redhat-linux-gnu) libcurl/7.15.5 OpenSSL/0.9.8b  
zlib/1.2.3 libidn/0.6.5”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header: “Accept: _/_”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header:  
“Content-Length: 37197”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header:  
"PUT /dev5/0/000/000/0000000058.fid HTTP/1.0  
Host: 192.168.100.11:7500  
Connection: close  
User-Agent: curl/7.15.5 (x86\_64-redhat-linux-gnu) libcurl/7.15.5  
OpenSSL/0.9.8b zlib/1.2.3 libidn/0.6.5  
Accept: _/_  
Content-Length: 37197

"  
2010/09/27 15:04:31 [debug] 22519#0: \*1 posix\_memalign:  
000000000CFD8A90:4096 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http cleanup add:  
000000000CFD8B70  
2010/09/27 15:04:31 [debug] 22519#0: \*1 name was resolved to  
192.168.100.11  
2010/09/27 15:04:31 [debug] 22519#0: \*1 get rr peer, try: 1  
2010/09/27 15:04:31 [debug] 22519#0: \*1 socket 12  
2010/09/27 15:04:31 [debug] 22519#0: \*1 epoll add connection: fd:12  
ev:80000005  
2010/09/27 15:04:31 [debug] 22519#0: \*1 connect to 192.168.100.11:7500,  
fd:12 #3  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream connect: -2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 12:  
60000:1285567531837  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
“/mogstored\_spare\_218028368/dabada.txt?” a:1, c:2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http request count:2 blk:0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer buf fl:0 s:234  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer buf fl:0 s:234  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer buf fl:1 s:37197  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer in:  
000000000CFD8C78  
2010/09/27 15:04:31 [debug] 22519#0: \*1 tcp\_nopush  
2010/09/27 15:04:31 [debug] 22519#0: \*1 writev: 234  
2010/09/27 15:04:31 [debug] 22519#0: \*1 sendfile: @0 37197  
2010/09/27 15:04:31 [debug] 22519#0: \*1 sendfile: 15694, @0 15694:37197  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer out:  
000000000CFD8C88  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer del: 12:  
1285567531837  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 12:  
60000:1285567531838  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream send request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer in:  
000000000CFD8C88  
2010/09/27 15:04:31 [debug] 22519#0: \*1 sendfile: @15694 21503  
2010/09/27 15:04:31 [debug] 22519#0: \*1 sendfile: 21503, @15694  
21503:21503  
2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer out:  
0000000000000000  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer del: 12:  
1285567531838  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 12:  
60000:1285567531838  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0BB140  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0D5150  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream dummy handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0BB140  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream process header  
2010/09/27 15:04:31 [debug] 22519#0: \*1 malloc: 000000000CFD9AA0:4096  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:12 118 of 4096  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy status 200 “200 OK”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header:  
“Content-Type: text/html”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header:  
“Content-Length: 18”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header: “Server:  
Perlbal”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header: “Connection:  
close”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header done  
2010/09/27 15:04:31 [debug] 22519#0: \*1 finalize http upstream request:  
0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 finalize http proxy request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free rr peer 1 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 close http upstream connection:  
12  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer del: 12:  
1285567531838  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http output filter  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http copy filter:  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http postpone filter  
“/mogstored\_spare\_218028368/dabada.txt?” 00007FFFFD434EA0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write old buf t:0 f:0  
0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 write new buf t:0 f:0  
0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http write filter: l:0 f:0 s:0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http copy filter: 0  
“/mogstored\_spare\_218028368/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: 0,  
“/mogstored\_spare\_218028368/dabada.txt?” a:1, c:1  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs finish phase handler:  
state=2, status=0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http wake parent request:  
“/testput/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http posted request:  
“/testput/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 content phase: 9  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler state: 2,  
status: 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http subrequest  
“/mogstored\_spare\_218032984/dabada.txt?”  
2010/09/27 15:04:31 [debug] 22519#0: \*1 posix\_memalign:  
000000000D0EEFC0:4096 @16  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
“/testput/dabada.txt?” a:0, c:1  
2010/09/27 15:04:31 [debug] 22519#0: \*1 set http keepalive handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http close request  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http log handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 run cleanup: 000000000CFDE830  
2010/09/27 15:04:31 [debug] 22519#0: \*1 file cleanup: fd:11  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFD9AA0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000D018020  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000D016010  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFDDBA0, unused:  
0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFDEBB0, unused:  
0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFD7A80, unused:  
2  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFD8A90, unused:  
124  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000D0EEFC0, unused:  
3659  
2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 10:  
1000:1285567472841  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFDD6B0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 free: 000000000CFD3340  
2010/09/27 15:04:31 [debug] 22519#0: \*1 hc free: 0000000000000000 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 hc busy: 0000000000000000 0  
2010/09/27 15:04:31 [debug] 22519#0: \*1 post event 000000000D0BB0D8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 delete posted event  
000000000D0BB0D8  
2010/09/27 15:04:31 [debug] 22519#0: \*1 http keepalive handler  
2010/09/27 15:04:31 [debug] 22519#0: \*1 malloc: 000000000CFD3340:1024  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 -1 of 1024  
2010/09/27 15:04:31 [debug] 22519#0: \*1 recv() not ready (11: Resource  
temporarily unavailable)  
2010/09/27 15:04:32 [debug] 22519#0: \*1 event timer del: 10:  
1285567472841  
2010/09/27 15:04:32 [debug] 22519#0: \*1 http keepalive handler  
2010/09/27 15:04:32 [debug] 22519#0: \*1 close http connection: 10  
2010/09/27 15:04:32 [debug] 22519#0: \*1 free: 000000000CFD3340  
2010/09/27 15:04:32 [debug] 22519#0: \*1 free: 0000000000000000  
2010/09/27 15:04:32 [debug] 22519#0: \*1 free: 000000000CFE8990, unused:  
8  
2010/09/27 15:04:32 [debug] 22519#0: \*1 free: 000000000D03D210, unused:  
128

---

<div class="post-metadata">

**Author:** ![casper\_the\_ghost](https://www.ruby-forum.com/letter_avatar_proxy/v4/letter/c/58956e/32.png) [@casper\_the\_ghost](https://www.ruby-forum.com/u/casper_the_ghost)\
**Post date:** [September 27, 2010, 2:46pm UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627/2 "2010-09-27T14:46:18Z")

</div>

What version of nginx are you using?

----- [removed\_email\_address@domain.invalid](mailto:removed_email_address@domain.invalid) wrote:

> ```
> location /testput/ {
> 
> ```
> 
> 60000:1285567531241  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http process request line  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http header: “Host: 127.0.0.1:81”  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 test location: “/testput/”  
> “/testput/dabada.txt?” a:1, c:1  
> /usr/local/nginx/client\_body\_temp/0000000001  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 recv: fd:10 8192 of 8192  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 write: 11, 000000000D016010,  
> “/testput/dabada.txt?” a:0, c:3  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 using configuration  
> key=dabada.txt&domain=test"  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
> Resource temporarily unavailable)  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 event timer add: 12:  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream process header  
> buffered downstream  
> “/mogstored\_spare\_218023808/dabada.txt?” 00007FFFFD434D70  
> “/testput/dabada.txt?”  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http finalize request: -4,  
> “/mogstored\_spare\_218028368/”  
> “192.168.100.11:7500”  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http proxy header:  
> 000000000CFD8A90:4096 @16  
> 60000:1285567531837  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream request:  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 chain writer out: 000000000CFD8C88  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 sendfile: @15694 21503  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 http upstream dummy handler  
> “Content-Length: 18”  
> “/mogstored\_spare\_218028368/dabada.txt?”  
> “/mogstored\_spare\_218028368/dabada.txt?”  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 mogilefs put handler state: 2,  
> 2010/09/27 15:04:31 [debug] 22519#0: \*1 run cleanup: 000000000CFDE830  
> 1000:1285567472841  
> temporarily unavailable)  
> [removed\_email\_address@domain.invalid](mailto:removed_email_address@domain.invalid)  
> [mailman.nginx.org archive](http://nginx.org/mailman/listinfo/nginx)

## –

Regards,  
Valery K.

---

<div class="post-metadata">

**Author:** ![casper\_the\_ghost](https://www.ruby-forum.com/letter_avatar_proxy/v4/letter/c/58956e/32.png) [@casper\_the\_ghost](https://www.ruby-forum.com/u/casper_the_ghost)\
**Post date:** [September 27, 2010, 2:59pm UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627/3 "2010-09-27T14:59:11Z")

</div>

thanks for reply  
I’m using nginx-0.8.50 and nginx-mogilefs-module 1.0.4

2010/9/27 Valery K. [removed\_email\_address@domain.invalid](mailto:removed_email_address@domain.invalid)

---

<div class="post-metadata">

**Author:** ![casper\_the\_ghost](https://www.ruby-forum.com/letter_avatar_proxy/v4/letter/c/58956e/32.png) [@casper\_the\_ghost](https://www.ruby-forum.com/u/casper_the_ghost)\
**Post date:** [September 28, 2010, 12:30pm UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627/4 "2010-09-28T12:30:00Z")

</div>

Thank you very much Valery,

Your patch worked very well in my environment.

> I’m going to look for a permanent solution later.  
> I’m looking forward to your best solution!!

Best regards

dai

(2010/09/28 18:55), -------- Original Message --------

---

<div class="post-metadata">

**Author:** ![casper\_the\_ghost](https://www.ruby-forum.com/letter_avatar_proxy/v4/letter/c/58956e/32.png) [@casper\_the\_ghost](https://www.ruby-forum.com/u/casper_the_ghost)\
**Post date:** [September 28, 2010, 11:56am UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627/5 "2010-09-28T11:56:38Z")

</div>

I can temporary fix it with attached patch.

I’m going to look for a permanent solution later.

---

<div class="post-metadata">

**Author:** ![casper\_the\_ghost](https://www.ruby-forum.com/letter_avatar_proxy/v4/letter/c/58956e/32.png) [@casper\_the\_ghost](https://www.ruby-forum.com/u/casper_the_ghost)\
**Post date:** [December 11, 2012, 2:38pm UTC](https://www.ruby-forum.com/t/cannot-put-file-with-nginx-mogilefs-module/195627/6 "2012-12-11T14:38:37Z")

</div>

[removed\_email\_address@domain.invalid](mailto:removed_email_address@domain.invalid) wrote in post #944380:

> Thank you very much Valery,
> 
> Your patch worked very well in my environment.
> 
> > I’m going to look for a permanent solution later.  
> > I’m looking forward to your best solution!!

Hi, I’m using FreeBSD 9.0 amd64 and nginx-1.2.5\_1,1 with the mogilefs  
module taken from github:

> <https://github.com/vkholodkov/nginx-mogilefs-module/blob/master/ngx_http_mogilefs_module.c>

During a ‘massive’ (1 upload / second) upload I see that nginx never  
closes opened connections:

root@motracker1:~# sockstat -v | grep 80 | wc -l  
260  
root@motracker1:~#

After seconds…

root@motracker1:~# sockstat -v | grep 80 | wc -l  
265  
root@motracker1:~#

And it grows up filling all worker\_connections slots.

Any hint?

Thanks,  
d.