access_by_lua在处理POST请求的时候无法正常结束请求

spirittf · 2015-06-23T21:21:10+00:00

Hello! 2015-06-22 12:56 GMT+08:00 高岩: > 如果每个连接都可以复用，&#x...

access_by_lua在处理POST请求的时候无法正常结束请求

spirittf

Nginx配置：

server {
Listen 1985;
root /home/tianfeng/lab/php;
location / {
index index.php index.html index.htm;
}
location ~ \.php$ {
access_by_lua_file '/home/tianfeng/lab/lua/test.lua';
fastcgi_pass 127.0.0.1:9000;
fastcgi_index index.php;
fastcgi_param SCRIPT_FILENAME $document_root$fastcgi_script_name;
include /home/work/nginx/conf/fastcgi_params;
}
}

/home/tianfeng/lab/lua/test.lua文件内容：

ngx.say("test")

/home/tianfeng/lab/php/index.php文件内容：

<?php
echo "I'm php";
?>

发如下POST请求：

curl -d "k=v" "http://172.16.0.210:1985"
tcpdump结果如下：
20:58:51.602468 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [S], seq 740686924, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 0,nop,wscale 7], length 0
..............E..<. @.@............o..,%.L........Y..........
&h.E........
20:58:51.602486 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [S.], seq 921964885, ack 740686925, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 644353861,nop,wscale 7], length 0
..............E..<..@.@..............o6..U,%.M....Y..........
&h.E&h.E....
20:58:51.602501 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4.
@.@............o..,%.M6..V...VY......
&h.E&h.E
20:58:51.602570 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [P.], seq 1:154, ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 153
..............E.....@.@..Z.........o..,%.M6..V...VZ......
&h.E&h.EPOST / HTTP/1.1
User-Agent: curl/7.29.0
Host: 172.16.0.210:1985
Accept: */*
Content-Length: 3
Content-Type: application/x-www-form-urlencoded
k=v
20:58:51.602577 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..V,%.....^Y......
&h.E&h.E
20:58:51.602740 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 1:183, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 182
..............E.....@.@..5...........o6..V,%.....^Z......
&h.E&h.EHTTP/1.1 200 OK
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: application/octet-stream
Transfer-Encoding: chunked
Connection: keep-alive
5
test
0

20:58:51.602748 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 183, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6......^Y......
&h.E&h.E
20:58:51.602817 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 183:498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 315
..............E..o..@.@..............o6...,%.....^[&.....
&h.E&h.EHTTP/1.1 400 Bad Request
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: text/html
Content-Length: 166
Connection: close
<html>
<head><title>400 Bad Request</title></head>
<body bgcolor="white">
<center><h1>400 Bad Request</h1></center>
<hr><center>nginx</center>
</body>
</html>
20:58:51.602824 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 498, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
@.@............o..,%..6..G...gY......
&h.E&h.E
20:58:51.602834 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [F.], seq 498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..G,%.....^Y......
&h.E&h.E
20:58:51.602930 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [F.], seq 154, ack 499, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6..H...gY......
&h.E&h.E
20:58:51.602939 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 155, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..H,%.....^Y......
&h.E&h.E

如上面抓包结果所示，1个request居然有2个response，第2个是400错误。

加上ngx.exit(ngx.HTTP_OK)结果也一样。

GET请求没有问题。

求春哥解惑。

nginx version: openresty/1.7.10.1

0yuan0

》。。。。。

》如上面抓包结果所示，1个request居然有2个response，第2个是400错误。

》加上ngx.exit(ngx.HTTP_OK)结果也一样。

》GET请求没有问题。

》求春哥解惑。

nginx默认是不会读取body信息的，需要显式调用读取body的函数才可以。

http://wiki.nginx.org/HttpLuaModule#ngx.req.read_body()

归结原因，是nginx自身最擅长HTTP负载均衡，body都是透传的。

对于路由，头部信息足够了，但对于web server，就需要根据需要显式读取一下body。

还有一个问题，为什么要在access阶段混用ngx.say呢（虽然允许）？如果是应答内容，还是走content吧，各司其职。

On Tuesday, June 23, 2015 at 9:21:10 PM UTC+8, 田峰 wrote:

Nginx配置：
server {
Listen 1985;
root /home/tianfeng/lab/php;
location / {
index index.php index.html index.htm;
}
location ~ \.php$ {
access_by_lua_file '/home/tianfeng/lab/lua/test.lua';
fastcgi_pass 127.0.0.1:9000;
fastcgi_index index.php;
fastcgi_param SCRIPT_FILENAME $document_root$fastcgi_script_name;
include /home/work/nginx/conf/fastcgi_params;
}
}

/home/tianfeng/lab/lua/test.lua文件内容：
ngx.say("test")

/home/tianfeng/lab/php/index.php文件内容：
<?php
echo "I'm php";
?>

发如下POST请求：
curl -d "k=v" "http://172.16.0.210:1985"
tcpdump结果如下：
20:58:51.602468 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [S], seq 740686924, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 0,nop,wscale 7], length 0
..............E..<. @.@............o..,%.L........Y..........
&h.E........
20:58:51.602486 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [S.], seq 921964885, ack 740686925, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 644353861,nop,wscale 7], length 0
..............E..<..@.@..............o6..U,%.M....Y..........
&h.E&h.E....
20:58:51.602501 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4.
@.@............o..,%.M6..V...VY......
&h.E&h.E
20:58:51.602570 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [P.], seq 1:154, ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 153
..............E.....@.@..Z.........o..,%.M6..V...VZ......
&h.E&h.EPOST / HTTP/1.1
User-Agent: curl/7.29.0
Host: 172.16.0.210:1985
Accept: */*
Content-Length: 3
Content-Type: application/x-www-form-urlencoded
k=v
20:58:51.602577 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..V,%.....^Y......
&h.E&h.E
20:58:51.602740 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 1:183, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 182
..............E.....@.@..5...........o6..V,%.....^Z......
&h.E&h.EHTTP/1.1 200 OK
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: application/octet-stream
Transfer-Encoding: chunked
Connection: keep-alive
5
test
0

20:58:51.602748 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 183, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6......^Y......
&h.E&h.E
20:58:51.602817 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 183:498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 315
..............E..o..@.@..............o6...,%.....^[&.....
&h.E&h.EHTTP/1.1 400 Bad Request
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: text/html
Content-Length: 166
Connection: close
<html>
<head><title>400 Bad Request</title></head>
<body bgcolor="white">
<center><h1>400 Bad Request</h1></center>
<hr><center>nginx</center>
</body>
</html>
20:58:51.602824 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 498, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
@.@............o..,%..6..G...gY......
&h.E&h.E
20:58:51.602834 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [F.], seq 498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..G,%.....^Y......
&h.E&h.E
20:58:51.602930 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [F.], seq 154, ack 499, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6..H...gY......
&h.E&h.E
20:58:51.602939 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 155, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..H,%.....^Y......
&h.E&h.E

如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
加上ngx.exit(ngx.HTTP_OK)结果也一样。
GET请求没有问题。
求春哥解惑。

nginx version: openresty/1.7.10.1

spirittf

谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。

在 2015年6月24日星期三 UTC+8下午1:15:37，YuanSheng Wang写道：

》。。。。。
》如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
》加上ngx.exit(ngx.HTTP_OK)结果也一样。
》GET请求没有问题。
》求春哥解惑。

nginx默认是不会读取body信息的，需要显式调用读取body的函数才可以。
http://wiki.nginx.org/HttpLuaModule#ngx.req.read_body()

归结原因，是nginx自身最擅长HTTP负载均衡，body都是透传的。
对于路由，头部信息足够了，但对于web server，就需要根据需要显式读取一下body。

还有一个问题，为什么要在access阶段混用ngx.say呢（虽然允许）？如果是应答内容，还是走content吧，各司其职。

On Tuesday, June 23, 2015 at 9:21:10 PM UTC+8, 田峰 wrote:
Nginx配置：
server {
Listen 1985;
root /home/tianfeng/lab/php;
location / {
index index.php index.html index.htm;
}
location ~ \.php$ {
access_by_lua_file '/home/tianfeng/lab/lua/test.lua';
fastcgi_pass 127.0.0.1:9000;
fastcgi_index index.php;
fastcgi_param SCRIPT_FILENAME $document_root$fastcgi_script_name;
include /home/work/nginx/conf/fastcgi_params;
}
}

/home/tianfeng/lab/lua/test.lua文件内容：
ngx.say("test")

/home/tianfeng/lab/php/index.php文件内容：
<?php
echo "I'm php";
?>

发如下POST请求：
curl -d "k=v" "http://172.16.0.210:1985"
tcpdump结果如下：
20:58:51.602468 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [S], seq 740686924, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 0,nop,wscale 7], length 0
..............E..<. @.@............o..,%.L........Y..........
&h.E........
20:58:51.602486 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [S.], seq 921964885, ack 740686925, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 644353861,nop,wscale 7], length 0
..............E..<..@.@..............o6..U,%.M....Y..........
&h.E&h.E....
20:58:51.602501 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4.
@.@............o..,%.M6..V...VY......
&h.E&h.E
20:58:51.602570 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [P.], seq 1:154, ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 153
..............E.....@.@..Z.........o..,%.M6..V...VZ......
&h.E&h.EPOST / HTTP/1.1
User-Agent: curl/7.29.0
Host: 172.16.0.210:1985
Accept: */*
Content-Length: 3
Content-Type: application/x-www-form-urlencoded
k=v
20:58:51.602577 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..V,%.....^Y......
&h.E&h.E
20:58:51.602740 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 1:183, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 182
..............E.....@.@..5...........o6..V,%.....^Z......
&h.E&h.EHTTP/1.1 200 OK
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: application/octet-stream
Transfer-Encoding: chunked
Connection: keep-alive
5
test
0

20:58:51.602748 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 183, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6......^Y......
&h.E&h.E
20:58:51.602817 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 183:498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 315
..............E..o..@.@..............o6...,%.....^[&.....
&h.E&h.EHTTP/1.1 400 Bad Request
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: text/html
Content-Length: 166
Connection: close
<html>
<head><title>400 Bad Request</title></head>
<body bgcolor="white">
<center><h1>400 Bad Request</h1></center>
<hr><center>nginx</center>
</body>
</html>
20:58:51.602824 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 498, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
@.@............o..,%..6..G...gY......
&h.E&h.E
20:58:51.602834 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [F.], seq 498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..G,%.....^Y......
&h.E&h.E
20:58:51.602930 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [F.], seq 154, ack 499, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6..H...gY......
&h.E&h.E
20:58:51.602939 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 155, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..H,%.....^Y......
&h.E&h.E

如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
加上ngx.exit(ngx.HTTP_OK)结果也一样。
GET请求没有问题。
求春哥解惑。

nginx version: openresty/1.7.10.1

0yuan0

》谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。
请仔细看看我刚刚给的连接并做实验，ngx.req.read_body不是给你返回body的内容，而是把http的body放到当前session中。

On Wednesday, June 24, 2015 at 1:44:00 PM UTC+8, 田峰 wrote:

谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。

在 2015年6月24日星期三 UTC+8下午1:15:37，YuanSheng Wang写道：
》。。。。。
》如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
》加上ngx.exit(ngx.HTTP_OK)结果也一样。
》GET请求没有问题。
》求春哥解惑。

nginx默认是不会读取body信息的，需要显式调用读取body的函数才可以。
http://wiki.nginx.org/HttpLuaModule#ngx.req.read_body()

归结原因，是nginx自身最擅长HTTP负载均衡，body都是透传的。
对于路由，头部信息足够了，但对于web server，就需要根据需要显式读取一下body。

还有一个问题，为什么要在access阶段混用ngx.say呢（虽然允许）？如果是应答内容，还是走content吧，各司其职。

On Tuesday, June 23, 2015 at 9:21:10 PM UTC+8, 田峰 wrote:
Nginx配置：
server {
Listen 1985;
root /home/tianfeng/lab/php;
location / {
index index.php index.html index.htm;
}
location ~ \.php$ {
access_by_lua_file '/home/tianfeng/lab/lua/test.lua';
fastcgi_pass 127.0.0.1:9000;
fastcgi_index index.php;
fastcgi_param SCRIPT_FILENAME $document_root$fastcgi_script_name;
include /home/work/nginx/conf/fastcgi_params;
}
}

/home/tianfeng/lab/lua/test.lua文件内容：
ngx.say("test")

/home/tianfeng/lab/php/index.php文件内容：
<?php
echo "I'm php";
?>

发如下POST请求：
curl -d "k=v" "http://172.16.0.210:1985"
tcpdump结果如下：
20:58:51.602468 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [S], seq 740686924, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 0,nop,wscale 7], length 0
..............E..<. @.@............o..,%.L........Y..........
&h.E........
20:58:51.602486 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [S.], seq 921964885, ack 740686925, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 644353861,nop,wscale 7], length 0
..............E..<..@.@..............o6..U,%.M....Y..........
&h.E&h.E....
20:58:51.602501 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4.
@.@............o..,%.M6..V...VY......
&h.E&h.E
20:58:51.602570 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [P.], seq 1:154, ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 153
..............E.....@.@..Z.........o..,%.M6..V...VZ......
&h.E&h.EPOST / HTTP/1.1
User-Agent: curl/7.29.0
Host: 172.16.0.210:1985
Accept: */*
Content-Length: 3
Content-Type: application/x-www-form-urlencoded
k=v
20:58:51.602577 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..V,%.....^Y......
&h.E&h.E
20:58:51.602740 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 1:183, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 182
..............E.....@.@..5...........o6..V,%.....^Z......
&h.E&h.EHTTP/1.1 200 OK
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: application/octet-stream
Transfer-Encoding: chunked
Connection: keep-alive
5
test
0

20:58:51.602748 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 183, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6......^Y......
&h.E&h.E
20:58:51.602817 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 183:498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 315
..............E..o..@.@..............o6...,%.....^[&.....
&h.E&h.EHTTP/1.1 400 Bad Request
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: text/html
Content-Length: 166
Connection: close
<html>
<head><title>400 Bad Request</title></head>
<body bgcolor="white">
<center><h1>400 Bad Request</h1></center>
<hr><center>nginx</center>
</body>
</html>
20:58:51.602824 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 498, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
@.@............o..,%..6..G...gY......
&h.E&h.E
20:58:51.602834 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [F.], seq 498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..G,%.....^Y......
&h.E&h.E
20:58:51.602930 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [F.], seq 154, ack 499, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6..H...gY......
&h.E&h.E
20:58:51.602939 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 155, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..H,%.....^Y......
&h.E&h.E

如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
加上ngx.exit(ngx.HTTP_OK)结果也一样。
GET请求没有问题。
求春哥解惑。

nginx version: openresty/1.7.10.1

agentzh

Hello!

2015-06-24 13:44 GMT+08:00 田峰:
> 谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。
>

在你的 access_by_lua* 处理程序里通过 ngx.exit() 调用提前结束请求之前，需要自己调用

    ngx.req.discard_body()

来丢弃当前请求的请求体，以避免影响当前下游连接上的后续请求（否则的话，当前请求未读取的请求体数据会被作为下一个请求的请求头，从而导致 400 错误）。

今明两天即将推出的下一个 OpenResty 发布（1.7.10.2 RC1）在此种情况下将会自动在内部调用
ngx.req.discard_body()，以防止用户忘记自己调用而发生不必要的 400 错误。

Regards,
-agentzh

spirittf

仔细看了文档，理解你的意思了，并测试了下，问题已经解决，非常感谢！

在 2015年6月24日星期三 UTC+8下午1:59:15，YuanSheng Wang写道：

》谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。
请仔细看看我刚刚给的连接并做实验，ngx.req.read_body不是给你返回body的内容，而是把http的body放到当前session中。

On Wednesday, June 24, 2015 at 1:44:00 PM UTC+8, 田峰 wrote:
谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。

在 2015年6月24日星期三 UTC+8下午1:15:37，YuanSheng Wang写道：
》。。。。。
》如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
》加上ngx.exit(ngx.HTTP_OK)结果也一样。
》GET请求没有问题。
》求春哥解惑。

nginx默认是不会读取body信息的，需要显式调用读取body的函数才可以。
http://wiki.nginx.org/HttpLuaModule#ngx.req.read_body()

归结原因，是nginx自身最擅长HTTP负载均衡，body都是透传的。
对于路由，头部信息足够了，但对于web server，就需要根据需要显式读取一下body。

还有一个问题，为什么要在access阶段混用ngx.say呢（虽然允许）？如果是应答内容，还是走content吧，各司其职。

On Tuesday, June 23, 2015 at 9:21:10 PM UTC+8, 田峰 wrote:
Nginx配置：
server {
Listen 1985;
root /home/tianfeng/lab/php;
location / {
index index.php index.html index.htm;
}
location ~ \.php$ {
access_by_lua_file '/home/tianfeng/lab/lua/test.lua';
fastcgi_pass 127.0.0.1:9000;
fastcgi_index index.php;
fastcgi_param SCRIPT_FILENAME $document_root$fastcgi_script_name;
include /home/work/nginx/conf/fastcgi_params;
}
}

/home/tianfeng/lab/lua/test.lua文件内容：
ngx.say("test")

/home/tianfeng/lab/php/index.php文件内容：
<?php
echo "I'm php";
?>

发如下POST请求：
curl -d "k=v" "http://172.16.0.210:1985"
tcpdump结果如下：
20:58:51.602468 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [S], seq 740686924, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 0,nop,wscale 7], length 0
..............E..<. @.@............o..,%.L........Y..........
&h.E........
20:58:51.602486 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [S.], seq 921964885, ack 740686925, win 43690, options [mss 65495,sackOK,TS val 644353861 ecr 644353861,nop,wscale 7], length 0
..............E..<..@.@..............o6..U,%.M....Y..........
&h.E&h.E....
20:58:51.602501 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4.
@.@............o..,%.M6..V...VY......
&h.E&h.E
20:58:51.602570 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [P.], seq 1:154, ack 1, win 342, options [nop,nop,TS val 644353861 ecr 644353861], length 153
..............E.....@.@..Z.........o..,%.M6..V...VZ......
&h.E&h.EPOST / HTTP/1.1
User-Agent: curl/7.29.0
Host: 172.16.0.210:1985
Accept: */*
Content-Length: 3
Content-Type: application/x-www-form-urlencoded
k=v
20:58:51.602577 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..V,%.....^Y......
&h.E&h.E
20:58:51.602740 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 1:183, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 182
..............E.....@.@..5...........o6..V,%.....^Z......
&h.E&h.EHTTP/1.1 200 OK
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: application/octet-stream
Transfer-Encoding: chunked
Connection: keep-alive
5
test
0

20:58:51.602748 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 183, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6......^Y......
&h.E&h.E
20:58:51.602817 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [P.], seq 183:498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 315
..............E..o..@.@..............o6...,%.....^[&.....
&h.E&h.EHTTP/1.1 400 Bad Request
Server: openresty
Date: Tue, 23 Jun 2015 12:58:51 GMT
Content-Type: text/html
Content-Length: 166
Connection: close
<html>
<head><title>400 Bad Request</title></head>
<body bgcolor="white">
<center><h1>400 Bad Request</h1></center>
<hr><center>nginx</center>
</body>
</html>
20:58:51.602824 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [.], ack 498, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
@.@............o..,%..6..G...gY......
&h.E&h.E
20:58:51.602834 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [F.], seq 498, ack 154, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..G,%.....^Y......
&h.E&h.E
20:58:51.602930 IP 172.16.0.210.50799 > 172.16.0.210.1985: Flags [F.], seq 154, ack 499, win 359, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@............o..,%..6..H...gY......
&h.E&h.E
20:58:51.602939 IP 172.16.0.210.1985 > 172.16.0.210.50799: Flags [.], ack 155, win 350, options [nop,nop,TS val 644353861 ecr 644353861], length 0
..............E..4..@.@..............o6..H,%.....^Y......
&h.E&h.E

如上面抓包结果所示，1个request居然有2个response，第2个是400错误。
加上ngx.exit(ngx.HTTP_OK)结果也一样。
GET请求没有问题。
求春哥解惑。

nginx version: openresty/1.7.10.1

spirittf

解释得非常清楚透彻，感谢春哥！

在 2015年6月24日星期三 UTC+8下午4:21:53，agentzh写道：

Hello!

2015-06-24 13:44 GMT+08:00 田峰:
> 谢谢回复，我不需要读取请求body，我只是想问为什么会返回两个HTTP头，且第二个是400状态；而改用GET方式请求就没有任何问题，lua会在access阶段正常输出"test"字符串，终止请求的处理，不走后面的PHASE。
>

在你的 access_by_lua* 处理程序里通过 ngx.exit() 调用提前结束请求之前，需要自己调用

ngx.req.discard_body()

来丢弃当前请求的请求体，以避免影响当前下游连接上的后续请求（否则的话，当前请求未读取的请求体数据会被作为下一个请求的请求头，从而导致 400 错误）。

今明两天即将推出的下一个 OpenResty 发布（1.7.10.2 RC1）在此种情况下将会自动在内部调用
ngx.req.discard_body()，以防止用户忘记自己调用而发生不必要的 400 错误。

Regards,
-agentzh