Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/15193/ Java: 64bit/jdk-9-ea+95 -XX:+UseCompressedOops -XX:+UseG1GC -XX:-CompactStrings
4 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SaslZkACLProviderTest Error Message: 5 threads leaked from SUITE scope at org.apache.solr.cloud.SaslZkACLProviderTest: 1) Thread[id=10975, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 2) Thread[id=10974, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 3) Thread[id=10973, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 4) Thread[id=10972, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:516) at java.util.TimerThread.mainLoop(Timer.java:526) at java.util.TimerThread.run(Timer.java:505) 5) Thread[id=10976, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 5 threads leaked from SUITE scope at org.apache.solr.cloud.SaslZkACLProviderTest: 1) Thread[id=10975, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 2) Thread[id=10974, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 3) Thread[id=10973, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 4) Thread[id=10972, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:516) at java.util.TimerThread.mainLoop(Timer.java:526) at java.util.TimerThread.run(Timer.java:505) 5) Thread[id=10976, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) at __randomizedtesting.SeedInfo.seed([F95C98D732A1532C]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SaslZkACLProviderTest Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id=10975, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 2) Thread[id=10974, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 3) Thread[id=10973, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 4) Thread[id=10972, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:516) at java.util.TimerThread.mainLoop(Timer.java:526) at java.util.TimerThread.run(Timer.java:505) 5) Thread[id=10976, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: 1) Thread[id=10975, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 2) Thread[id=10974, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 3) Thread[id=10973, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) 4) Thread[id=10972, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:516) at java.util.TimerThread.mainLoop(Timer.java:526) at java.util.TimerThread.run(Timer.java:505) 5) Thread[id=10976, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at jdk.internal.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) at java.lang.Thread.run(Thread.java:747) at __randomizedtesting.SeedInfo.seed([F95C98D732A1532C]:0) FAILED: org.apache.solr.cloud.SaslZkACLProviderTest.testSaslZkACLProvider Error Message: org.apache.directory.api.ldap.model.exception.LdapOtherException: org.apache.directory.api.ldap.model.exception.LdapOtherException: ERR_04447_CANNOT_NORMALIZE_VALUE Cannot normalize the wrapped value ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' Stack Trace: java.lang.RuntimeException: org.apache.directory.api.ldap.model.exception.LdapOtherException: org.apache.directory.api.ldap.model.exception.LdapOtherException: ERR_04447_CANNOT_NORMALIZE_VALUE Cannot normalize the wrapped value ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' at org.apache.solr.cloud.SaslZkACLProviderTest$SaslZkTestServer.run(SaslZkACLProviderTest.java:211) at org.apache.solr.cloud.SaslZkACLProviderTest.setUp(SaslZkACLProviderTest.java:81) at sun.reflect.GeneratedMethodAccessor6.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:520) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:905) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:747) Caused by: org.apache.directory.api.ldap.model.exception.LdapOtherException: org.apache.directory.api.ldap.model.exception.LdapOtherException: ERR_04447_CANNOT_NORMALIZE_VALUE Cannot normalize the wrapped value ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' at org.apache.directory.server.core.api.partition.AbstractPartition.initialize(AbstractPartition.java:84) at org.apache.directory.server.core.DefaultDirectoryService.initialize(DefaultDirectoryService.java:1808) at org.apache.directory.server.core.DefaultDirectoryService.startup(DefaultDirectoryService.java:1248) at org.apache.hadoop.minikdc.MiniKdc.initDirectoryService(MiniKdc.java:383) at org.apache.hadoop.minikdc.MiniKdc.start(MiniKdc.java:319) at org.apache.solr.cloud.SaslZkACLProviderTest$SaslZkTestServer.run(SaslZkACLProviderTest.java:204) ... 38 more Caused by: java.lang.RuntimeException: org.apache.directory.api.ldap.model.exception.LdapOtherException: ERR_04447_CANNOT_NORMALIZE_VALUE Cannot normalize the wrapped value ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' at org.apache.directory.server.core.api.schema.SchemaPartition.doInit(SchemaPartition.java:226) at org.apache.directory.server.core.api.partition.AbstractPartition.initialize(AbstractPartition.java:79) ... 43 more Caused by: org.apache.directory.api.ldap.model.exception.LdapOtherException: ERR_04447_CANNOT_NORMALIZE_VALUE Cannot normalize the wrapped value ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' at org.apache.directory.server.core.api.partition.AbstractPartition.initialize(AbstractPartition.java:84) at org.apache.directory.server.core.api.schema.SchemaPartition.doInit(SchemaPartition.java:219) ... 44 more Caused by: org.apache.directory.api.ldap.model.exception.LdapInvalidAttributeValueException: ERR_04447_CANNOT_NORMALIZE_VALUE Cannot normalize the wrapped value ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' at org.apache.directory.api.ldap.model.entry.AbstractValue.apply(AbstractValue.java:211) at org.apache.directory.api.ldap.model.entry.StringValue.<init>(StringValue.java:107) at org.apache.directory.api.ldap.model.entry.DefaultAttribute.<init>(DefaultAttribute.java:468) at org.apache.directory.api.ldap.model.entry.DefaultEntry.<init>(DefaultEntry.java:315) at org.apache.directory.server.core.partition.ldif.LdifPartition.loadEntries(LdifPartition.java:517) at org.apache.directory.server.core.partition.ldif.LdifPartition.loadEntries(LdifPartition.java:549) at org.apache.directory.server.core.partition.ldif.LdifPartition.doInit(LdifPartition.java:164) at org.apache.directory.server.core.api.partition.AbstractPartition.initialize(AbstractPartition.java:79) ... 45 more Caused by: org.apache.directory.api.ldap.model.exception.LdapInvalidAttributeValueException: ERR_04473_NOT_VALID_VALUE Not a valid value '20090818022733Z' for the AttributeType 'ATTRIBUTE_TYPE ( 1.3.6.1.4.1.18060.0.4.1.2.35 NAME 'schemaModifyTimestamp' DESC time which schema was modified SUP modifyTimestamp EQUALITY generalizedTimeMatch ORDERING generalizedTimeOrderingMatch SYNTAX 1.3.6.1.4.1.1466.115.121.1.24 USAGE directoryOperation ) ' at org.apache.directory.api.ldap.model.entry.AbstractValue.apply(AbstractValue.java:204) ... 52 more FAILED: org.apache.solr.cloud.TestAuthenticationFramework.testCollectionCreateSearchDelete Error Message: expected:<1> but was:<0> Stack Trace: java.lang.AssertionError: expected:<1> but was:<0> at __randomizedtesting.SeedInfo.seed([F95C98D732A1532C:5AA63672B549B989]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.junit.Assert.assertEquals(Assert.java:456) at org.apache.solr.cloud.TestMiniSolrCloudCluster.testCollectionCreateSearchDelete(TestMiniSolrCloudCluster.java:175) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:520) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:747) Build Log: [...truncated 10565 lines...] [junit4] Suite: org.apache.solr.cloud.TestAuthenticationFramework [junit4] 2> 692293 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 692294 INFO (Thread-1831) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 692294 INFO (Thread-1831) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 692394 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.ZkTestServer start zk server on port:42219 [junit4] 2> 692394 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692394 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692431 INFO (zkCallback-511-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17ba55e6 name:ZooKeeperConnection Watcher:127.0.0.1:42219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692431 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692431 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692431 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml [junit4] 2> 692451 INFO (jetty-launcher-510-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 692452 INFO (jetty-launcher-510-thread-3) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 692452 INFO (jetty-launcher-510-thread-2) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 692453 INFO (jetty-launcher-510-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7eb7f228{/solr,null,AVAILABLE} [junit4] 2> 692453 INFO (jetty-launcher-510-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a5d5267{/solr,null,AVAILABLE} [junit4] 2> 692453 INFO (jetty-launcher-510-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4959363{/solr,null,AVAILABLE} [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.e.j.s.ServerConnector Started ServerConnector@5fb47597{HTTP/1.1}{127.0.0.1:51673} [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.e.j.s.Server Started @694398ms [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=51673} [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node2' [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 692456 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 692457 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692457 INFO (jetty-launcher-510-thread-3) [ ] o.e.j.s.ServerConnector Started ServerConnector@20a5ae37{HTTP/1.1}{127.0.0.1:50378} [junit4] 2> 692456 INFO (jetty-launcher-510-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@36a48dad{HTTP/1.1}{127.0.0.1:60935} [junit4] 2> 692457 INFO (jetty-launcher-510-thread-3) [ ] o.e.j.s.Server Started @694400ms [junit4] 2> 692457 INFO (jetty-launcher-510-thread-1) [ ] o.e.j.s.Server Started @694400ms [junit4] 2> 692457 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=50378} [junit4] 2> 692457 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=60935} [junit4] 2> 692457 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692458 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 692458 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 692458 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node1' [junit4] 2> 692458 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node3' [junit4] 2> 692458 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 692458 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 692458 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 692458 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 692458 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692458 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692458 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692458 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692460 INFO (zkCallback-512-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3066cd5c name:ZooKeeperConnection Watcher:127.0.0.1:42219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692460 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692460 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692461 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 692461 INFO (zkCallback-514-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@25a09115 name:ZooKeeperConnection Watcher:127.0.0.1:42219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692461 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692462 INFO (zkCallback-513-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@59cc5e4d name:ZooKeeperConnection Watcher:127.0.0.1:42219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692462 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692462 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692462 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692462 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 692462 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 692467 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node2/. [junit4] 2> 692467 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer New CoreContainer 321237794 [junit4] 2> 692467 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node2] [junit4] 2> 692467 WARN (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node2/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node2/lib [junit4] 2> 692468 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 692468 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 692469 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 692469 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 692469 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42219/solr [junit4] 2> 692469 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 692469 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692469 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node3/. [junit4] 2> 692469 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node1/. [junit4] 2> 692469 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 843593505 [junit4] 2> 692469 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer New CoreContainer 293336912 [junit4] 2> 692469 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692469 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node3] [junit4] 2> 692469 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node1] [junit4] 2> 692469 WARN (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node3/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node3/lib [junit4] 2> 692469 WARN (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node1/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node1/lib [junit4] 2> 692469 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 692470 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 692470 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 692470 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42219/solr [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 692470 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42219/solr [junit4] 2> 692470 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692470 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 692470 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692471 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692471 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692472 INFO (zkCallback-516-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5abc5f6d name:ZooKeeperConnection Watcher:127.0.0.1:42219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692472 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692472 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692473 INFO (zkCallback-519-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@59313fbc name:ZooKeeperConnection Watcher:127.0.0.1:42219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692474 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692474 INFO (zkCallback-520-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5cff0b60 name:ZooKeeperConnection Watcher:127.0.0.1:42219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692474 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692474 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692474 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692476 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692478 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692479 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692479 INFO (zkCallback-521-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5cc47767 name:ZooKeeperConnection Watcher:127.0.0.1:42219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692479 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692480 INFO (zkCallback-522-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1eba63d1 name:ZooKeeperConnection Watcher:127.0.0.1:42219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692480 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692483 INFO (zkCallback-523-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19a229e1 name:ZooKeeperConnection Watcher:127.0.0.1:42219/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692483 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692484 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 692486 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 692486 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 692494 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 692494 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 692494 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 692507 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 692507 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 692507 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 692514 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 692514 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 692515 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 692534 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 692534 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 692534 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 692547 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 692547 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 692547 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 692550 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 692550 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 692550 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 692554 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 692555 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 692555 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 692560 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 692560 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 692560 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 692564 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 692564 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 692564 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 692590 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51673_solr [junit4] 2> 692590 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:50378_solr [junit4] 2> 692590 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60935_solr [junit4] 2> 692592 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:51673_solr [junit4] 2> 692592 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:50378_solr [junit4] 2> 692592 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:60935_solr [junit4] 2> 692594 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 692594 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 692594 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 692598 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 692598 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 692598 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 692601 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 692601 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 692601 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 692603 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95178617458065417-127.0.0.1:60935_solr-n_0000000000 [junit4] 2> 692604 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95178617458065416-127.0.0.1:50378_solr-n_0000000001 [junit4] 2> 692604 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95178617458065415-127.0.0.1:51673_solr-n_0000000002 [junit4] 2> 692605 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60935_solr [junit4] 2> 692605 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 692605 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/95178617458065417-127.0.0.1:60935_solr-n_0000000000 to know if I could be the leader [junit4] 2> 692605 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/95178617458065416-127.0.0.1:50378_solr-n_0000000001 to know if I could be the leader [junit4] 2> 692605 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 692605 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 692607 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.Overseer Overseer (id=95178617458065417-127.0.0.1:60935_solr-n_0000000000) starting [junit4] 2> 692612 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 692619 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 692619 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer Authentication plugin class obtained from system property 'authenticationPlugin': org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin [junit4] 2> 692619 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer Reconfiguring the shard handler factory and update shard handler. [junit4] 2> 692619 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Reconfiguring the default client with: org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin$MockClientConfigurer@24d7ef06 [junit4] 2> 692620 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.u.UpdateShardHandler Reconfiguring the default client with: org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin$MockClientConfigurer@24d7ef06 [junit4] 2> 692620 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node3/. [junit4] 2> 692620 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer Authentication plugin class obtained from system property 'authenticationPlugin': org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer Reconfiguring the shard handler factory and update shard handler. [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Reconfiguring the default client with: org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin$MockClientConfigurer@22ba0d12 [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.u.UpdateShardHandler Reconfiguring the default client with: org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin$MockClientConfigurer@22ba0d12 [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node2/. [junit4] 2> 692624 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 692625 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2 [junit4] 2> 692625 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 692625 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2 [junit4] 2> 692625 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 692641 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 692642 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 692642 INFO (OverseerCollectionConfigSetProcessor-95178617458065417-127.0.0.1:60935_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 692642 INFO (OverseerStateUpdate-95178617458065417-127.0.0.1:60935_solr-n_0000000000) [ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 692650 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 692650 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer Authentication plugin class obtained from system property 'authenticationPlugin': org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin [junit4] 2> 692650 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer Reconfiguring the shard handler factory and update shard handler. [junit4] 2> 692650 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Reconfiguring the default client with: org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin$MockClientConfigurer@6c0f5d99 [junit4] 2> 692650 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.u.UpdateShardHandler Reconfiguring the default client with: org.apache.solr.cloud.TestAuthenticationFramework$MockAuthenticationPlugin$MockClientConfigurer@6c0f5d99 [junit4] 2> 692651 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-001/node1/. [junit4] 2> 692651 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 692651 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2 [junit4] 2> 692651 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 692651 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 692652 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 692654 INFO (zkCallback-524-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@268e2bc1 name:ZooKeeperConnection Watcher:127.0.0.1:42219 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 692654 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 692654 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 692657 INFO (jetty-launcher-510-thread-1) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@20a5ae37{HTTP/1.1}{127.0.0.1:0} [junit4] 2> 692658 INFO (jetty-launcher-510-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=293336912 [junit4] 2> 692658 INFO (jetty-launcher-510-thread-2) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@5fb47597{HTTP/1.1}{127.0.0.1:0} [junit4] 2> 692658 INFO (jetty-launcher-510-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=321237794 [junit4] 2> 692659 INFO (jetty-launcher-510-thread-3) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@36a48dad{HTTP/1.1}{127.0.0.1:0} [junit4] 2> 692659 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=843593505 [junit4] 2> 692662 INFO (zkCallback-523-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 692662 INFO (zkCallback-522-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 692662 INFO (zkCallback-521-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 692662 INFO (jetty-launcher-510-thread-3) [ ] o.a.s.c.Overseer Overseer (id=95178617458065417-127.0.0.1:60935_solr-n_0000000000) closing [junit4] 2> 692663 WARN (zkCallback-521-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 692663 INFO (OverseerStateUpdate-95178617458065417-127.0.0.1:60935_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60935_solr [junit4] 2> 692663 INFO (jetty-launcher-510-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a5d5267{/solr,null,UNAVAILABLE} [junit4] 2> 692666 INFO (zkCallback-523-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 692666 WARN (zkCallback-523-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 692666 INFO (jetty-launcher-510-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4959363{/solr,null,UNAVAILABLE} [junit4] 2> 694163 WARN (zkCallback-522-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 694164 INFO (jetty-launcher-510-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7eb7f228{/solr,null,UNAVAILABLE} [junit4] 2> 694165 INFO (TEST-TestAuthenticationFramework.testErrorsInShutdown-seed#[F95C98D732A1532C]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42219 42219 [junit4] 2> 694200 INFO (Thread-1831) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:42219 42219 [junit4] 2> 694201 WARN (Thread-1831) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 3 /solr/aliases.json [junit4] 2> 3 /solr/security.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 3 /solr/clusterstate.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 3 /solr/live_nodes [junit4] 2> 3 /solr/collections [junit4] 2> [junit4] 2> 694207 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 694207 INFO (Thread-1868) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 694207 INFO (Thread-1868) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 694307 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.ZkTestServer start zk server on port:43813 [junit4] 2> 694307 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694307 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694331 INFO (zkCallback-527-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c089501 name:ZooKeeperConnection Watcher:127.0.0.1:43813 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694332 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694332 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694332 INFO (TEST-TestAuthenticationFramework.testBasics-seed#[F95C98D732A1532C]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml [junit4] 2> 694341 INFO (jetty-launcher-526-thread-2) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 694341 INFO (jetty-launcher-526-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 694343 INFO (jetty-launcher-526-thread-3) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 694343 INFO (jetty-launcher-526-thread-5) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 694343 INFO (jetty-launcher-526-thread-4) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 694344 INFO (jetty-launcher-526-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@25eddc42{/solr,null,AVAILABLE} [junit4] 2> 694344 INFO (jetty-launcher-526-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@325b3814{/solr,null,AVAILABLE} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@618bf51f{/solr,null,AVAILABLE} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-5) [ ] o.e.j.s.ServerConnector Started ServerConnector@378bce5d{HTTP/1.1}{127.0.0.1:33934} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-5) [ ] o.e.j.s.Server Started @696287ms [junit4] 2> 694345 INFO (jetty-launcher-526-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@26cd2496{/solr,null,AVAILABLE} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33934} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-4) [ ] o.e.j.s.ServerConnector Started ServerConnector@7cd5138a{HTTP/1.1}{127.0.0.1:40150} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-4) [ ] o.e.j.s.Server Started @696288ms [junit4] 2> 694345 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=40150} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-2) [ ] o.e.j.s.ServerConnector Started ServerConnector@2b9cb4db{HTTP/1.1}{127.0.0.1:36177} [junit4] 2> 694345 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 694345 INFO (jetty-launcher-526-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@cfd3581{/solr,null,AVAILABLE} [junit4] 2> 694346 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node5' [junit4] 2> 694346 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 694346 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 694346 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node4' [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.e.j.s.ServerConnector Started ServerConnector@5093a253{HTTP/1.1}{127.0.0.1:41374} [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.e.j.s.Server Started @696288ms [junit4] 2> 694346 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41374} [junit4] 2> 694346 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node3' [junit4] 2> 694346 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 694345 INFO (jetty-launcher-526-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@28535b33{HTTP/1.1}{127.0.0.1:59728} [junit4] 2> 694346 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694346 INFO (jetty-launcher-526-thread-1) [ ] o.e.j.s.Server Started @696289ms [junit4] 2> 694346 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 694347 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694345 INFO (jetty-launcher-526-thread-2) [ ] o.e.j.s.Server Started @696288ms [junit4] 2> 694347 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36177} [junit4] 2> 694347 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 694347 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node2' [junit4] 2> 694347 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 694347 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 694347 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694347 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694347 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694346 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59728} [junit4] 2> 694348 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694348 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694348 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@deb6432 [junit4] 2> 694348 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node1' [junit4] 2> 694348 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 694348 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 694348 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694348 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694349 INFO (zkCallback-528-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@72253f4e name:ZooKeeperConnection Watcher:127.0.0.1:43813/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694349 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694349 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694350 INFO (zkCallback-529-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3477a1d6 name:ZooKeeperConnection Watcher:127.0.0.1:43813/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694350 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694350 INFO (zkCallback-531-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@27bc6c5e name:ZooKeeperConnection Watcher:127.0.0.1:43813/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694351 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694351 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 694351 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694351 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694351 INFO (zkCallback-530-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6c47141c name:ZooKeeperConnection Watcher:127.0.0.1:43813/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694351 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 694351 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694351 INFO (zkCallback-532-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@671432a name:ZooKeeperConnection Watcher:127.0.0.1:43813/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694351 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 694351 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694351 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694351 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694354 INFO (jetty-launcher-526-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 694354 INFO (jetty-launcher-526-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 694356 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node3/. [junit4] 2> 694356 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.CoreContainer New CoreContainer 929848007 [junit4] 2> 694356 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node3] [junit4] 2> 694356 WARN (jetty-launcher-526-thread-3) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node3/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node3/lib [junit4] 2> 694356 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43813/solr [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694357 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node4/. [junit4] 2> 694357 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.CoreContainer New CoreContainer 1893274561 [junit4] 2> 694357 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694357 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node4] [junit4] 2> 694358 WARN (jetty-launcher-526-thread-4) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node4/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node4/lib [junit4] 2> 694358 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 694358 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 694358 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 694358 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 694358 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43813/solr [junit4] 2> 694358 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 694359 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 694359 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 694361 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node2/. [junit4] 2> 694362 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.CoreContainer New CoreContainer 1833835201 [junit4] 2> 694362 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node2] [junit4] 2> 694362 WARN (jetty-launcher-526-thread-2) [ ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node2/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestAuthenticationFramework_F95C98D732A1532C-001/tempDir-002/node2/lib [junit4] 2> 694362 INFO (jetty-launcher-526-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 694362 INFO (zkCallback-534-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7e6a7993 name:ZooKeeperConnection Watcher:127.0.0.1:43813 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694362 INFO (zkCallback-536-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@72f8cf68 name:ZooKeeperConnection Watcher:127.0.0.1:43813 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 694362 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 694362 INFO (jetty-launcher-526-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 694362 INFO (jetty-launcher-526-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> [...truncated too long message...] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > 3) Thread[id=10973, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > 4) Thread[id=10972, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at java.lang.Object.wait(Native Method) [junit4] > at java.lang.Object.wait(Object.java:516) [junit4] > at java.util.TimerThread.mainLoop(Timer.java:526) [junit4] > at java.util.TimerThread.run(Timer.java:505) [junit4] > 5) Thread[id=10976, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > at __randomizedtesting.SeedInfo.seed([F95C98D732A1532C]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated: [junit4] > 1) Thread[id=10975, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > 2) Thread[id=10974, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > 3) Thread[id=10973, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > 4) Thread[id=10972, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at java.lang.Object.wait(Native Method) [junit4] > at java.lang.Object.wait(Object.java:516) [junit4] > at java.util.TimerThread.mainLoop(Timer.java:526) [junit4] > at java.util.TimerThread.run(Timer.java:505) [junit4] > 5) Thread[id=10976, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] [junit4] > at jdk.internal.misc.Unsafe.park(Native Method) [junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:218) [junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2103) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1136) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:853) [junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1083) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1143) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:632) [junit4] > at java.lang.Thread.run(Thread.java:747) [junit4] > at __randomizedtesting.SeedInfo.seed([F95C98D732A1532C]:0) [junit4] Completed [443/563 (2!)] on J1 in 25.32s, 1 test, 3 errors <<< FAILURES! [...truncated 425 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:794: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:738: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:59: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:233: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:526: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1444: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1000: There were test failures: 563 suites (7 ignored), 2236 tests, 2 suite-level errors, 1 error, 1 failure, 379 ignored (39 assumptions) [seed: F95C98D732A1532C] Total time: 86 minutes 48 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org