For https://stackoverflow.com/questions/75264362/nginx-ingress-controller-returns-fake-certificate-for-one-ingress-but-the-right

bad.log

--- LOGS ---
2023/01/29 16:50:02 [debug] 586#586: *83205 http cleanup add: 00007F4FA30E6040
2023/01/29 16:50:02 [debug] 586#586: *83205 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 585#585: *83206 http cleanup add: 00007F4FABA13670
2023/01/29 16:50:02 [debug] 585#585: *83206 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 586#586: *83205 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83206 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83205 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83206 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83205 lua deleting light thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 585#585: *83206 lua deleting light thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 586#586: *83205 lua caching unused lua thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 585#585: *83206 lua caching unused lua thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 586#586: *83205 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 585#585: *83206 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 586#586: *83205 http lua fake request count:1
2023/01/29 16:50:02 [debug] 585#585: *83206 http lua fake request count:1
2023/01/29 16:50:02 [debug] 586#586: *83205 http lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83206 http lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83205 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83206 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83205 http lua finalize threads
2023/01/29 16:50:02 [debug] 585#585: *83206 http lua finalize threads
2023/01/29 16:50:02 [debug] 586#586: *83205 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 585#585: *83206 http lua close fake http connection 00007F4FA47E3E18
2023/01/29 16:50:02 [debug] 585#585: *83207 http cleanup add: 00007F4FABA13790
2023/01/29 16:50:02 [debug] 585#585: *83207 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 585#585: *83207 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83207 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83207 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 585#585: *83207 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 585#585: *83207 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 585#585: *83207 http lua fake request count:1
2023/01/29 16:50:02 [debug] 585#585: *83207 http lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83207 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83207 http lua finalize threads
2023/01/29 16:50:02 [debug] 585#585: *83207 http lua close fake http connection 00007F4FA47E3E18
2023/01/29 16:50:02 [debug] 585#585: *83208 http cleanup add: 00007F4FABA13940
2023/01/29 16:50:02 [debug] 585#585: *83208 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 585#585: *83208 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83208 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83208 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 585#585: *83208 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 585#585: *83208 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 585#585: *83208 http lua fake request count:1
2023/01/29 16:50:02 [debug] 585#585: *83208 http lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83208 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83208 http lua finalize threads
2023/01/29 16:50:02 [debug] 585#585: *83208 http lua close fake http connection 00007F4FA47E3E18
2023/01/29 16:50:02 [debug] 584#584: *83209 http cleanup add: 00007F4FABA13670
2023/01/29 16:50:02 [debug] 584#584: *83209 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 584#584: *83209 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83209 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83209 lua deleting light thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 584#584: *83209 lua caching unused lua thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 584#584: *83209 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 584#584: *83209 http lua fake request count:1
2023/01/29 16:50:02 [debug] 584#584: *83209 http lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83209 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83209 http lua finalize threads
2023/01/29 16:50:02 [debug] 584#584: *83209 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 584#584: *83210 http cleanup add: 00007F4FABA13790
2023/01/29 16:50:02 [debug] 584#584: *83210 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 584#584: *83210 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83210 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83210 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 584#584: *83210 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 584#584: *83210 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 584#584: *83210 http lua fake request count:1
2023/01/29 16:50:02 [debug] 584#584: *83210 http lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83210 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83210 http lua finalize threads
2023/01/29 16:50:02 [debug] 584#584: *83210 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 584#584: *83211 http cleanup add: 00007F4FABA13940
2023/01/29 16:50:02 [debug] 584#584: *83211 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 584#584: *83211 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83211 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83211 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 584#584: *83211 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 584#584: *83211 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 584#584: *83211 http lua fake request count:1
2023/01/29 16:50:02 [debug] 584#584: *83211 http lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83211 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83211 http lua finalize threads
2023/01/29 16:50:02 [debug] 584#584: *83211 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 584#584: *83212 stream cleanup add: 00007F4FABA13AE0
2023/01/29 16:50:02 [debug] 584#584: *83212 lua run thread, top:0
2023/01/29 16:50:02 [debug] 584#584: *83212 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83212 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83212 lua deleting light thread
2023/01/29 16:50:02 [debug] 584#584: *83212 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 584#584: *83212 stream lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83212 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83212 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 586#586: *83213 http cleanup add: 00007F4FA30E61F0
2023/01/29 16:50:02 [debug] 586#586: *83213 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 586#586: *83213 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83213 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83213 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 586#586: *83213 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 586#586: *83213 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 586#586: *83213 http lua fake request count:1
2023/01/29 16:50:02 [debug] 586#586: *83213 http lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83213 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83213 http lua finalize threads
2023/01/29 16:50:02 [debug] 586#586: *83213 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 586#586: *83214 http cleanup add: 00007F4FA30E6310
2023/01/29 16:50:02 [debug] 586#586: *83214 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 586#586: *83214 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83214 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83214 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 586#586: *83214 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 586#586: *83214 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 586#586: *83214 http lua fake request count:1
2023/01/29 16:50:02 [debug] 586#586: *83214 http lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83214 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83214 http lua finalize threads
2023/01/29 16:50:02 [debug] 586#586: *83214 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 586#586: *83215 stream cleanup add: 00007F4FA30E64B0
2023/01/29 16:50:02 [debug] 586#586: *83215 lua run thread, top:0
2023/01/29 16:50:02 [debug] 586#586: *83215 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83215 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83215 lua deleting light thread
2023/01/29 16:50:02 [debug] 586#586: *83215 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 586#586: *83215 stream lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83215 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83215 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 587#587: *83216 http cleanup add: 00007F4FABA13670
2023/01/29 16:50:02 [debug] 587#587: *83216 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83216 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83216 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83216 lua deleting light thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 587#587: *83216 lua caching unused lua thread 00007F4FA6544A88 (ref 1)
2023/01/29 16:50:02 [debug] 587#587: *83216 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83216 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83216 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83216 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83216 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83216 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 587#587: *83217 http cleanup add: 00007F4FABA13790
2023/01/29 16:50:02 [debug] 587#587: *83217 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83217 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83217 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83217 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 587#587: *83217 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:50:02 [debug] 587#587: *83217 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83217 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83217 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83217 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83217 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83217 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 587#587: *83218 http cleanup add: 00007F4FABA13940
2023/01/29 16:50:02 [debug] 587#587: *83218 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83218 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83218 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83218 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 587#587: *83218 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:50:02 [debug] 587#587: *83218 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83218 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83218 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83218 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83218 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83218 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 587#587: *83219 stream cleanup add: 00007F4FABA13AE0
2023/01/29 16:50:02 [debug] 587#587: *83219 lua run thread, top:0
2023/01/29 16:50:02 [debug] 587#587: *83219 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83219 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83219 lua deleting light thread
2023/01/29 16:50:02 [debug] 587#587: *83219 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 587#587: *83219 stream lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83219 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83219 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:50:02 [debug] 585#585: *83220 stream cleanup add: 00007F4FABA13AE0
2023/01/29 16:50:02 [debug] 585#585: *83220 lua run thread, top:0
2023/01/29 16:50:02 [debug] 585#585: *83220 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83220 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83220 lua deleting light thread
2023/01/29 16:50:02 [debug] 585#585: *83220 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 585#585: *83220 stream lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83220 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83220 stream lua close fake stream connection 00007F4FA47E3E18
2023/01/29 16:50:02 [debug] 585#585: accept on 0.0.0.0:443, ready: 1
2023/01/29 16:50:02 [debug] 585#585: posix_memalign: 00007F4FAB919420:512 @16
2023/01/29 16:50:02 [debug] 585#585: *83221 accept: 10.16.240.150:37738 fd:4
2023/01/29 16:50:02 [debug] 585#585: *83221 event timer add: 4: 60000:8762022670
2023/01/29 16:50:02 [debug] 585#585: *83221 reusable connection: 1
2023/01/29 16:50:02 [debug] 585#585: *83221 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:50:02 [debug] 585#585: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:50:02 [debug] 585#585: *83221 http check ssl handshake
2023/01/29 16:50:02 [debug] 585#585: *83221 http recv(): 0
2023/01/29 16:50:02 [info] 585#585: *83221 client closed connection while SSL handshaking, client: 10.16.240.150, server: 0.0.0.0:443
2023/01/29 16:50:02 [debug] 585#585: *83221 close http connection: 4
2023/01/29 16:50:02 [debug] 585#585: *83221 event timer del: 4: 8762022670
2023/01/29 16:50:02 [debug] 585#585: *83221 reusable connection: 0
2023/01/29 16:50:02 [debug] 585#585: *83221 free: 00007F4FAB919420, unused: 232
2023/01/29 16:50:02 [debug] 585#585: accept on 0.0.0.0:443, ready: 1
2023/01/29 16:50:02 [debug] 585#585: posix_memalign: 00007F82691501E0:512 @16
2023/01/29 16:50:02 [debug] 585#585: *83520 accept: 10.16.240.153:49784 fd:4
2023/01/29 16:50:02 [debug] 585#585: *83520 event timer add: 4: 60000:8762022054
2023/01/29 16:50:02 [debug] 585#585: *83520 reusable connection: 1
2023/01/29 16:50:02 [debug] 585#585: *83520 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:50:02 [debug] 585#585: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:50:02 [debug] 585#585: *83520 http check ssl handshake
2023/01/29 16:50:02 [debug] 585#585: *83520 http recv(): 0
2023/01/29 16:50:02 [info] 585#585: *83520 client closed connection while SSL handshaking, client: 10.16.240.153, server: 0.0.0.0:443
2023/01/29 16:50:02 [debug] 585#585: *83520 close http connection: 4
2023/01/29 16:50:02 [debug] 585#585: *83520 event timer del: 4: 8762022054
2023/01/29 16:50:02 [debug] 585#585: *83520 reusable connection: 0
2023/01/29 16:50:02 [debug] 585#585: *83520 free: 00007F82691501E0, unused: 232
2023/01/29 16:50:02 [debug] 584#584: *83521 http cleanup add: 00007F826924A670
2023/01/29 16:50:02 [debug] 584#584: *83521 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 584#584: *83521 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83521 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83521 lua deleting light thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 584#584: *83521 lua caching unused lua thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 584#584: *83521 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 584#584: *83521 http lua fake request count:1
2023/01/29 16:50:02 [debug] 584#584: *83521 http lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83521 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83521 http lua finalize threads
2023/01/29 16:50:02 [debug] 584#584: *83521 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 584#584: *83522 http cleanup add: 00007F826924A790
2023/01/29 16:50:02 [debug] 584#584: *83522 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 584#584: *83522 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83522 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83522 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 584#584: *83522 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 584#584: *83522 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 584#584: *83522 http lua fake request count:1
2023/01/29 16:50:02 [debug] 584#584: *83522 http lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83522 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83522 http lua finalize threads
2023/01/29 16:50:02 [debug] 584#584: *83522 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 584#584: *83523 http cleanup add: 00007F826924A940
2023/01/29 16:50:02 [debug] 584#584: *83523 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 584#584: *83523 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83523 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83523 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 584#584: *83523 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 584#584: *83523 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 584#584: *83523 http lua fake request count:1
2023/01/29 16:50:02 [debug] 584#584: *83523 http lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83523 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83523 http lua finalize threads
2023/01/29 16:50:02 [debug] 584#584: *83523 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 585#585: *83524 http cleanup add: 00007F826924A670
2023/01/29 16:50:02 [debug] 585#585: *83524 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 585#585: *83524 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83524 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83524 lua deleting light thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 585#585: *83524 lua caching unused lua thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 585#585: *83524 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 585#585: *83524 http lua fake request count:1
2023/01/29 16:50:02 [debug] 585#585: *83524 http lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83524 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83524 http lua finalize threads
2023/01/29 16:50:02 [debug] 585#585: *83524 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 585#585: *83525 http cleanup add: 00007F826924A790
2023/01/29 16:50:02 [debug] 585#585: *83525 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 585#585: *83525 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83525 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83525 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 585#585: *83525 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 585#585: *83525 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 585#585: *83525 http lua fake request count:1
2023/01/29 16:50:02 [debug] 585#585: *83525 http lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83525 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83525 http lua finalize threads
2023/01/29 16:50:02 [debug] 585#585: *83525 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 585#585: *83526 http cleanup add: 00007F826924A940
2023/01/29 16:50:02 [debug] 585#585: *83526 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 585#585: *83526 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83526 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83526 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 585#585: *83526 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 585#585: *83526 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 585#585: *83526 http lua fake request count:1
2023/01/29 16:50:02 [debug] 585#585: *83526 http lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83526 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83526 http lua finalize threads
2023/01/29 16:50:02 [debug] 585#585: *83526 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 587#587: accept on 0.0.0.0:443, ready: 1
2023/01/29 16:50:02 [debug] 587#587: posix_memalign: 00007F826914EDB0:512 @16
2023/01/29 16:50:02 [debug] 587#587: *83527 accept: 10.16.240.153:49788 fd:4
2023/01/29 16:50:02 [debug] 587#587: *83527 event timer add: 4: 60000:8762022186
2023/01/29 16:50:02 [debug] 587#587: *83527 reusable connection: 1
2023/01/29 16:50:02 [debug] 587#587: *83527 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:50:02 [debug] 587#587: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:50:02 [debug] 587#587: *83527 http check ssl handshake
2023/01/29 16:50:02 [debug] 587#587: *83527 http recv(): 1
2023/01/29 16:50:02 [debug] 587#587: *83527 https ssl handshake: 0x16
2023/01/29 16:50:02 [debug] 587#587: *83527 tcp_nodelay
2023/01/29 16:50:02 [debug] 587#587: *83527 reusable connection: 0
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL server name: "bad.xyz.com"
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL ALPN supported by client: h2
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL ALPN supported by client: http/1.1
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL ALPN selected: h2
2023/01/29 16:50:02 [debug] 587#587: *83527 ssl cert: connection reusable: 0
2023/01/29 16:50:02 [debug] 587#587: *83528 code cache lookup (key='ssl_certificate_by_lua_nhli_eb62659df6af69ef3ea4b2f4d168e185', ref=-1)
2023/01/29 16:50:02 [debug] 587#587: *83528 code cache miss (key='ssl_certificate_by_lua_nhli_eb62659df6af69ef3ea4b2f4d168e185', ref=-1)
2023/01/29 16:50:02 [debug] 587#587: *83528 lua creating new thread
2023/01/29 16:50:02 [debug] 587#587: *83528 lua reusing cached lua thread 00007F8268FC0638 (ref 4)
2023/01/29 16:50:02 [debug] 587#587: *83528 http cleanup add: 00007F826924A670
2023/01/29 16:50:02 [debug] 587#587: *83528 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83528 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83528 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83528 lua deleting light thread 00007F8268FC0638 (ref 4)
2023/01/29 16:50:02 [debug] 587#587: *83528 lua caching unused lua thread 00007F8268FC0638 (ref 4)
2023/01/29 16:50:02 [debug] 587#587: *83528 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83528 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83528 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83528 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83528 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83528 http lua close fake http connection 00007F826201AE18
2023/01/29 16:50:02 [debug] 587#587: *83527 lua_certificate_by_lua: handler return value: 0, cert cb exit code: 1
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL_do_handshake: -1
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL_get_error: 2
2023/01/29 16:50:02 [debug] 586#586: *83529 http cleanup add: 00007F826924A670
2023/01/29 16:50:02 [debug] 586#586: *83529 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 586#586: *83529 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83529 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83529 lua deleting light thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 586#586: *83529 lua caching unused lua thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 586#586: *83529 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 586#586: *83529 http lua fake request count:1
2023/01/29 16:50:02 [debug] 586#586: *83529 http lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83529 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83529 http lua finalize threads
2023/01/29 16:50:02 [debug] 586#586: *83529 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 586#586: *83530 http cleanup add: 00007F826924A790
2023/01/29 16:50:02 [debug] 586#586: *83530 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 586#586: *83530 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83530 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83530 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 586#586: *83530 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 586#586: *83530 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 586#586: *83530 http lua fake request count:1
2023/01/29 16:50:02 [debug] 586#586: *83530 http lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83530 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83530 http lua finalize threads
2023/01/29 16:50:02 [debug] 586#586: *83530 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 586#586: *83531 http cleanup add: 00007F826924A940
2023/01/29 16:50:02 [debug] 586#586: *83531 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 586#586: *83531 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83531 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83531 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 586#586: *83531 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 586#586: *83531 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 586#586: *83531 http lua fake request count:1
2023/01/29 16:50:02 [debug] 586#586: *83531 http lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83531 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83531 http lua finalize threads
2023/01/29 16:50:02 [debug] 586#586: *83531 http lua close fake http connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 586#586: *83532 stream cleanup add: 00007F826924AAE0
2023/01/29 16:50:02 [debug] 586#586: *83532 lua run thread, top:0
2023/01/29 16:50:02 [debug] 586#586: *83532 lua resume returned 0
2023/01/29 16:50:02 [debug] 586#586: *83532 lua light thread ended normally
2023/01/29 16:50:02 [debug] 586#586: *83532 lua deleting light thread
2023/01/29 16:50:02 [debug] 586#586: *83532 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 586#586: *83532 stream lua close fake request
2023/01/29 16:50:02 [debug] 586#586: *83532 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 586#586: *83532 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 587#587: *83533 http cleanup add: 00007F82691F2310
2023/01/29 16:50:02 [debug] 587#587: *83533 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83533 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83533 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83533 lua deleting light thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 587#587: *83533 lua caching unused lua thread 00007F8268FC0050 (ref 1)
2023/01/29 16:50:02 [debug] 587#587: *83533 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83533 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83533 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83533 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83533 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83533 http lua close fake http connection 00007F826201AE18
2023/01/29 16:50:02 [debug] 587#587: *83534 http cleanup add: 00007F82691F2430
2023/01/29 16:50:02 [debug] 587#587: *83534 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83534 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83534 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83534 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 587#587: *83534 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:50:02 [debug] 587#587: *83534 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83534 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83534 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83534 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83534 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83534 http lua close fake http connection 00007F826201AE18
2023/01/29 16:50:02 [debug] 587#587: *83535 http cleanup add: 00007F826900DB80
2023/01/29 16:50:02 [debug] 587#587: *83535 lua run thread, top:0 c:1
2023/01/29 16:50:02 [debug] 587#587: *83535 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83535 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83535 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 587#587: *83535 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:50:02 [debug] 587#587: *83535 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:50:02 [debug] 587#587: *83535 http lua fake request count:1
2023/01/29 16:50:02 [debug] 587#587: *83535 http lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83535 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83535 http lua finalize threads
2023/01/29 16:50:02 [debug] 587#587: *83535 http lua close fake http connection 00007F826201AE18
2023/01/29 16:50:02 [debug] 587#587: *83536 stream cleanup add: 00007F826900DD20
2023/01/29 16:50:02 [debug] 587#587: *83536 lua run thread, top:0
2023/01/29 16:50:02 [debug] 587#587: *83536 lua resume returned 0
2023/01/29 16:50:02 [debug] 587#587: *83536 lua light thread ended normally
2023/01/29 16:50:02 [debug] 587#587: *83536 lua deleting light thread
2023/01/29 16:50:02 [debug] 587#587: *83536 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 587#587: *83536 stream lua close fake request
2023/01/29 16:50:02 [debug] 587#587: *83536 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 587#587: *83536 stream lua close fake stream connection 00007F826201AE18
2023/01/29 16:50:02 [debug] 584#584: *83537 stream cleanup add: 00007F826924AAE0
2023/01/29 16:50:02 [debug] 584#584: *83537 lua run thread, top:0
2023/01/29 16:50:02 [debug] 584#584: *83537 lua resume returned 0
2023/01/29 16:50:02 [debug] 584#584: *83537 lua light thread ended normally
2023/01/29 16:50:02 [debug] 584#584: *83537 lua deleting light thread
2023/01/29 16:50:02 [debug] 584#584: *83537 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 584#584: *83537 stream lua close fake request
2023/01/29 16:50:02 [debug] 584#584: *83537 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 584#584: *83537 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL handshake handler: 0
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL_do_handshake: -1
2023/01/29 16:50:02 [debug] 585#585: *83538 stream cleanup add: 00007F826924AAE0
2023/01/29 16:50:02 [debug] 585#585: *83538 lua run thread, top:0
2023/01/29 16:50:02 [debug] 585#585: *83538 lua resume returned 0
2023/01/29 16:50:02 [debug] 585#585: *83538 lua light thread ended normally
2023/01/29 16:50:02 [debug] 585#585: *83538 lua deleting light thread
2023/01/29 16:50:02 [debug] 585#585: *83538 stream lua finalize fake request: 0
2023/01/29 16:50:02 [debug] 585#585: *83538 stream lua close fake request
2023/01/29 16:50:02 [debug] 585#585: *83538 lua request cleanup: forcible=0
2023/01/29 16:50:02 [debug] 585#585: *83538 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:50:02 [debug] 587#587: *83527 SSL_get_error: 1
2023/01/29 16:50:02 [info] 587#587: *83527 SSL_do_handshake() failed (SSL: error:14094418:SSL routines:ssl3_read_bytes:tlsv1 alert unknown ca:SSL alert number 48) while SSL handshaking, client: 10.16.240.153, server: 0.0.0.0:443
2023/01/29 16:50:02 [debug] 587#587: *83527 close http connection: 4
2023/01/29 16:50:02 [debug] 587#587: *83527 event timer del: 4: 8762022186
2023/01/29 16:50:02 [debug] 587#587: *83527 reusable connection: 0
2023/01/29 16:50:02 [debug] 587#587: *83527 free: 00007F826914EDB0, unused: 32

good.log

Hey Hello!

ASPNET: 6.0.9
BUILD_NUMBER: 1.0.0.34
--- LOGS ---
2023/01/29 16:49:53 [debug] 584#584: *83040 http cleanup add: 00007F4FAB9DFF70
2023/01/29 16:49:53 [debug] 584#584: *83040 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 584#584: *83040 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83040 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83040 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 584#584: *83040 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 584#584: *83040 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 584#584: *83040 http lua fake request count:1
2023/01/29 16:49:53 [debug] 584#584: *83040 http lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83040 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83040 http lua finalize threads
2023/01/29 16:49:53 [debug] 584#584: *83040 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 584#584: *83041 http cleanup add: 00007F4FABA135E0
2023/01/29 16:49:53 [debug] 584#584: *83041 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 584#584: *83041 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83041 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83041 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 584#584: *83041 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 584#584: *83041 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 584#584: *83041 http lua fake request count:1
2023/01/29 16:49:53 [debug] 584#584: *83041 http lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83041 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83041 http lua finalize threads
2023/01/29 16:49:53 [debug] 584#584: *83041 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 584#584: *83042 http cleanup add: 00007F4FABA13700
2023/01/29 16:49:53 [debug] 584#584: *83042 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 584#584: *83042 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83042 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83042 lua deleting light thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 584#584: *83042 lua caching unused lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 584#584: *83042 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 584#584: *83042 http lua fake request count:1
2023/01/29 16:49:53 [debug] 584#584: *83042 http lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83042 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83042 http lua finalize threads
2023/01/29 16:49:53 [debug] 584#584: *83042 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 586#586: *83043 http cleanup add: 00007F4FAB9DFF70
2023/01/29 16:49:53 [debug] 586#586: *83043 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83043 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83043 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83043 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 586#586: *83043 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 586#586: *83043 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83043 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83043 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83043 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83043 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83043 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 585#585: *83044 http cleanup add: 00007F4FAB9DFF70
2023/01/29 16:49:53 [debug] 585#585: *83044 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 585#585: *83044 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83044 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83044 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 585#585: *83044 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 585#585: *83044 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 585#585: *83044 http lua fake request count:1
2023/01/29 16:49:53 [debug] 585#585: *83044 http lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83044 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83044 http lua finalize threads
2023/01/29 16:49:53 [debug] 585#585: *83044 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 585#585: *83045 http cleanup add: 00007F4FABA135E0
2023/01/29 16:49:53 [debug] 585#585: *83045 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 585#585: *83045 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83045 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83045 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 585#585: *83045 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 585#585: *83045 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 585#585: *83045 http lua fake request count:1
2023/01/29 16:49:53 [debug] 585#585: *83045 http lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83045 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83045 http lua finalize threads
2023/01/29 16:49:53 [debug] 585#585: *83045 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 585#585: *83046 http cleanup add: 00007F4FABA13700
2023/01/29 16:49:53 [debug] 585#585: *83046 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 585#585: *83046 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83046 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83046 lua deleting light thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 585#585: *83046 lua caching unused lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 585#585: *83046 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 585#585: *83046 http lua fake request count:1
2023/01/29 16:49:53 [debug] 585#585: *83046 http lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83046 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83046 http lua finalize threads
2023/01/29 16:49:53 [debug] 585#585: *83046 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 586#586: *83047 http cleanup add: 00007F4FABA135E0
2023/01/29 16:49:53 [debug] 586#586: *83047 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83047 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83047 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83047 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 586#586: *83047 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 586#586: *83047 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83047 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83047 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83047 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83047 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83047 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 586#586: *83048 http cleanup add: 00007F4FABA13700
2023/01/29 16:49:53 [debug] 586#586: *83048 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83048 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83048 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83048 lua deleting light thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83048 lua caching unused lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83048 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83048 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83048 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83048 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83048 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83048 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 584#584: *83049 stream cleanup add: 00007F4FABA13930
2023/01/29 16:49:53 [debug] 584#584: *83049 lua run thread, top:0
2023/01/29 16:49:53 [debug] 584#584: *83049 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83049 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83049 lua deleting light thread
2023/01/29 16:49:53 [debug] 584#584: *83049 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 584#584: *83049 stream lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83049 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83049 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 586#586: *83050 stream cleanup add: 00007F4FABA13930
2023/01/29 16:49:53 [debug] 586#586: *83050 lua run thread, top:0
2023/01/29 16:49:53 [debug] 586#586: *83050 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83050 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83050 lua deleting light thread
2023/01/29 16:49:53 [debug] 586#586: *83050 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 586#586: *83050 stream lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83050 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83050 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 585#585: *83051 stream cleanup add: 00007F4FABA13930
2023/01/29 16:49:53 [debug] 585#585: *83051 lua run thread, top:0
2023/01/29 16:49:53 [debug] 585#585: *83051 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83051 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83051 lua deleting light thread
2023/01/29 16:49:53 [debug] 585#585: *83051 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 585#585: *83051 stream lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83051 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83051 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 587#587: *83052 http cleanup add: 00007F4FAB9DFF70
2023/01/29 16:49:53 [debug] 587#587: *83052 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 587#587: *83052 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83052 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83052 lua deleting light thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 587#587: *83052 lua caching unused lua thread 00007F4FA6544C80 (ref 2)
2023/01/29 16:49:53 [debug] 587#587: *83052 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 587#587: *83052 http lua fake request count:1
2023/01/29 16:49:53 [debug] 587#587: *83052 http lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83052 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83052 http lua finalize threads
2023/01/29 16:49:53 [debug] 587#587: *83052 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 587#587: *83053 http cleanup add: 00007F4FABA135E0
2023/01/29 16:49:53 [debug] 587#587: *83053 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 587#587: *83053 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83053 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83053 lua deleting light thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 587#587: *83053 lua caching unused lua thread 00007F4FA6544E78 (ref 3)
2023/01/29 16:49:53 [debug] 587#587: *83053 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 587#587: *83053 http lua fake request count:1
2023/01/29 16:49:53 [debug] 587#587: *83053 http lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83053 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83053 http lua finalize threads
2023/01/29 16:49:53 [debug] 587#587: *83053 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 587#587: *83054 http cleanup add: 00007F4FABA13700
2023/01/29 16:49:53 [debug] 587#587: *83054 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 587#587: *83054 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83054 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83054 lua deleting light thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 587#587: *83054 lua caching unused lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 587#587: *83054 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 587#587: *83054 http lua fake request count:1
2023/01/29 16:49:53 [debug] 587#587: *83054 http lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83054 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83054 http lua finalize threads
2023/01/29 16:49:53 [debug] 587#587: *83054 http lua close fake http connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 587#587: *83055 stream cleanup add: 00007F4FABA13930
2023/01/29 16:49:53 [debug] 587#587: *83055 lua run thread, top:0
2023/01/29 16:49:53 [debug] 587#587: *83055 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83055 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83055 lua deleting light thread
2023/01/29 16:49:53 [debug] 587#587: *83055 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 587#587: *83055 stream lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83055 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83055 stream lua close fake stream connection 00007F4FA47E3D30
2023/01/29 16:49:53 [debug] 586#586: accept on 0.0.0.0:443, ready: 1
2023/01/29 16:49:53 [debug] 586#586: posix_memalign: 00007F4FAB918460:512 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 accept: 10.16.240.150:47088 fd:4
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer add: 4: 60000:8762013233
2023/01/29 16:49:53 [debug] 586#586: *83056 reusable connection: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:49:53 [debug] 586#586: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:49:53 [debug] 586#586: *83056 http check ssl handshake
2023/01/29 16:49:53 [debug] 586#586: *83056 http recv(): 1
2023/01/29 16:49:53 [debug] 586#586: *83056 https ssl handshake: 0x16
2023/01/29 16:49:53 [debug] 586#586: *83056 tcp_nodelay
2023/01/29 16:49:53 [debug] 586#586: *83056 reusable connection: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL server name: "good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL ALPN supported by client: h2
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL ALPN supported by client: http/1.1
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL ALPN selected: h2
2023/01/29 16:49:53 [debug] 586#586: *83056 ssl cert: connection reusable: 0
2023/01/29 16:49:53 [debug] 586#586: *83057 code cache lookup (key='ssl_certificate_by_lua_nhli_eb62659df6af69ef3ea4b2f4d168e185', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83057 code cache miss (key='ssl_certificate_by_lua_nhli_eb62659df6af69ef3ea4b2f4d168e185', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83057 lua creating new thread
2023/01/29 16:49:53 [debug] 586#586: *83057 lua reusing cached lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83057 http cleanup add: 00007F4FABA13A60
2023/01/29 16:49:53 [debug] 586#586: *83057 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83057 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83057 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83057 lua deleting light thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83057 lua caching unused lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83057 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83057 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83057 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83057 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83057 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83057 http lua close fake http connection 00007F4FA47E3E18
2023/01/29 16:49:53 [debug] 586#586: *83056 lua_certificate_by_lua: handler return value: 0, cert cb exit code: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_do_handshake: -1
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_get_error: 2
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL handshake handler: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 ssl new session: 8EC4C5EB:32:190
2023/01/29 16:49:53 [debug] 586#586: *83056 ssl new session: 1C407342:32:191
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_do_handshake: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL: TLSv1.3, cipher: "TLS_AES_256_GCM_SHA384 TLSv1.3 Kx=any Au=any Enc=AESGCM(256) Mac=AEAD"
2023/01/29 16:49:53 [debug] 586#586: *83056 init http2 connection
2023/01/29 16:49:53 [debug] 586#586: *83056 malloc: 00007F4FAB905E00:456
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB8F70B0:4096 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB919D20:512 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 add cleanup: 00007F4FAB919D40
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 send SETTINGS frame
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 send WINDOW_UPDATE frame sid:0, window:2147418112
2023/01/29 16:49:53 [debug] 586#586: *83056 reusable connection: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 read handler
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: 24
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: 27
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: 13
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: 77
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: -1
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_get_error: 2
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 preface verified
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame type:4 f:0 l:18 sid:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 SETTINGS frame
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 setting 3:100
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 setting 4:33554432
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 setting 2:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame complete pos:00007F4FA3F23743 end:00007F4FA3F2379D
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame type:8 f:0 l:4 sid:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 WINDOW_UPDATE frame sid:0 window:33488897
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame complete pos:00007F4FA3F23750 end:00007F4FA3F2379D
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame type:1 f:5 l:68 sid:1
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 HEADERS frame sid:1 depends on 0 excl:0 weight:16
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FA30E9440:1024 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB8F82F0:4096 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB8F9500:4096 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer del: 4: 8762013233
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 get indexed header: 2
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header: ":method: GET"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 get indexed name: 4
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 encoded string, len:21
2023/01/29 16:49:53 [debug] 586#586: *83056 http uri: "/dev/master/helloworldservice"
2023/01/29 16:49:53 [debug] 586#586: *83056 http args: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http exten: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header: ":path: /dev/master/helloworldservice"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 get indexed header: 7
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header: ":scheme: https"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 get indexed name: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 encoded string, len:26
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 table add: ":authority: good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 malloc: 00007F4FAB919F60:512
2023/01/29 16:49:53 [debug] 586#586: *83056 malloc: 00007F4FAB9EB4D0:4096
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 table account: 78 free:4096
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header: ":authority: good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 get indexed name: 58
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 encoded string, len:8
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 table add: "user-agent: curl/7.75.0"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 table account: 53 free:4018
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header: "user-agent: curl/7.75.0"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 get indexed name: 19
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 raw string, len:3
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 table add: "accept: */*"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 table account: 41 free:3965
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB91A1A0:512 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header: "accept: */*"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 request line: "GET /dev/master/helloworldservice HTTP/2.0"
2023/01/29 16:49:53 [debug] 586#586: *83056 generic phase: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 rewrite phase: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "-"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $proxy_upstream_name
2023/01/29 16:49:53 [debug] 586#586: *83056 test location: ~ "^/dev/master/helloworldservice(/|$)(.*)"
2023/01/29 16:49:53 [debug] 586#586: *83056 using configuration "^/dev/master/helloworldservice(/|$)(.*)"
2023/01/29 16:49:53 [debug] 586#586: *83056 http cl:-1 max:1048576
2023/01/29 16:49:53 [debug] 586#586: *83056 rewrite phase: 3
2023/01/29 16:49:53 [debug] 586#586: *83056 lua rewrite handler, uri:"/dev/master/helloworldservice" c:1
2023/01/29 16:49:53 [debug] 586#586: *83056 rewrite phase: 3
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "dev-dfpayroll"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $namespace
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "helloworldservice-master-ingress"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $ingress_name
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "helloworldservice-master"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $service_name
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "80"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $service_port
2023/01/29 16:49:53 [debug] 586#586: *83056 http script complex value
2023/01/29 16:49:53 [debug] 586#586: *83056 http geo started: 10.16.240.150
2023/01/29 16:49:53 [debug] 586#586: *83056 http geo: $
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "/dev/master/helloworldservice(/|"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "$"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: ")(.*)"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $location_path
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "n"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $global_rate_limit_exceeding
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "-1"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $balancer_ewma_score
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: "dev-dfpayroll-helloworldservice-master-80"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $proxy_upstream_name
2023/01/29 16:49:53 [debug] 586#586: *83056 http script complex value
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "dev-dfpayroll-helloworldservice-master-80"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $proxy_host
2023/01/29 16:49:53 [debug] 586#586: *83056 http script complex value
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "https"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $pass_access_scheme
2023/01/29 16:49:53 [debug] 586#586: *83056 http script complex value
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "443"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $pass_server_port
2023/01/29 16:49:53 [debug] 586#586: *83056 http script complex value
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $best_http_host
2023/01/29 16:49:53 [debug] 586#586: *83056 http script complex value
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "443"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $pass_port
2023/01/29 16:49:53 [debug] 586#586: *83056 http script value: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http script set $proxy_alternative_upstream_name
2023/01/29 16:49:53 [debug] 586#586: *83056 http script regex: "(?i)/dev/master/helloworldservice(/|$)(.*)"
2023/01/29 16:49:53 [notice] 586#586: *83056 "(?i)/dev/master/helloworldservice(/|$)(.*)" matches "/dev/master/helloworldservice", client: 10.16.240.150, server: good.xyz.com, request: "GET /dev/master/helloworldservice HTTP/2.0", host: "good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script capture: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http script regex end
2023/01/29 16:49:53 [notice] 586#586: *83056 rewritten data: "/", args: "", client: 10.16.240.150, server: good.xyz.com, request: "GET /dev/master/helloworldservice HTTP/2.0", host: "good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 rewrite phase: 4
2023/01/29 16:49:53 [debug] 586#586: *83056 lua rewrite handler, uri:"/" c:1
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache lookup (key='rewrite_by_lua_nhli_0b5957293aadfec043f3de317a2f03cb', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache miss (key='rewrite_by_lua_nhli_0b5957293aadfec043f3de317a2f03cb', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 lua creating new thread
2023/01/29 16:49:53 [debug] 586#586: *83056 lua reusing cached lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83056 lua reset ctx
2023/01/29 16:49:53 [debug] 586#586: *83056 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83056 http cleanup add: 00007F4FAB8FA148
2023/01/29 16:49:53 [debug] 586#586: *83056 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83056 add cleanup: 00007F4FAB8FA1A0
2023/01/29 16:49:53 [debug] 586#586: *83056 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83056 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83056 lua deleting light thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83056 lua caching unused lua thread 00007F4FAB711C58 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83056 post rewrite phase: 5
2023/01/29 16:49:53 [debug] 586#586: *83056 generic phase: 6
2023/01/29 16:49:53 [debug] 586#586: *83056 generic phase: 7
2023/01/29 16:49:53 [debug] 586#586: *83056 generic phase: 8
2023/01/29 16:49:53 [debug] 586#586: *83056 access phase: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 access: 96F0100A 00000000 00000000
2023/01/29 16:49:53 [debug] 586#586: *83056 access phase: 10
2023/01/29 16:49:53 [debug] 586#586: *83056 access phase: 11
2023/01/29 16:49:53 [debug] 586#586: *83056 post access phase: 12
2023/01/29 16:49:53 [debug] 586#586: *83056 generic phase: 13
2023/01/29 16:49:53 [debug] 586#586: *83056 generic phase: 14
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB9EC790:4096 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 http init upstream, client timer: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 post event 00007F4FAB8F7400
2023/01/29 16:49:53 [debug] 586#586: *83056 http map started
2023/01/29 16:49:53 [debug] 586#586: *83056 http map: "" ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http map started
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "414baa4f00228bd55532a0d6456d66cf"
2023/01/29 16:49:53 [debug] 586#586: *83056 http map: "" "414baa4f00228bd55532a0d6456d66cf"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "Host"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Request-ID"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "414baa4f00228bd55532a0d6456d66cf"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Real-IP"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "10.16.240.150"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Forwarded-For"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "10.16.240.150"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Forwarded-Host"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "good.xyz.com"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Forwarded-Port"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "443"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Forwarded-Proto"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "https"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Forwarded-Scheme"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "https"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: "X-Scheme"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "https"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http script copy: ""
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header: "user-agent: curl/7.75.0"
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header: "accept: */*"
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header:
"GET / HTTP/1.1
Host: good.xyz.com
X-Request-ID: 414baa4f00228bd55532a0d6456d66cf
X-Real-IP: 10.16.240.150
X-Forwarded-For: 10.16.240.150
X-Forwarded-Host: good.xyz.com
X-Forwarded-Port: 443
X-Forwarded-Proto: https
X-Forwarded-Scheme: https
X-Scheme: https
user-agent: curl/7.75.0
accept: */*

"
2023/01/29 16:49:53 [debug] 586#586: *83056 http cleanup add: 00007F4FAB9ECDA8
2023/01/29 16:49:53 [debug] 586#586: *83056 init keepalive peer
2023/01/29 16:49:53 [debug] 586#586: *83056 get keepalive peer
2023/01/29 16:49:53 [debug] 586#586: *83056 lua balancer peer, tries: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 lua reset ctx
2023/01/29 16:49:53 [debug] 586#586: *83056 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache lookup (key='balancer_by_lua_nhli_0f29762dfd828b8baa4d895affbc4b90', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache miss (key='balancer_by_lua_nhli_0f29762dfd828b8baa4d895affbc4b90', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 stream socket 10
2023/01/29 16:49:53 [debug] 586#586: *83056 epoll add connection: fd:10 ev:80002005
2023/01/29 16:49:53 [debug] 586#586: *83056 connect to 10.16.240.38:80, fd:10 #83058
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream connect: -2
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FA30E60A0:128 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer add: 10: 5000:8761958325
2023/01/29 16:49:53 [debug] 586#586: *83056 http finalize request: -4, "/?" a:1, c:2
2023/01/29 16:49:53 [debug] 586#586: *83056 http request count:2 blk:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame complete pos:00007F4FA3F2379D end:00007F4FA3F2379D
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame out: 00007F4FAB8F7268 sid:0 bl:0 len:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame out: 00007F4FAB8F71B8 sid:0 bl:0 len:4
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame out: 00007F4FAB8F7100 sid:0 bl:0 len:18
2023/01/29 16:49:53 [debug] 586#586: *83056 malloc: 00007F4FAB9ED9D0:4096
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 27
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 13
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL to write: 49
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_write: 49
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame sent: 00007F4FAB8F7100 sid:0 bl:0 len:18
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame sent: 00007F4FAB8F71B8 sid:0 bl:0 len:4
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame sent: 00007F4FAB8F7268 sid:0 bl:0 len:0
2023/01/29 16:49:53 [debug] 586#586: *83056 delete posted event 00007F4FAB8F7400
2023/01/29 16:49:53 [debug] 586#586: *83056 http run request: "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream check client, write event:0, "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream request: "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream send request handler
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream send request
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream send request body
2023/01/29 16:49:53 [debug] 586#586: *83056 chain writer buf fl:1 s:355
2023/01/29 16:49:53 [debug] 586#586: *83056 chain writer in: 00007F4FAB9ECEB8
2023/01/29 16:49:53 [debug] 586#586: *83056 writev: 355 of 355
2023/01/29 16:49:53 [debug] 586#586: *83056 chain writer out: 0000000000000000
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer del: 10: 8761958325
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer add: 10: 60000:8762013329
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream request: "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream process header
2023/01/29 16:49:53 [debug] 586#586: *83056 malloc: 00007F4FAD4680E0:4096
2023/01/29 16:49:53 [debug] 586#586: *83056 recv: eof:0, avail:-1
2023/01/29 16:49:53 [debug] 586#586: *83056 recv: fd:10 160 of 4096
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy status 200 "200 OK"
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header: "date: Sun, 29 Jan 2023 16:49:52 GMT"
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header: "server: Kestrel"
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header: "transfer-encoding: chunked"
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy header done
2023/01/29 16:49:53 [debug] 586#586: *83056 lua header filter for user lua code, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache lookup (key='header_filter_by_lua_nhli_803cd74e9d568018c83d620326995b86', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache miss (key='header_filter_by_lua_nhli_803cd74e9d568018c83d620326995b86', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 lua capture header filter, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 headers more header filter, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 header filter
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 output header: ":status: 200"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 output header: "date: Sun, 29 Jan 2023 16:49:53 GMT"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 output header: "strict-transport-security: max-age=15724800; includeSubDomains"
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 create HEADERS frame 00007F4FAB9ED218: len:72 fin:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http cleanup add: 00007F4FAB9ED310
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame out: 00007F4FAB9ED218 sid:1 bl:1 len:72
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 72
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 HEADERS frame 00007F4FAB9ED218 was sent
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame sent: 00007F4FAB9ED218 sid:1 bl:1 len:72
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy filter init s:200 h:0 c:1 l:-1
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 33 s:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 30 s:1
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0D s:1
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0A s:3
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 48 s:4
2023/01/29 16:49:53 [debug] 586#586: *83056 http proxy out buf 00007F4FAD468149 48
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0D s:5
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0A s:6
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 30 s:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0D s:1
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0A s:8
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0D s:9
2023/01/29 16:49:53 [debug] 586#586: *83056 http chunked byte: 0A s:10
2023/01/29 16:49:53 [debug] 586#586: *83056 http upstream process non buffered downstream
2023/01/29 16:49:53 [debug] 586#586: *83056 http output filter "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 http copy filter: "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 lua body filter for user lua code, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache lookup (key='body_filter_by_lua_nhli_3a2f242b62105b30603c936f5cdae3b5', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache miss (key='body_filter_by_lua_nhli_3a2f242b62105b30603c936f5cdae3b5', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 lua capture body filter, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 http postpone filter "/?" 00007F4FAB9ED328
2023/01/29 16:49:53 [debug] 586#586: *83056 write new buf t:0 f:0 0000000000000000, pos 00007F4FAD468149, size: 48 file: 0, size: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 http write filter: l:0 f:1 s:48
2023/01/29 16:49:53 [debug] 586#586: *83056 http write filter limit 0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 windows: conn:33554432 stream:33554432
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 create DATA frame 00007F4FAB9ED218: len:48 flags:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame out: 00007F4FAB9ED218 sid:1 bl:0 len:48
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 48
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL to write: 138
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_write: 138
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 DATA frame 00007F4FAB9ED218 was sent
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame sent: 00007F4FAB9ED218 sid:1 bl:0 len:48
2023/01/29 16:49:53 [debug] 586#586: *83056 http write filter 0000000000000000
2023/01/29 16:49:53 [debug] 586#586: *83056 http copy filter: 0 "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 finalize http upstream request: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 finalize http proxy request
2023/01/29 16:49:53 [debug] 586#586: *83056 free keepalive peer
2023/01/29 16:49:53 [debug] 586#586: *83056 free keepalive peer: saving connection 00007F4FA47E3E18
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer: 10, old: 8762013329, new: 8762013333
2023/01/29 16:49:53 [debug] 586#586: *83056 lua balancer free peer, tries: 2
2023/01/29 16:49:53 [debug] 586#586: *83056 http output filter "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 http copy filter: "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 lua body filter for user lua code, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache lookup (key='body_filter_by_lua_nhli_3a2f242b62105b30603c936f5cdae3b5', ref=5)
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache hit (key='body_filter_by_lua_nhli_3a2f242b62105b30603c936f5cdae3b5', ref=5)
2023/01/29 16:49:53 [debug] 586#586: *83056 lua capture body filter, uri "/"
2023/01/29 16:49:53 [debug] 586#586: *83056 http postpone filter "/?" 00007FFF37719E60
2023/01/29 16:49:53 [debug] 586#586: *83056 write new buf t:0 f:0 0000000000000000, pos 0000000000000000, size: 0 file: 0, size: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 http write filter: l:1 f:0 s:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http write filter limit 0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 create DATA frame 00007F4FAB9ED218: len:0 flags:1
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame out: 00007F4FAB9ED218 sid:1 bl:0 len:0
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL buf copy: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL to write: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_write: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 http2:1 DATA frame 00007F4FAB9ED218 was sent
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame sent: 00007F4FAB9ED218 sid:1 bl:0 len:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http write filter 0000000000000000
2023/01/29 16:49:53 [debug] 586#586: *83056 http copy filter: 0 "/?"
2023/01/29 16:49:53 [debug] 586#586: *83056 http finalize request: 0, "/?" a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83056 http request count:1 blk:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 close stream 1, queued 0, processing 1, pushing 0
2023/01/29 16:49:53 [debug] 586#586: *83056 http close request
2023/01/29 16:49:53 [debug] 586#586: *83056 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83056 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83056 lua log handler, uri:"/" c:0
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache lookup (key='log_by_lua_nhli_27c6f2c663f6b902e19ecbccfb407670', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 code cache miss (key='log_by_lua_nhli_27c6f2c663f6b902e19ecbccfb407670', ref=-1)
2023/01/29 16:49:53 [debug] 586#586: *83056 http log handler
2023/01/29 16:49:53 [debug] 586#586: *83056 http map started
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "/dev/master/helloworldservice"
2023/01/29 16:49:53 [debug] 586#586: *83056 http map: "/dev/master/helloworldservice" "1"
2023/01/29 16:49:53 [debug] 586#586: *83056 http script var: "1"
2023/01/29 16:49:53 [debug] 586#586: *83056 run cleanup: 00007F4FAB8FA1A0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAD4680E0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB8F82F0, unused: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB8F9500, unused: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB9EC790, unused: 82
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FA30E9440, unused: 851
2023/01/29 16:49:53 [debug] 586#586: *83056 post event 00007F4FA46625D0
2023/01/29 16:49:53 [debug] 586#586: *83056 delete posted event 00007F4FA46625D0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 handle connection handler
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer add: 4: 75000:8762028333
2023/01/29 16:49:53 [debug] 586#586: *83056 reusable connection: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB8F70B0, unused: 2952
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB9ED9D0
10.16.240.150 - - [29/Jan/2023:16:49:53 +0000] "GET /dev/master/helloworldservice HTTP/2.0" 200 48 "-" "curl/7.75.0" 68 0.009 [dev-dfpayroll-helloworldservice-master-80] [] 10.16.240.38:80 59 0.008 200 414baa4f00228bd55532a0d6456d66cf
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 idle handler
2023/01/29 16:49:53 [debug] 586#586: *83056 reusable connection: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 posix_memalign: 00007F4FAB9EC7A0:4096 @16
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 read handler
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: 9
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_read: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_get_error: 6
2023/01/29 16:49:53 [debug] 586#586: *83056 peer shutdown SSL cleanly
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame type:4 f:1 l:0 sid:0
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 SETTINGS frame
2023/01/29 16:49:53 [debug] 586#586: *83056 http2 frame complete pos:00007F4FA3F23719 end:00007F4FA3F23719
2023/01/29 16:49:53 [debug] 586#586: *83056 close http connection: 4
2023/01/29 16:49:53 [debug] 586#586: *83056 SSL_shutdown: 1
2023/01/29 16:49:53 [debug] 586#586: *83056 event timer del: 4: 8762028333
2023/01/29 16:49:53 [debug] 586#586: *83056 reusable connection: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 run cleanup: 00007F4FAB919D40
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB9EC7A0, unused: 4016
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 0000000000000000
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB9EB4D0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB919F60
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB905E00
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB918460, unused: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB919D20, unused: 0
2023/01/29 16:49:53 [debug] 586#586: *83056 free: 00007F4FAB91A1A0, unused: 336
2023/01/29 16:49:53 [debug] 584#584: *83353 http cleanup add: 00007F8269216F70
2023/01/29 16:49:53 [debug] 584#584: *83353 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 584#584: *83353 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83353 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83353 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 584#584: *83353 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 584#584: *83353 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 584#584: *83353 http lua fake request count:1
2023/01/29 16:49:53 [debug] 584#584: *83353 http lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83353 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83353 http lua finalize threads
2023/01/29 16:49:53 [debug] 584#584: *83353 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 584#584: *83354 http cleanup add: 00007F826924A5E0
2023/01/29 16:49:53 [debug] 584#584: *83354 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 584#584: *83354 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83354 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83354 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 584#584: *83354 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 584#584: *83354 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 584#584: *83354 http lua fake request count:1
2023/01/29 16:49:53 [debug] 584#584: *83354 http lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83354 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83354 http lua finalize threads
2023/01/29 16:49:53 [debug] 584#584: *83354 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 584#584: *83355 http cleanup add: 00007F826924A700
2023/01/29 16:49:53 [debug] 584#584: *83355 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 584#584: *83355 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83355 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83355 lua deleting light thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 584#584: *83355 lua caching unused lua thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 584#584: *83355 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 584#584: *83355 http lua fake request count:1
2023/01/29 16:49:53 [debug] 584#584: *83355 http lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83355 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83355 http lua finalize threads
2023/01/29 16:49:53 [debug] 584#584: *83355 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 587#587: accept on 0.0.0.0:443, ready: 1
2023/01/29 16:49:53 [debug] 587#587: posix_memalign: 00007F826914EB70:512 @16
2023/01/29 16:49:53 [debug] 587#587: *83356 accept: 10.16.240.153:52352 fd:4
2023/01/29 16:49:53 [debug] 587#587: *83356 event timer add: 4: 60000:8762013169
2023/01/29 16:49:53 [debug] 587#587: *83356 reusable connection: 1
2023/01/29 16:49:53 [debug] 587#587: *83356 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:49:53 [debug] 587#587: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:49:53 [debug] 587#587: *83356 http check ssl handshake
2023/01/29 16:49:53 [debug] 587#587: *83356 http recv(): 0
2023/01/29 16:49:53 [info] 587#587: *83356 client closed connection while SSL handshaking, client: 10.16.240.153, server: 0.0.0.0:443
2023/01/29 16:49:53 [debug] 587#587: *83356 close http connection: 4
2023/01/29 16:49:53 [debug] 587#587: *83356 event timer del: 4: 8762013169
2023/01/29 16:49:53 [debug] 587#587: *83356 reusable connection: 0
2023/01/29 16:49:53 [debug] 587#587: *83356 free: 00007F826914EB70, unused: 232
2023/01/29 16:49:53 [debug] 585#585: *83357 http cleanup add: 00007F8269216F70
2023/01/29 16:49:53 [debug] 585#585: *83357 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 585#585: *83357 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83357 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83357 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 585#585: *83357 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 585#585: *83357 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 585#585: *83357 http lua fake request count:1
2023/01/29 16:49:53 [debug] 585#585: *83357 http lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83357 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83357 http lua finalize threads
2023/01/29 16:49:53 [debug] 585#585: *83357 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 585#585: *83358 http cleanup add: 00007F826924A5E0
2023/01/29 16:49:53 [debug] 585#585: *83358 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 585#585: *83358 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83358 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83358 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 585#585: *83358 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 585#585: *83358 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 585#585: *83358 http lua fake request count:1
2023/01/29 16:49:53 [debug] 585#585: *83358 http lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83358 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83358 http lua finalize threads
2023/01/29 16:49:53 [debug] 585#585: *83358 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 585#585: *83359 http cleanup add: 00007F826924A700
2023/01/29 16:49:53 [debug] 585#585: *83359 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 585#585: *83359 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83359 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83359 lua deleting light thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 585#585: *83359 lua caching unused lua thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 585#585: *83359 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 585#585: *83359 http lua fake request count:1
2023/01/29 16:49:53 [debug] 585#585: *83359 http lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83359 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83359 http lua finalize threads
2023/01/29 16:49:53 [debug] 585#585: *83359 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 586#586: *83360 http cleanup add: 00007F8269216F70
2023/01/29 16:49:53 [debug] 586#586: *83360 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83360 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83360 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83360 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 586#586: *83360 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 586#586: *83360 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83360 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83360 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83360 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83360 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83360 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 586#586: *83361 http cleanup add: 00007F826924A5E0
2023/01/29 16:49:53 [debug] 586#586: *83361 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83361 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83361 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83361 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 586#586: *83361 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 586#586: *83361 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83361 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83361 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83361 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83361 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83361 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 586#586: *83362 http cleanup add: 00007F826924A700
2023/01/29 16:49:53 [debug] 586#586: *83362 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 586#586: *83362 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83362 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83362 lua deleting light thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83362 lua caching unused lua thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 586#586: *83362 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 586#586: *83362 http lua fake request count:1
2023/01/29 16:49:53 [debug] 586#586: *83362 http lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83362 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83362 http lua finalize threads
2023/01/29 16:49:53 [debug] 586#586: *83362 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 586#586: *83363 stream cleanup add: 00007F826924A930
2023/01/29 16:49:53 [debug] 586#586: *83363 lua run thread, top:0
2023/01/29 16:49:53 [debug] 586#586: *83363 lua resume returned 0
2023/01/29 16:49:53 [debug] 586#586: *83363 lua light thread ended normally
2023/01/29 16:49:53 [debug] 586#586: *83363 lua deleting light thread
2023/01/29 16:49:53 [debug] 586#586: *83363 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 586#586: *83363 stream lua close fake request
2023/01/29 16:49:53 [debug] 586#586: *83363 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 586#586: *83363 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 584#584: *83364 stream cleanup add: 00007F826924A930
2023/01/29 16:49:53 [debug] 584#584: *83364 lua run thread, top:0
2023/01/29 16:49:53 [debug] 584#584: *83364 lua resume returned 0
2023/01/29 16:49:53 [debug] 584#584: *83364 lua light thread ended normally
2023/01/29 16:49:53 [debug] 584#584: *83364 lua deleting light thread
2023/01/29 16:49:53 [debug] 584#584: *83364 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 584#584: *83364 stream lua close fake request
2023/01/29 16:49:53 [debug] 584#584: *83364 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 584#584: *83364 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 587#587: *83365 http cleanup add: 00007F8269216F70
2023/01/29 16:49:53 [debug] 587#587: *83365 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 587#587: *83365 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83365 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83365 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 587#587: *83365 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:53 [debug] 587#587: *83365 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 587#587: *83365 http lua fake request count:1
2023/01/29 16:49:53 [debug] 587#587: *83365 http lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83365 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83365 http lua finalize threads
2023/01/29 16:49:53 [debug] 587#587: *83365 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 587#587: *83366 http cleanup add: 00007F826924A5E0
2023/01/29 16:49:53 [debug] 587#587: *83366 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 587#587: *83366 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83366 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83366 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 587#587: *83366 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:53 [debug] 587#587: *83366 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 587#587: *83366 http lua fake request count:1
2023/01/29 16:49:53 [debug] 587#587: *83366 http lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83366 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83366 http lua finalize threads
2023/01/29 16:49:53 [debug] 587#587: *83366 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 587#587: *83367 http cleanup add: 00007F826924A700
2023/01/29 16:49:53 [debug] 587#587: *83367 lua run thread, top:0 c:1
2023/01/29 16:49:53 [debug] 587#587: *83367 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83367 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83367 lua deleting light thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 587#587: *83367 lua caching unused lua thread 00007F8268FC0638 (ref 4)
2023/01/29 16:49:53 [debug] 587#587: *83367 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:53 [debug] 587#587: *83367 http lua fake request count:1
2023/01/29 16:49:53 [debug] 587#587: *83367 http lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83367 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83367 http lua finalize threads
2023/01/29 16:49:53 [debug] 587#587: *83367 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 587#587: *83368 stream cleanup add: 00007F826924A930
2023/01/29 16:49:53 [debug] 587#587: *83368 lua run thread, top:0
2023/01/29 16:49:53 [debug] 587#587: *83368 lua resume returned 0
2023/01/29 16:49:53 [debug] 587#587: *83368 lua light thread ended normally
2023/01/29 16:49:53 [debug] 587#587: *83368 lua deleting light thread
2023/01/29 16:49:53 [debug] 587#587: *83368 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 587#587: *83368 stream lua close fake request
2023/01/29 16:49:53 [debug] 587#587: *83368 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 587#587: *83368 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 585#585: *83369 stream cleanup add: 00007F826924A930
2023/01/29 16:49:53 [debug] 585#585: *83369 lua run thread, top:0
2023/01/29 16:49:53 [debug] 585#585: *83369 lua resume returned 0
2023/01/29 16:49:53 [debug] 585#585: *83369 lua light thread ended normally
2023/01/29 16:49:53 [debug] 585#585: *83369 lua deleting light thread
2023/01/29 16:49:53 [debug] 585#585: *83369 stream lua finalize fake request: 0
2023/01/29 16:49:53 [debug] 585#585: *83369 stream lua close fake request
2023/01/29 16:49:53 [debug] 585#585: *83369 lua request cleanup: forcible=0
2023/01/29 16:49:53 [debug] 585#585: *83369 stream lua close fake stream connection 00007F826201AD30
2023/01/29 16:49:53 [debug] 585#585: accept on 0.0.0.0:80, ready: 1
2023/01/29 16:49:53 [debug] 585#585: posix_memalign: 00007F826914EDB0:512 @16
2023/01/29 16:49:53 [debug] 585#585: *83370 accept: 10.16.240.153:48408 fd:4
2023/01/29 16:49:53 [debug] 585#585: *83370 event timer add: 4: 60000:8762013625
2023/01/29 16:49:53 [debug] 585#585: *83370 reusable connection: 1
2023/01/29 16:49:53 [debug] 585#585: *83370 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:49:53 [debug] 585#585: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:49:53 [debug] 585#585: *83370 http wait request handler
2023/01/29 16:49:53 [debug] 585#585: *83370 malloc: 00007F826920DB00:1024
2023/01/29 16:49:53 [debug] 585#585: *83370 recv: eof:1, avail:-1
2023/01/29 16:49:53 [debug] 585#585: *83370 recv: fd:4 0 of 1024
2023/01/29 16:49:53 [info] 585#585: *83370 client closed connection while waiting for request, client: 10.16.240.153, server: 0.0.0.0:80
2023/01/29 16:49:53 [debug] 585#585: *83370 close http connection: 4
2023/01/29 16:49:53 [debug] 585#585: *83370 event timer del: 4: 8762013625
2023/01/29 16:49:53 [debug] 585#585: *83370 reusable connection: 0
2023/01/29 16:49:53 [debug] 585#585: *83370 free: 00007F826920DB00
2023/01/29 16:49:53 [debug] 585#585: *83370 free: 00007F826914EDB0, unused: 136
2023/01/29 16:49:53 [debug] 585#585: accept on 0.0.0.0:443, ready: 1
2023/01/29 16:49:53 [debug] 585#585: posix_memalign: 00007F826914EFD0:512 @16
2023/01/29 16:49:53 [debug] 585#585: *83371 accept: 10.16.240.153:52370 fd:4
2023/01/29 16:49:53 [debug] 585#585: *83371 event timer add: 4: 60000:8762013637
2023/01/29 16:49:53 [debug] 585#585: *83371 reusable connection: 1
2023/01/29 16:49:53 [debug] 585#585: *83371 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:49:53 [debug] 585#585: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:49:53 [debug] 585#585: *83371 http check ssl handshake
2023/01/29 16:49:53 [debug] 585#585: *83371 http recv(): 0
2023/01/29 16:49:53 [info] 585#585: *83371 client closed connection while SSL handshaking, client: 10.16.240.153, server: 0.0.0.0:443
2023/01/29 16:49:53 [debug] 585#585: *83371 close http connection: 4
2023/01/29 16:49:53 [debug] 585#585: *83371 event timer del: 4: 8762013637
2023/01/29 16:49:53 [debug] 585#585: *83371 reusable connection: 0
2023/01/29 16:49:53 [debug] 585#585: *83371 free: 00007F826914EFD0, unused: 232
2023/01/29 16:49:53 [debug] 584#584: accept on 0.0.0.0:80, ready: 1
2023/01/29 16:49:53 [debug] 584#584: posix_memalign: 00007F826914F6A0:512 @16
2023/01/29 16:49:53 [debug] 584#584: *83372 accept: 10.16.240.153:48414 fd:4
2023/01/29 16:49:53 [debug] 584#584: *83372 event timer add: 4: 60000:8762013749
2023/01/29 16:49:53 [debug] 584#584: *83372 reusable connection: 1
2023/01/29 16:49:53 [debug] 584#584: *83372 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:49:53 [debug] 584#584: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:49:53 [debug] 584#584: *83372 http wait request handler
2023/01/29 16:49:53 [debug] 584#584: *83372 malloc: 00007F826920DF10:1024
2023/01/29 16:49:53 [debug] 584#584: *83372 recv: eof:1, avail:-1
2023/01/29 16:49:53 [debug] 584#584: *83372 recv: fd:4 0 of 1024
2023/01/29 16:49:53 [info] 584#584: *83372 client closed connection while waiting for request, client: 10.16.240.153, server: 0.0.0.0:80
2023/01/29 16:49:53 [debug] 584#584: *83372 close http connection: 4
2023/01/29 16:49:53 [debug] 584#584: *83372 event timer del: 4: 8762013749
2023/01/29 16:49:53 [debug] 584#584: *83372 reusable connection: 0
2023/01/29 16:49:53 [debug] 584#584: *83372 free: 00007F826920DF10
2023/01/29 16:49:53 [debug] 584#584: *83372 free: 00007F826914F6A0, unused: 136
2023/01/29 16:49:54 [debug] 586#586: accept on 0.0.0.0:80, ready: 1
2023/01/29 16:49:54 [debug] 586#586: posix_memalign: 00007F826914E940:512 @16
2023/01/29 16:49:54 [debug] 586#586: *83373 accept: 10.16.240.153:48416 fd:4
2023/01/29 16:49:54 [debug] 586#586: *83373 event timer add: 4: 60000:8762014093
2023/01/29 16:49:54 [debug] 586#586: *83373 reusable connection: 1
2023/01/29 16:49:54 [debug] 586#586: *83373 epoll add event: fd:4 op:1 ev:80002001
2023/01/29 16:49:54 [debug] 586#586: accept() not ready (11: Resource temporarily unavailable)
2023/01/29 16:49:54 [debug] 586#586: *83373 http wait request handler
2023/01/29 16:49:54 [debug] 586#586: *83373 malloc: 00007F826920D660:1024
2023/01/29 16:49:54 [debug] 586#586: *83373 recv: eof:1, avail:-1
2023/01/29 16:49:54 [debug] 586#586: *83373 recv: fd:4 0 of 1024
2023/01/29 16:49:54 [info] 586#586: *83373 client closed connection while waiting for request, client: 10.16.240.153, server: 0.0.0.0:80
2023/01/29 16:49:54 [debug] 586#586: *83373 close http connection: 4
2023/01/29 16:49:54 [debug] 586#586: *83373 event timer del: 4: 8762014093
2023/01/29 16:49:54 [debug] 586#586: *83373 reusable connection: 0
2023/01/29 16:49:54 [debug] 586#586: *83373 free: 00007F826920D660
2023/01/29 16:49:54 [debug] 586#586: *83373 free: 00007F826914E940, unused: 136
2023/01/29 16:49:54 [debug] 584#584: *83374 http cleanup add: 00007F826924AA60
2023/01/29 16:49:54 [debug] 584#584: *83374 lua run thread, top:0 c:1
2023/01/29 16:49:54 [debug] 584#584: *83374 lua resume returned 0
2023/01/29 16:49:54 [debug] 584#584: *83374 lua light thread ended normally
2023/01/29 16:49:54 [debug] 584#584: *83374 lua deleting light thread 00007F8268FC0050 (ref 1)
2023/01/29 16:49:54 [debug] 584#584: *83374 lua caching unused lua thread 00007F8268FC0050 (ref 1)
2023/01/29 16:49:54 [debug] 584#584: *83374 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:54 [debug] 584#584: *83374 http lua fake request count:1
2023/01/29 16:49:54 [debug] 584#584: *83374 http lua close fake request
2023/01/29 16:49:54 [debug] 584#584: *83374 lua request cleanup: forcible=0
2023/01/29 16:49:54 [debug] 584#584: *83374 http lua finalize threads
2023/01/29 16:49:54 [debug] 584#584: *83374 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:54 [debug] 584#584: *83375 http cleanup add: 00007F826924AB80
2023/01/29 16:49:54 [debug] 584#584: *83375 lua run thread, top:0 c:1
2023/01/29 16:49:54 [debug] 584#584: *83375 lua resume returned 0
2023/01/29 16:49:54 [debug] 584#584: *83375 lua light thread ended normally
2023/01/29 16:49:54 [debug] 584#584: *83375 lua deleting light thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:54 [debug] 584#584: *83375 lua caching unused lua thread 00007F8268FC0248 (ref 2)
2023/01/29 16:49:54 [debug] 584#584: *83375 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:54 [debug] 584#584: *83375 http lua fake request count:1
2023/01/29 16:49:54 [debug] 584#584: *83375 http lua close fake request
2023/01/29 16:49:54 [debug] 584#584: *83375 lua request cleanup: forcible=0
2023/01/29 16:49:54 [debug] 584#584: *83375 http lua finalize threads
2023/01/29 16:49:54 [debug] 584#584: *83375 http lua close fake http connection 00007F826201AD30
2023/01/29 16:49:54 [debug] 584#584: *83376 http cleanup add: 00007F826924ACA0
2023/01/29 16:49:54 [debug] 584#584: *83376 lua run thread, top:0 c:1
2023/01/29 16:49:54 [debug] 584#584: *83376 lua resume returned 0
2023/01/29 16:49:54 [debug] 584#584: *83376 lua light thread ended normally
2023/01/29 16:49:54 [debug] 584#584: *83376 lua deleting light thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:54 [debug] 584#584: *83376 lua caching unused lua thread 00007F8268FC0440 (ref 3)
2023/01/29 16:49:54 [debug] 584#584: *83376 http lua finalize fake request: 0, a:1, c:1
2023/01/29 16:49:54 [debug] 584#584: *83376 http lua fake request count:1
2023/01/29 16:49:54 [debug] 584#584: *83376 http lua close fake request
2023/01/29 16:49:54 [debug] 584#584: *83376 lua request cleanup: forcible=0
2023/01/29 16:49:54 [debug] 584#584: *83376 http lua finalize threads
2023/01/29 16:49:54 [debug] 584#584: *83376 http lua close fake http connection 00007F826201AD30