Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/116/

6 tests failed.
FAILED:  org.apache.solr.cloud.HttpPartitionTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=25190, 
name=SocketProxy-Response-37204:54204, state=RUNNABLE, 
group=TGRP-HttpPartitionTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=25190, name=SocketProxy-Response-37204:54204, 
state=RUNNABLE, group=TGRP-HttpPartitionTest]
        at 
__randomizedtesting.SeedInfo.seed([56EEEACA37CCC526:DEBAD5109930A8DE]:0)
Caused by: java.lang.RuntimeException: java.net.SocketException: Socket is 
closed
        at __randomizedtesting.SeedInfo.seed([56EEEACA37CCC526]:0)
        at 
org.apache.solr.cloud.SocketProxy$Bridge$Pump.run(SocketProxy.java:347)
Caused by: java.net.SocketException: Socket is closed
        at java.net.Socket.setSoTimeout(Socket.java:1137)
        at 
org.apache.solr.cloud.SocketProxy$Bridge$Pump.run(SocketProxy.java:344)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest:     1) 
Thread[id=151274, name=searcherExecutor-18176-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest: 
   1) Thread[id=151274, name=searcherExecutor-18176-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([56EEEACA37CCC526]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=151274, name=searcherExecutor-18176-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=151274, name=searcherExecutor-18176-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([56EEEACA37CCC526]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.overseer.ZkStateWriterTest

Error Message:
1 thread leaked from SUITE scope at 
org.apache.solr.cloud.overseer.ZkStateWriterTest:     1) Thread[id=212982, 
name=watches-5398-thread-1, state=TIMED_WAITING, group=TGRP-ZkStateWriterTest]  
       at sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)         
at 
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
         at 
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
         at 
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)         
at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.cloud.overseer.ZkStateWriterTest: 
   1) Thread[id=212982, name=watches-5398-thread-1, state=TIMED_WAITING, 
group=TGRP-ZkStateWriterTest]
        at sun.misc.Unsafe.park(Native Method)
        at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at 
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
        at 
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
        at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([56EEEACA37CCC526]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.overseer.ZkStateWriterTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=212982, name=watches-5398-thread-1, state=TIMED_WAITING, 
group=TGRP-ZkStateWriterTest]         at sun.misc.Unsafe.park(Native Method)    
     at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)  
       at 
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
         at 
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
         at 
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)         
at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=212982, name=watches-5398-thread-1, state=TIMED_WAITING, 
group=TGRP-ZkStateWriterTest]
        at sun.misc.Unsafe.park(Native Method)
        at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
        at 
java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
        at 
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
        at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([56EEEACA37CCC526]:0)


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

Error Message:
Timeout occured while waiting response from server at: 
http://127.0.0.1:33683/_fj/ar

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:33683/_fj/ar
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:399)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:515)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:179)
        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:498)
        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:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        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:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        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:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        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)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:170)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:495)
        ... 47 more




Build Log:
[...truncated 12524 lines...]
   [junit4] Suite: org.apache.solr.cloud.HttpPartitionTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/init-core-data-001
   [junit4]   2> 3646183 INFO  
(SUITE-HttpPartitionTest-seed#[56EEEACA37CCC526]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 3646183 INFO  
(SUITE-HttpPartitionTest-seed#[56EEEACA37CCC526]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /sno/
   [junit4]   2> 3646197 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 3646206 INFO  (Thread-10489) [    ] o.a.s.c.ZkTestServer 
client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 3646206 INFO  (Thread-10489) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 3646306 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:42014
   [junit4]   2> 3646306 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3646314 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3646328 INFO  (zkCallback-4097-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7c3bdcab 
name:ZooKeeperConnection Watcher:127.0.0.1:42014 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3646328 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3646328 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3646328 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 3646330 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3646338 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3646377 INFO  (zkCallback-4098-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@46a3012e 
name:ZooKeeperConnection Watcher:127.0.0.1:42014/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3646377 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3646377 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3646377 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 3646390 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 3646391 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 3646392 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 3646393 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 3646393 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 3646395 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 3646395 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 3646396 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 3646396 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 3646397 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 3646397 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 3646398 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 3646398 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 3646403 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 3646403 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 3646404 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 3646404 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 3646405 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 3646405 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 3646406 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 3646406 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 3646407 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 3646407 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 3646408 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 3646408 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 3646599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1
   [junit4]   2> 3646601 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.e.j.s.Server 
jetty-9.3.8.v20160314
   [junit4]   2> 3646607 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@556bc2b9{/sno,null,AVAILABLE}
   [junit4]   2> 3646608 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@a3e8d5b{HTTP/1.1,[http/1.1]}{127.0.0.1:43322}
   [junit4]   2> 3646608 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.e.j.s.Server 
Started @3650605ms
   [junit4]   2> 3646608 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/tempDir-001/control/data,
 hostContext=/sno, hostPort=33828, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores}
   [junit4]   2> 3646609 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 3646609 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001'
   [junit4]   2> 3646609 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 3646609 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 3646609 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3646618 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3646630 INFO  (zkCallback-4099-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@50c8e771 
name:ZooKeeperConnection Watcher:127.0.0.1:42014/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3646634 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3646634 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3646636 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 3646636 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/solr.xml
   [junit4]   2> 3646640 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores
   [junit4]   2> 3646640 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1409477028
   [junit4]   2> 3646640 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001]
   [junit4]   2> 3646641 WARN  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/lib
   [junit4]   2> 3646641 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
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> 3646642 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 3646643 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.a.s.l.LogWatcher 
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3646643 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.a.s.l.LogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3646643 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42014/solr
   [junit4]   2> 3646643 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 3646643 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3646655 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3646674 INFO  (zkCallback-4102-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@56c02158 
name:ZooKeeperConnection Watcher:127.0.0.1:42014 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3646674 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3646675 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3646676 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$$Lambda$34/713325738@5a8e2acb
   [junit4]   2> 3646690 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3646718 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1acb7250 
name:ZooKeeperConnection Watcher:127.0.0.1:42014/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3646718 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3646719 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 3646720 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 3646722 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 3646723 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 3646725 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 3646725 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 3646726 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 3646727 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 3646728 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 3646729 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 3646729 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3646729 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 3646731 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 3646732 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 3646732 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3646733 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/96217665882619908-127.0.0.1:33828_sno-n_0000000000
   [junit4]   2> 3646733 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.OverseerElectionContext I am going to be the leader 
127.0.0.1:33828_sno
   [junit4]   2> 3646733 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 3646734 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.Overseer Overseer 
(id=96217665882619908-127.0.0.1:33828_sno-n_0000000000) starting
   [junit4]   2> 3646735 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 3646738 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 3646744 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 3646745 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 3646758 INFO  
(OverseerCollectionConfigSetProcessor-96217665882619908-127.0.0.1:33828_sno-n_0000000000)
 [n:127.0.0.1:33828_sno    ] o.a.s.c.OverseerTaskProcessor Process current 
queue of overseer operations
   [junit4]   2> 3646766 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33828_sno
   [junit4]   2> 3646766 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:33828_sno
   [junit4]   2> 3646767 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [0])
   [junit4]   2> 3646768 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 3646779 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 3646779 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 3646780 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores
   [junit4]   2> 3646781 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] 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> 3646781 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1
   [junit4]   2> 3646781 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 3646799 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 3646799 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController numShards not found on descriptor - reading it from system 
property
   [junit4]   2> 3646800 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection control_collection not visible yet, but 
flagging it so a watch is registered when it becomes visible
   [junit4]   2> 3646800 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
   [junit4]   2> 3646819 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 3646819 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:33828_sno    
] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 3646823 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController look for our core node name
   [junit4]   2> 3646823 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] 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:33828/sno";,
   [junit4]   2>   "node_name":"127.0.0.1:33828_sno",
   [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> 3646823 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] 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:33828/sno";,
   [junit4]   2>   "node_name":"127.0.0.1:33828_sno",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 3646824 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 3646824 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.o.ReplicaMutator Assigning new node to 
shard shard=shard1
   [junit4]   2> 3646825 INFO  
(zkCallback-4103-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] 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> 3647824 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 3647824 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 3647824 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 3647824 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 3647824 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 3647825 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1'
   [junit4]   2> 3647825 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 3647825 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 3647826 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] o.a.s.c.Config 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 3647830 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 3647833 WARN  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 3647834 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.2.0
   [junit4]   2> 3647856 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 3647861 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 3648216 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 3648222 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 3648227 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 3648240 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 3648242 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 3648244 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 3648245 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 3648247 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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-6.x/solr/build/solr-core/test/J2
   [junit4]   2> 3648247 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection
   [junit4]   2> 3648247 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 3648247 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data/]
   [junit4]   2> 3648247 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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@6dcf746d
   [junit4]   2> 3648248 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data
   [junit4]   2> 3648248 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data/index/
   [junit4]   2> 3648248 WARN  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 3648248 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data/index
   [junit4]   2> 3648248 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.24721143588410568]
   [junit4]   2> 3648254 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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@619c32e1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3e6f8baa),segFN=segments_1,generation=1}
   [junit4]   2> 3648254 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 3648266 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 3648266 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 3648266 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 3648266 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 3648266 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 3648266 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648267 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648267 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648267 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648267 WARN  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648269 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 3648269 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 3648270 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 3648271 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 3648273 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/dump,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 3648273 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648274 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:33828_sno 
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-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data/
   [junit4]   2> 3648274 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 3648288 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648289 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648289 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 3648289 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 3648290 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@1169190
   [junit4]   2> 3648290 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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@619c32e1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3e6f8baa),segFN=segments_1,generation=1}
   [junit4]   2> 3648290 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 3648290 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@78f8ae13[collection1] main]
   [junit4]   2> 3648290 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648291 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648291 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648291 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO 
with znodeBase: /configs/conf1
   [junit4]   2> 3648291 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 3648291 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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> 3648292 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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 1539482656296665088
   [junit4]   2> 3648294 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno 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 1539482656296665088
   [junit4]   2> 3648294 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 3648294 INFO  
(coreLoadExecutor-9429-thread-1-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 3648295 INFO  
(searcherExecutor-9430-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@78f8ae13[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3648299 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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:33828/sno 
collection:control_collection shard:shard1
   [junit4]   2> 3648300 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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> 3648302 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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/96217665882619908-core_node1-n_0000000000
   [junit4]   2> 3648302 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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> 3648304 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] 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> 3648305 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 3648305 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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> 3648305 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:33828/sno/collection1/
   [junit4]   2> 3648305 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 3648305 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:33828/sno/collection1/ has no replicas
   [junit4]   2> 3648306 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 3648307 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/control_collection/leaders/shard1/leader after winning as 
/collections/control_collection/leader_elect/shard1/election/96217665882619908-core_node1-n_0000000000
   [junit4]   2> 3648308 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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:33828/sno/collection1/ shard1
   [junit4]   2> 3648310 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] 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:33828/sno";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 3648323 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3648324 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3648331 INFO  (zkCallback-4107-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@44c3604a 
name:ZooKeeperConnection Watcher:127.0.0.1:42014/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3648331 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3648331 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3648331 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 3648332 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3648333 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3648334 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 3648334 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 3648334 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3648335 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3648335 INFO  (zkCallback-4108-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@250b1a25 
name:ZooKeeperConnection Watcher:127.0.0.1:42014/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3648335 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3648335 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3648342 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"create",
   [junit4]   2>   "name":"collection1",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "stateFormat":"2"} current state version: 1
   [junit4]   2> 3648342 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 3648343 INFO  
(zkCallback-4103-thread-3-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] 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> 3648343 INFO  (zkCallback-4107-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: [1])
   [junit4]   2> 3648387 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:33828/sno/collection1/ and leader is 
http://127.0.0.1:33828/sno/collection1/
   [junit4]   2> 3648387 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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:33828/sno
   [junit4]   2> 3648387 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 3648388 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 3648388 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
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> 3648389 INFO  
(coreZkRegister-9423-thread-1-processing-n:127.0.0.1:33828_sno x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:33828_sno 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection 
control_collection
   [junit4]   2> 3648391 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] 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:33828/sno";,
   [junit4]   2>   "node_name":"127.0.0.1:33828_sno",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 2
   [junit4]   2> 3648391 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
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:33828/sno";,
   [junit4]   2>   "node_name":"127.0.0.1:33828_sno",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 3648391 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/collection1/state.json
   [junit4]   2> 3648497 INFO  (zkCallback-4107-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: [1])
   [junit4]   2> 3648497 INFO  
(zkCallback-4103-thread-3-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] 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> 3648529 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001/cores/collection1
   [junit4]   2> 3648530 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001
   [junit4]   2> 3648530 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.e.j.s.Server 
jetty-9.3.8.v20160314
   [junit4]   2> 3648598 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3317b57b{/sno,null,AVAILABLE}
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@3f1f98b3{HTTP/1.1,[http/1.1]}{127.0.0.1:57877}
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.e.j.s.Server 
Started @3652596ms
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/sno, hostPort=32960, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001/cores}
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001'
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 3648599 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 3648600 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3648611 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3648630 INFO  (zkCallback-4109-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@895c6e8 name:ZooKeeperConnection 
Watcher:127.0.0.1:42014/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 3648630 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3648631 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3648632 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 3648632 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001/solr.xml
   [junit4]   2> 3648636 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001/cores
   [junit4]   2> 3648636 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 961673952
   [junit4]   2> 3648636 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001]
   [junit4]   2> 3648636 WARN  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest_56EEEACA37CCC526-001/shard-1-001/lib
   [junit4]   2> 3648637 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
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> 3648638 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 3648638 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.a.s.l.LogWatcher 
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 3648638 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] o.a.s.l.LogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 3648638 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42014/solr
   [junit4]   2> 3648638 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 3648638 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 3648643 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3648646 INFO  (zkCallback-4112-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@456e5aa3 
name:ZooKeeperConnection Watcher:127.0.0.1:42014 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3648646 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3648646 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 3648648 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.ZkController Added new OnReconnect listener 
org.apache.solr.cloud.ZkController$$Lambda$34/713325738@59ea33d5
   [junit4]   2> 3648651 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3648664 INFO  
(zkCallback-4113-thread-1-processing-n:127.0.0.1:32960_sno) 
[n:127.0.0.1:32960_sno    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6ae415bf 
name:ZooKeeperConnection Watcher:127.0.0.1:42014/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 3648664 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3648676 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 3648677 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3648677 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3648679 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3648679 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/96217665882619913-127.0.0.1:32960_sno-n_0000000001
   [junit4]   2> 3648680 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/96217665882619908-127.0.0.1:33828_sno-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 3648680 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.ZkController Publish node=127.0.0.1:32960_sno as DOWN
   [junit4]   2> 3648681 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:32960_sno
   [junit4]   2> 3648681 INFO  
(TEST-HttpPartitionTest.test-seed#[56EEEACA37CCC526]) [n:127.0.0.1:32960_sno    
] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:32960_sno
   [junit4]   2> 3648681 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:32960_sno"} current state version: 3
   [junit4]   2> 3648682 INFO  
(OverseerStateUpdate-96217665882619908-127.0.0.1:33828_sno-n_0000000000) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:32960_sno
   [junit4]   2> 3648682 INFO  (zkCallback-4107-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> 3648682 INFO  
(zkCallback-4103-thread-4-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] 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> 3648682 INFO  (zkCallback-4107-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3648682 INFO  
(zkCallback-4103-thread-4-processing-n:127.0.0.1:33828_sno) 
[n:127.0.0.1:33828_sno    ] o.a.s.c.c.ZkStateRe

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

htlyTests-6.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-common-2.7.2-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-hdfs-2.7.2-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-minikdc-2.7.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/htrace-core-3.2.0-incubating.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-core-asl-1.9.13.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-mapper-asl-1.9.13.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/netty-all-4.0.36.Final.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/analysis/icu/lucene-analyzers-icu-6.2.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/contrib/analysis-extras/lib/icu4j-56.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.4.jar
 com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160710_143657_515.events
 
@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160710_143657_515.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-6.x/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:530:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1443:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:984:
 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: 316 minutes 47 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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to