2017-05-31 09:49:02,968 DEBUG [org.apereo.cas.authentication.RegisteredServiceAuthenticationHandlerResolver] - <No specific authentication handlers are required for this transaction>
2017-05-31 09:49:02,970 DEBUG [org.apereo.cas.authentication.RegisteredServiceAuthenticationHandlerResolver] - <Authentication handlers used for this transaction are [OpenIdCredentialsAuthenticationHandlerHttpBasedServiceCredentialsAuthenticationHandlerLdapAuthenticationHandler]>
2017-05-31 09:49:02,977 DEBUG [org.apereo.cas.authentication.handler.support.AbstractUsernamePasswordAuthenticationHandler] - <Transforming credential username via [org.apereo.cas.configuration.support.Beans$$Lambda$77/1077246245]>
2017-05-31 09:49:02,978 DEBUG [org.apereo.cas.authentication.handler.support.AbstractUsernamePasswordAuthenticationHandler] - <Attempting to encode credential password via [org.springframework.security.crypto.password.NoOpPasswordEncoder] for [
aaa...@ccc.com]>
2017-05-31 09:49:02,979 DEBUG [org.apereo.cas.authentication.handler.support.AbstractUsernamePasswordAuthenticationHandler] - <Attempting authentication internally for transformed credential [
aaa...@ccc.com]>
2017-05-31 09:49:02,982 DEBUG [org.apereo.cas.authentication.LdapAuthenticationHandler] - <Attempting LDAP authentication for [
aaa...@ccc.com]. Authenticator pre-configured attributes are [null], additional requested attributes for this authentication request are [[uid, mail, givenName, sn, cn]]>
2017-05-31 09:49:02,986 DEBUG [org.ldaptive.auth.PooledSearchDnResolver] - <resolve user=[org.ldaptive.auth.User@1810991362::identifier=
aaa...@ccc.com, context=null]>
2017-05-31 09:49:02,986 DEBUG [org.ldaptive.auth.PooledSearchDnResolver] - <searching for DN using userFilter>
2017-05-31 09:49:02,991 DEBUG [org.ldaptive.SearchOperation] - <execute request=[org.ldaptive.SearchRequest@-577997831::baseDn=, searchFilter=[org.ldaptive.SearchFilter@1642584434::filter=(objectClass=*), parameters={}], returnAttributes=[1.1], searchScope=OBJECT, timeLimit=PT0S, sizeLimit=1, derefAliases=null, typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, searchEntryHandlers=null, searchReferenceHandlers=[org.ldaptive.referral.SearchReferralHandler$SearchReferenceHandler@2c95d987], controls=null, referralHandler=org.ldaptive.referral.SearchReferralHandler@7d707b9c, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1101123226::config=[org.ldaptive.ConnectionConfig@1520253722::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@
2079692145::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@
2039028212::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@255e3579], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@1884695011::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@611790701::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@76f4ed47, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@39ee281d]>
2017-05-31 09:49:03,024 DEBUG [org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: SearchRequest(baseDN='', scope=BASE, deref=NEVER, sizeLimit=1, timeLimit=0, filter='(objectClass=*)', attrs={1.1})>
2017-05-31 09:49:03,053 DEBUG [org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: [org.ldaptive.Response@789486597::result=null, resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>
2017-05-31 09:49:03,055 DEBUG [org.ldaptive.SearchOperation] - <execute response=[org.ldaptive.Response@1317418705::result=[org.ldaptive.SearchResult@-1951902882::entries=[[dn=[], responseControls=null, messageId=2]], references=[]], resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=2] for request=[org.ldaptive.SearchRequest@-577997831::baseDn=, searchFilter=[org.ldaptive.SearchFilter@1642584434::filter=(objectClass=*), parameters={}], returnAttributes=[1.1], searchScope=OBJECT, timeLimit=PT0S, sizeLimit=1, derefAliases=null, typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, searchEntryHandlers=null, searchReferenceHandlers=[org.ldaptive.referral.SearchReferralHandler$SearchReferenceHandler@2c95d987], controls=null, referralHandler=org.ldaptive.referral.SearchReferralHandler@7d707b9c, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1101123226::config=[org.ldaptive.ConnectionConfig@1520253722::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@
2079692145::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@
2039028212::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@255e3579], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@1884695011::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@611790701::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@76f4ed47, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@39ee281d]>
2017-05-31 09:49:03,056 DEBUG [org.ldaptive.SearchOperation] - <execute request=[org.ldaptive.SearchRequest@1041964045::baseDn=ou=individuel,dc=xxxxxxxx,dc=com, searchFilter=[org.ldaptive.SearchFilter@-489204262::filter=mail={user}, parameters={context=null, user=
aaa...@ccc.com}], returnAttributes=[1.1], searchScope=SUBTREE, timeLimit=PT0S, sizeLimit=0, derefAliases=null, typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1101123226::config=[org.ldaptive.ConnectionConfig@1520253722::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@
2079692145::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@
2039028212::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@255e3579], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@1884695011::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@611790701::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@76f4ed47, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@39ee281d]>
2017-05-31 09:49:03,057 DEBUG [org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: SearchRequest(baseDN='ou=individuel,dc=xxxxxxxx,dc=com', scope=SUB, deref=NEVER, sizeLimit=0, timeLimit=0, filter='mail=
aaa...@ccc.com', attrs={1.1})>
2017-05-31 09:49:03,060 DEBUG [org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: [org.ldaptive.Response@1895138053::result=null, resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=3]>
2017-05-31 09:49:03,060 DEBUG [org.ldaptive.SearchOperation] - <execute response=[org.ldaptive.Response@725665706::result=[org.ldaptive.SearchResult@191229211::entries=[[dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com[], responseControls=null, messageId=3]], references=[]], resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=3] for request=[org.ldaptive.SearchRequest@1041964045::baseDn=ou=individuel,dc=xxxxxxxx,dc=com, searchFilter=[org.ldaptive.SearchFilter@-489204262::filter=mail={user}, parameters={context=null, user=
aaa...@ccc.com}], returnAttributes=[1.1], searchScope=SUBTREE, timeLimit=PT0S, sizeLimit=0, derefAliases=null, typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1101123226::config=[org.ldaptive.ConnectionConfig@1520253722::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@
2079692145::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@
2039028212::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@255e3579], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@1884695011::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@611790701::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@76f4ed47, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@39ee281d]>
2017-05-31 09:49:03,060 DEBUG [org.ldaptive.BindOperation] - <execute request=[org.ldaptive.BindRequest@1997076822::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, saslConfig=null, controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1101123226::config=[org.ldaptive.ConnectionConfig@1520253722::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@
2079692145::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@
2039028212::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@255e3579], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@1884695011::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@611790701::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@76f4ed47, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@39ee281d]>
2017-05-31 09:49:03,070 DEBUG [org.ldaptive.BindOperation] - <execute response=[org.ldaptive.Response@1418681517::result=null, resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=4] for request=[org.ldaptive.BindRequest@1997076822::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, saslConfig=null, controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1101123226::config=[org.ldaptive.ConnectionConfig@1520253722::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@
2079692145::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@
2039028212::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@255e3579], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@1884695011::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@611790701::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@76f4ed47, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@39ee281d]>
2017-05-31 09:49:03,071 DEBUG [org.ldaptive.auth.PooledSearchDnResolver] - <resolved dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com for user=[org.ldaptive.auth.User@1810991362::identifier=
aaa...@ccc.com, context=null]>
2017-05-31 09:49:03,075 DEBUG [org.ldaptive.auth.Authenticator] - <authenticate dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com with request=[org.ldaptive.auth.AuthenticationRequest@518364974::user=[org.ldaptive.auth.User@1810991362::identifier=
aaa...@ccc.com, context=null], returnAttributes=[uid, mail, givenName, sn, cn]]>
2017-05-31 09:49:03,077 DEBUG [org.ldaptive.auth.PooledCompareAuthenticationHandler] - <authenticate criteria=[org.ldaptive.auth.AuthenticationCriteria@1112853084::dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com, authenticationRequest=[org.ldaptive.auth.AuthenticationRequest@518364974::user=[org.ldaptive.auth.User@1810991362::identifier=
aaa...@ccc.com, context=null], returnAttributes=[uid, mail, givenName, sn, cn]]]>
2017-05-31 09:49:03,077 DEBUG [org.ldaptive.SearchOperation] - <execute request=[org.ldaptive.SearchRequest@1891521909::baseDn=, searchFilter=[org.ldaptive.SearchFilter@1642584434::filter=(objectClass=*), parameters={}], returnAttributes=[1.1], searchScope=OBJECT, timeLimit=PT0S, sizeLimit=1, derefAliases=null, typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, searchEntryHandlers=null, searchReferenceHandlers=[org.ldaptive.referral.SearchReferralHandler$SearchReferenceHandler@10f62397], controls=null, referralHandler=org.ldaptive.referral.SearchReferralHandler@5f1c09c8, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991]>
2017-05-31 09:49:03,078 DEBUG [org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: SearchRequest(baseDN='', scope=BASE, deref=NEVER, sizeLimit=1, timeLimit=0, filter='(objectClass=*)', attrs={1.1})>
2017-05-31 09:49:03,081 DEBUG [org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: [org.ldaptive.Response@1870936107::result=null, resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>
2017-05-31 09:49:03,081 DEBUG [org.ldaptive.SearchOperation] - <execute response=[org.ldaptive.Response@1103129410::result=[org.ldaptive.SearchResult@-1951902882::entries=[[dn=[], responseControls=null, messageId=2]], references=[]], resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=2] for request=[org.ldaptive.SearchRequest@1891521909::baseDn=, searchFilter=[org.ldaptive.SearchFilter@1642584434::filter=(objectClass=*), parameters={}], returnAttributes=[1.1], searchScope=OBJECT, timeLimit=PT0S, sizeLimit=1, derefAliases=null, typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, searchEntryHandlers=null, searchReferenceHandlers=[org.ldaptive.referral.SearchReferralHandler$SearchReferenceHandler@10f62397], controls=null, referralHandler=org.ldaptive.referral.SearchReferralHandler@5f1c09c8, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991]>
2017-05-31 09:49:03,087 DEBUG [org.ldaptive.CompareOperation] - <execute request=[org.ldaptive.CompareRequest@1936625851::compareDn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com, attribute=[userPassword[e1NIQX1xeWlINUdPc2xQbmpvNnlvcUd3bGh1V0c3b2c9]], controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991]>
2017-05-31 09:49:03,096 DEBUG [org.ldaptive.CompareOperation] - <execute response=[org.ldaptive.Response@467627795::result=false, resultCode=COMPARE_FALSE, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=3] for request=[org.ldaptive.CompareRequest@1936625851::compareDn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com, attribute=[userPassword[e1NIQX1xeWlINUdPc2xQbmpvNnlvcUd3bGh1V0c3b2c9]], controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991]>
2017-05-31 09:49:03,097 DEBUG [org.ldaptive.auth.PooledCompareAuthenticationHandler] - <authenticate response=[org.ldaptive.auth.AuthenticationHandlerResponse@481550235::connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991], result=false, resultCode=COMPARE_FALSE, message=null, controls=null] for criteria=[org.ldaptive.auth.AuthenticationCriteria@1112853084::dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com, authenticationRequest=[org.ldaptive.auth.AuthenticationRequest@518364974::user=[org.ldaptive.auth.User@1810991362::identifier=
aaa...@ccc.com, context=null], returnAttributes=[uid, mail, givenName, sn, cn]]]>
2017-05-31 09:49:03,097 DEBUG [org.ldaptive.BindOperation] - <execute request=[org.ldaptive.BindRequest@1806262712::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, saslConfig=null, controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991]>
2017-05-31 09:49:03,099 DEBUG [org.ldaptive.BindOperation] - <execute response=[org.ldaptive.Response@1851287311::result=null, resultCode=SUCCESS, message=null, matchedDn=null, responseControls=null, referralURLs=[], messageId=4] for request=[org.ldaptive.BindRequest@1806262712::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, saslConfig=null, controls=null, referralHandler=null, intermediateResponseHandlers=null] with connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991]>
2017-05-31 09:49:03,099 INFO [org.ldaptive.auth.Authenticator] - <Authentication failed for dn: cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com>
2017-05-31 09:49:03,101 DEBUG [org.ldaptive.auth.Authenticator] - <authenticate response=[org.ldaptive.auth.AuthenticationHandlerResponse@481550235::connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@1656964227::config=[org.ldaptive.ConnectionConfig@1763680363::ldapUrl=ldap://xxxx:xxxx, connectTimeout=PT1H23M20S, responseTimeout=PT5S, sslConfig=[org.ldaptive.ssl.SslConfig@1442941949::credentialConfig=null, trustManagers=null, enabledCipherSuites=null, enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, useStartTLS=false, connectionInitializer=[org.ldaptive.BindConnectionInitializer@1878521940::bindDn=cn=xxxxxxxx,dc=xxxxxxxx,dc=com, bindSaslConfig=null, bindControls=null], connectionStrategy=org.ldaptive.DefaultConnectionStrategy@2ccf8f1f], providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFactory@849749463::metadata=[ldapUrl=ldap://xxxx:xxxx, count=1], providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@1648485355::operationExceptionResultCodes=[SERVER_DOWN], properties={}, controlProcessor=org.ldaptive.provider.ControlProcessor@61f51e70, connectionOptions=null, socketFactory=null, sslSocketFactory=null, searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED, REFERRAL]]], providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@196ab991], result=false, resultCode=COMPARE_FALSE, message=null, controls=null] for dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com with request=[org.ldaptive.auth.AuthenticationRequest@518364974::user=[org.ldaptive.auth.User@1810991362::identifier=
aaa...@ccc.com, context=null], returnAttributes=[uid, mail, givenName, sn, cn]]>
2017-05-31 09:49:03,101 DEBUG [org.apereo.cas.authentication.LdapAuthenticationHandler] - <LDAP response: [[org.ldaptive.auth.AuthenticationResponse@185733131::authenticationResultCode=AUTHENTICATION_HANDLER_FAILURE, resolvedDn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com, ldapEntry=[dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com[]], accountState=null, result=false, resultCode=COMPARE_FALSE, message=null, controls=null]]>
2017-05-31 09:49:03,102 DEBUG [org.apereo.cas.authentication.LdapAuthenticationHandler] - <Applying password policy to [[org.ldaptive.auth.AuthenticationResponse@185733131::authenticationResultCode=AUTHENTICATION_HANDLER_FAILURE, resolvedDn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com, ldapEntry=[dn=cn=inf10771,ou=xxxxxx,ou=xxxxxx,ou=individuel,dc=xxxxxxxx,dc=com[]], accountState=null, result=false, resultCode=COMPARE_FALSE, message=null, controls=null]]>
2017-05-31 09:49:03,104 DEBUG [org.apereo.cas.authentication.support.DefaultAccountStateHandler] - <Account state not defined. Returning empty list of messages.>
2017-05-31 09:49:03,105 INFO [org.apereo.cas.authentication.PolicyBasedAuthenticationManager] - <[LdapAuthenticationHandler] failed authenticating [
aaa...@ccc.com]>
2017-05-31 09:49:03,106 DEBUG [org.apereo.cas.authentication.PolicyBasedAuthenticationManager] - <[LdapAuthenticationHandler] exception details: [Invalid credentials]>
2017-05-31 09:49:03,106 WARN [org.apereo.cas.authentication.PolicyBasedAuthenticationManager] - <Authentication has failed. Credentials may be incorrect or CAS cannot find authentication handler that supports [
aaa...@ccc.com] of type [UsernamePasswordCredential], which suggests a configuration problem.>
2017-05-31 09:49:03,110 INFO [org.apereo.inspektr.audit.support.Slf4jLoggingAuditTrailManager] - <Audit trail record BEGIN
=============================================================
ACTION: AUTHENTICATION_FAILED
APPLICATION: CAS
WHEN: Wed May 31 09:49:03 EDT 2017
CLIENT IP ADDRESS: 127.0.0.1
SERVER IP ADDRESS: 127.0.0.1
=============================================================