SuccessConsole Output

Skipping 489 KB.. Full Log
.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [ERROR]: Error removing entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 726
    Del request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@15b06546    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:102)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [ERROR]: Error removing entry: cn=testGroup,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 728
    Del request
        Entry : 'cn=testGroup,dc=dataone,dc=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@ebf312b    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=testGroup,dc=dataone,dc=org]; remaining name 'cn=testGroup,dc=dataone,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:107)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [WARN]: Subject not a valid DN: http://orcid.org/0000-0003-1758-9950 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: Created DN from subject: uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [WARN]: Subject not a valid DN: http://orcid.org/0000-0003-1758-9950 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: Created DN from subject: uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [WARN]: Problem checking attribute: uid [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 732
    Compare request
        Entry : 'uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org'
        Attribute description : 'uid'
        Attribute value : 'http://orcid.org/0000-0003-1758-9950org.apache.directory.api.ldap.model.message.CompareRequestImpl@6940f935    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org]; remaining name '"uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org"'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.updateOrcidAccount(CNIdentityLDAPImplTestUnit.java:1106)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [WARN]: could not parse attribute from string: uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.substring(String.java:1904)
	at org.dataone.cn.ldap.LDAPService.parseAttribute(LDAPService.java:171)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:837)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.updateOrcidAccount(CNIdentityLDAPImplTestUnit.java:1106)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [WARN]: Did not find matching attribute: mail=test2@dataone.org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:03: [WARN]: Subject not a valid DN: http://orcid.org/0000-0003-1758-9950 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: Created DN from subject: uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [WARN]: could not parse attribute from string: uid=http://orcid.org/0000-0003-1758-9950,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.substring(String.java:1904)
	at org.dataone.cn.ldap.LDAPService.parseAttribute(LDAPService.java:171)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.updateAccount(CNIdentityLDAPImpl.java:670)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.updateOrcidAccount(CNIdentityLDAPImplTestUnit.java:1117)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [INFO]: 6 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [ERROR]: Error removing entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 743
    Del request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@b3349e01    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:97)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [ERROR]: Error removing entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 745
    Del request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@15b1d1e9    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:102)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [ERROR]: Error removing entry: cn=testGroup,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 747
    Del request
        Entry : 'cn=testGroup,dc=dataone,dc=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@ec09dce    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=testGroup,dc=dataone,dc=org]; remaining name 'cn=testGroup,dc=dataone,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:107)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [WARN]: Problem checking attribute: CN [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 753
    Compare request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
        Attribute description : 'CN'
        Attribute value : '+aQVbUA-org.apache.directory.api.ldap.model.message.CompareRequestImpl@21ab386d    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.listSubjects(CNIdentityLDAPImplTestUnit.java:1164)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: 1 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: The start index is 0 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: The count is null or equal or less than 0=================== [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [INFO]: the count value is ===============100 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [WARN]: Failed to normalize filter value: String index out of range: -1 [org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor]
org.apache.directory.api.ldap.model.exception.LdapInvalidDnException: String index out of range: -1
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:56)
	at org.apache.directory.api.ldap.model.name.Dn.parseInternal(Dn.java:1394)
	at org.apache.directory.api.ldap.model.name.Dn.<init>(Dn.java:289)
	at org.apache.directory.api.ldap.model.schema.normalizers.UniqueMemberNormalizer.normalize(UniqueMemberNormalizer.java:139)
	at org.apache.directory.api.ldap.model.schema.normalizers.ConcreteNameComponentNormalizer.normalizeByName(ConcreteNameComponentNormalizer.java:114)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.normalizeValue(FilterNormalizingVisitor.java:248)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitSimpleNode(FilterNormalizingVisitor.java:312)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:579)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitBranchNode(FilterNormalizingVisitor.java:496)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:569)
	at org.apache.directory.api.ldap.model.filter.BranchNode.accept(BranchNode.java:225)
	at org.apache.directory.server.core.normalization.NormalizationInterceptor.search(NormalizationInterceptor.java:290)
	at org.apache.directory.server.core.DefaultOperationManager.search(DefaultOperationManager.java:1342)
	at org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1122)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.doSimpleSearch(SearchRequestHandler.java:810)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleIgnoringReferrals(SearchRequestHandler.java:1164)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:201)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:92)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
	at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
	at org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:216)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
	at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
	at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.charAt(String.java:658)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.attributeTypeAndValue(AntlrDnParser.java:480)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedName(AntlrDnParser.java:237)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedNames(AntlrDnParser.java:302)
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:52)
	... 30 more
20170130-19:56:03: [WARN]: undefined filter based on undefined attributeType not evaluted at all.  Returning empty enumeration. [org.apache.directory.server.core.normalization.NormalizationInterceptor]
20170130-19:56:03: [INFO]: 11 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:03: [ERROR]: Error removing entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 813
    Del request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@b339dd67    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:97)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [ERROR]: Error removing entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 815
    Del request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@15b7114f    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:102)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [ERROR]: Error removing entry: cn=testGroup,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 817
    Del request
        Entry : 'cn=testGroup,dc=dataone,dc=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@ec5dd34    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=testGroup,dc=dataone,dc=org]; remaining name 'cn=testGroup,dc=dataone,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:107)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:03: [INFO]: mapIdentity()- [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:03: [INFO]: mapIdentity()-identityService.registerAccount [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:03: [WARN]: Problem checking attribute: CN [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 835
    Compare request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
        Attribute description : 'CN'
        Attribute value : '+aQVbUA-org.apache.directory.api.ldap.model.message.CompareRequestImpl@21b15e1f    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.mapIdentity(CNIdentityLDAPImplTestUnit.java:1255)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [INFO]: mapIdentity()-identityService.registerAccount [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [WARN]: Problem checking attribute: CN [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 842
    Compare request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
        Attribute description : 'CN'
        Attribute value : 'Test2org.apache.directory.api.ldap.model.message.CompareRequestImpl@3ea1b748    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.mapIdentity(CNIdentityLDAPImplTestUnit.java:1258)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [INFO]: mapIdentity()-identityService.mapIdentity [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]: 3 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [INFO]: mapIdentity()-identityService.mapIdentity [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]:   nodelist refresh: new cached time: Jan 30, 2017 7:56:04 PM [org.dataone.service.cn.v2.impl.NodeRegistryServiceImpl]
20170130-19:56:04: [WARN]: Did not find matching attribute: equivalentIdentity=CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:04: [INFO]: 3 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [INFO]: mapIdentity()-checkAttribute(p1.getValue [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]: mapIdentity()-checkAttribute(p2.getValue [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]: mapIdentity()-removeSubject(p1) [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]: mapIdentity()-removeSubject(p2) [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]: mapIdentity()-deleteNode [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [INFO]: mapIdentity()-Finished [org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit]
20170130-19:56:04: [ERROR]: Error removing entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 860
    Del request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@b33d6366    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:97)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [ERROR]: Error removing entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 862
    Del request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@15ba974e    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:102)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [ERROR]: Error removing entry: cn=testGroup,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 864
    Del request
        Entry : 'cn=testGroup,dc=dataone,dc=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@ec96333    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=testGroup,dc=dataone,dc=org]; remaining name 'cn=testGroup,dc=dataone,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:107)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [WARN]: Problem checking attribute: cn [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 882
    Compare request
        Entry : 'cn=\+aQVbUA-,o=Test,c=US,dc=cilogon,dc=org'
        Attribute description : 'cn'
        Attribute value : '+aQVbUA-org.apache.directory.api.ldap.model.message.CompareRequestImpl@2201a81e    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=\+aQVbUA-,o=Test,c=US,dc=cilogon,dc=org]; remaining name 'cn=\+aQVbUA-,o=Test,c=US,dc=cilogon,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.getSubjectInfoIdentityTwoWay(CNIdentityLDAPImplTestUnit.java:1365)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [WARN]: Problem checking attribute: cn [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 889
    Compare request
        Entry : 'cn=Test2,o=Test,c=US,dc=cilogon,dc=org'
        Attribute description : 'cn'
        Attribute value : 'Test2org.apache.directory.api.ldap.model.message.CompareRequestImpl@3ef20147    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=Test2,o=Test,c=US,dc=cilogon,dc=org]; remaining name 'cn=Test2,o=Test,c=US,dc=cilogon,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.getSubjectInfoIdentityTwoWay(CNIdentityLDAPImplTestUnit.java:1367)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:04: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [WARN]: Did not find matching attribute: equivalentIdentityRequest=cn=Test2,o=Test,c=US,dc=cilogon,dc=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:04: [WARN]: Did not find matching attribute: equivalentIdentityRequest=cn=\5c+aQVbUA-,o=Test,c=US,dc=cilogon,dc=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:04: [INFO]: 4 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:04: [WARN]: Did not find matching attribute: equivalentIdentity=cn=Test2,o=Test,c=US,dc=cilogon,dc=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:04: [WARN]: Did not find matching attribute: equivalentIdentity=cn=\5c+aQVbUA-,o=Test,c=US,dc=cilogon,dc=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:04: [WARN]: AbandonableRequest with messageId 903 not found in outstandingRequests. [org.apache.directory.server.ldap.LdapSession]
20170130-19:56:05: [INFO]: 5 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [WARN]: AbandonableRequest with messageId 911 not found in outstandingRequests. [org.apache.directory.server.ldap.LdapSession]
20170130-19:56:05: [WARN]: Failed to normalize filter value: String index out of range: -1 [org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor]
org.apache.directory.api.ldap.model.exception.LdapInvalidDnException: String index out of range: -1
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:56)
	at org.apache.directory.api.ldap.model.name.Dn.parseInternal(Dn.java:1394)
	at org.apache.directory.api.ldap.model.name.Dn.<init>(Dn.java:289)
	at org.apache.directory.api.ldap.model.schema.normalizers.UniqueMemberNormalizer.normalize(UniqueMemberNormalizer.java:139)
	at org.apache.directory.api.ldap.model.schema.normalizers.ConcreteNameComponentNormalizer.normalizeByName(ConcreteNameComponentNormalizer.java:114)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.normalizeValue(FilterNormalizingVisitor.java:248)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitSimpleNode(FilterNormalizingVisitor.java:312)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:579)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitBranchNode(FilterNormalizingVisitor.java:496)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:569)
	at org.apache.directory.api.ldap.model.filter.BranchNode.accept(BranchNode.java:225)
	at org.apache.directory.server.core.normalization.NormalizationInterceptor.search(NormalizationInterceptor.java:290)
	at org.apache.directory.server.core.DefaultOperationManager.search(DefaultOperationManager.java:1342)
	at org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1122)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.doSimpleSearch(SearchRequestHandler.java:810)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleIgnoringReferrals(SearchRequestHandler.java:1164)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:201)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:92)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
	at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
	at org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:216)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
	at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
	at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.charAt(String.java:658)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.attributeTypeAndValue(AntlrDnParser.java:480)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedName(AntlrDnParser.java:237)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedNames(AntlrDnParser.java:302)
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:52)
	... 30 more
20170130-19:56:05: [WARN]: undefined filter based on undefined attributeType not evaluted at all.  Returning empty enumeration. [org.apache.directory.server.core.normalization.NormalizationInterceptor]
20170130-19:56:05: [INFO]: 9 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [ERROR]: Error removing entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 925
    Del request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@b34242d7    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:97)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:05: [ERROR]: Error removing entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 927
    Del request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@15bf76bf    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:102)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:05: [ERROR]: Error removing entry: cn=testGroup,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 929
    Del request
        Entry : 'cn=testGroup,dc=dataone,dc=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@ece42a4    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=testGroup,dc=dataone,dc=org]; remaining name 'cn=testGroup,dc=dataone,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:107)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:05: [WARN]: Problem checking attribute: CN [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : COMPARE_REQUEST
Message ID : 935
    Compare request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
        Attribute description : 'CN'
        Attribute value : '+aQVbUA-org.apache.directory.api.ldap.model.message.CompareRequestImpl@21b8dd43    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.searchAux(LdapCtx.java:1845)
	at com.sun.jndi.ldap.LdapCtx.c_search(LdapCtx.java:1773)
	at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_search(ComponentDirContext.java:386)
	at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.search(PartialCompositeDirContext.java:356)
	at javax.naming.directory.InitialDirContext.search(InitialDirContext.java:276)
	at org.dataone.cn.ldap.LDAPService.checkAttribute(LDAPService.java:95)
	at org.dataone.cn.ldap.LDAPService.constructTree(LDAPService.java:213)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl.registerAccount(CNIdentityLDAPImpl.java:830)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.editGroupMissingMember(CNIdentityLDAPImplTestUnit.java:151)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:05: [INFO]: 8 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]: 1 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [WARN]: Failed to normalize filter value: String index out of range: -1 [org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor]
org.apache.directory.api.ldap.model.exception.LdapInvalidDnException: String index out of range: -1
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:56)
	at org.apache.directory.api.ldap.model.name.Dn.parseInternal(Dn.java:1394)
	at org.apache.directory.api.ldap.model.name.Dn.<init>(Dn.java:289)
	at org.apache.directory.api.ldap.model.schema.normalizers.UniqueMemberNormalizer.normalize(UniqueMemberNormalizer.java:139)
	at org.apache.directory.api.ldap.model.schema.normalizers.ConcreteNameComponentNormalizer.normalizeByName(ConcreteNameComponentNormalizer.java:114)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.normalizeValue(FilterNormalizingVisitor.java:248)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitSimpleNode(FilterNormalizingVisitor.java:312)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:579)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitBranchNode(FilterNormalizingVisitor.java:496)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:569)
	at org.apache.directory.api.ldap.model.filter.BranchNode.accept(BranchNode.java:225)
	at org.apache.directory.server.core.normalization.NormalizationInterceptor.search(NormalizationInterceptor.java:290)
	at org.apache.directory.server.core.DefaultOperationManager.search(DefaultOperationManager.java:1342)
	at org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1122)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.doSimpleSearch(SearchRequestHandler.java:810)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleIgnoringReferrals(SearchRequestHandler.java:1164)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:201)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:92)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
	at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
	at org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:216)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
	at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
	at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.charAt(String.java:658)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.attributeTypeAndValue(AntlrDnParser.java:480)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedName(AntlrDnParser.java:237)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedNames(AntlrDnParser.java:302)
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:52)
	... 30 more
20170130-19:56:05: [WARN]: undefined filter based on undefined attributeType not evaluted at all.  Returning empty enumeration. [org.apache.directory.server.core.normalization.NormalizationInterceptor]
20170130-19:56:05: [INFO]: 9 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]: 2 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [WARN]: Could not find LDAP entry for DN: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:05: [WARN]: Could not check whether member subject is a group: null [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]: 1 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]: The start index is 0 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]: The count is null or equal or less than 0=================== [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]: the count value is ===============100 [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [WARN]: Failed to normalize filter value: String index out of range: -1 [org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor]
org.apache.directory.api.ldap.model.exception.LdapInvalidDnException: String index out of range: -1
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:56)
	at org.apache.directory.api.ldap.model.name.Dn.parseInternal(Dn.java:1394)
	at org.apache.directory.api.ldap.model.name.Dn.<init>(Dn.java:289)
	at org.apache.directory.api.ldap.model.schema.normalizers.UniqueMemberNormalizer.normalize(UniqueMemberNormalizer.java:139)
	at org.apache.directory.api.ldap.model.schema.normalizers.ConcreteNameComponentNormalizer.normalizeByName(ConcreteNameComponentNormalizer.java:114)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.normalizeValue(FilterNormalizingVisitor.java:248)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitSimpleNode(FilterNormalizingVisitor.java:312)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:579)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitBranchNode(FilterNormalizingVisitor.java:496)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:569)
	at org.apache.directory.api.ldap.model.filter.BranchNode.accept(BranchNode.java:225)
	at org.apache.directory.server.core.normalization.NormalizationInterceptor.search(NormalizationInterceptor.java:290)
	at org.apache.directory.server.core.DefaultOperationManager.search(DefaultOperationManager.java:1342)
	at org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1122)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.doSimpleSearch(SearchRequestHandler.java:810)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleIgnoringReferrals(SearchRequestHandler.java:1164)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:201)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:92)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
	at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
	at org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:216)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
	at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
	at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.charAt(String.java:658)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.attributeTypeAndValue(AntlrDnParser.java:480)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedName(AntlrDnParser.java:237)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedNames(AntlrDnParser.java:302)
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:52)
	... 30 more
20170130-19:56:05: [WARN]: undefined filter based on undefined attributeType not evaluted at all.  Returning empty enumeration. [org.apache.directory.server.core.normalization.NormalizationInterceptor]
20170130-19:56:05: [WARN]: Could not find LDAP entry for DN: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:05: [INFO]: 11 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:05: [INFO]:   nodelist refresh: new cached time: Jan 30, 2017 7:56:05 PM [org.dataone.service.cn.v2.impl.NodeRegistryServiceImpl]
20170130-19:56:05: [WARN]: Failed to normalize filter value: String index out of range: -1 [org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor]
org.apache.directory.api.ldap.model.exception.LdapInvalidDnException: String index out of range: -1
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:56)
	at org.apache.directory.api.ldap.model.name.Dn.parseInternal(Dn.java:1394)
	at org.apache.directory.api.ldap.model.name.Dn.<init>(Dn.java:289)
	at org.apache.directory.api.ldap.model.schema.normalizers.UniqueMemberNormalizer.normalize(UniqueMemberNormalizer.java:139)
	at org.apache.directory.api.ldap.model.schema.normalizers.ConcreteNameComponentNormalizer.normalizeByName(ConcreteNameComponentNormalizer.java:114)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.normalizeValue(FilterNormalizingVisitor.java:248)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitSimpleNode(FilterNormalizingVisitor.java:312)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:579)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visitBranchNode(FilterNormalizingVisitor.java:496)
	at org.apache.directory.server.core.api.normalization.FilterNormalizingVisitor.visit(FilterNormalizingVisitor.java:569)
	at org.apache.directory.api.ldap.model.filter.BranchNode.accept(BranchNode.java:225)
	at org.apache.directory.server.core.normalization.NormalizationInterceptor.search(NormalizationInterceptor.java:290)
	at org.apache.directory.server.core.DefaultOperationManager.search(DefaultOperationManager.java:1342)
	at org.apache.directory.server.core.shared.DefaultCoreSession.search(DefaultCoreSession.java:1122)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.doSimpleSearch(SearchRequestHandler.java:810)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handleIgnoringReferrals(SearchRequestHandler.java:1164)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:201)
	at org.apache.directory.server.ldap.handlers.request.SearchRequestHandler.handle(SearchRequestHandler.java:92)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:207)
	at org.apache.directory.server.ldap.handlers.LdapRequestHandler.handleMessage(LdapRequestHandler.java:56)
	at org.apache.mina.handler.demux.DemuxingIoHandler.messageReceived(DemuxingIoHandler.java:221)
	at org.apache.directory.server.ldap.LdapProtocolHandler.messageReceived(LdapProtocolHandler.java:216)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:854)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:542)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:48)
	at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:943)
	at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:74)
	at org.apache.mina.core.session.IoEvent.run(IoEvent.java:63)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.runTask(UnorderedThreadPoolExecutor.java:475)
	at org.apache.mina.filter.executor.UnorderedThreadPoolExecutor$Worker.run(UnorderedThreadPoolExecutor.java:429)
	at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
	at java.lang.String.charAt(String.java:658)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.attributeTypeAndValue(AntlrDnParser.java:480)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedName(AntlrDnParser.java:237)
	at org.apache.directory.api.ldap.model.name.AntlrDnParser.relativeDistinguishedNames(AntlrDnParser.java:302)
	at org.apache.directory.api.ldap.model.name.ComplexDnParser.parseDn(ComplexDnParser.java:52)
	... 30 more
20170130-19:56:05: [WARN]: undefined filter based on undefined attributeType not evaluted at all.  Returning empty enumeration. [org.apache.directory.server.core.normalization.NormalizationInterceptor]
20170130-19:56:05: [WARN]: Could not find LDAP entry for DN: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
20170130-19:56:05: [WARN]: Could not find: CN=Test2,O=Test,C=US,DC=cilogon,DC=org : in Ldap: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : SEARCH_REQUEST
Message ID : 971
    SearchRequest
        baseDn : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
        filter : '(objectClass=*)'
        scope : base object
        typesOnly : false
        Size Limit : no limit
        Time Limit : no limit
        Deref Aliases : deref Always
        attributes : 
org.apache.directory.api.ldap.model.message.SearchRequestImpl@4a9398fa    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: ERR_648 Invalid search base CN=Test2,O=Test,C=US,DC=cilogon,DC=org] [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:06: [WARN]: could not find member DN: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:06: [INFO]: 9 returning DirContext [org.dataone.service.cn.impl.v2.CNIdentityLDAPImpl]
20170130-19:56:06: [ERROR]: Error removing entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 977
    Del request
        Entry : 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@b34628cb    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=\+aQVbUA-,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:97)
	at sun.reflect.GeneratedMethodAccessor15.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:06: [ERROR]: Error removing entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 979
    Del request
        Entry : 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@15c35cb3    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: CN=Test2,O=Test,C=US,DC=cilogon,DC=org]; remaining name 'CN=Test2,O=Test,C=US,DC=cilogon,DC=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:102)
	at sun.reflect.GeneratedMethodAccessor15.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:06: [ERROR]: Error removing entry: cn=testGroup,dc=dataone,dc=org [org.dataone.cn.ldap.LDAPService]
javax.naming.NameNotFoundException: [LDAP: error code 32 - NO_SUCH_OBJECT: failed for MessageType : DEL_REQUEST
Message ID : 981
    Del request
        Entry : 'cn=testGroup,dc=dataone,dc=org'
org.apache.directory.api.ldap.model.message.DeleteRequestImpl@ed22898    ManageDsaITImpl Control
        Type OID    : '2.16.840.1.113730.3.4.2'
        Criticality : 'false'
'
: Attempt to lookup non-existant entry: cn=testGroup,dc=dataone,dc=org]; remaining name 'cn=testGroup,dc=dataone,dc=org'
	at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3113)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3034)
	at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2841)
	at com.sun.jndi.ldap.LdapCtx.c_destroySubcontext(LdapCtx.java:868)
	at com.sun.jndi.toolkit.ctx.ComponentContext.p_destroySubcontext(ComponentContext.java:671)
	at com.sun.jndi.toolkit.ctx.PartialCompositeContext.destroySubcontext(PartialCompositeContext.java:354)
	at javax.naming.InitialContext.destroySubcontext(InitialContext.java:479)
	at org.dataone.cn.ldap.LDAPService.removeEntry(LDAPService.java:61)
	at org.dataone.cn.ldap.LDAPTestIdentityCleanUp.removeEntry(LDAPTestIdentityCleanUp.java:45)
	at org.dataone.service.cn.impl.v2.CNIdentityLDAPImplTestUnit.cleanUp(CNIdentityLDAPImplTestUnit.java:107)
	at sun.reflect.GeneratedMethodAccessor15.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:24)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.dataone.test.apache.directory.server.integ.ApacheDSSuiteRunner.run(ApacheDSSuiteRunner.java:208)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:53)
	at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:123)
	at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.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 java.lang.reflect.Method.invoke(Method.java:606)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:164)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:110)
	at org.apache.maven.surefire.booter.SurefireStarter.invokeProvider(SurefireStarter.java:175)
	at org.apache.maven.surefire.booter.SurefireStarter.runSuitesInProcessWhenForked(SurefireStarter.java:107)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:68)
20170130-19:56:06: [INFO]: Unbind of an LDAP service (15389) is complete. [org.apache.directory.server.ldap.LdapServer]
20170130-19:56:06: [INFO]: Sending notice of disconnect to existing clients sessions. [org.apache.directory.server.ldap.LdapServer]
20170130-19:56:06: [INFO]: Ldap service stopped. [org.apache.directory.server.ldap.LdapServer]
20170130-19:56:06: [WARN]: javax.naming.CommunicationException: localhost:15389 connection closed [org.dataone.cn.ldap.DirContextUnsolicitedNotificationListener]
20170130-19:56:06: [WARN]: javax.naming.CommunicationException: localhost:15389 connection closed [org.dataone.cn.ldap.DirContextUnsolicitedNotificationListener]
20170130-19:56:06: [INFO]: clearing all the caches [org.apache.directory.server.core.api.CacheService]
Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 35.693 sec

Results :

Tests run: 17, Failures: 0, Errors: 0, Skipped: 0

[JENKINS] Recording test results
[INFO] 
[INFO] --- maven-jar-plugin:2.2:jar (default-jar) @ d1_identity_manager ---
[INFO] Building jar: /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/d1_identity_manager-2.3.1.jar
[INFO] 
[INFO] --- maven-install-plugin:2.3:install (default-install) @ d1_identity_manager ---
[INFO] Installing /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/d1_identity_manager-2.3.1.jar to /var/lib/jenkins/.m2/repository/org/dataone/d1_identity_manager/2.3.1/d1_identity_manager-2.3.1.jar
[INFO] Installing /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/pom.xml to /var/lib/jenkins/.m2/repository/org/dataone/d1_identity_manager/2.3.1/d1_identity_manager-2.3.1.pom
[INFO] 
[INFO] --- buildnumber-maven-plugin:1.4:create (default) @ d1_identity_manager ---
[INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager' && 'svn' '--non-interactive' 'info'
[INFO] Working directory: /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager
[INFO] Storing buildNumber: 18574 at timestamp: 1485806172083
[INFO] Executing: /bin/sh -c cd '/var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager' && 'svn' '--non-interactive' 'info'
[INFO] Working directory: /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager
[INFO] Storing buildScmBranch: branches/D1_IDENTITY_MANAGER_v2.3
[WARNING] Failed to getClass for org.apache.maven.plugin.javadoc.JavadocReport
[INFO] 
[INFO] --- maven-javadoc-plugin:2.10.4:javadoc (default-cli) @ d1_identity_manager ---
[INFO] 
Loading source files for package org.dataone.service.cn.impl.v2...
Loading source files for package org.dataone.service.cn.impl.v1...
Constructing Javadoc information...
Standard Doclet version 1.7.0_121
Building tree for all the packages and classes...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/CNIdentityLDAPImpl.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/ReserveIdentifierService.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/CNIdentityLDAPImpl.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/ReserveIdentifierService.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/overview-frame.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/package-frame.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/package-summary.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/package-tree.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/constant-values.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/class-use/ReserveIdentifierService.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/class-use/CNIdentityLDAPImpl.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/class-use/ReserveIdentifierService.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/class-use/CNIdentityLDAPImpl.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v1/package-use.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/org/dataone/service/cn/impl/v2/package-use.html...
Building index for all the packages and classes...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/overview-tree.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/index-all.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/deprecated-list.html...
Building index for all classes...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/allclasses-frame.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/allclasses-noframe.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/index.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/overview-summary.html...
Generating /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/target/site/apidocs/help-doc.html...
6 warnings
[WARNING] Javadoc Warnings
[WARNING] /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/src/main/java/org/dataone/service/cn/impl/v2/ReserveIdentifierService.java:111: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/src/main/java/org/dataone/service/cn/impl/v2/ReserveIdentifierService.java:269: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/src/main/java/org/dataone/service/cn/impl/v2/ReserveIdentifierService.java:399: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/src/main/java/org/dataone/service/cn/impl/v2/ReserveIdentifierService.java:311: warning - @param argument "id" is not a parameter name.
[WARNING] /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/src/main/java/org/dataone/service/cn/impl/v1/ReserveIdentifierService.java:76: warning - @return tag has no arguments.
[WARNING] /var/lib/jenkins/jobs/d1_identity_manager_beta/workspace/d1_identity_manager/src/main/java/org/dataone/service/cn/impl/v1/ReserveIdentifierService.java:108: warning - @return tag has no arguments.
[JENKINS] Archiving  javadoc
Notifying upstream projects of job completion
Join notifier requires a CauseAction
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:10.408s
[INFO] Finished at: Mon Jan 30 19:56:22 UTC 2017
[INFO] Final Memory: 53M/538M
[INFO] ------------------------------------------------------------------------
Waiting for Jenkins to finish collecting data