haresh14 / vt-middleware

Automatically exported from code.google.com/p/vt-middleware
0 stars 0 forks source link

ldaptive: unboundid binary attribute support #223

Closed GoogleCodeExporter closed 9 years ago

GoogleCodeExporter commented 9 years ago
The UnboundID provider leverages Attribute#needsBase64Encoding()  to determine 
if an attribute is binary.
This can be improved by checking whether the 'binary' option has been set.

Also, the binaryAttributes property is not being used, so users cannot declare 
custom binary attributes.

Original issue reported on code.google.com by dfis...@gmail.com on 18 Aug 2014 at 4:14

GoogleCodeExporter commented 9 years ago
While I was testing this, my binary attribute was going to include a byte[] 
that was the result of serializing an object. 

final byte[] data = SerializationUtils.serialize(theObject);
final LdapAttribute attr = new LdapAttribute("binaryAttributeXYZ", data);

SerializationUtils belongs to the Apache library. This really is a custom 
attribute that is specifically used in the context of CAS. Service Registry 
data includes classes and objects that, if persisting to a backend LDAP must 
serialize and be kept in binary attributes. 

Original comment by misagh.moayyed on 19 Aug 2014 at 6:45

GoogleCodeExporter commented 9 years ago
So my theory is that the serialized byte array somehow only contained bytes 
that represent ASCII characters.
Please add a comment that includes the value for this specific attribute. 
(base64 encode it)
That will help me with the testing.

Original comment by dfis...@gmail.com on 19 Aug 2014 at 1:09

GoogleCodeExporter commented 9 years ago
That last comment may be a bit confusing.
What I need is the LDIF of the entry that is causing you problems.

Original comment by dfis...@gmail.com on 19 Aug 2014 at 2:08

GoogleCodeExporter commented 9 years ago
I attached a few sample files I am working with. 

The schema file should have what you are after, I believe. In particular, take 
a look at the "casAttributeReleasePolicy" attribute type and the 
"casRegisteredService" object class. 

In the code, I create an ldap entry with all the right attributes, assign it 
the above object class and pass a byte array for the attribute above. Saves it 
fine via UnBound. The retrieval is of course where I have problems and cant get 
the binary value back out of the attribute. 

Do let me know plz if I can further provide info. 

Original comment by misagh.moayyed on 20 Aug 2014 at 4:44

Attachments:

GoogleCodeExporter commented 9 years ago
P.S: There is a very good chance this may be configuration error on my part. I 
am just not seeing it perhaps! 

Original comment by misagh.moayyed on 20 Aug 2014 at 4:45

GoogleCodeExporter commented 9 years ago
Can you provide a sample value for "casAttributeReleasePolicy" ?

Original comment by dfis...@gmail.com on 20 Aug 2014 at 5:19

GoogleCodeExporter commented 9 years ago
Made some relevant changes in r3039.
Still need to see one of these values to know exactly what is going on.

My guess is you will have to declare the attribute as binary in the search 
request or request the attribute with the ;binary option.

Original comment by dfis...@gmail.com on 20 Aug 2014 at 5:46

GoogleCodeExporter commented 9 years ago
Sorry, was out and about for a few days.

So, what would be the best way for me to provide the value for 
casAttributeReleasePolicy? All I have is a byte[]. 

How could I declare the binary attribute as part of my request? Because in CAS, 
these attributes are simply collected by the authenticator object, and then 
passed down to the search resolver for it to find them. What does the ";binary" 
come from in the configuration? 

Original comment by misagh.moayyed on 2 Sep 2014 at 5:53

GoogleCodeExporter commented 9 years ago
> So, what would be the best way for me to provide the value for 
casAttributeReleasePolicy? All I have is a byte[].

If you can, echo the base64 encoded value to System.out, then post it here.

> How could I declare the binary attribute as part of my request?

Somewhere you should be defining return attributes. You would change that name 
to:
casAttributeReleasePolicy;binary

Original comment by dfis...@gmail.com on 2 Sep 2014 at 2:39

GoogleCodeExporter commented 9 years ago
So, I took the byte[] and called:

base64String = Base64.encodeBase64URLSafeString(myByteArray);

This is what came out:
rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNl
cm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcGVyc2lzdGVudElkR2VuZXJhdG9ydAA

I'll try declaring the attribute as binary as you specified, and see what 
happens. 

Original comment by misagh.moayyed on 4 Sep 2014 at 8:32

GoogleCodeExporter commented 9 years ago
We werent actually requesting attributes explicitly before. The SearchRequest 
would retrieve everything it had available. But I went ahead and defined a list:

```xml
    <util:list id="returnAttrbutes">
        <value>objectClass</value>
        <value>casServiceUrlPattern</value>
        <value>uid</value>
        <value>cn</value>
        <value>casServiceEnabled</value>
        <value>casServiceSsoEnabled</value>
        <value>casServiceTheme</value>
        <value>casServiceProxyPolicy;binary</value>
        <value>casUsernameAttributeProvider;binary</value>
        <value>casAttributeReleasePolicy;binary</value>
        <value>casEvaluationOrder</value>
        <value>casRequiredHandlers</value>
    </util:list>

    <bean id="searchRequest"
          class="org.ldaptive.SearchRequest"
          p:baseDn="${ldap.service.baseDn}"
          p:returnAttributes="#{returnAttrbutes.toArray(new java.lang.String[0])}" />

This could be a bit simplified if the return attributes were declared as a list, and not as an array.

Then I looked at my search request's getBinaryAttributes() and it returns 0. Return attributes are not configured with my above list, with attributes coming back under the name "casUsernameAttributeProvider;binary" for example.


Original comment by `misagh.moayyed` on 4 Sep 2014 at 9:19
GoogleCodeExporter commented 9 years ago
Just another note; that in this particular case folks are not going to be 
defining a list of attributes. That would be painful. We are hoping to let the 
request return everything, and the API should handle which is binary and which 
is not, so that our code would know when to call getBinary() or getString(), 
etc on the attribute. 

Original comment by misagh.moayyed on 4 Sep 2014 at 9:22

GoogleCodeExporter commented 9 years ago
That should definitely be a binary value.
Is the behavior the same for the JNDI provider?

Original comment by dfis...@gmail.com on 4 Sep 2014 at 8:05

GoogleCodeExporter commented 9 years ago
It would also be helpful if you could post the results from a standard 
ldapsearch command line client.
I'm curious what the LDIF output looks like.

Original comment by dfis...@gmail.com on 5 Sep 2014 at 3:36

GoogleCodeExporter commented 9 years ago
Can you point me to the CAS unit test where this is failing?
I might make some progress if I can see what's happening over there.

Original comment by dfis...@gmail.com on 9 Sep 2014 at 8:56

GoogleCodeExporter commented 9 years ago
Looking at the DefaultLdapServiceMapper I created a test case using your schema.
The UnboundID provider worked for me, so I'm guessing that you aren't using 
that provider.
You're probably using the default JNDI provider.
You can set the provider with DefaultConnectionFactory#setProvider or globally 
with -Dorg.ldaptive.provider

Original comment by dfis...@gmail.com on 10 Sep 2014 at 10:06

GoogleCodeExporter commented 9 years ago
Added Schema#getBinaryAttributeNames() to provide a mechanism for passing 
binary attributes from your schema into the SearchRequest.

Original comment by dfis...@gmail.com on 11 Sep 2014 at 7:37

GoogleCodeExporter commented 9 years ago
Daniel. Thanks for reviewing this. I'll shortly point you towards the branch 
that is causing the failure. The changes are in my local fork right now, and 
I'll get them cleaned up and passed over so that you can review and see what 
might be missing. I'll try to get around to it this weekend, fingers crossed. 

Original comment by misagh.moayyed on 12 Sep 2014 at 3:35

GoogleCodeExporter commented 9 years ago
So, here where I am at:

Clone this cas fork please: https://github.com/Unicon/cas
Switch to branch "ldap-server-uboundid"
Run LdapServiceRegistryDaoTests

You should see the follow stacktrace:

org.apache.commons.lang3.SerializationException: 
java.io.StreamCorruptedException: invalid stream header: EFBFBDEF
    at org.apache.commons.lang3.SerializationUtils.deserialize(SerializationUtils.java:232)
    at org.apache.commons.lang3.SerializationUtils.deserialize(SerializationUtils.java:268)
    at org.jasig.cas.adaptors.ldap.services.DefaultLdapServiceMapper.mapToRegisteredService(DefaultLdapServiceMapper.java:162)
    at org.jasig.cas.adaptors.ldap.services.LdapServiceRegistryDao.load(LdapServiceRegistryDao.java:180)
    at org.jasig.cas.adaptors.ldap.services.LdapServiceRegistryDaoTests.testServices(LdapServiceRegistryDaoTests.java:94)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
    at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
    at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
    at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
    at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
    at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
    at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
    at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
    at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
    at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
    at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
    at org.junit.runner.JUnitCore.run(JUnitCore.java:160)
    at com.intellij.junit4.JUnit4IdeaTestRunner.startRunnerWithArgs(JUnit4IdeaTestRunner.java:74)
    at com.intellij.rt.execution.junit.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:211)
    at com.intellij.rt.execution.junit.JUnitStarter.main(JUnitStarter.java:67)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
    at com.intellij.rt.execution.application.AppMain.main(AppMain.java:134)
Caused by: java.io.StreamCorruptedException: invalid stream header: EFBFBDEF
    at java.io.ObjectInputStream.readStreamHeader(ObjectInputStream.java:804)
    at java.io.ObjectInputStream.<init>(ObjectInputStream.java:299)
    at org.apache.commons.lang3.SerializationUtils.deserialize(SerializationUtils.java:222)
    ... 33 more

FYI, we have decided to switch over to JSON serilization for these complex 
objects, but nonetheless, I think the binary format should still be figured 
out. 

Original comment by misagh.moayyed on 16 Sep 2014 at 9:47

GoogleCodeExporter commented 9 years ago
You'll find the schema definition and ldif files under src/main/resources/ldif 
and src/main/resources/schema of the CAS ldap module. There is also an 
InMemoryTestLdapDirectoryServer that runs an unboundid ldap server on startup 
and gets populated by these files. 

Original comment by misagh.moayyed on 16 Sep 2014 at 9:49

GoogleCodeExporter commented 9 years ago
I have not been able to get this branch to compile.
However, I think one of the above suggestions will fix your issue.

1) Use DefaultConnectionFactory#setProvider(new UnboundIDProvider())

or

2) Use Schema#getBinaryAttributes() and pass those attributes into your search 
request.

Original comment by dfis...@gmail.com on 3 Oct 2014 at 2:37

GoogleCodeExporter commented 9 years ago
Sure, thanks. I'll give this another try and report back. 

Original comment by misagh.moayyed on 3 Oct 2014 at 4:47

GoogleCodeExporter commented 9 years ago
So, first off, very much appreciate your working with me on this.

Seems like newing up UnboundIDProvider takes care of the original issue. I am 
running into another one now, which may or may not be related here. Here is 
what is happening:

I am creating an LdapEntry with a whole bunch of attributes, one of which is:

...
attrs.add(new LdapAttribute(this.serviceDescriptionAttribute, 
svc.getDescription()));
...
return new LdapEntry(newDn, attrs);
...

The "serviceDescriptionAttribute" has a default value of "description" and the 
"svc" object definitely returns a value for "svc.getDescription()"

I see that this entry is persisted just fine.

Next, when I attempt to load it I try to look into the description attribute, 
but there exists none. All other attributes for the same entry are retrieved 
except "description". 

Suggestions? 

Original comment by misagh.moayyed on 6 Oct 2014 at 5:29

GoogleCodeExporter commented 9 years ago
Can you post some debug ldaptive logs that show the add and the search?

Original comment by dfis...@gmail.com on 6 Oct 2014 at 5:51

GoogleCodeExporter commented 9 years ago
Here is everything I have on the logs:

2014-10-06 10:56:45,707 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@14202621::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@30790885::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@21082424::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1d9dd68]>

2014-10-06 10:56:45,718 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@17131351::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for 
request=[org.ldaptive.BindRequest@14202621::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@30790885::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@21082424::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1d9dd68]>

2014-10-06 10:56:45,724 DEBUG [org.ldaptive.SearchOperation] - <execute 
request=[org.ldaptive.SearchRequest@1019718355::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@711044294::filter=(objectClass=casRegist
eredService), parameters={}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@30790885::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@21082424::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1d9dd68]>

2014-10-06 10:56:45,752 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: 
SearchRequest(baseDN='ou=people,dc=springframework,dc=org', scope=SUB, 
deref=NEVER, sizeLimit=0, timeLimit=0, 
filter='(objectClass=casRegisteredService)', attrs={objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers})>

Original comment by misagh.moayyed on 6 Oct 2014 at 5:58

GoogleCodeExporter commented 9 years ago

2014-10-06 10:56:45,759 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: 
[org.ldaptive.Response@11096570::result=null, resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>

2014-10-06 10:56:45,764 DEBUG [org.ldaptive.SearchOperation] - <execute 
response=[org.ldaptive.Response@4521909::result=[org.ldaptive.SearchResult@43031
53::entries=[], references=[]], resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2] for 
request=[org.ldaptive.SearchRequest@1019718355::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@711044294::filter=(objectClass=casRegist
eredService), parameters={}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@30790885::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@21082424::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1d9dd68]>

2014-10-06 10:56:45,774 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

2014-10-06 10:56:45,778 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@33157682::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9159179::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@24146142::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1021b41]>

2014-10-06 10:56:45,785 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@2116053::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for 
request=[org.ldaptive.BindRequest@33157682::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9159179::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@24146142::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1021b41]>

2014-10-06 10:56:45,792 DEBUG [org.ldaptive.SearchOperation] - <execute 
request=[org.ldaptive.SearchRequest@1019718355::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@711044294::filter=(objectClass=casRegist
eredService), parameters={}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9159179::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@24146142::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1021b41]>

2014-10-06 10:56:45,799 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: 
SearchRequest(baseDN='ou=people,dc=springframework,dc=org', scope=SUB, 
deref=NEVER, sizeLimit=0, timeLimit=0, 
filter='(objectClass=casRegisteredService)', attrs={objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers})>

2014-10-06 10:56:45,802 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: 
[org.ldaptive.Response@30361400::result=null, resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>

2014-10-06 10:56:45,803 DEBUG [org.ldaptive.SearchOperation] - <execute 
response=[org.ldaptive.Response@21809704::result=[org.ldaptive.SearchResult@4303
153::entries=[], references=[]], resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2] for 
request=[org.ldaptive.SearchRequest@1019718355::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@711044294::filter=(objectClass=casRegist
eredService), parameters={}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9159179::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@24146142::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1021b41]>

2014-10-06 10:56:45,811 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

2014-10-06 10:56:45,838 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@4989944::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13474046::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@19681327::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@446e79]>

Original comment by misagh.moayyed on 6 Oct 2014 at 5:58

GoogleCodeExporter commented 9 years ago

2014-10-06 10:56:45,842 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@32050624::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for request=[org.ldaptive.BindRequest@4989944::bindDn=cn=Directory 
Manager, saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13474046::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@19681327::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@446e79]>

2014-10-06 10:56:45,879 DEBUG [org.ldaptive.AddOperation] - <execute 
request=[org.ldaptive.AddRequest@16655287::createDn=uid=37639838138141,ou=people
,dc=springframework,dc=org, attributes=[[uid[37639838138141]], 
[casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADZvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
EF0dHJpYnV0ZVJlbGVhc2VQb2xpY3lMmFeoUZ6WYwIAAHhyADVvcmcuamFzaWcuY2FzLnNlcnZpY2VzL
kFic3RyYWN0QXR0cmlidXRlUmVsZWFzZVBvbGljeUnn1nNsmxQHAgACTAAPYXR0cmlidXRlRmlsdGVyd
AAoTG9yZy9qYXNpZy9jYXMvc2VydmljZXMvQXR0cmlidXRlRmlsdGVyO0wABmxvZ2dlcnQAEkxvcmcvc
2xmNGovTG9nZ2VyO3hwcHNyACJvcmcuc2xmNGouaW1wbC5DYXNEZWxlZ2F0aW5nTG9nZ2VyVc3XNr3j9
dECAAFMAAhkZWxlZ2F0ZXEAfgADeHIAJG9yZy5zbGY0ai5oZWxwZXJzLk1hcmtlcklnbm9yaW5nQmFzZ
X2DsVVOXSebAgAAeHIAIW9yZy5zbGY0ai5oZWxwZXJzLk5hbWVkTG9nZ2VyQmFzZWiSncgcTlV9AgABT
AAEbmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwcHNyACFvcmcuc2xmNGouaW1wbC5Mb2c0akxvZ2dlc
kFkYXB0ZXJVzdc2veP10QIAAVoADHRyYWNlQ2FwYWJsZXhxAH4ABnQANm9yZy5qYXNpZy5jYXMuc2Vyd
mljZXMuUmV0dXJuQWxsQXR0cmlidXRlUmVsZWFzZVBvbGljeQE=]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [casServiceTheme[the theme 
name]], [cn[Service Name1]], [casDescription[Service description]], 
[casEvaluationOrder[123]], [casServiceUrlPattern[https://?.edu/**]], 
[casServiceSsoEnabled[TRUE]], [casRequiredHandlers[handle92, handler8]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEDlTeVNiRVdlVmdtVmRXTUo=]], 
[objectClass[casRegisteredService]]], controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13474046::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@19681327::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@446e79]>

2014-10-06 10:56:45,894 DEBUG [org.ldaptive.AddOperation] - <execute 
response=[org.ldaptive.Response@3531692::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=2] for 
request=[org.ldaptive.AddRequest@16655287::createDn=uid=37639838138141,ou=people
,dc=springframework,dc=org, attributes=[[uid[37639838138141]], 
[casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADZvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
EF0dHJpYnV0ZVJlbGVhc2VQb2xpY3lMmFeoUZ6WYwIAAHhyADVvcmcuamFzaWcuY2FzLnNlcnZpY2VzL
kFic3RyYWN0QXR0cmlidXRlUmVsZWFzZVBvbGljeUnn1nNsmxQHAgACTAAPYXR0cmlidXRlRmlsdGVyd
AAoTG9yZy9qYXNpZy9jYXMvc2VydmljZXMvQXR0cmlidXRlRmlsdGVyO0wABmxvZ2dlcnQAEkxvcmcvc
2xmNGovTG9nZ2VyO3hwcHNyACJvcmcuc2xmNGouaW1wbC5DYXNEZWxlZ2F0aW5nTG9nZ2VyVc3XNr3j9
dECAAFMAAhkZWxlZ2F0ZXEAfgADeHIAJG9yZy5zbGY0ai5oZWxwZXJzLk1hcmtlcklnbm9yaW5nQmFzZ
X2DsVVOXSebAgAAeHIAIW9yZy5zbGY0ai5oZWxwZXJzLk5hbWVkTG9nZ2VyQmFzZWiSncgcTlV9AgABT
AAEbmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwcHNyACFvcmcuc2xmNGouaW1wbC5Mb2c0akxvZ2dlc
kFkYXB0ZXJVzdc2veP10QIAAVoADHRyYWNlQ2FwYWJsZXhxAH4ABnQANm9yZy5qYXNpZy5jYXMuc2Vyd
mljZXMuUmV0dXJuQWxsQXR0cmlidXRlUmVsZWFzZVBvbGljeQE=]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [casServiceTheme[the theme 
name]], [cn[Service Name1]], [casDescription[Service description]], 
[casEvaluationOrder[123]], [casServiceUrlPattern[https://?.edu/**]], 
[casServiceSsoEnabled[TRUE]], [casRequiredHandlers[handle92, handler8]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEDlTeVNiRVdlVmdtVmRXTUo=]], 
[objectClass[casRegisteredService]]], controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13474046::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@19681327::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@446e79]>

2014-10-06 10:56:45,905 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

2014-10-06 10:56:45,913 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@29962994::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@3132552::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@1900569::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1f177ba]>

2014-10-06 10:56:45,919 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@26165031::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for 
request=[org.ldaptive.BindRequest@29962994::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@3132552::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@1900569::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1f177ba]>

2014-10-06 10:56:45,927 DEBUG [org.ldaptive.AddOperation] - <execute 
request=[org.ldaptive.AddRequest@2796335::createDn=uid=37639909415014,ou=people,
dc=springframework,dc=org, attributes=[[uid[37639909415014]], 
[casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
G93ZWRBdHRyaWJ1dGVSZWxlYXNlUG9saWN5r+eTz6Z/GScCAAFMABFhbGxvd2VkQXR0cmlidXRlc3QAE
ExqYXZhL3V0aWwvTGlzdDt4cgA1b3JnLmphc2lnLmNhcy5zZXJ2aWNlcy5BYnN0cmFjdEF0dHJpYnV0Z
VJlbGVhc2VQb2xpY3lJ59ZzbJsUBwIAAkwAD2F0dHJpYnV0ZUZpbHRlcnQAKExvcmcvamFzaWcvY2FzL
3NlcnZpY2VzL0F0dHJpYnV0ZUZpbHRlcjtMAAZsb2dnZXJ0ABJMb3JnL3NsZjRqL0xvZ2dlcjt4cHBzc
gAib3JnLnNsZjRqLmltcGwuQ2FzRGVsZWdhdGluZ0xvZ2dlclXN1za94/XRAgABTAAIZGVsZWdhdGVxA
H4ABHhyACRvcmcuc2xmNGouaGVscGVycy5NYXJrZXJJZ25vcmluZ0Jhc2V9g7FVTl0nmwIAAHhyACFvc
mcuc2xmNGouaGVscGVycy5OYW1lZExvZ2dlckJhc2Vokp3IHE5VfQIAAUwABG5hbWV0ABJMamF2YS9sY
W5nL1N0cmluZzt4cHBzcgAhb3JnLnNsZjRqLmltcGwuTG9nNGpMb2dnZXJBZGFwdGVyVc3XNr3j9dECA
AFaAAx0cmFjZUNhcGFibGV4cQB+AAd0ADpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsbG93Z
WRBdHRyaWJ1dGVSZWxlYXNlUG9saWN5AXNyAB9qYXZhLnV0aWwuQ29sbGVjdGlvbnMkRW1wdHlMaXN0e
rgXtDynnt4CAAB4cA==]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [casServiceTheme[the theme 
name]], [cn[Service Name Regex]], [casDescription[Here is another 
description]], [casEvaluationOrder[123]], [casServiceUrlPattern[^http?://.+]], 
[casServiceSsoEnabled[TRUE]], [casRequiredHandlers[handler1, handler2]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEFNOVmlQa0pMWng3a2dibUg=]], 
[objectClass[casRegisteredService]]], controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@3132552::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@1900569::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1f177ba]>

2014-10-06 10:56:45,940 DEBUG [org.ldaptive.AddOperation] - <execute 
response=[org.ldaptive.Response@21798617::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=2] for 
request=[org.ldaptive.AddRequest@2796335::createDn=uid=37639909415014,ou=people,
dc=springframework,dc=org, attributes=[[uid[37639909415014]], 
[casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
G93ZWRBdHRyaWJ1dGVSZWxlYXNlUG9saWN5r+eTz6Z/GScCAAFMABFhbGxvd2VkQXR0cmlidXRlc3QAE
ExqYXZhL3V0aWwvTGlzdDt4cgA1b3JnLmphc2lnLmNhcy5zZXJ2aWNlcy5BYnN0cmFjdEF0dHJpYnV0Z
VJlbGVhc2VQb2xpY3lJ59ZzbJsUBwIAAkwAD2F0dHJpYnV0ZUZpbHRlcnQAKExvcmcvamFzaWcvY2FzL
3NlcnZpY2VzL0F0dHJpYnV0ZUZpbHRlcjtMAAZsb2dnZXJ0ABJMb3JnL3NsZjRqL0xvZ2dlcjt4cHBzc
gAib3JnLnNsZjRqLmltcGwuQ2FzRGVsZWdhdGluZ0xvZ2dlclXN1za94/XRAgABTAAIZGVsZWdhdGVxA
H4ABHhyACRvcmcuc2xmNGouaGVscGVycy5NYXJrZXJJZ25vcmluZ0Jhc2V9g7FVTl0nmwIAAHhyACFvc
mcuc2xmNGouaGVscGVycy5OYW1lZExvZ2dlckJhc2Vokp3IHE5VfQIAAUwABG5hbWV0ABJMamF2YS9sY
W5nL1N0cmluZzt4cHBzcgAhb3JnLnNsZjRqLmltcGwuTG9nNGpMb2dnZXJBZGFwdGVyVc3XNr3j9dECA
AFaAAx0cmFjZUNhcGFibGV4cQB+AAd0ADpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsbG93Z
WRBdHRyaWJ1dGVSZWxlYXNlUG9saWN5AXNyAB9qYXZhLnV0aWwuQ29sbGVjdGlvbnMkRW1wdHlMaXN0e
rgXtDynnt4CAAB4cA==]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [casServiceTheme[the theme 
name]], [cn[Service Name Regex]], [casDescription[Here is another 
description]], [casEvaluationOrder[123]], [casServiceUrlPattern[^http?://.+]], 
[casServiceSsoEnabled[TRUE]], [casRequiredHandlers[handler1, handler2]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEFNOVmlQa0pMWng3a2dibUg=]], 
[objectClass[casRegisteredService]]], controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@3132552::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@1900569::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1f177ba]>

2014-10-06 10:56:45,953 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

Original comment by misagh.moayyed on 6 Oct 2014 at 5:58

GoogleCodeExporter commented 9 years ago

2014-10-06 10:56:45,962 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@8479520::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9633920::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@17170144::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@a06546]>

2014-10-06 10:56:45,974 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@26260170::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for request=[org.ldaptive.BindRequest@8479520::bindDn=cn=Directory 
Manager, saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9633920::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@17170144::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@a06546]>

2014-10-06 10:56:45,984 DEBUG [org.ldaptive.SearchOperation] - <execute 
request=[org.ldaptive.SearchRequest@1019718355::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@711044294::filter=(objectClass=casRegist
eredService), parameters={}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9633920::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@17170144::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@a06546]>

2014-10-06 10:56:45,995 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: 
SearchRequest(baseDN='ou=people,dc=springframework,dc=org', scope=SUB, 
deref=NEVER, sizeLimit=0, timeLimit=0, 
filter='(objectClass=casRegisteredService)', attrs={objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers})>

2014-10-06 10:56:46,008 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: 
[org.ldaptive.Response@8028787::result=null, resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>

2014-10-06 10:56:46,012 DEBUG [org.ldaptive.SearchOperation] - <execute 
response=[org.ldaptive.Response@7780951::result=[org.ldaptive.SearchResult@-2713
30680::entries=[[dn=uid=37639838138141,ou=people,dc=springframework,dc=org[[uid[
37639838138141]], [casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADZvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
EF0dHJpYnV0ZVJlbGVhc2VQb2xpY3lMmFeoUZ6WYwIAAHhyADVvcmcuamFzaWcuY2FzLnNlcnZpY2VzL
kFic3RyYWN0QXR0cmlidXRlUmVsZWFzZVBvbGljeUnn1nNsmxQHAgACTAAPYXR0cmlidXRlRmlsdGVyd
AAoTG9yZy9qYXNpZy9jYXMvc2VydmljZXMvQXR0cmlidXRlRmlsdGVyO0wABmxvZ2dlcnQAEkxvcmcvc
2xmNGovTG9nZ2VyO3hwcHNyACJvcmcuc2xmNGouaW1wbC5DYXNEZWxlZ2F0aW5nTG9nZ2VyVc3XNr3j9
dECAAFMAAhkZWxlZ2F0ZXEAfgADeHIAJG9yZy5zbGY0ai5oZWxwZXJzLk1hcmtlcklnbm9yaW5nQmFzZ
X2DsVVOXSebAgAAeHIAIW9yZy5zbGY0ai5oZWxwZXJzLk5hbWVkTG9nZ2VyQmFzZWiSncgcTlV9AgABT
AAEbmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwcHNyACFvcmcuc2xmNGouaW1wbC5Mb2c0akxvZ2dlc
kFkYXB0ZXJVzdc2veP10QIAAVoADHRyYWNlQ2FwYWJsZXhxAH4ABnQANm9yZy5qYXNpZy5jYXMuc2Vyd
mljZXMuUmV0dXJuQWxsQXR0cmlidXRlUmVsZWFzZVBvbGljeQE=]], [casServiceTheme[the 
theme name]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [cn[Service Name1]], 
[casEvaluationOrder[123]], [casServiceUrlPattern[https://?.edu/**]], 
[casServiceSsoEnabled[TRUE]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEDlTeVNiRVdlVmdtVmRXTUo=]], 
[casRequiredHandlers[handle92, handler8]], 
[objectClass[casRegisteredService]]], responseControls=null, messageId=2], 
[dn=uid=37639909415014,ou=people,dc=springframework,dc=org[[uid[37639909415014]]
, [casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
G93ZWRBdHRyaWJ1dGVSZWxlYXNlUG9saWN5r+eTz6Z/GScCAAFMABFhbGxvd2VkQXR0cmlidXRlc3QAE
ExqYXZhL3V0aWwvTGlzdDt4cgA1b3JnLmphc2lnLmNhcy5zZXJ2aWNlcy5BYnN0cmFjdEF0dHJpYnV0Z
VJlbGVhc2VQb2xpY3lJ59ZzbJsUBwIAAkwAD2F0dHJpYnV0ZUZpbHRlcnQAKExvcmcvamFzaWcvY2FzL
3NlcnZpY2VzL0F0dHJpYnV0ZUZpbHRlcjtMAAZsb2dnZXJ0ABJMb3JnL3NsZjRqL0xvZ2dlcjt4cHBzc
gAib3JnLnNsZjRqLmltcGwuQ2FzRGVsZWdhdGluZ0xvZ2dlclXN1za94/XRAgABTAAIZGVsZWdhdGVxA
H4ABHhyACRvcmcuc2xmNGouaGVscGVycy5NYXJrZXJJZ25vcmluZ0Jhc2V9g7FVTl0nmwIAAHhyACFvc
mcuc2xmNGouaGVscGVycy5OYW1lZExvZ2dlckJhc2Vokp3IHE5VfQIAAUwABG5hbWV0ABJMamF2YS9sY
W5nL1N0cmluZzt4cHBzcgAhb3JnLnNsZjRqLmltcGwuTG9nNGpMb2dnZXJBZGFwdGVyVc3XNr3j9dECA
AFaAAx0cmFjZUNhcGFibGV4cQB+AAd0ADpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsbG93Z
WRBdHRyaWJ1dGVSZWxlYXNlUG9saWN5AXNyAB9qYXZhLnV0aWwuQ29sbGVjdGlvbnMkRW1wdHlMaXN0e
rgXtDynnt4CAAB4cA==]], [casServiceTheme[the theme name]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [cn[Service Name Regex]], 
[casEvaluationOrder[123]], [casServiceUrlPattern[^http?://.+]], 
[casServiceSsoEnabled[TRUE]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEFNOVmlQa0pMWng3a2dibUg=]], 
[casRequiredHandlers[handler1, handler2]], 
[objectClass[casRegisteredService]]], responseControls=null, messageId=2]], 
references=[]], resultCode=SUCCESS, message=null, matchedDn=null, 
responseControls=null, referralURLs=[], messageId=2] for 
request=[org.ldaptive.SearchRequest@1019718355::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@711044294::filter=(objectClass=casRegist
eredService), parameters={}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@9633920::con
fig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@17170144::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@a06546]>

2014-10-06 10:56:46,044 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

2014-10-06 10:56:46,047 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@25406899::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@57412::confi
g=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@25414619::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1bccaee]>

2014-10-06 10:56:46,060 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@32245088::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for 
request=[org.ldaptive.BindRequest@25406899::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@57412::confi
g=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@25414619::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1bccaee]>

2014-10-06 10:56:46,065 DEBUG [org.ldaptive.SearchOperation] - <execute 
request=[org.ldaptive.SearchRequest@2089736096::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@127046083::filter=(uid={0}), 
parameters={0=37639838138141}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@57412::confi
g=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@25414619::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1bccaee]>

Original comment by misagh.moayyed on 6 Oct 2014 at 5:58

GoogleCodeExporter commented 9 years ago

2014-10-06 10:56:46,074 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: 
SearchRequest(baseDN='ou=people,dc=springframework,dc=org', scope=SUB, 
deref=NEVER, sizeLimit=0, timeLimit=0, filter='(uid=37639838138141)', 
attrs={objectClass, casServiceUrlPattern, uid, cn, casServiceEnabled, 
casServiceSsoEnabled, casServiceTheme, casServiceProxyPolicy, 
casUsernameAttributeProvider, casAttributeReleasePolicy, casEvaluationOrder, 
casRequiredHandlers})>

2014-10-06 10:56:46,081 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: 
[org.ldaptive.Response@22206221::result=null, resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>

2014-10-06 10:56:46,083 DEBUG [org.ldaptive.SearchOperation] - <execute 
response=[org.ldaptive.Response@5455807::result=[org.ldaptive.SearchResult@-1008
216502::entries=[[dn=uid=37639838138141,ou=people,dc=springframework,dc=org[[uid
[37639838138141]], [casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADZvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
EF0dHJpYnV0ZVJlbGVhc2VQb2xpY3lMmFeoUZ6WYwIAAHhyADVvcmcuamFzaWcuY2FzLnNlcnZpY2VzL
kFic3RyYWN0QXR0cmlidXRlUmVsZWFzZVBvbGljeUnn1nNsmxQHAgACTAAPYXR0cmlidXRlRmlsdGVyd
AAoTG9yZy9qYXNpZy9jYXMvc2VydmljZXMvQXR0cmlidXRlRmlsdGVyO0wABmxvZ2dlcnQAEkxvcmcvc
2xmNGovTG9nZ2VyO3hwcHNyACJvcmcuc2xmNGouaW1wbC5DYXNEZWxlZ2F0aW5nTG9nZ2VyVc3XNr3j9
dECAAFMAAhkZWxlZ2F0ZXEAfgADeHIAJG9yZy5zbGY0ai5oZWxwZXJzLk1hcmtlcklnbm9yaW5nQmFzZ
X2DsVVOXSebAgAAeHIAIW9yZy5zbGY0ai5oZWxwZXJzLk5hbWVkTG9nZ2VyQmFzZWiSncgcTlV9AgABT
AAEbmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwcHNyACFvcmcuc2xmNGouaW1wbC5Mb2c0akxvZ2dlc
kFkYXB0ZXJVzdc2veP10QIAAVoADHRyYWNlQ2FwYWJsZXhxAH4ABnQANm9yZy5qYXNpZy5jYXMuc2Vyd
mljZXMuUmV0dXJuQWxsQXR0cmlidXRlUmVsZWFzZVBvbGljeQE=]], [casServiceTheme[the 
theme name]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [cn[Service Name1]], 
[casEvaluationOrder[123]], [casServiceUrlPattern[https://?.edu/**]], 
[casServiceSsoEnabled[TRUE]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEDlTeVNiRVdlVmdtVmRXTUo=]], 
[casRequiredHandlers[handle92, handler8]], 
[objectClass[casRegisteredService]]], responseControls=null, messageId=2]], 
references=[]], resultCode=SUCCESS, message=null, matchedDn=null, 
responseControls=null, referralURLs=[], messageId=2] for 
request=[org.ldaptive.SearchRequest@2089736096::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@127046083::filter=(uid={0}), 
parameters={0=37639838138141}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@57412::confi
g=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@25414619::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1bccaee]>

2014-10-06 10:56:46,097 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

2014-10-06 10:56:46,101 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@28294599::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13920037::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@12568891::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1347429]>

2014-10-06 10:56:46,107 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@10669390::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for 
request=[org.ldaptive.BindRequest@28294599::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13920037::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@12568891::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1347429]>

2014-10-06 10:56:46,112 DEBUG [org.ldaptive.SearchOperation] - <execute 
request=[org.ldaptive.SearchRequest@2089736096::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@127046083::filter=(uid={0}), 
parameters={0=37639838138141}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13920037::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@12568891::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1347429]>

2014-10-06 10:56:46,119 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <performing search: 
SearchRequest(baseDN='ou=people,dc=springframework,dc=org', scope=SUB, 
deref=NEVER, sizeLimit=0, timeLimit=0, filter='(uid=37639838138141)', 
attrs={objectClass, casServiceUrlPattern, uid, cn, casServiceEnabled, 
casServiceSsoEnabled, casServiceTheme, casServiceProxyPolicy, 
casUsernameAttributeProvider, casAttributeReleasePolicy, casEvaluationOrder, 
casRequiredHandlers})>

2014-10-06 10:56:46,122 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <created response: 
[org.ldaptive.Response@30136561::result=null, resultCode=SUCCESS, message=null, 
matchedDn=null, responseControls=null, referralURLs=[], messageId=2]>

2014-10-06 10:56:46,124 DEBUG [org.ldaptive.SearchOperation] - <execute 
response=[org.ldaptive.Response@29381025::result=[org.ldaptive.SearchResult@-100
8216502::entries=[[dn=uid=37639838138141,ou=people,dc=springframework,dc=org[[ui
d[37639838138141]], [casServiceEnabled[TRUE]], 
[casAttributeReleasePolicy[rO0ABXNyADZvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJldHVybkFsb
EF0dHJpYnV0ZVJlbGVhc2VQb2xpY3lMmFeoUZ6WYwIAAHhyADVvcmcuamFzaWcuY2FzLnNlcnZpY2VzL
kFic3RyYWN0QXR0cmlidXRlUmVsZWFzZVBvbGljeUnn1nNsmxQHAgACTAAPYXR0cmlidXRlRmlsdGVyd
AAoTG9yZy9qYXNpZy9jYXMvc2VydmljZXMvQXR0cmlidXRlRmlsdGVyO0wABmxvZ2dlcnQAEkxvcmcvc
2xmNGovTG9nZ2VyO3hwcHNyACJvcmcuc2xmNGouaW1wbC5DYXNEZWxlZ2F0aW5nTG9nZ2VyVc3XNr3j9
dECAAFMAAhkZWxlZ2F0ZXEAfgADeHIAJG9yZy5zbGY0ai5oZWxwZXJzLk1hcmtlcklnbm9yaW5nQmFzZ
X2DsVVOXSebAgAAeHIAIW9yZy5zbGY0ai5oZWxwZXJzLk5hbWVkTG9nZ2VyQmFzZWiSncgcTlV9AgABT
AAEbmFtZXQAEkxqYXZhL2xhbmcvU3RyaW5nO3hwcHNyACFvcmcuc2xmNGouaW1wbC5Mb2c0akxvZ2dlc
kFkYXB0ZXJVzdc2veP10QIAAVoADHRyYWNlQ2FwYWJsZXhxAH4ABnQANm9yZy5qYXNpZy5jYXMuc2Vyd
mljZXMuUmV0dXJuQWxsQXR0cmlidXRlUmVsZWFzZVBvbGljeQE=]], [casServiceTheme[the 
theme name]], 
[casServiceProxyPolicy[rO0ABXNyADlvcmcuamFzaWcuY2FzLnNlcnZpY2VzLlJlZnVzZVJlZ2lzd
GVyZWRTZXJ2aWNlUHJveHlQb2xpY3mwpABuw1jmVAIAAHhw]], [cn[Service Name1]], 
[casEvaluationOrder[123]], [casServiceUrlPattern[https://?.edu/**]], 
[casServiceSsoEnabled[TRUE]], 
[casUsernameAttributeProvider[rO0ABXNyAEpvcmcuamFzaWcuY2FzLnNlcnZpY2VzLkFub255bW
91c1JlZ2lzdGVyZWRTZXJ2aWNlVXNlcm5hbWVBdHRyaWJ1dGVQcm92aWRlcmHYRqcetrXDAgABTAAVcG
Vyc2lzdGVudElkR2VuZXJhdG9ydAA+TG9yZy9qYXNpZy9jYXMvYXV0aGVudGljYXRpb24vcHJpbmNpcG
FsL1BlcnNpc3RlbnRJZEdlbmVyYXRvcjt4cHNyAFBvcmcuamFzaWcuY2FzLmF1dGhlbnRpY2F0aW9uLn
ByaW5jaXBhbC5TaGliYm9sZXRoQ29tcGF0aWJsZVBlcnNpc3RlbnRJZEdlbmVyYXRvclXN2yFPd3ARAg
ABWwAEc2FsdHQAAltCeHB1cgACW0Ks8xf4BghU4AIAAHhwAAAAEDlTeVNiRVdlVmdtVmRXTUo=]], 
[casRequiredHandlers[handle92, handler8]], 
[objectClass[casRegisteredService]]], responseControls=null, messageId=2]], 
references=[]], resultCode=SUCCESS, message=null, matchedDn=null, 
responseControls=null, referralURLs=[], messageId=2] for 
request=[org.ldaptive.SearchRequest@2089736096::baseDn=ou=people,dc=springframew
ork,dc=org, 
searchFilter=[org.ldaptive.SearchFilter@127046083::filter=(uid={0}), 
parameters={0=37639838138141}], returnAttributes=[objectClass, 
casServiceUrlPattern, uid, cn, casServiceEnabled, casServiceSsoEnabled, 
casServiceTheme, casServiceProxyPolicy, casUsernameAttributeProvider, 
casAttributeReleasePolicy, casEvaluationOrder, casRequiredHandlers], 
searchScope=SUBTREE, timeLimit=0, sizeLimit=0, derefAliases=null, 
typesOnly=false, binaryAttributes=null, sortBehavior=UNORDERED, 
searchEntryHandlers=null, searchReferenceHandlers=null, controls=null, 
followReferrals=false, intermediateResponseHandlers=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@13920037::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@12568891::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1347429]>

2014-10-06 10:56:46,141 DEBUG [org.ldaptive.BindOperation] - <execute 
request=[org.ldaptive.BindRequest@20078132::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@29799377::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@4691358::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1afda10]>

2014-10-06 10:56:46,149 DEBUG [org.ldaptive.BindOperation] - <execute 
response=[org.ldaptive.Response@9968918::result=null, resultCode=SUCCESS, 
message=null, matchedDn=null, responseControls=null, referralURLs=[], 
messageId=1] for 
request=[org.ldaptive.BindRequest@20078132::bindDn=cn=Directory Manager, 
saslConfig=null, controls=null] with 
connection=[org.ldaptive.DefaultConnectionFactory$DefaultConnection@29799377::co
nfig=[org.ldaptive.ConnectionConfig@19994160::ldapUrl=ldap://localhost:389, 
connectTimeout=3000, responseTimeout=-1, 
sslConfig=[org.ldaptive.ssl.SslConfig@2201866::credentialConfig=[org.ldaptive.ss
l.KeyStoreCredentialConfig@-194287243::trustStore=null, trustStoreType=null, 
trustStoreAliases=null, keyStore=null, keyStoreType=null, 
keyStoreAliases=null], trustManagers=null, enabledCipherSuites=null, 
enabledProtocols=null, handshakeCompletedListeners=null], useSSL=false, 
useStartTLS=false, 
connectionInitializer=[org.ldaptive.BindConnectionInitializer@26425219::bindDn=c
n=Directory Manager, bindSaslConfig=null, bindControls=null]], 
providerConnectionFactory=[org.ldaptive.provider.unboundid.UnboundIDConnectionFa
ctory@4691358::metadata=[ldapUrl=ldap://localhost:389, count=1], 
providerConfig=[org.ldaptive.provider.unboundid.UnboundIDProviderConfig@16934250
::operationExceptionResultCodes=[SERVER_DOWN], properties={}, 
connectionStrategy=org.ldaptive.provider.ConnectionStrategies$DefaultConnectionS
trategy@1fc9052, 
controlProcessor=org.ldaptive.provider.ControlProcessor@f7b28a, 
connectionOptions=null, socketFactory=null, 
searchIgnoreResultCodes=[TIME_LIMIT_EXCEEDED, SIZE_LIMIT_EXCEEDED]]], 
providerConnection=org.ldaptive.provider.unboundid.UnboundIDConnection@1afda10]>

2014-10-06 10:56:46,157 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

2014-10-06 10:56:46,158 DEBUG 
[org.ldaptive.provider.unboundid.UnboundIDConnection] - <Disconnection 
received: DisconnectType(name='UNBIND', resultCode='82 (local error)', 
description='The client closed the connection with an unbind request.')>

java.lang.RuntimeException: java.lang.IllegalArgumentException: Value cannot be 
null
    at org.jasig.cas.adaptors.ldap.services.DefaultLdapServiceMapper.mapFromRegisteredService(DefaultLdapServiceMapper.java:139)
    at org.jasig.cas.adaptors.ldap.services.LdapServiceRegistryDao.update(LdapServiceRegistryDao.java:129)
    at org.jasig.cas.adaptors.ldap.services.LdapServiceRegistryDao.save(LdapServiceRegistryDao.java:90)
    at org.jasig.cas.adaptors.ldap.services.LdapServiceRegistryDaoTests.testServices(LdapServiceRegistryDaoTests.java:104)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
    at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
    at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
    at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
    at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
    at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
    at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
    at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
    at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
    at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
    at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
    at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
    at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
    at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
    at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
    at org.junit.runner.JUnitCore.run(JUnitCore.java:160)
    at com.intellij.junit4.JUnit4IdeaTestRunner.startRunnerWithArgs(JUnit4IdeaTestRunner.java:74)
    at com.intellij.rt.execution.junit.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:211)
    at com.intellij.rt.execution.junit.JUnitStarter.main(JUnitStarter.java:67)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
    at com.intellij.rt.execution.application.AppMain.main(AppMain.java:134)
Caused by: java.lang.IllegalArgumentException: Value cannot be null
    at org.ldaptive.LdapAttribute$LdapAttributeValues.checkValue(LdapAttribute.java:809)
    at org.ldaptive.LdapAttribute$LdapAttributeValues.add(LdapAttribute.java:778)
    at org.ldaptive.LdapAttribute.addStringValue(LdapAttribute.java:319)
    at org.ldaptive.LdapAttribute.<init>(LdapAttribute.java:118)
    at org.jasig.cas.adaptors.ldap.services.DefaultLdapServiceMapper.mapFromRegisteredService(DefaultLdapServiceMapper.java:109)
    ... 32 more

Process finished with exit code -1

Original comment by misagh.moayyed on 6 Oct 2014 at 5:59

GoogleCodeExporter commented 9 years ago
That attribute is not listed in your return attributes:

returnAttributes=[objectClass, casServiceUrlPattern, uid, cn, 
casServiceEnabled, casServiceSsoEnabled, casServiceTheme, 
casServiceProxyPolicy, casUsernameAttributeProvider, casAttributeReleasePolicy, 
casEvaluationOrder, casRequiredHandlers]

Original comment by dfis...@gmail.com on 6 Oct 2014 at 6:12

GoogleCodeExporter commented 9 years ago
Why, that is strange because nowhere else in the config am I listing any return 
attributes. I imagine the absense of the configuration notes that everything 
should be returned on the entry, right? 

Do the logs show that the "description" attribute is persisted correctly? Maybe 
the issue lies with persistence and not with retrieval? 

Original comment by misagh.moayyed on 6 Oct 2014 at 6:18

GoogleCodeExporter commented 9 years ago
It looks like the logs do show that I have a casDescription going out, but I 
dont see why everything else is retrieved BUT that one particular attribute. 

Description is defined as such:

attributeTypes: ( 2.5.4.13
  NAME 'description'
  EQUALITY caseIgnoreMatch
  SUBSTR caseIgnoreSubstringsMatch
  SYNTAX 1.3.6.1.4.1.1466.115.121.1.15
  X-ORIGIN 'RFC 4519' )

and the CAS objectclass is such:

objectClasses: ( 1.6.7.9.0.1.4563.1.4.7
  NAME 'casRegisteredService'
  SUP top
  STRUCTURAL
  MUST ( uid $
         casServiceUrlPattern $
         cn $
         description $
         casServiceEnabled $
         casServiceSsoEnabled $
         casServiceAnonymousAccess $
         casServiceTheme $
         casUsernameAttribute $
         casEvaluationOrder $
         casRequiredHandlers $
         casAttributeReleasePolicy $
         casServiceProxyPolicy $
         userPKCS12 )
  X-ORIGIN 'RFC 3112' )

The objectclass attribute is also set by the code as an attribute on the entry. 

Original comment by misagh.moayyed on 6 Oct 2014 at 6:22

GoogleCodeExporter commented 9 years ago
I see this attribute gets added:
[casDescription[Service description]]

but I don't see an attribute called 'serviceDescriptionAttribute'

Original comment by dfis...@gmail.com on 6 Oct 2014 at 6:25

GoogleCodeExporter commented 9 years ago
Post a github link to the code that performs the search.

Original comment by dfis...@gmail.com on 6 Oct 2014 at 6:28

GoogleCodeExporter commented 9 years ago
Ah, I "may" have discovered a bug:

When the load operation is called, and the search request is constructed, this 
happens:

final SearchOperation searchOperation = new SearchOperation(connection);
final SearchRequest request = newRequest(filter);

where the filter is basically: new SearchFilter(this.loadFilter)

newRequest() does this:

private SearchRequest newRequest(final SearchFilter filter) {
        final SearchRequest sr = new SearchRequest(this.searchRequest.getBaseDn(), filter);
        sr.setBinaryAttributes(this.searchRequest.getBinaryAttributes());
        sr.setDerefAliases(this.searchRequest.getDerefAliases());
        sr.setSearchEntryHandlers(this.searchRequest.getSearchEntryHandlers());
               sr.setSearchReferenceHandlers(this.searchRequest.getSearchReferenceHandlers());
        sr.setFollowReferrals(this.searchRequest.getFollowReferrals());
        sr.setReturnAttributes(this.searchRequest.getReturnAttributes());
        sr.setSearchScope(this.searchRequest.getSearchScope());
        sr.setSizeLimit(this.searchRequest.getSizeLimit());
        sr.setSortBehavior(this.searchRequest.getSortBehavior());
        sr.setTimeLimit(this.searchRequest.getTimeLimit());
        sr.setTypesOnly(this.searchRequest.getTypesOnly());
        sr.setControls(this.searchRequest.getControls());
        return sr;
    }

So, if I comment out the line that sets the return attributes, all my tests 
pass correctly. Even though there is nothing in the list of return attributes, 
I think when it's explicitly set, an empty list signifies that "nothing" should 
be returned.

Should this be changed? 

Original comment by misagh.moayyed on 6 Oct 2014 at 6:28

GoogleCodeExporter commented 9 years ago
I'll post a link in a second.

Original comment by misagh.moayyed on 6 Oct 2014 at 6:30

GoogleCodeExporter commented 9 years ago
The class that does the mapping from/to ldap entries:

https://github.com/Unicon/cas/blob/ldap-server-uboundid/cas-server-support-ldap/
src/main/java/org/jasig/cas/adaptors/ldap/services/DefaultLdapServiceMapper.java

The load operation:
https://github.com/Unicon/cas/blob/ldap-server-uboundid/cas-server-support-ldap/
src/main/java/org/jasig/cas/adaptors/ldap/services/LdapServiceRegistryDao.java#L
171

It's strange that setting return attributes only affects "description" and 
nothing else.

Original comment by misagh.moayyed on 6 Oct 2014 at 6:32

GoogleCodeExporter commented 9 years ago
P.S: I did try to change the name of the attribute to casDescription just for 
kicks to see if that causes anything to change, and it did not. 

This:
attrs.add(new LdapAttribute(this.serviceDescriptionAttribute, 
svc.getDescription()));

Really is:
attrs.add(new LdapAttribute("description", svc.getDescription()));

Original comment by misagh.moayyed on 6 Oct 2014 at 6:39

GoogleCodeExporter commented 9 years ago
By default a search request will return all user attributes.
So don't set returnAttributes if that is what you want.
The logs you posted indicate that you are in fact setting return attributes.
Is another component invoking LdapServiceRegistryDao#setSearchRequest() ?

Original comment by dfis...@gmail.com on 6 Oct 2014 at 6:41

GoogleCodeExporter commented 9 years ago
FYI, ldaptive 1.0.4 shipped with a persistence API.
http://www.ldaptive.org/docs/guide/beans/persistence

Should reduce the amount of code you've got.

Original comment by dfis...@gmail.com on 6 Oct 2014 at 6:45

GoogleCodeExporter commented 9 years ago
>By default a search request will return all user attributes.
ِDoes that only act on null, or does it also intend to consider an empty-list 
to mean that all user attributes should be returned? 

In this particular case, we may have no need to set those again, because there 
is no way for them to be configured anywhere by the user, but I'd propose that 
even IF this was a requirement, perhaps an empty-list should also indicate that 
ALL should be returned.

Thanks for the pointer to the persistence API. Care to point me to the docs 
where this is all configured? Google would probably turn something up though. 

Original comment by misagh.moayyed on 6 Oct 2014 at 6:50

GoogleCodeExporter commented 9 years ago
>>By default a search request will return all user attributes.
ِ>Does that only act on null, or does it also intend to consider an empty-list 
to mean that all user attributes should be returned? 
That behavior is actually provider specific, unfortunately.
For the UnboundID provider, null returns all user attributes.
Your logs indicate that something is setting it.
I recommend that you use the ReturnAttributes enum to declare exactly what you 
want.
In this case, ReturnAttributes#ALL_USER

>Thanks for the pointer to the persistence API. Care to point me to the docs 
where this is all configured? Google would probably turn something up though.

Basically just here:
http://www.ldaptive.org/docs/guide/beans/mapping
and here;
http://www.ldaptive.org/docs/guide/beans/persistence

Not much to it, annotate your class then use the DefaultLdapEntryManager to 
find, persist, and delete.

Original comment by dfis...@gmail.com on 6 Oct 2014 at 7:04

GoogleCodeExporter commented 9 years ago
Excellent thank you.

What would be the component that ReturnAttributes.ALL_USER would be passed or 
set for? 

I guess I could simply just do:
sr.setReturnAttributes(ReturnAttributes.ALL_USER.value());

Which seems to work just fine. Thanks!

I'll take a look at the API and see what can be done there.

Original comment by misagh.moayyed on 6 Oct 2014 at 7:17

GoogleCodeExporter commented 9 years ago
Goes without saying that you can mark this as closed/resolved, etc. 

Original comment by misagh.moayyed on 6 Oct 2014 at 7:18