## Starting login (GLPI)## 2023.12.15 19:22:01 LOG7[main]: Found 1 ready file descriptor(s) 2023.12.15 19:22:01 LOG7[main]: FD=4 events=0x2001 revents=0x0 2023.12.15 19:22:01 LOG7[main]: FD=9 events=0x2001 revents=0x1 2023.12.15 19:22:01 LOG7[main]: Service [ldap] accepted (FD=3) from 127.0.0.1:46486 2023.12.15 19:22:01 LOG7[3]: Service [ldap] started 2023.12.15 19:22:01 LOG7[3]: Setting local socket options (FD=3) 2023.12.15 19:22:01 LOG7[3]: Option TCP_NODELAY set on local socket 2023.12.15 19:22:01 LOG5[3]: Service [ldap] accepted connection from 127.0.0.1:46486 2023.12.15 19:22:01 LOG6[3]: failover: priority, starting at entry #0 2023.12.15 19:22:01 LOG6[3]: s_connect: connecting 2001:4860:4802:32::3a:636 2023.12.15 19:22:01 LOG7[3]: s_connect: s_poll_wait 2001:4860:4802:32::3a:636: waiting 10 seconds 2023.12.15 19:22:01 LOG7[3]: FD=6 events=0x2001 revents=0x0 2023.12.15 19:22:01 LOG7[3]: FD=11 events=0x2005 revents=0x0 2023.12.15 19:22:11 LOG3[3]: s_connect: s_poll_wait 2001:4860:4802:32::3a:636: TIMEOUTconnect exceeded 2023.12.15 19:22:11 LOG6[3]: s_connect: connecting 216.239.32.58:636 2023.12.15 19:22:11 LOG7[3]: s_connect: s_poll_wait 216.239.32.58:636: waiting 10 seconds 2023.12.15 19:22:11 LOG7[3]: FD=6 events=0x2001 revents=0x0 2023.12.15 19:22:11 LOG7[3]: FD=11 events=0x2005 revents=0x0 2023.12.15 19:22:11 LOG5[3]: s_connect: connected 216.239.32.58:636 2023.12.15 19:22:11 LOG5[3]: Service [ldap] connected remote server from 138.122.72.19:58716 2023.12.15 19:22:11 LOG7[3]: Setting remote socket options (FD=11) 2023.12.15 19:22:11 LOG7[3]: Option TCP_NODELAY set on remote socket 2023.12.15 19:22:11 LOG7[3]: Remote descriptor (FD=11) initialized 2023.12.15 19:22:11 LOG6[3]: SNI: sending servername: ldap.google.com 2023.12.15 19:22:11 LOG6[3]: Peer certificate not required 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): before SSL initialization 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS write client hello 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS write client hello 2023.12.15 19:22:11 LOG7[3]: Initializing application specific data for session authenticated 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS read server hello 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): TLSv1.3 read encrypted extensions 2023.12.15 19:22:11 LOG6[3]: No client CA list 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS read server certificate request 2023.12.15 19:22:11 LOG6[3]: Certificate verification disabled 2023.12.15 19:22:11 LOG6[3]: Certificate verification disabled 2023.12.15 19:22:11 LOG6[3]: Certificate verification disabled 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS read server certificate 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): TLSv1.3 read server certificate verify 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS read finished 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS write change cipher spec 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS write client certificate 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS write certificate verify 2023.12.15 19:22:11 LOG7[3]: TLS state (connect): SSLv3/TLS write finished 2023.12.15 19:22:11 LOG7[3]: 4 client connect(s) requested 2023.12.15 19:22:11 LOG7[3]: 4 client connect(s) succeeded 2023.12.15 19:22:11 LOG7[3]: 0 client renegotiation(s) requested 2023.12.15 19:22:11 LOG7[3]: 1 session reuse(s) 2023.12.15 19:22:11 LOG6[3]: TLS connected: new session negotiated 2023.12.15 19:22:11 LOG6[3]: TLSv1.3 ciphersuite: TLS_AES_256_GCM_SHA384 (256-bit encryption) 2023.12.15 19:22:11 LOG6[3]: Peer temporary key: X25519, 253 bits 2023.12.15 19:22:11 LOG7[3]: Compression: null, expansion: null 2023.12.15 19:22:12 LOG7[3]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:12 LOG7[3]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:12 LOG7[3]: Initializing application specific data for session authenticated 2023.12.15 19:22:12 LOG7[3]: Deallocating application specific data for session connect address 2023.12.15 19:22:12 LOG7[3]: New session callback 2023.12.15 19:22:12 LOG7[3]: Deallocating application specific data for session connect address 2023.12.15 19:22:12 LOG6[3]: Session id: 07835A3E5EE462F340AD5339222C74AF724E232B69E6D269F1E4CC6E5BE2C04E 2023.12.15 19:22:12 LOG7[3]: TLS state (connect): SSLv3/TLS read server session ticket 2023.12.15 19:22:12 LOG7[3]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:12 LOG7[3]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:12 LOG7[3]: Initializing application specific data for session authenticated 2023.12.15 19:22:12 LOG7[3]: New session callback 2023.12.15 19:22:12 LOG7[3]: Deallocating application specific data for session connect address 2023.12.15 19:22:12 LOG6[3]: Session id: 65220203CD62D2684B823711724DC24F0B8F1B8C5A0CA7AF5067A0652A402D24 2023.12.15 19:22:12 LOG7[3]: TLS state (connect): SSLv3/TLS read server session ticket 2023.12.15 19:22:14 LOG7[main]: Found 1 ready file descriptor(s) 2023.12.15 19:22:14 LOG7[main]: FD=4 events=0x2001 revents=0x0 2023.12.15 19:22:14 LOG7[main]: FD=9 events=0x2001 revents=0x1 2023.12.15 19:22:14 LOG7[main]: Service [ldap] accepted (FD=12) from 127.0.0.1:53644 2023.12.15 19:22:14 LOG7[4]: Service [ldap] started 2023.12.15 19:22:14 LOG7[4]: Setting local socket options (FD=12) 2023.12.15 19:22:14 LOG7[4]: Option TCP_NODELAY set on local socket 2023.12.15 19:22:14 LOG5[4]: Service [ldap] accepted connection from 127.0.0.1:53644 2023.12.15 19:22:14 LOG6[4]: failover: priority, starting at entry #0 2023.12.15 19:22:14 LOG6[4]: s_connect: connecting 2001:4860:4802:32::3a:636 2023.12.15 19:22:14 LOG7[4]: s_connect: s_poll_wait 2001:4860:4802:32::3a:636: waiting 10 seconds 2023.12.15 19:22:14 LOG7[4]: FD=6 events=0x2001 revents=0x0 2023.12.15 19:22:14 LOG7[4]: FD=13 events=0x2005 revents=0x0 2023.12.15 19:22:24 LOG3[4]: s_connect: s_poll_wait 2001:4860:4802:32::3a:636: TIMEOUTconnect exceeded 2023.12.15 19:22:24 LOG6[4]: s_connect: connecting 216.239.32.58:636 2023.12.15 19:22:24 LOG7[4]: s_connect: s_poll_wait 216.239.32.58:636: waiting 10 seconds 2023.12.15 19:22:24 LOG7[4]: FD=6 events=0x2001 revents=0x0 2023.12.15 19:22:24 LOG7[4]: FD=13 events=0x2005 revents=0x0 2023.12.15 19:22:24 LOG5[4]: s_connect: connected 216.239.32.58:636 2023.12.15 19:22:24 LOG5[4]: Service [ldap] connected remote server from 138.122.72.19:49168 2023.12.15 19:22:24 LOG7[4]: Setting remote socket options (FD=13) 2023.12.15 19:22:24 LOG7[4]: Option TCP_NODELAY set on remote socket 2023.12.15 19:22:24 LOG7[4]: Remote descriptor (FD=13) initialized 2023.12.15 19:22:24 LOG6[4]: SNI: sending servername: ldap.google.com 2023.12.15 19:22:24 LOG6[4]: Peer certificate not required 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): before SSL initialization 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): SSLv3/TLS write client hello 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): SSLv3/TLS write client hello 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): SSLv3/TLS read server hello 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): TLSv1.3 read encrypted extensions 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): SSLv3/TLS read finished 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): SSLv3/TLS write change cipher spec 2023.12.15 19:22:24 LOG7[4]: TLS state (connect): SSLv3/TLS write finished 2023.12.15 19:22:24 LOG7[4]: Remove session callback 2023.12.15 19:22:24 LOG7[4]: 5 client connect(s) requested 2023.12.15 19:22:24 LOG7[4]: 5 client connect(s) succeeded 2023.12.15 19:22:24 LOG7[4]: 0 client renegotiation(s) requested 2023.12.15 19:22:24 LOG7[4]: 2 session reuse(s) 2023.12.15 19:22:24 LOG6[4]: TLS connected: previous session reused 2023.12.15 19:22:24 LOG6[4]: TLSv1.3 ciphersuite: TLS_AES_256_GCM_SHA384 (256-bit encryption) 2023.12.15 19:22:24 LOG6[4]: Peer temporary key: X25519, 253 bits 2023.12.15 19:22:24 LOG7[4]: Compression: null, expansion: null 2023.12.15 19:22:24 LOG6[4]: Session id: 65220203CD62D2684B823711724DC24F0B8F1B8C5A0CA7AF5067A0652A402D24 2023.12.15 19:22:25 LOG7[4]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:25 LOG7[4]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:25 LOG7[4]: Initializing application specific data for session authenticated 2023.12.15 19:22:25 LOG7[4]: New session callback 2023.12.15 19:22:25 LOG6[4]: Session id: 7A7CD57FAD209ABDC541A9364120F76AAB4EAB259FCE8CA4CE6EAA06813F553A 2023.12.15 19:22:25 LOG7[4]: TLS state (connect): SSLv3/TLS read server session ticket 2023.12.15 19:22:25 LOG7[4]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:25 LOG7[4]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:25 LOG7[4]: Initializing application specific data for session authenticated 2023.12.15 19:22:25 LOG7[4]: New session callback 2023.12.15 19:22:25 LOG7[4]: Deallocating application specific data for session connect address 2023.12.15 19:22:25 LOG6[4]: Session id: 74D966D999144BB933862F72A6C282D5B5DB690C53725B6670C58980BC47F4BC 2023.12.15 19:22:25 LOG7[4]: TLS state (connect): SSLv3/TLS read server session ticket 2023.12.15 19:22:25 LOG6[4]: Read socket closed (read hangup) 2023.12.15 19:22:25 LOG7[4]: Sending close_notify alert 2023.12.15 19:22:25 LOG7[4]: TLS alert (write): warning: close notify 2023.12.15 19:22:25 LOG6[4]: SSL_shutdown successfully sent close_notify alert 2023.12.15 19:22:25 LOG7[main]: Found 1 ready file descriptor(s) 2023.12.15 19:22:25 LOG7[main]: FD=4 events=0x2001 revents=0x0 2023.12.15 19:22:25 LOG7[main]: FD=9 events=0x2001 revents=0x1 2023.12.15 19:22:25 LOG7[main]: Service [ldap] accepted (FD=14) from 127.0.0.1:41376 2023.12.15 19:22:25 LOG7[5]: Service [ldap] started 2023.12.15 19:22:25 LOG7[5]: Setting local socket options (FD=14) 2023.12.15 19:22:25 LOG7[5]: Option TCP_NODELAY set on local socket 2023.12.15 19:22:25 LOG5[5]: Service [ldap] accepted connection from 127.0.0.1:41376 2023.12.15 19:22:25 LOG6[5]: failover: priority, starting at entry #0 2023.12.15 19:22:25 LOG6[5]: s_connect: connecting 2001:4860:4802:32::3a:636 2023.12.15 19:22:25 LOG7[5]: s_connect: s_poll_wait 2001:4860:4802:32::3a:636: waiting 10 seconds 2023.12.15 19:22:25 LOG7[5]: FD=6 events=0x2001 revents=0x0 2023.12.15 19:22:25 LOG7[5]: FD=15 events=0x2005 revents=0x0 2023.12.15 19:22:25 LOG3[4]: SSL_read: ../ssl/record/rec_layer_s3.c:308: error:0A000126:SSL routines::unexpected eof while reading 2023.12.15 19:22:25 LOG5[4]: Connection reset: 55 byte(s) sent to TLS, 31 byte(s) sent to socket 2023.12.15 19:22:25 LOG7[4]: Remote descriptor (FD=13) closed 2023.12.15 19:22:25 LOG7[4]: Local descriptor (FD=12) closed 2023.12.15 19:22:25 LOG7[4]: Service [ldap] finished (2 left) 2023.12.15 19:22:35 LOG3[5]: s_connect: s_poll_wait 2001:4860:4802:32::3a:636: TIMEOUTconnect exceeded 2023.12.15 19:22:35 LOG6[5]: s_connect: connecting 216.239.32.58:636 2023.12.15 19:22:35 LOG7[5]: s_connect: s_poll_wait 216.239.32.58:636: waiting 10 seconds 2023.12.15 19:22:35 LOG7[5]: FD=6 events=0x2001 revents=0x0 2023.12.15 19:22:35 LOG7[5]: FD=12 events=0x2005 revents=0x0 2023.12.15 19:22:35 LOG5[5]: s_connect: connected 216.239.32.58:636 2023.12.15 19:22:35 LOG5[5]: Service [ldap] connected remote server from 138.122.72.19:39460 2023.12.15 19:22:35 LOG7[5]: Setting remote socket options (FD=12) 2023.12.15 19:22:35 LOG7[5]: Option TCP_NODELAY set on remote socket 2023.12.15 19:22:35 LOG7[5]: Remote descriptor (FD=12) initialized 2023.12.15 19:22:35 LOG6[5]: SNI: sending servername: ldap.google.com 2023.12.15 19:22:35 LOG6[5]: Peer certificate not required 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): before SSL initialization 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): SSLv3/TLS write client hello 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): SSLv3/TLS write client hello 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): SSLv3/TLS read server hello 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): TLSv1.3 read encrypted extensions 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): SSLv3/TLS read finished 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): SSLv3/TLS write change cipher spec 2023.12.15 19:22:35 LOG7[5]: TLS state (connect): SSLv3/TLS write finished 2023.12.15 19:22:35 LOG7[5]: Remove session callback 2023.12.15 19:22:35 LOG7[5]: 6 client connect(s) requested 2023.12.15 19:22:35 LOG7[5]: 6 client connect(s) succeeded 2023.12.15 19:22:35 LOG7[5]: 0 client renegotiation(s) requested 2023.12.15 19:22:35 LOG7[5]: 3 session reuse(s) 2023.12.15 19:22:35 LOG6[5]: TLS connected: previous session reused 2023.12.15 19:22:35 LOG6[5]: TLSv1.3 ciphersuite: TLS_AES_256_GCM_SHA384 (256-bit encryption) 2023.12.15 19:22:35 LOG6[5]: Peer temporary key: X25519, 253 bits 2023.12.15 19:22:35 LOG7[5]: Compression: null, expansion: null 2023.12.15 19:22:35 LOG6[5]: Session id: 74D966D999144BB933862F72A6C282D5B5DB690C53725B6670C58980BC47F4BC 2023.12.15 19:22:36 LOG7[5]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:36 LOG7[5]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:36 LOG7[5]: Initializing application specific data for session authenticated 2023.12.15 19:22:36 LOG7[5]: New session callback 2023.12.15 19:22:36 LOG7[5]: Deallocating application specific data for session connect address 2023.12.15 19:22:36 LOG6[5]: Session id: 031A54F73E6396553C764FD708C46E04068B4CF6A503E330A971BBB70F9ECB30 2023.12.15 19:22:36 LOG7[5]: TLS state (connect): SSLv3/TLS read server session ticket 2023.12.15 19:22:36 LOG7[5]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:36 LOG7[5]: TLS state (connect): SSL negotiation finished successfully 2023.12.15 19:22:36 LOG7[5]: Initializing application specific data for session authenticated 2023.12.15 19:22:36 LOG7[5]: New session callback 2023.12.15 19:22:36 LOG7[5]: Deallocating application specific data for session connect address 2023.12.15 19:22:36 LOG6[5]: Session id: D27FA43E5D4A689ADE6FEE490C50497AFACC19F1030DF1401D34E5545EB23D50 2023.12.15 19:22:36 LOG7[5]: TLS state (connect): SSLv3/TLS read server session ticket 2023.12.15 19:22:36 LOG6[5]: Read socket closed (read hangup) 2023.12.15 19:22:36 LOG7[5]: Sending close_notify alert 2023.12.15 19:22:36 LOG7[5]: TLS alert (write): warning: close notify 2023.12.15 19:22:36 LOG6[5]: SSL_shutdown successfully sent close_notify alert 2023.12.15 19:22:36 LOG6[3]: Read socket closed (read hangup) 2023.12.15 19:22:36 LOG7[3]: Sending close_notify alert 2023.12.15 19:22:36 LOG7[3]: TLS alert (write): warning: close notify 2023.12.15 19:22:36 LOG6[3]: SSL_shutdown successfully sent close_notify alert 2023.12.15 19:22:36 LOG3[5]: SSL_read: ../ssl/record/rec_layer_s3.c:308: error:0A000126:SSL routines::unexpected eof while reading 2023.12.15 19:22:36 LOG5[5]: Connection reset: 55 byte(s) sent to TLS, 31 byte(s) sent to socket 2023.12.15 19:22:36 LOG7[5]: Remote descriptor (FD=12) closed 2023.12.15 19:22:36 LOG7[5]: Local descriptor (FD=14) closed 2023.12.15 19:22:36 LOG7[5]: Service [ldap] finished (1 left) 2023.12.15 19:22:36 LOG3[3]: SSL_read: ../ssl/record/rec_layer_s3.c:308: error:0A000126:SSL routines::unexpected eof while reading 2023.12.15 19:22:36 LOG5[3]: Connection reset: 495 byte(s) sent to TLS, 1293 byte(s) sent to socket 2023.12.15 19:22:36 LOG7[3]: Deallocating application specific data for session connect address 2023.12.15 19:22:36 LOG7[3]: Remote descriptor (FD=11) closed 2023.12.15 19:22:36 LOG7[3]: Local descriptor (FD=3) closed 2023.12.15 19:22:36 LOG7[3]: Service [ldap] finished (0 left) ## Login Sucess - Delay ~ 35 seconds ##