2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_do_handshake: -1
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_get_error: 2
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL handshake handler: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_do_handshake: 1
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL: TLSv1.3, cipher: "TLS_AES_256_GCM_SHA384 TLSv1.3 Kx=any Au=any Enc=AESGCM(256) Mac=AEAD"
2022/02/26 13:48:12 [debug] 136459#136459: *145 reusable connection: 1
2022/02/26 13:48:12 [debug] 136459#136459: *145 http wait request handler
2022/02/26 13:48:12 [debug] 136459#136459: *145 malloc: 0000AAAADE93BF90:1024
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_read: -1
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_get_error: 2
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE93BF90
2022/02/26 13:48:12 [debug] 136459#136459: *145 http wait request handler
2022/02/26 13:48:12 [debug] 136459#136459: *145 malloc: 0000AAAADE93BF90:1024
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_read: 332
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_read: -1
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_get_error: 2
2022/02/26 13:48:12 [debug] 136459#136459: *145 reusable connection: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 posix_memalign: 0000AAAADE989430:4096 @16
2022/02/26 13:48:12 [debug] 136459#136459: *145 http process request line
2022/02/26 13:48:12 [debug] 136459#136459: *145 http request line: "GET / HTTP/1.0"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http uri: "/"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http args: ""
2022/02/26 13:48:12 [debug] 136459#136459: *145 http exten: ""
2022/02/26 13:48:12 [debug] 136459#136459: *145 posix_memalign: 0000AAAADE98A440:4096 @16
2022/02/26 13:48:12 [debug] 136459#136459: *145 http process request header line
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header: "User-Agent: Mozilla/5.0 (Windows NT 6.1; rv:45.0) Gecko/20100101 Firefox/45.0."
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header: "Accept: text/html, text/*;q=0.5, image/*, application/*, audio/*, message/*, video/*"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header: "Accept-Encoding: gzip, compress, bzip, bzip2, deflate"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header: "Accept-Language: en;q=1.0"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header: "Host: share.libre-depanne.fr"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header: "Authorization: Basic dGVzdDp0ZXN0"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http header done
2022/02/26 13:48:12 [debug] 136459#136459: *145 event timer del: 65: 23152254321
2022/02/26 13:48:12 [debug] 136459#136459: *145 generic phase: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 rewrite phase: 1
2022/02/26 13:48:12 [debug] 136459#136459: *145 test location: "/"
2022/02/26 13:48:12 [debug] 136459#136459: *145 using configuration "/"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http cl:-1 max:18253611008
2022/02/26 13:48:12 [debug] 136459#136459: *145 rewrite phase: 3
2022/02/26 13:48:12 [debug] 136459#136459: *145 post rewrite phase: 4
2022/02/26 13:48:12 [debug] 136459#136459: *145 generic phase: 5
2022/02/26 13:48:12 [debug] 136459#136459: *145 generic phase: 6
2022/02/26 13:48:12 [debug] 136459#136459: *145 generic phase: 7
2022/02/26 13:48:12 [debug] 136459#136459: *145 access phase: 8
2022/02/26 13:48:12 [debug] 136459#136459: *145 access phase: 9
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: Username is "test"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: Authentication loop (phase=0, iteration=0)
2022/02/26 13:48:12 [debug] 136459#136459: *145 event timer add: 65: 10000:23152204353
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: request_timeout=10000
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: Authentication loop (phase=1, iteration=0)
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: Wants a free connection to "ldaplocal"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: Search filter is "(&(objectClass=*)((&(uid=${admin})(objectClass=people))=test))"
2022/02/26 13:48:12 [error] 136459#136459: *145 http_auth_ldap: ldap_search_ext() failed (-7, Bad search filter), client: 192.168.1.1, server: share.libre-depanne.fr, request: "GET / HTTP/1.0", host: "share.libre-depanne.fr"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http_auth_ldap: Authentication loop (phase=6, iteration=0)
2022/02/26 13:48:12 [debug] 136459#136459: *145 event timer del: 65: 23152204353
2022/02/26 13:48:12 [debug] 136459#136459: *145 http finalize request: 401, "/?" a:1, c:1
2022/02/26 13:48:12 [debug] 136459#136459: *145 http special response: 401, "/?"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http set discard body
2022/02/26 13:48:12 [debug] 136459#136459: *145 xslt filter header
2022/02/26 13:48:12 [debug] 136459#136459: *145 HTTP/1.1 401 Unauthorized
Server: nginx/1.18.0
Date: Sat, 26 Feb 2022 12:48:12 GMT
Content-Type: text/html
Content-Length: 179
Connection: close
WWW-Authenticate: Basic realm="Forbidden"

2022/02/26 13:48:12 [debug] 136459#136459: *145 write new buf t:1 f:0 0000AAAADE98A8B0, pos 0000AAAADE98A8B0, size: 196 file: 0, size: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 http write filter: l:0 f:0 s:196
2022/02/26 13:48:12 [debug] 136459#136459: *145 http output filter "/?"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http copy filter: "/?"
2022/02/26 13:48:12 [debug] 136459#136459: *145 image filter
2022/02/26 13:48:12 [debug] 136459#136459: *145 xslt filter body
2022/02/26 13:48:12 [debug] 136459#136459: *145 http postpone filter "/?" 0000AAAADE98AAC0
2022/02/26 13:48:12 [debug] 136459#136459: *145 write old buf t:1 f:0 0000AAAADE98A8B0, pos 0000AAAADE98A8B0, size: 196 file: 0, size: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 write new buf t:0 f:0 0000000000000000, pos 0000AAAAC77E66B8, size: 126 file: 0, size: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 write new buf t:0 f:0 0000000000000000, pos 0000AAAAC77E5698, size: 53 file: 0, size: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 http write filter: l:1 f:0 s:375
2022/02/26 13:48:12 [debug] 136459#136459: *145 http write filter limit 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 posix_memalign: 0000AAAADE98C330:512 @16
2022/02/26 13:48:12 [debug] 136459#136459: *145 malloc: 0000AAAADE981BE0:16384
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL buf copy: 196
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL buf copy: 126
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL buf copy: 53
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL to write: 375
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_write: 375
2022/02/26 13:48:12 [debug] 136459#136459: *145 http write filter 0000000000000000
2022/02/26 13:48:12 [debug] 136459#136459: *145 http copy filter: 0 "/?"
2022/02/26 13:48:12 [debug] 136459#136459: *145 http finalize request: 0, "/?" a:1, c:1
2022/02/26 13:48:12 [debug] 136459#136459: *145 http request count:1 blk:0
2022/02/26 13:48:12 [debug] 136459#136459: *145 http close request
2022/02/26 13:48:12 [debug] 136459#136459: *145 http log handler
192.168.1.1 - test [26/Feb/2022:13:48:12 +0100] "GET / HTTP/1.0" 401 179 "-" "Mozilla/5.0 (Windows NT 6.1; rv:45.0) Gecko/20100101 Firefox/45.0."
2022/02/26 13:48:12 [debug] 136459#136459: *145 geoip2 http log handler
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE989430, unused: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE98A440, unused: 2178
2022/02/26 13:48:12 [debug] 136459#136459: *145 close http connection: 65
2022/02/26 13:48:12 [debug] 136459#136459: *145 SSL_shutdown: 1
2022/02/26 13:48:12 [debug] 136459#136459: *145 reusable connection: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE981BE0
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE93BF90
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE977D40, unused: 0
2022/02/26 13:48:12 [debug] 136459#136459: *145 free: 0000AAAADE98C330, unused: 384