Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/882/

10 tests failed.
FAILED:  org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([712A9BC123B2B08E]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.FullSolrCloudDistribCmdsTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([712A9BC123B2B08E]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.FullSolrCloudDistribCmdsTest

Error Message:
Captured an uncaught exception in thread: Thread[id=4193, 
name=zkCallback-541-thread-4, state=RUNNABLE, 
group=TGRP-FullSolrCloudDistribCmdsTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=4193, name=zkCallback-541-thread-4, 
state=RUNNABLE, group=TGRP-FullSolrCloudDistribCmdsTest]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.FullSolrCloudDistribCmdsTest

Error Message:
Captured an uncaught exception in thread: Thread[id=3385, 
name=OverseerHdfsCoreFailoverThread-95038595507486724-127.0.0.1:44248_-n_0000000000,
 state=RUNNABLE, group=Overseer Hdfs SolrCore Failover Thread.]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=3385, 
name=OverseerHdfsCoreFailoverThread-95038595507486724-127.0.0.1:44248_-n_0000000000,
 state=RUNNABLE, group=Overseer Hdfs SolrCore Failover Thread.]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.FullSolrCloudDistribCmdsTest

Error Message:
Captured an uncaught exception in thread: Thread[id=3383, 
name=OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000, 
state=RUNNABLE, group=Overseer state updater.]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=3383, 
name=OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000, 
state=RUNNABLE, group=Overseer state updater.]
Caused by: java.lang.OutOfMemoryError: GC overhead limit exceeded


FAILED:  org.apache.solr.cloud.HttpPartitionTest.test

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([712A9BC123B2B08E]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.HttpPartitionTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([712A9BC123B2B08E]:0)


FAILED:  org.apache.solr.cloud.hdfs.HdfsChaosMonkeyNothingIsSafeTest.test

Error Message:
document count mismatch.  control=5468 sum(shards)=5467 cloudClient=5467

Stack Trace:
java.lang.AssertionError: document count mismatch.  control=5468 
sum(shards)=5467 cloudClient=5467
        at 
__randomizedtesting.SeedInfo.seed([712A9BC123B2B08E:F97EA41B8D4EDD76]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkShardConsistency(AbstractFullDistribZkTestBase.java:1298)
        at 
org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.test(ChaosMonkeyNothingIsSafeTest.java:234)
        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:497)
        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 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:965)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940)
        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:745)


FAILED:  
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([712A9BC123B2B08E]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([712A9BC123B2B08E]:0)




Build Log:
[...truncated 10396 lines...]
   [junit4] JVM J1: stdout was not empty, see: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/temp/junit4-J1-20151215_095831_840.sysout
   [junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
   [junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
   [junit4] Dumping heap to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/heapdumps/java_pid6940.hprof
 ...
   [junit4] Heap dump file created [606766085 bytes in 3.907 secs]
   [junit4] <<< JVM J1: EOF ----

   [junit4] JVM J1: stderr was not empty, see: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/temp/junit4-J1-20151215_095831_840.syserr
   [junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
   [junit4] WARN: Unhandled exception in event serialization. -> 
java.lang.OutOfMemoryError: GC overhead limit exceeded
   [junit4]     at java.nio.CharBuffer.wrap(CharBuffer.java:373)
   [junit4]     at sun.nio.cs.StreamEncoder.implWrite(StreamEncoder.java:265)
   [junit4]     at sun.nio.cs.StreamEncoder.write(StreamEncoder.java:125)
   [junit4]     at sun.nio.cs.StreamEncoder.write(StreamEncoder.java:135)
   [junit4]     at java.io.OutputStreamWriter.write(OutputStreamWriter.java:220)
   [junit4]     at java.io.Writer.write(Writer.java:157)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.gson.stream.JsonWriter.string(JsonWriter.java:573)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.gson.stream.JsonWriter.value(JsonWriter.java:414)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.events.Serializer$2.run(Serializer.java:100)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.events.Serializer$2.run(Serializer.java:96)
   [junit4]     at java.security.AccessController.doPrivileged(Native Method)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.events.Serializer.flushQueue(Serializer.java:96)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.events.Serializer.serialize(Serializer.java:81)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain$3$2.write(SlaveMain.java:456)
   [junit4]     at 
java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:82)
   [junit4]     at 
java.io.BufferedOutputStream.flush(BufferedOutputStream.java:140)
   [junit4]     at java.io.PrintStream.flush(PrintStream.java:338)
   [junit4]     at java.io.FilterOutputStream.flush(FilterOutputStream.java:140)
   [junit4]     at java.io.PrintStream.write(PrintStream.java:482)
   [junit4]     at sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)
   [junit4]     at 
sun.nio.cs.StreamEncoder.implFlushBuffer(StreamEncoder.java:291)
   [junit4]     at sun.nio.cs.StreamEncoder.implFlush(StreamEncoder.java:295)
   [junit4]     at sun.nio.cs.StreamEncoder.flush(StreamEncoder.java:141)
   [junit4]     at java.io.OutputStreamWriter.flush(OutputStreamWriter.java:229)
   [junit4]     at 
org.apache.log4j.helpers.QuietWriter.flush(QuietWriter.java:59)
   [junit4]     at 
org.apache.log4j.WriterAppender.subAppend(WriterAppender.java:324)
   [junit4]     at 
org.apache.log4j.WriterAppender.append(WriterAppender.java:162)
   [junit4]     at 
org.apache.log4j.AppenderSkeleton.doAppend(AppenderSkeleton.java:251)
   [junit4]     at org.apache.log4j.h
   [junit4] 
elpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66)
   [junit4]     at org.apache.log4j.Category.callAppenders(Category.java:206)
   [junit4]     at org.apache.log4j.Category.forcedLog(Category.java:391)
   [junit4]     at org.apache.log4j.Category.log(Category.java:856)
   [junit4] <<< JVM J1: EOF ----

[...truncated 217 lines...]
   [junit4] Suite: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/init-core-data-001
   [junit4]   2> 366336 INFO  
(SUITE-FullSolrCloudDistribCmdsTest-seed#[712A9BC123B2B08E]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 366340 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 366340 INFO  (Thread-1202) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 366340 INFO  (Thread-1202) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 366440 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:58829
   [junit4]   2> 366440 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 366441 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 366443 INFO  (zkCallback-536-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@40f13dba 
name:ZooKeeperConnection Watcher:127.0.0.1:58829 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 366444 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 366444 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 366444 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 366446 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 366447 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 366448 INFO  (zkCallback-537-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@77abed32 
name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 366448 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 366448 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 366448 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 366449 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 366451 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 366452 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 366455 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 366455 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 366459 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 366459 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 366460 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 366461 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 366463 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 366463 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 366464 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 366464 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 366472 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 366472 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 366474 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 366474 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 366475 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 366475 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 366477 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 366477 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 366478 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 366479 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 366481 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 366481 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 366849 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1
   [junit4]   2> 366851 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.Server jetty-9.3.6.v20151106
   [junit4]   2> 366853 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3e991353{/,null,AVAILABLE}
   [junit4]   2> 366863 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@7dd2af1c{HTTP/1.1,[http/1.1]}{127.0.0.1:44248}
   [junit4]   2> 366863 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.Server Started @370267ms
   [junit4]   2> 366863 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/tempDir-001/control/data,
 hostContext=/, hostPort=44248, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores}
   [junit4]   2> 366864 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 366864 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001'
   [junit4]   2> 366864 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 366864 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 366864 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 366873 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 366873 INFO  (zkCallback-538-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@16a4169f 
name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 366873 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 366874 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 366875 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 366875 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/solr.xml
   [junit4]   2> 366879 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores
   [junit4]   2> 366880 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 77849489
   [junit4]   2> 366880 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001]
   [junit4]   2> 366880 WARN  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/lib
   [junit4]   2> 366880 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
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> 366882 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 366882 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 366882 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 366882 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58829/solr
   [junit4]   2> 366882 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 366882 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 366883 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 366885 INFO  (zkCallback-540-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@358af1d0 
name:ZooKeeperConnection Watcher:127.0.0.1:58829 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 366885 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 366886 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 366891 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 366892 INFO  
(zkCallback-541-thread-1-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@67d38ea5 
name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 366892 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 366894 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 366900 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 366904 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 366905 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 366906 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 366908 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 366909 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 366911 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 366912 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 366913 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44248_
   [junit4]   2> 366913 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:44248_
   [junit4]   2> 366915 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 366917 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 366918 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 366918 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/95038595507486724-127.0.0.1:44248_-n_0000000000
   [junit4]   2> 366918 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.OverseerElectionContext I am going to be the 
leader 127.0.0.1:44248_
   [junit4]   2> 366918 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 366919 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer Overseer 
(id=95038595507486724-127.0.0.1:44248_-n_0000000000) starting
   [junit4]   2> 366921 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 366928 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 366929 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 366930 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 366935 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 366935 INFO  
(OverseerCollectionConfigSetProcessor-95038595507486724-127.0.0.1:44248_-n_0000000000)
 [n:127.0.0.1:44248_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 366981 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 366981 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 366982 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores
   [junit4]   2> 366983 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 366983 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.CorePropertiesLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1
   [junit4]   2> 366983 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 366984 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 366985 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 366985 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:44248_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 366985 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 366986 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:44248";,
   [junit4]   2>   "node_name":"127.0.0.1:44248_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 366987 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 366987 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:44248";,
   [junit4]   2>   "node_name":"127.0.0.1:44248_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 366988 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 366988 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 366990 INFO  
(zkCallback-541-thread-1-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 1)
   [junit4]   2> 366991 INFO  
(zkCallback-541-thread-2-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 1)
   [junit4]   2> 367987 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 367987 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 367988 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 367988 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config 
from:/collections/control_collection
   [junit4]   2> 367988 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 
specified config exists in ZooKeeper
   [junit4]   2> 367988 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1'
   [junit4]   2> 367989 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 367989 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 367990 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 367995 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 367999 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 368006 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 368013 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 368098 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 368099 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 368100 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 368104 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 368124 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/configs/conf1', 
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 368124 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 368125 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 368125 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data/]
   [junit4]   2> 368125 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX 
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@d28ee65
   [junit4]   2> 368126 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data
   [junit4]   2> 368126 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data/index/
   [junit4]   2> 368126 WARN  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 368126 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data/index
   [junit4]   2> 368127 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=11, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=19.935546875, 
floorSegmentMB=0.791015625, forceMergeDeletesPctAllowed=22.539443265727368, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3764691806371193
   [junit4]   2> 368127 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@51d62c4d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4800abe1),segFN=segments_1,generation=1}
   [junit4]   2> 368128 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 368134 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data/
   [junit4]   2> 368134 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 368137 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-explicit"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 368138 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating 
implicit default
   [junit4]   2> 368138 WARN  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 368140 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 368141 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 368142 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 368143 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 368146 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 368146 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 368147 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 368147 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 368148 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 368148 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 368149 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=3, maxMergeAtOnceExplicit=4, maxMergedSegmentMB=17.46875, 
floorSegmentMB=0.4609375, forceMergeDeletesPctAllowed=25.01121132785535, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 368149 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@51d62c4d 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4800abe1),segFN=segments_1,generation=1}
   [junit4]   2> 368149 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 368149 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@27f3b2cd[collection1] main
   [junit4]   2> 368149 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config 
from:/collections/control_collection
   [junit4]   2> 368150 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 
specified config exists in ZooKeeper
   [junit4]   2> 368150 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the 
RestManager with znodeBase: /configs/conf1
   [junit4]   2> 368150 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 368151 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 368151 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 368151 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage No data found for znode 
/configs/conf1/_rest_managed.json
   [junit4]   2> 368151 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 368151 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 368151 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 368152 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
   [junit4]   2> 368152 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version 
buckets from index
   [junit4]   2> 368152 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket 
highest value from index
   [junit4]   2> 368152 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1520617530018758656
   [junit4]   2> 368154 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 
1520617530018758656
   [junit4]   2> 368154 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 368154 INFO  
(coreLoadExecutor-1147-thread-1-processing-n:127.0.0.1:44248_) 
[n:127.0.0.1:44248_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 368154 INFO  
(searcherExecutor-1148-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@27f3b2cd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 368155 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
Register replica - core:collection1 address:http://127.0.0.1:44248 
collection:control_collection shard:shard1
   [junit4]   2> 368156 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 368159 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector 
Joined leadership election with path: 
/collections/control_collection/leader_elect/shard1/election/95038595507486724-core_node1-n_0000000000
   [junit4]   2> 368159 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 
and weAreReplacement=false and leaderVoteWait=10000
   [junit4]   2> 368161 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 368161 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 368161 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection"} current state version: 1
   [junit4]   2> 368161 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:44248/collection1/
   [junit4]   2> 368161 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 368161 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:44248/collection1/ has no replicas
   [junit4]   2> 368162 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 368164 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 368166 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:44248/collection1/ shard1
   [junit4]   2> 368167 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "base_url":"http://127.0.0.1:44248";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 368269 INFO  
(zkCallback-541-thread-2-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 1)
   [junit4]   2> 368269 INFO  
(zkCallback-541-thread-1-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 1)
   [junit4]   2> 368317 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:44248/collection1/ and leader is 
http://127.0.0.1:44248/collection1/
   [junit4]   2> 368317 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:44248
   [junit4]   2> 368317 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 368317 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 368317 INFO  
(coreZkRegister-1141-thread-1-processing-n:127.0.0.1:44248_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:44248_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 368319 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:44248";,
   [junit4]   2>   "node_name":"127.0.0.1:44248_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 2
   [junit4]   2> 368319 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:44248";,
   [junit4]   2>   "node_name":"127.0.0.1:44248_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 368425 INFO  
(zkCallback-541-thread-2-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 1)
   [junit4]   2> 368425 INFO  
(zkCallback-541-thread-1-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 1)
   [junit4]   2> 368486 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 368487 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 368488 INFO  (zkCallback-543-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4c80c0b4 
name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 368488 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 368488 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 368488 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 368490 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 368885 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/cores/collection1
   [junit4]   2> 368886 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001
   [junit4]   2> 368887 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.Server jetty-9.3.6.v20151106
   [junit4]   2> 368888 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4d0df294{/,null,AVAILABLE}
   [junit4]   2> 368889 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@23d0f763{HTTP/1.1,[http/1.1]}{127.0.0.1:33870}
   [junit4]   2> 368889 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.e.j.s.Server Started @372293ms
   [junit4]   2> 368889 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=33870, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/cores}
   [junit4]   2> 368890 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 368890 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001'
   [junit4]   2> 368890 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 368890 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 368890 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 368891 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 368895 INFO  (zkCallback-544-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1957a545 
name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 368895 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 368896 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 368897 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 368897 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/solr.xml
   [junit4]   2> 368902 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/cores
   [junit4]   2> 368902 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 637120388
   [junit4]   2> 368902 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001]
   [junit4]   2> 368902 WARN  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/lib
   [junit4]   2> 368902 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
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> 368903 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 368904 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 368904 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 368904 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58829/solr
   [junit4]   2> 368904 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 368904 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 368905 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 368906 INFO  (zkCallback-546-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6ae98d2b 
name:ZooKeeperConnection Watcher:127.0.0.1:58829 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 368907 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 368907 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 368908 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 368909 INFO  
(zkCallback-547-thread-1-processing-n:127.0.0.1:33870_) [n:127.0.0.1:33870_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3943d618 
name:ZooKeeperConnection Watcher:127.0.0.1:58829/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 368909 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 368914 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.c.ZkStateReader Updating cluster state from 
ZooKeeper... 
   [junit4]   2> 369919 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33870_
   [junit4]   2> 369921 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:33870_
   [junit4]   2> 369922 INFO  
(zkCallback-541-thread-2-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] 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> 369922 INFO  (zkCallback-543-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> 369922 INFO  
(zkCallback-541-thread-1-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] 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> 369922 INFO  
(zkCallback-547-thread-1-processing-n:127.0.0.1:33870_) [n:127.0.0.1:33870_    
] 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> 369923 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 369924 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.LeaderElector Joined leadership election with 
path: /overseer_elect/election/95038595507486728-127.0.0.1:33870_-n_0000000001
   [junit4]   2> 369928 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/95038595507486724-127.0.0.1:44248_-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 369944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 369944 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 369945 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/cores
   [junit4]   2> 369946 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=collection1, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 369946 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.CorePropertiesLocator Found core collection1 
in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/cores/collection1
   [junit4]   2> 369946 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 369947 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
   [junit4]   2> 369947 INFO  
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[712A9BC123B2B08E]) 
[n:127.0.0.1:33870_    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() 
done
   [junit4]   2> 369947 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 369947 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 369949 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.ZkController look 
for our core node name
   [junit4]   2> 369949 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:33870";,
   [junit4]   2>   "node_name":"127.0.0.1:33870_",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"} current state version: 3
   [junit4]   2> 369949 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ReplicaMutator Update state numShards=3 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:33870";,
   [junit4]   2>   "node_name":"127.0.0.1:33870_",
   [junit4]   2>   "numShards":"3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 369949 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 369949 INFO  
(OverseerStateUpdate-95038595507486724-127.0.0.1:44248_-n_0000000000) 
[n:127.0.0.1:44248_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard2
   [junit4]   2> 369950 INFO  (zkCallback-543-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 369950 INFO  
(zkCallback-541-thread-2-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 369950 INFO  
(zkCallback-547-thread-1-processing-n:127.0.0.1:33870_) [n:127.0.0.1:33870_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 369951 INFO  
(zkCallback-541-thread-1-processing-n:127.0.0.1:44248_) [n:127.0.0.1:44248_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred 
- updating... (live nodes size: 2)
   [junit4]   2> 370949 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.ZkController waiting 
to find shard id in clusterstate for collection1
   [junit4]   2> 370949 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.ZkController Check 
for collection zkNode:collection1
   [junit4]   2> 370950 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 370950 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader Load 
collection config from:/collections/collection1
   [junit4]   2> 370950 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 370950 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.FullSolrCloudDistribCmdsTest_712A9BC123B2B08E-001/shard-1-001/cores/collection1'
   [junit4]   2> 370950 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 370951 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 370952 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.Config loaded config 
solrconfig.xml with version 0 
   [junit4]   2> 370957 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.SolrConfig current 
version of requestparams : -1
   [junit4]   2> 370960 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.0.0
   [junit4]   2> 370968 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) 
[n:127.0.0.1:33870_ c:collection1   x:collection1] o.a.s.c.SolrConfig Loaded 
SolrConfig: solrconfig.xml
   [junit4]   2> 370973 INFO  
(coreLoadExecutor-1158-thread-1-processing-n:127.0.0.1:33870_) [n

[...truncated too long message...]

kins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-changelog-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/build/analysis/icu/lucene-analyzers-icu-6.0.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/contrib/analysis-extras/lib/icu4j-54.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.2.jar
 com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/temp/junit4-J1-20151215_095831_840.events
 
@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/temp/junit4-J1-20151215_095831_840.suites
 -stdin
   [junit4] ERROR: JVM J1 ended with an exception: Quit event not received from 
the forked process? This may indicate JVM crash or runner bugs.
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955)
   [junit4]     at 
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952)
   [junit4]     at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]     at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]     at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]     at java.lang.Thread.run(Thread.java:745)

BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:791:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:728:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:516:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1436:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:991:
 At least one slave process threw an exception, first: Quit event not received 
from the forked process? This may indicate JVM crash or runner bugs.

Total time: 419 minutes 33 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to