2020/02/21 17:37:28 [debug] 6206#6206: epoll del event: fd:7 op:2 ev:00000000 2020/02/21 17:37:28 [debug] 6206#6206: epoll del event: fd:8 op:2 ev:00000000 2020/02/21 17:37:28 [debug] 6329#6329: epoll add event: fd:7 op:1 ev:00002001 2020/02/21 17:37:28 [debug] 6329#6329: epoll add event: fd:8 op:1 ev:00002001 2020/02/21 17:37:28 [debug] 6335#6335: epoll add event: fd:7 op:1 ev:00002001 2020/02/21 17:37:28 [debug] 6335#6335: epoll add event: fd:8 op:1 ev:00002001 2020/02/21 17:37:28 [debug] 6329#6329: epoll del event: fd:7 op:2 ev:00000000 2020/02/21 17:37:28 [debug] 6329#6329: epoll del event: fd:8 op:2 ev:00000000 2020/02/21 17:37:38 [debug] 6335#6335: post event 0000555BA9D6D0E0 2020/02/21 17:37:38 [debug] 6335#6335: delete posted event 0000555BA9D6D0E0 2020/02/21 17:37:38 [debug] 6335#6335: accept on 0.0.0.0:8081, ready: 0 2020/02/21 17:37:38 [debug] 6335#6335: posix_memalign: 0000555BA9D5FC10:512 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 accept: 10.10.122.11:50463 fd:15 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 15: 60000:1582335518184 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 epoll add event: fd:15 op:1 ev:80002001 2020/02/21 17:37:38 [debug] 6335#6335: post event 0000555BA9D6D0E0 2020/02/21 17:37:38 [debug] 6335#6335: delete posted event 0000555BA9D6D0E0 2020/02/21 17:37:38 [debug] 6335#6335: accept on 0.0.0.0:8081, ready: 0 2020/02/21 17:37:38 [debug] 6335#6335: posix_memalign: 0000555BA9D610D0:512 @16 2020/02/21 17:37:38 [debug] 6335#6335: *2 accept: 10.10.122.11:50464 fd:17 2020/02/21 17:37:38 [debug] 6335#6335: *2 event timer add: 17: 60000:1582335518184 2020/02/21 17:37:38 [debug] 6335#6335: *2 reusable connection: 1 2020/02/21 17:37:38 [debug] 6335#6335: *2 epoll add event: fd:17 op:1 ev:80002001 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 http wait request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 malloc: 0000555BA9D2CDC0:1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:15 458 of 1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D3E820:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http process request line 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request line: "GET / HTTP/1.1" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http uri: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http args: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http exten: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http process request header line 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Host: ourhost.domain:8081" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Connection: keep-alive" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Cache-Control: max-age=0" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Upgrade-Insecure-Requests: 1" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D31380:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Accept-Encoding: gzip, deflate" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Accept-Language: en-US,en;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header done 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 15: 1582335518184 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 using configuration "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cl:-1 max:1048576 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 3 2020/02/21 17:37:38 [debug] 6335#6335: *1 post rewrite phase: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 5 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 6 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 7 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 9 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 10 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 http subrequest "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http posted request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 using configuration "=/auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cl:-1 max:1048576 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 3 2020/02/21 17:37:38 [debug] 6335#6335: *1 post rewrite phase: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 5 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 6 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 7 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D32390:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http init upstream, client timer: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 epoll add event: fd:15 op:3 ev:80002005 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cache key: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 add cleanup: 0000555BA9D327F0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http file cache exists: -5 e:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 cache file: "/usr/share/nginx/cache/d41d8cd98f00b204e9800998ecf8427e" 2020/02/21 17:37:38 [debug] 6335#6335: *1 add cleanup: 0000555BA9D32840 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream cache: -5 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Ldap-URL: ldap://:389 " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Ldap-BaseDN: ou=name,ou=name,ou=name,dc=name,dc=name " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Ldap-BindDN: cn=binduserr,ou=name,ou=name,ou=name,dc=name,dc=name " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Ldap-BindPass: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Ldap-Template: (sAMAccountName=%(username)s) " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-CookieName: nginxauth " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Cookie: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "nginxauth=" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Host: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script var: "127.0.0.1:8888" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Connection: close " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Cache-Control: max-age=0" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Upgrade-Insecure-Requests: 1" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Encoding: gzip, deflate" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Language: en-US,en;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "GET /auth-proxy HTTP/1.0 X-Ldap-URL: ldap://:389 X-Ldap-BaseDN: ou=user,ou=user,ou=user,dc=user,dc=user X-Ldap-BindDN: cn=binduser,ou=user,ou=user,ou=user,dc=user,dc=user X-Ldap-BindPass: X-Ldap-Template: (sAMAccountName=%(username)s) X-CookieName: nginxauth Cookie: nginxauth= Host: 127.0.0.1:8888 Connection: close Cache-Control: max-age=0 Upgrade-Insecure-Requests: 1 User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36 Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9 Accept-Encoding: gzip, deflate Accept-Language: en-US,en;q=0.9 " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cleanup add: 0000555BA9D32C68 2020/02/21 17:37:38 [debug] 6335#6335: *1 get rr peer, try: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 stream socket 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 epoll add connection: fd:19 ev:80002005 2020/02/21 17:37:38 [debug] 6335#6335: *1 connect to 127.0.0.1:8888, fd:19 #3 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream connect: -2 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D5FE20:128 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 19: 60000:1582335518185 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: -4, "/auth-proxy?" a:1, c:3 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request count:3 blk:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F210 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F210 2020/02/21 17:37:38 [debug] 6335#6335: *1 http run request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream check client, write event:1, "/auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream recv(): -1 (11: Resource temporarily unavailable) 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream send request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream send request 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream send request body 2020/02/21 17:37:38 [debug] 6335#6335: *1 chain writer buf fl:1 s:771 2020/02/21 17:37:38 [debug] 6335#6335: *1 chain writer in: 0000555BA9D32CA0 2020/02/21 17:37:38 [debug] 6335#6335: *1 writev: 771 of 771 2020/02/21 17:37:38 [debug] 6335#6335: *1 chain writer out: 0000000000000000 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 19: 1582335518185 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 19: 60000:1582335518185 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream process header 2020/02/21 17:37:38 [debug] 6335#6335: *1 malloc: 0000555BA9D333A0:4096 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 100 of 3945 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy status 401 "401 Unauthorized" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Server: BaseHTTP/0.3 Python/2.7.12" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Date: Sat, 22 Feb 2020 01:37:38 GMT" 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 69 of 3845 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "WWW-Authenticate: Basic realm="Restricted"" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Cache-Control: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 2 of 3776 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header done 2020/02/21 17:37:38 [debug] 6335#6335: *1 xslt filter header 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http upstream request: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http proxy request 2020/02/21 17:37:38 [debug] 6335#6335: *1 free rr peer 1 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 close http upstream connection: 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D5FE20, unused: 48 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 19: 1582335518185 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http file cache free, fd: -1 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 0, "/auth-proxy?" a:1, c:2 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request done s:401 2020/02/21 17:37:38 [debug] 6335#6335: *1 http wake parent request: "/?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http posted request: "/?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 10 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request set variables 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 401, "/?" a:1, c:1 2020/02/21 17:37:38 [debug] 6335#6335: *1 http special response: 401, "/?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 internal redirect: "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 using configuration "/login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cl:-1 max:1048576 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 3 2020/02/21 17:37:38 [debug] 6335#6335: *1 post rewrite phase: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 5 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 6 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 7 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 9 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 10 2020/02/21 17:37:38 [debug] 6335#6335: *1 post access phase: 11 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D343B0:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http init upstream, client timer: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Target: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script var: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Host: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script var: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Connection: close " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Cache-Control: max-age=0" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Upgrade-Insecure-Requests: 1" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Encoding: gzip, deflate" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Language: en-US,en;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "GET /login HTTP/1.0 X-Target: / Host: 10.10.140.119 Connection: close Cache-Control: max-age=0 Upgrade-Insecure-Requests: 1 User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36 Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9 Accept-Encoding: gzip, deflate Accept-Language: en-US,en;q=0.9 " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cleanup add: 0000555BA9D34860 2020/02/21 17:37:38 [debug] 6335#6335: *1 get rr peer, try: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 stream socket 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 epoll add connection: fd:19 ev:80002005 2020/02/21 17:37:38 [debug] 6335#6335: *1 connect to 10.10.140.119:80, fd:19 #4 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream connect: -2 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D5FE20:128 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 19: 60000:1582335518186 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: -4, "/login?" a:1, c:3 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request count:3 blk:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: -4, "/login?" a:1, c:2 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request count:2 blk:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream process header 2020/02/21 17:37:38 [error] 6335#6335: *1 connect() failed (111: Connection refused) while connecting to upstream, client: 10.10.122.11, server: , request: "GET / HTTP/1.1", upstream: "http://:80/login", host: ":8081" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http next upstream, 2 2020/02/21 17:37:38 [debug] 6335#6335: *1 free rr peer 1 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http upstream request: 502 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http proxy request 2020/02/21 17:37:38 [debug] 6335#6335: *1 close http upstream connection: 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D5FE20, unused: 48 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 19: 1582335518186 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 502, "/login?" a:1, c:1 2020/02/21 17:37:38 [debug] 6335#6335: *1 http special response: 502, "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 xslt filter header 2020/02/21 17:37:38 [debug] 6335#6335: *1 HTTP/1.1 502 Bad Gateway Server: nginx/1.10.3 (Ubuntu) Date: Sat, 22 Feb 2020 01:37:38 GMT Content-Type: text/html Content-Length: 584 Connection: keep-alive WWW-Authenticate: Basic realm="Restricted" 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:1 f:0 0000555BA9D348E8, pos 0000555BA9D348E8, size: 210 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter: l:0 f:0 s:210 2020/02/21 17:37:38 [debug] 6335#6335: *1 http output filter "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http copy filter: "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 image filter 2020/02/21 17:37:38 [debug] 6335#6335: *1 xslt filter body 2020/02/21 17:37:38 [debug] 6335#6335: *1 http postpone filter "/login?" 0000555BA9D34B48 2020/02/21 17:37:38 [debug] 6335#6335: *1 write old buf t:1 f:0 0000555BA9D348E8, pos 0000555BA9D348E8, size: 210 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:0 f:0 0000000000000000, pos 0000555BA8386AC0, size: 120 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:0 f:0 0000000000000000, pos 0000555BA8387E40, size: 62 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:0 f:0 0000000000000000, pos 0000555BA8387C60, size: 402 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter: l:1 f:0 s:794 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter limit 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 writev: 794 of 794 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter 0000000000000000 2020/02/21 17:37:38 [debug] 6335#6335: *1 http copy filter: 0 "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 0, "/login?" a:1, c:1 2020/02/21 17:37:38 [debug] 6335#6335: *1 set http keepalive handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 http close request 2020/02/21 17:37:38 [debug] 6335#6335: *1 http log handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 run cleanup: 0000555BA9D327F0 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D333A0 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D3E820, unused: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D31380, unused: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D32390, unused: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D343B0, unused: 1829 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D2CDC0 2020/02/21 17:37:38 [debug] 6335#6335: *1 hc free: 0000000000000000 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 hc busy: 0000000000000000 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 tcp_nodelay 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 15: 65000:1582335523186 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 http keepalive handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 malloc: 0000555BA9D2CDC0:1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:15 -1 of 1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv() not ready (11: Resource temporarily unavailable) 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D2CDC0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F210 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 http keepalive handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 malloc: 0000555BA9D2CDC0:1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:15 414 of 1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D3E820:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 15: 1582335523186 2020/02/21 17:37:38 [debug] 6335#6335: *1 http process request line 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request line: "GET /favicon.ico HTTP/1.1" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http uri: "/favicon.ico" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http args: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http exten: "ico" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http process request header line 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Host: :8081" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Connection: keep-alive" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Pragma: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Cache-Control: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Accept: image/webp,image/apng,image/*,*/*;q=0.8" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Referer: http://:8081/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Accept-Encoding: gzip, deflate" 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D31380:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header: "Accept-Language: en-US,en;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http header done 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 using configuration "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cl:-1 max:1048576 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 3 2020/02/21 17:37:38 [debug] 6335#6335: *1 post rewrite phase: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 5 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 6 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 7 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 9 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 10 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 http subrequest "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http posted request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 using configuration "=/auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cl:-1 max:1048576 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 3 2020/02/21 17:37:38 [debug] 6335#6335: *1 post rewrite phase: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 5 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 6 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 7 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D32390:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http init upstream, client timer: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cache key: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 add cleanup: 0000555BA9D32360 2020/02/21 17:37:38 [debug] 6335#6335: *1 http file cache exists: -5 e:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 cache file: "/usr/share/nginx/cache/d41d8cd98f00b204e9800998ecf8427e" 2020/02/21 17:37:38 [debug] 6335#6335: *1 add cleanup: 0000555BA9D32828 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream cache: -5 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Cookie: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "nginxauth=" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Host: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script var: "127.0.0.1:8888" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Connection: close " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Pragma: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Cache-Control: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept: image/webp,image/apng,image/*,*/*;q=0.8" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Referer: http://:8081/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Encoding: gzip, deflate" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Language: en-US,en;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "GET /auth-proxy HTTP/1.0 Cookie: nginxauth= Host: 127.0.0.1:8888 Connection: close Pragma: no-cache Cache-Control: no-cache User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36 Accept: image/webp,image/apng,image/*,*/*;q=0.8 Referer: http://:8081/ Accept-Encoding: gzip, deflate Accept-Language: en-US,en;q=0.9 " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cleanup add: 0000555BA9D32C28 2020/02/21 17:37:38 [debug] 6335#6335: *1 get rr peer, try: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 stream socket 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 epoll add connection: fd:19 ev:80002005 2020/02/21 17:37:38 [debug] 6335#6335: *1 connect to 127.0.0.1:8888, fd:19 #5 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream connect: -2 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D5FE20:128 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 19: 60000:1582335518232 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: -4, "/auth-proxy?" a:1, c:3 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request count:3 blk:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F210 2020/02/21 17:37:38 [debug] 6335#6335: *1 http run request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream check client, write event:1, "/auth-proxy" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream recv(): -1 (11: Resource temporarily unavailable) 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream send request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream send request 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream send request body 2020/02/21 17:37:38 [debug] 6335#6335: *1 chain writer buf fl:1 s:716 2020/02/21 17:37:38 [debug] 6335#6335: *1 chain writer in: 0000555BA9D32C60 2020/02/21 17:37:38 [debug] 6335#6335: *1 writev: 716 of 716 2020/02/21 17:37:38 [debug] 6335#6335: *1 chain writer out: 0000000000000000 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 19: 1582335518232 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 19: 60000:1582335518233 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream process header 2020/02/21 17:37:38 [debug] 6335#6335: *1 malloc: 0000555BA9D333A0:4096 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 63 of 3945 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy status 401 "401 Unauthorized" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Server: BaseHTTP/0.3 Python/2.7.12" 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 -1 of 3882 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv() not ready (11: Resource temporarily unavailable) 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream dummy handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/auth-proxy?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream process header 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 81 of 3882 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Date: Sat, 22 Feb 2020 01:37:38 GMT" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "WWW-Authenticate: Basic realm="Restricted"" 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 25 of 3801 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Cache-Control: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:19 2 of 3776 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header done 2020/02/21 17:37:38 [debug] 6335#6335: *1 xslt filter header 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http upstream request: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http proxy request 2020/02/21 17:37:38 [debug] 6335#6335: *1 free rr peer 1 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 close http upstream connection: 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D5FE20, unused: 48 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 19: 1582335518233 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http file cache free, fd: -1 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 0, "/auth-proxy?" a:1, c:2 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request done s:401 2020/02/21 17:37:38 [debug] 6335#6335: *1 http wake parent request: "/favicon.ico?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http posted request: "/favicon.ico?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 10 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 auth request set variables 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 401, "/favicon.ico?" a:1, c:1 2020/02/21 17:37:38 [debug] 6335#6335: *1 http special response: 401, "/favicon.ico?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 internal redirect: "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 test location: "login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 using configuration "/login" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cl:-1 max:1048576 2020/02/21 17:37:38 [debug] 6335#6335: *1 rewrite phase: 3 2020/02/21 17:37:38 [debug] 6335#6335: *1 post rewrite phase: 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 5 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 6 2020/02/21 17:37:38 [debug] 6335#6335: *1 generic phase: 7 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 9 2020/02/21 17:37:38 [debug] 6335#6335: *1 access phase: 10 2020/02/21 17:37:38 [debug] 6335#6335: *1 post access phase: 11 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D343B0:4096 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 http init upstream, client timer: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "X-Target: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script var: "/favicon.ico" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Host: " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script var: "10.10.140.119" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: " " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "Connection: close " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http script copy: "" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Pragma: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Cache-Control: no-cache" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept: image/webp,image/apng,image/*,*/*;q=0.8" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Referer: http://:8081/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Encoding: gzip, deflate" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "Accept-Language: en-US,en;q=0.9" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http proxy header: "GET /login HTTP/1.0 X-Target: /favicon.ico Host: Connection: close Pragma: no-cache Cache-Control: no-cache User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/79.0.3945.130 Safari/537.36 Accept: image/webp,image/apng,image/*,*/*;q=0.8 Referer: http://:8081/ Accept-Encoding: gzip, deflate Accept-Language: en-US,en;q=0.9 " 2020/02/21 17:37:38 [debug] 6335#6335: *1 http cleanup add: 0000555BA9D33370 2020/02/21 17:37:38 [debug] 6335#6335: *1 get rr peer, try: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 stream socket 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 epoll add connection: fd:19 ev:80002005 2020/02/21 17:37:38 [debug] 6335#6335: *1 connect to :80, fd:19 #6 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream connect: -2 2020/02/21 17:37:38 [debug] 6335#6335: *1 posix_memalign: 0000555BA9D5FE20:128 @16 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 19: 60000:1582335518233 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: -4, "/login?" a:1, c:3 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request count:3 blk:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: -4, "/login?" a:1, c:2 2020/02/21 17:37:38 [debug] 6335#6335: *1 http request count:2 blk:0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D2C0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream request: "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http upstream process header 2020/02/21 17:37:38 [error] 6335#6335: *1 connect() failed (111: Connection refused) while connecting to upstream, client: , server: , request: "GET /favicon.ico HTTP/1.1", upstream: "http:///login", host: ":8081", referrer: "http://:8081/" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http next upstream, 2 2020/02/21 17:37:38 [debug] 6335#6335: *1 free rr peer 1 4 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http upstream request: 502 2020/02/21 17:37:38 [debug] 6335#6335: *1 finalize http proxy request 2020/02/21 17:37:38 [debug] 6335#6335: *1 close http upstream connection: 19 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D5FE20, unused: 48 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer del: 19: 1582335518233 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D7F2D0 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 502, "/login?" a:1, c:1 2020/02/21 17:37:38 [debug] 6335#6335: *1 http special response: 502, "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 xslt filter header 2020/02/21 17:37:38 [debug] 6335#6335: *1 HTTP/1.1 502 Bad Gateway Server: nginx/1.10.3 (Ubuntu) Date: Sat, 22 Feb 2020 01:37:38 GMT Content-Type: text/html Content-Length: 584 Connection: keep-alive WWW-Authenticate: Basic realm="Restricted" 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:1 f:0 0000555BA9D34878, pos 0000555BA9D34878, size: 210 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter: l:0 f:0 s:210 2020/02/21 17:37:38 [debug] 6335#6335: *1 http output filter "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http copy filter: "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 image filter 2020/02/21 17:37:38 [debug] 6335#6335: *1 xslt filter body 2020/02/21 17:37:38 [debug] 6335#6335: *1 http postpone filter "/login?" 0000555BA9D34AD8 2020/02/21 17:37:38 [debug] 6335#6335: *1 write old buf t:1 f:0 0000555BA9D34878, pos 0000555BA9D34878, size: 210 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:0 f:0 0000000000000000, pos 0000555BA8386AC0, size: 120 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:0 f:0 0000000000000000, pos 0000555BA8387E40, size: 62 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 write new buf t:0 f:0 0000000000000000, pos 0000555BA8387C60, size: 402 file: 0, size: 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter: l:1 f:0 s:794 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter limit 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 writev: 794 of 794 2020/02/21 17:37:38 [debug] 6335#6335: *1 http write filter 0000000000000000 2020/02/21 17:37:38 [debug] 6335#6335: *1 http copy filter: 0 "/login?" 2020/02/21 17:37:38 [debug] 6335#6335: *1 http finalize request: 0, "/login?" a:1, c:1 2020/02/21 17:37:38 [debug] 6335#6335: *1 set http keepalive handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 http close request 2020/02/21 17:37:38 [debug] 6335#6335: *1 http log handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 run cleanup: 0000555BA9D32360 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D333A0 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D3E820, unused: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D31380, unused: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D32390, unused: 8 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D343B0, unused: 1899 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D2CDC0 2020/02/21 17:37:38 [debug] 6335#6335: *1 hc free: 0000000000000000 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 hc busy: 0000000000000000 0 2020/02/21 17:37:38 [debug] 6335#6335: *1 reusable connection: 1 2020/02/21 17:37:38 [debug] 6335#6335: *1 event timer add: 15: 65000:1582335523233 2020/02/21 17:37:38 [debug] 6335#6335: *1 post event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 delete posted event 0000555BA9D6D200 2020/02/21 17:37:38 [debug] 6335#6335: *1 http keepalive handler 2020/02/21 17:37:38 [debug] 6335#6335: *1 malloc: 0000555BA9D2CDC0:1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv: fd:15 -1 of 1024 2020/02/21 17:37:38 [debug] 6335#6335: *1 recv() not ready (11: Resource temporarily unavailable) 2020/02/21 17:37:38 [debug] 6335#6335: *1 free: 0000555BA9D2CDC0