Openresty关闭lua_code_cache后debug发现无法正常读取请求体lua resume returned 0

zhoujing00k · 2015-09-07T18:43:45+00:00

谢春哥那我就先自己折腾折腾吧在 2015年9月8&#x65E5...

Openresty关闭lua_code_cache后debug发现无法正常读取请求体lua resume returned 0

zhoujing00k

春哥好！

最近想基于Openresty开发一个类似Yaf的业务开发框架，以便于降低Openresty使用门槛，使做业务开发的同学也能更平滑的过度。

但是在测试时发现：如果去除lua_code_cache off的设置，就无法正常返回数据，没有报错，对比了正常和异常两种情况的debug日志发现如图所示的现象：

正常情况下*1 lua start to read buffered request body

2015/09/07 18:15:47 [debug] 889#0: *1 post access phase: 10
2015/09/07 18:15:47 [debug] 889#0: *1 lua content handler, uri:"/t/aa" c:1
2015/09/07 18:15:47 [debug] 889#0: *1 lua reset ctx
2015/09/07 18:15:47 [debug] 889#0: *1 lua creating new thread
2015/09/07 18:15:47 [debug] 889#0: *1 http cleanup add: 00007FF3FA807DC0
2015/09/07 18:15:47 [debug] 889#0: *1 lua run thread, top:0 c:1
2015/09/07 18:15:47 [debug] 889#0: *1 lua start to read buffered request body
2015/09/07 18:15:47 [debug] 889#0: *1 lua req body post read, c:2
2015/09/07 18:15:47 [debug] 889#0: *1 lua has read buffered request body in a single run
2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Host: localhost:7200"
2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Connection: keep-alive"
2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Pragma: no-cache"
2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Cache-Control: no-cache"

异常情况下*1 lua resume returned 0

2015/09/07 18:16:15 [debug] 889#0: *1 post access phase: 10
2015/09/07 18:16:15 [debug] 889#0: *1 lua content handler, uri:"/t/aa" c:1
2015/09/07 18:16:15 [debug] 889#0: *1 lua reset ctx
2015/09/07 18:16:15 [debug] 889#0: *1 lua creating new thread
2015/09/07 18:16:15 [debug] 889#0: *1 http cleanup add: 00007FF3FA807DC0
2015/09/07 18:16:15 [debug] 889#0: *1 lua run thread, top:0 c:1
2015/09/07 18:16:15 [debug] 889#0: *1 lua resume returned 0
2015/09/07 18:16:15 [debug] 889#0: *1 lua light thread ended normally
2015/09/07 18:16:15 [debug] 889#0: *1 lua deleting light thread
2015/09/07 18:16:15 [debug] 889#0: *1 lua capture header filter, uri "/t/aa"
2015/09/07 18:16:15 [debug] 889#0: *1 HTTP/1.1 200 OK

求助如何处理，非常感谢。

Attachment: xxx.jpg
Description: JPEG image

yuansheng_2f16

你最好给出可以复现问题的代码最小集，这样大家可以更好的帮助你定位问题和错误，而不是只看日志。

毕竟日志不是那么友好，分析起来比较费劲。

2015-09-07 18:43 GMT+08:00 zhoujingk_49 <zhouj...@gmail.com>:

春哥好！

最近想基于Openresty开发一个类似Yaf的业务开发框架，以便于降低Openresty使用门槛，使做业务开发的同学也能更平滑的过度。
但是在测试时发现：如果去除lua_code_cache off的设置，就无法正常返回数据，没有报错，对比了正常和异常两种情况的debug日志发现如图所示的现象：
正常情况下*1 lua start to read buffered request body
2015/09/07 18:15:47 [debug] 889#0: *1 post access phase: 10 2015/09/07 18:15:47 [debug] 889#0: *1 lua content handler, uri:"/t/aa" c:1 2015/09/07 18:15:47 [debug] 889#0: *1 lua reset ctx 2015/09/07 18:15:47 [debug] 889#0: *1 lua creating new thread 2015/09/07 18:15:47 [debug] 889#0: *1 http cleanup add: 00007FF3FA807DC0 2015/09/07 18:15:47 [debug] 889#0: *1 lua run thread, top:0 c:1 2015/09/07 18:15:47 [debug] 889#0: *1 lua start to read buffered request body 2015/09/07 18:15:47 [debug] 889#0: *1 lua req body post read, c:2 2015/09/07 18:15:47 [debug] 889#0: *1 lua has read buffered request body in a single run 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Host: localhost:7200" 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Connection: keep-alive" 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Pragma: no-cache" 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Cache-Control: no-cache"

异常情况下*1 lua resume returned 0
2015/09/07 18:16:15 [debug] 889#0: *1 post access phase: 10 2015/09/07 18:16:15 [debug] 889#0: *1 lua content handler, uri:"/t/aa" c:1 2015/09/07 18:16:15 [debug] 889#0: *1 lua reset ctx 2015/09/07 18:16:15 [debug] 889#0: *1 lua creating new thread 2015/09/07 18:16:15 [debug] 889#0: *1 http cleanup add: 00007FF3FA807DC0 2015/09/07 18:16:15 [debug] 889#0: *1 lua run thread, top:0 c:1 2015/09/07 18:16:15 [debug] 889#0: *1 lua resume returned 0 2015/09/07 18:16:15 [debug] 889#0: *1 lua light thread ended normally 2015/09/07 18:16:15 [debug] 889#0: *1 lua deleting light thread 2015/09/07 18:16:15 [debug] 889#0: *1 lua capture header filter, uri "/t/aa" 2015/09/07 18:16:15 [debug] 889#0: *1 HTTP/1.1 200 OK

求助如何处理，非常感谢。

--

Membhis

My github: https://github.com/membphis

Our Book: OpenResty Best Practices

zhoujing00k

感谢院生，这个问题解决了，原因是我的入口是一个lua文件，但是我是用了

content_by_lua 'require(\"pub.index\")';

所以当开启缓存后，只有第一次能去读请求体，往后都被缓存了，这个问题两种解决方法：

第一种：要么入口文件封装成一个包，require的时候将ngx变量传进去，这样每次请求处理都调用最新的ngx变量如下：

content_by_lua 'require(\"pub.index\").run(ngx)';

第二种：直接使用content_by_lua_file

content_by_lua_file ./pub/index.lua;

这里为了迎合业务开发同学使用框架的习惯，我选择第二种，再次感谢各位：）

在 2015年9月7日星期一 UTC+8下午7:37:47，YuanSheng Wang写道：

你最好给出可以复现问题的代码最小集，这样大家可以更好的帮助你定位问题和错误，而不是只看日志。

毕竟日志不是那么友好，分析起来比较费劲。

2015-09-07 18:43 GMT+08:00 zhoujingk_49 <zhouj...@gmail.com>:
春哥好！

最近想基于Openresty开发一个类似Yaf的业务开发框架，以便于降低Openresty使用门槛，使做业务开发的同学也能更平滑的过度。
但是在测试时发现：如果去除lua_code_cache off的设置，就无法正常返回数据，没有报错，对比了正常和异常两种情况的debug日志发现如图所示的现象：
正常情况下*1 lua start to read buffered request body
2015/09/07 18:15:47 [debug] 889#0: *1 post access phase: 10 2015/09/07 18:15:47 [debug] 889#0: *1 lua content handler, uri:"/t/aa" c:1 2015/09/07 18:15:47 [debug] 889#0: *1 lua reset ctx 2015/09/07 18:15:47 [debug] 889#0: *1 lua creating new thread 2015/09/07 18:15:47 [debug] 889#0: *1 http cleanup add: 00007FF3FA807DC0 2015/09/07 18:15:47 [debug] 889#0: *1 lua run thread, top:0 c:1 2015/09/07 18:15:47 [debug] 889#0: *1 lua start to read buffered request body 2015/09/07 18:15:47 [debug] 889#0: *1 lua req body post read, c:2 2015/09/07 18:15:47 [debug] 889#0: *1 lua has read buffered request body in a single run 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Host: localhost:7200" 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Connection: keep-alive" 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Pragma: no-cache" 2015/09/07 18:15:47 [debug] 889#0: *1 lua request header: "Cache-Control: no-cache"

异常情况下*1 lua resume returned 0
2015/09/07 18:16:15 [debug] 889#0: *1 post access phase: 10 2015/09/07 18:16:15 [debug] 889#0: *1 lua content handler, uri:"/t/aa" c:1 2015/09/07 18:16:15 [debug] 889#0: *1 lua reset ctx 2015/09/07 18:16:15 [debug] 889#0: *1 lua creating new thread 2015/09/07 18:16:15 [debug] 889#0: *1 http cleanup add: 00007FF3FA807DC0 2015/09/07 18:16:15 [debug] 889#0: *1 lua run thread, top:0 c:1 2015/09/07 18:16:15 [debug] 889#0: *1 lua resume returned 0 2015/09/07 18:16:15 [debug] 889#0: *1 lua light thread ended normally 2015/09/07 18:16:15 [debug] 889#0: *1 lua deleting light thread 2015/09/07 18:16:15 [debug] 889#0: *1 lua capture header filter, uri "/t/aa" 2015/09/07 18:16:15 [debug] 889#0: *1 HTTP/1.1 200 OK

求助如何处理，非常感谢。

--

--

Membhis
My github: https://github.com/membphis
Our Book: OpenResty Best Practices