server{} ngx.exit not work when error_page

[3782...@qq.com]

server 块 用rewrite_by_lua或者access_by_lua  执行 ngx.exit(403)

location 块的 error_page 403 会有作用？ 

ngx.exit

syntax: ngx.exit(status)

context: rewrite_by_lua*, access_by_lua*, content_by_lua*, header_filter_by_lua*, ngx.timer.*, balancer_by_lua*, ssl_certificate_by_lua*, ssl_session_fetch_by_lua*, ssl_session_store_by_lua*

When status >= 200 (i.e., ngx.HTTP_OK and above), it will interrupt the execution of the current request and return status code to nginx.

复现case

server {

    listen 80 ;

    server_name test.tv ;

    set_by_lua $test '

        ngx.log(ngx.ERR,"set_by_lua")

    ';

    rewrite_by_lua '

        ngx.exit(403)

    ';

    location / {

        error_page 404 403 = /;

    }

}

curl -H "Host:test.tv" "http://127.0.0.1"

error_log :

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, "test.tv"

[error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1

nginx debug:

2018/08/31 12:16:08 [debug] 5134#5134: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5133#5133: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5132#5132: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5129#5129: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5128#5128: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5133#5133: posix_memalign: 00000000019FBA30:512 @16

2018/08/31 12:16:08 [debug] 5130#5130: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5132#5132: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5129#5129: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5134#5134: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5134#5134: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5133#5133: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5132#5132: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5129#5129: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5128#5128: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5133#5133: posix_memalign: 00000000019FBA30:512 @16

2018/08/31 12:16:08 [debug] 5130#5130: accept on 0.0.0.0:80, ready: 0

2018/08/31 12:16:08 [debug] 5132#5132: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5129#5129: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5134#5134: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5133#5133: *25 accept: 127.0.0.1:4618 fd:4

2018/08/31 12:16:08 [debug] 5128#5128: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5133#5133: *25 event timer add: 4: 10000:1535688978779

2018/08/31 12:16:08 [debug] 5133#5133: *25 reusable connection: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 epoll add event: fd:4 op:1 ev:80002001

2018/08/31 12:16:08 [debug] 5130#5130: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5133#5133: *25 http wait request handler

2018/08/31 12:16:08 [debug] 5133#5133: *25 malloc: 000000000190F970:1024

2018/08/31 12:16:08 [debug] 5133#5133: *25 recv: eof:0, avail:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 recv: fd:4 70 of 1024

2018/08/31 12:16:08 [debug] 5133#5133: *25 accept: 127.0.0.1:4618 fd:4

2018/08/31 12:16:08 [debug] 5128#5128: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5133#5133: *25 event timer add: 4: 10000:1535688978779

2018/08/31 12:16:08 [debug] 5133#5133: *25 reusable connection: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 epoll add event: fd:4 op:1 ev:80002001

2018/08/31 12:16:08 [debug] 5130#5130: accept() not ready (11: Resource temporarily unavailable)

2018/08/31 12:16:08 [debug] 5133#5133: *25 http wait request handler

2018/08/31 12:16:08 [debug] 5133#5133: *25 malloc: 000000000190F970:1024

2018/08/31 12:16:08 [debug] 5133#5133: *25 recv: eof:0, avail:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 recv: fd:4 70 of 1024

2018/08/31 12:16:08 [debug] 5133#5133: *25 reusable connection: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 000000000197E790:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http process request line

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request line: "GET / HTTP/1.1"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http uri: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http args: ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http exten: ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 0000000001965940:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http process request header line

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header: "User-Agent: curl/7.29.0"

2018/08/31 12:16:08 [debug] 5133#5133: *25 reusable connection: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 000000000197E790:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http process request line

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request line: "GET / HTTP/1.1"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http uri: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http args: ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http exten: ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 0000000001965940:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http process request header line

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header: "User-Agent: curl/7.29.0"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header: "Accept: */*"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header: "Host: test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header done

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header: "Accept: */*"

2018/08/31 12:16:08 [debug] 5133#5133: *25 event timer del: 4: 1535688978779

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header: "Host: test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http header done

2018/08/31 12:16:08 [debug] 5133#5133: *25 generic phase: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 event timer del: 4: 1535688978779

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 000000000197F698

2018/08/31 12:16:08 [debug] 5133#5133: *25 generic phase: 0

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 000000000197F698

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 000000000197F708

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 000000000197F708

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 000000000197F778

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 000000000197F778

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001966598

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001966598

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001966838

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001966838

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 0000000001966950:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 00000000019668A8

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 0000000001966950:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 00000000019668A8

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001966918

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001967058

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001966918

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 00000000019672F8

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001967058

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001967598

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001967838

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 00000000019672F8

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 500, "/?" a:1, c:12

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 500, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http set discard body

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua capture header filter, uri "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 HTTP/1.1 500 Internal Server Error

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 write new buf t:1 f:0 00000000019678A0, pos 00000000019678A0, size: 155 file: 0, size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter: l:0 f:0 s:155

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 00000000019709E0:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http output filter "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http copy filter: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua capture body filter, uri "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http postpone filter "/?" 0000000001970B20

2018/08/31 12:16:08 [debug] 5133#5133: *25 write old buf t:1 f:0 00000000019678A0, pos 00000000019678A0, size: 155 file: 0, size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 write new buf t:0 f:0 0000000000000000, pos 0000000000A2A4E0, size: 140 file: 0, size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 write new buf t:0 f:0 0000000000000000, pos 0000000000A2B7A0, size: 46 file: 0,size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001967598

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter: l:1 f:0 s:341

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter limit 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 writev: 341 of 341

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter 0000000000000000

2018/08/31 12:16:08 [debug] 5133#5133: *25 http copy filter: 0 "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 0, "/?" a:1, c:12

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:12 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:11 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 internal redirect: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cleanup add: 0000000001967838

2018/08/31 12:16:08 [error] 5133#5133: *25 [lua] set_by_lua:2: set_by_lua, client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script value (post filter): ""

2018/08/31 12:16:08 [debug] 5133#5133: *25 http script set $test

2018/08/31 12:16:08 [debug] 5133#5133: *25 test location: "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 using configuration "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http cl:-1 max:67108864

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 3

2018/08/31 12:16:08 [debug] 5133#5133: *25 rewrite phase: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua rewrite handler, uri:"/" c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua creating new thread

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua reset ctx

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:10 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua run thread, top:0 c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:9 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua exit with code 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua resume returned 1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:8 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread yielded

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua thread aborting request with status 403

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:7 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua request cleanup: forcible=0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 403, "/?" a:1, c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:6 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 403, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:5

2018/08/31 12:16:08 [error] 5133#5133: *25 rewrite or internal redirection cycle while internally redirecting to "/", client: 127.0.0.1, server: test.tv, request: "GET / HTTP/1.1", host: "test.tv"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 500, "/?" a:1, c:12

2018/08/31 12:16:08 [debug] 5133#5133: *25 http special response: 500, "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http set discard body

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua capture header filter, uri "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 HTTP/1.1 500 Internal Server Error

2018/08/31 12:16:08 [debug] 5133#5133: *25 write new buf t:1 f:0 00000000019678A0, pos 00000000019678A0, size: 155 file: 0, size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter: l:0 f:0 s:155

2018/08/31 12:16:08 [debug] 5133#5133: *25 posix_memalign: 00000000019709E0:4096 @16

2018/08/31 12:16:08 [debug] 5133#5133: *25 http output filter "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http copy filter: "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 lua capture body filter, uri "/"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http postpone filter "/?" 0000000001970B20

2018/08/31 12:16:08 [debug] 5133#5133: *25 write old buf t:1 f:0 00000000019678A0, pos 00000000019678A0, size: 155 file: 0, size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 write new buf t:0 f:0 0000000000000000, pos 0000000000A2A4E0, size: 140 file: 0, size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 write new buf t:0 f:0 0000000000000000, pos 0000000000A2B7A0, size: 46 file: 0,size: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter: l:1 f:0 s:341

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter limit 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 writev: 341 of 341

2018/08/31 12:16:08 [debug] 5133#5133: *25 http write filter 0000000000000000

2018/08/31 12:16:08 [debug] 5133#5133: *25 http copy filter: 0 "/?"

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: 0, "/?" a:1, c:12

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:12 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:11

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:11 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:10

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:10 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:9

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:9 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:8

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:8 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:7

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:7 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:6

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:6 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:5 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:5

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:5 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:4 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:4

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:4 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:3 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:3

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:3 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:2 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:2

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:2 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:1 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http finalize request: -4, "/?" a:1, c:1

2018/08/31 12:16:08 [debug] 5133#5133: *25 http close request

2018/08/31 12:16:08 [debug] 5133#5133: *25 http request count:1 blk:0

2018/08/31 12:16:08 [debug] 5133#5133: *25 http close request

2018/08/31 12:16:08 [debug] 5133#5133: *25 http log handler

2018/08/31 12:16:08 [debug] 5133#5133: *25 http log handler

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 000000000197E790, unused: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 0000000001965940, unused: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 0000000001966950, unused: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 000000000197E790, unused: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 00000000019709E0, unused: 3508

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 0000000001965940, unused: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 close http connection: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 reusable connection: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 000000000190F970

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 0000000001966950, unused: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 00000000019FBA30, unused: 120

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 00000000019709E0, unused: 3508

2018/08/31 12:16:08 [debug] 5133#5133: *25 close http connection: 4

2018/08/31 12:16:08 [debug] 5133#5133: *25 reusable connection: 0

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 000000000190F970

2018/08/31 12:16:08 [debug] 5133#5133: *25 free: 00000000019FBA30, unused: 120

[tokers]

Hello!

These server-level ngx_lua phase hooks will be inherited by the inside location

if the location doesn't contain the corresponding directive. So this is an expected

behavior.