Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1097/

3 tests failed.
FAILED:  
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([4B17D181DD650A:1FF1662651BDA3CF]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:41)
        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 
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)


FAILED:  junit.framework.TestSuite.org.apache.solr.schema.TestManagedSchemaAPI

Error Message:
ObjectTracker found 2 object(s) that were not released!!! 
[MockDirectoryWrapper, MockDirectoryWrapper]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 2 object(s) that were not 
released!!! [MockDirectoryWrapper, MockDirectoryWrapper]
        at __randomizedtesting.SeedInfo.seed([4B17D181DD650A]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:255)
        at sun.reflect.GeneratedMethodAccessor32.invoke(Unknown Source)
        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$7.evaluate(RandomizedRunner.java:834)
        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)


FAILED:  org.apache.solr.spelling.suggest.SuggesterTSTTest.testReload

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([4B17D181DD650A:C7BB6FD24B9E9D18]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:780)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:747)
        at 
org.apache.solr.spelling.suggest.SuggesterTest.testReload(SuggesterTest.java:90)
        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 
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.lang.RuntimeException: REQUEST FAILED: 
xpath=//lst[@name='spellcheck']/lst[@name='suggestions']/lst[@name='ac']/int[@name='numFound'][.='2']
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">1</int></lst><lst name="spellcheck"><lst name="suggestions"/><lst 
name="collations"/></lst>
</response>

        request 
was:q=ac&qt=/suggest_tst&spellcheck.onlyMorePopular=true&spellcheck.count=2&wt=xml
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:773)
        ... 41 more




Build Log:
[...truncated 10846 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_4B17D181DD650A-001/init-core-data-001
   [junit4]   2> 349956 INFO  
(SUITE-ZkStateReaderTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 349970 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 349970 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 349976 INFO  (Thread-526) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 349976 INFO  (Thread-526) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 350076 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer start zk server on port:57182
   [junit4]   2> 350076 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 350084 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 350143 INFO  (zkCallback-226-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@a300628 name:ZooKeeperConnection 
Watcher:127.0.0.1:57182 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 350143 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 350143 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 350145 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 350145 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 350146 INFO  (zkCallback-227-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@41f62d14 
name:ZooKeeperConnection Watcher:127.0.0.1:57182 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 350146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 350146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 350146 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 350149 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 350149 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 350150 INFO  (zkCallback-228-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@30ba8701 
name:ZooKeeperConnection Watcher:127.0.0.1:57182/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 350150 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 350150 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 350151 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 350151 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 350154 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 350155 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 350155 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 350156 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 350157 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 350157 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 350157 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 350158 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 350158 INFO  (zkCallback-228-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 350166 INFO  (zkCallback-228-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 350225 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 350236 INFO  (zkCallback-228-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 350242 INFO  (zkCallback-228-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: [0])
   [junit4]   2> 350244 INFO  (zkCallback-228-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 350387 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57182 57182
   [junit4]   2> 350692 INFO  (Thread-526) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:57182 57182
   [junit4]   2> 350704 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 350705 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 350706 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 350712 INFO  (Thread-527) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 350712 INFO  (Thread-527) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 350812 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer start zk server on port:36669
   [junit4]   2> 350812 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 350823 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 350839 INFO  (zkCallback-229-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5a300502 
name:ZooKeeperConnection Watcher:127.0.0.1:36669 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 350844 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 350844 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 350888 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 350896 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 350924 INFO  (zkCallback-230-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@badfd4 name:ZooKeeperConnection 
Watcher:127.0.0.1:36669 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 350928 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 350928 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 350928 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 351000 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 351004 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 351007 INFO  (zkCallback-231-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5e7ef505 
name:ZooKeeperConnection Watcher:127.0.0.1:36669/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 351007 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 351007 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 351008 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 351009 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 351009 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 351010 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 351011 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 351012 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 351013 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 351013 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 351014 INFO  (zkCallback-231-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 351014 INFO  (zkCallback-231-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: [0])
   [junit4]   2> 351015 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 351016 INFO  (zkCallback-231-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: [0])
   [junit4]   2> 351090 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1543b2690f90002, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 351091 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36669 36669
   [junit4]   2> 351372 INFO  (Thread-527) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:36669 36669
   [junit4]   2> 351373 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 351374 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 351374 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 351376 INFO  (Thread-528) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 351376 INFO  (Thread-528) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 351480 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer start zk server on port:54276
   [junit4]   2> 351480 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 351488 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 351516 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@50d7b765 
name:ZooKeeperConnection Watcher:127.0.0.1:54276 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 351520 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 351520 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 351545 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 351549 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 351555 INFO  (zkCallback-233-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6f1e29f2 
name:ZooKeeperConnection Watcher:127.0.0.1:54276 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 351555 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 351555 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 351556 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 351560 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 351560 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 351564 INFO  (zkCallback-234-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@36c7dcf8 
name:ZooKeeperConnection Watcher:127.0.0.1:54276/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 351564 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 351564 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 351565 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 351565 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 351566 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 351566 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 351567 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 351567 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 351568 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 351568 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 351568 INFO  (zkCallback-234-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 351573 INFO  (zkCallback-234-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: [0])
   [junit4]   2> 351637 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 351656 INFO  (zkCallback-234-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: [0])
   [junit4]   2> 351708 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:54276 54276
   [junit4]   2> 351973 INFO  (Thread-528) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:54276 54276
   [junit4]   2> 351988 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 351992 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 351992 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 351994 INFO  (Thread-529) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 351994 INFO  (Thread-529) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 352096 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer start zk server on port:35813
   [junit4]   2> 352096 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 352108 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 352127 INFO  (zkCallback-235-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@17ec1cbd 
name:ZooKeeperConnection Watcher:127.0.0.1:35813 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 352127 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 352128 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 352129 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 352129 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 352131 INFO  (zkCallback-236-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@64207fc3 
name:ZooKeeperConnection Watcher:127.0.0.1:35813 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 352132 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 352132 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 352132 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 352137 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x1543b2695fc0001, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 352138 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 352139 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 352140 INFO  (zkCallback-237-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1f718a3 name:ZooKeeperConnection 
Watcher:127.0.0.1:35813/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 352140 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 352140 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 352140 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 352141 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 352141 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 352142 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 352143 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 352143 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 352144 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 352144 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 352145 INFO  (zkCallback-237-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 352145 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 352146 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 352146 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 352146 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 352148 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35813 35813
   [junit4]   2> 352388 INFO  (Thread-529) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:35813 35813
   [junit4]   2> 352392 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 352404 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 352404 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 352408 INFO  (Thread-530) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 352408 INFO  (Thread-530) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 352509 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.ZkTestServer start zk server on port:52151
   [junit4]   2> 352509 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 352509 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 352532 INFO  (zkCallback-238-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7e2d0b99 
name:ZooKeeperConnection Watcher:127.0.0.1:52151 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 352536 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 352536 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 352552 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 352556 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 352576 INFO  (zkCallback-239-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@278a8fe5 
name:ZooKeeperConnection Watcher:127.0.0.1:52151 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 352576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 352576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 352576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 352648 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 352660 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 352680 INFO  (zkCallback-240-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@52ec7ecf 
name:ZooKeeperConnection Watcher:127.0.0.1:52151/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 352680 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 352680 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 352690 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 352691 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 352691 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 352692 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 352692 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 352693 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 352693 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 352693 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 352694 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 352694 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 352695 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 352696 INFO  (zkCallback-240-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 352704 INFO  (zkCallback-240-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 352706 INFO  (zkCallback-240-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 352752 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:52151 52151
   [junit4]   2> 352972 INFO  (Thread-530) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:52151 52151
   [junit4]   2> 352984 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4B17D181DD650A]) [  
  ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 352992 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 352993 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 352998 INFO  (Thread-531) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 352998 INFO  (Thread-531) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 353100 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer start zk server on port:48978
   [junit4]   2> 353100 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 353116 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 353140 INFO  (zkCallback-241-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@32267e89 
name:ZooKeeperConnection Watcher:127.0.0.1:48978 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 353140 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 353140 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 353195 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 353199 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 353216 INFO  (zkCallback-242-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@135aa7f5 
name:ZooKeeperConnection Watcher:127.0.0.1:48978 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 353220 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 353220 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 353220 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 353223 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 353233 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 353240 INFO  (zkCallback-243-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@29657a2a 
name:ZooKeeperConnection Watcher:127.0.0.1:48978/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 353244 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 353244 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 353256 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 353257 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 353257 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 353258 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 353258 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 353259 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 353259 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 353260 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 353260 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 353260 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 353261 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 353268 ERROR 
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A]-EventThread)
 [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$7/787100141@2480caec
 rejected from 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@20bf4aa4[Shutting
 down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 1]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 353269 ERROR 
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A]-EventThread)
 [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$7/787100141@76670435
 rejected from 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@20bf4aa4[Shutting
 down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 1]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 353269 ERROR 
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A]-EventThread)
 [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$7/787100141@ea2fde3
 rejected from 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@20bf4aa4[Shutting
 down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 1]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
   [junit4]   2>        at 
java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
   [junit4]   2> 353280 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48978 48978
   [junit4]   2> 353587 INFO  (Thread-531) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:48978 48978
   [junit4]   2> 353610 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[4B17D181DD650A])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithExplicitRefresh 
-Dtests.seed=4B17D181DD650A -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=hr-HR -Dtests.timezone=Europe/Sofia -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.63s J0 | 
ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([4B17D181DD650A:1FF1662651BDA3CF]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:41)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 353612 INFO  
(SUITE-ZkStateReaderTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_4B17D181DD650A-001
   [junit4]   2> Apr 21, 2016 11:27:46 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, maxPointsInLeafNode=507, maxMBSortInHeap=5.7829140854726875, 
sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=hr-HR, 
timezone=Europe/Sofia
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=205733248,total=393216000
   [junit4]   2> NOTE: All tests run in this JVM: 
[PathHierarchyTokenizerFactoryTest, TestSearcherReuse, ZkNodePropsTest, 
HdfsWriteToMultipleCollectionsTest, TestDownShardTolerantSearch, 
URLClassifyProcessorTest, SSLMigrationTest, TestLuceneMatchVersion, 
TestSolr4Spatial2, TestComponentsName, AnalyticsQueryTest, SOLR749Test, 
ExplicitHLLTest, TestMacros, TestLazyCores, TestFunctionQuery, 
ConcurrentDeleteAndCreateCollectionTest, DefaultValueUpdateProcessorTest, 
CopyFieldTest, TestPseudoReturnFields, PreAnalyzedFieldTest, 
TestPivotHelperCode, BufferStoreTest, TestFaceting, TestRandomFaceting, 
TestOmitPositions, CacheHeaderTest, TestConfigSetsAPIZkFailure, 
TestCollectionAPI, ActionThrottleTest, 
OverseerCollectionConfigSetProcessorTest, CurrencyFieldOpenExchangeTest, 
BasicAuthIntegrationTest, PrimUtilsTest, DocumentAnalysisRequestHandlerTest, 
TestAnalyzedSuggestions, TestRandomDVFaceting, TestDocSet, 
TestPKIAuthenticationPlugin, QueryElevationComponentTest, JsonLoaderTest, 
TestFieldResource, TestScoreJoinQPNoScore, OverseerTaskQueueTest, 
ZkStateReaderTest]
   [junit4] Completed [104/590 (1!)] on J0 in 3.92s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 659 lines...]
   [junit4] Suite: org.apache.solr.spelling.suggest.SuggesterTSTTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 1531994 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 1532061 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 1532094 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1532107 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] o.a.s.c.SolrConfig 
Loaded SolrConfig: solrconfig-spellchecker.xml
   [junit4]   2> 1532109 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=Solr SpellCheck Test
   [junit4]   2> 1532118 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1532118 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.s.IndexSchema query parser default operator is OR
   [junit4]   2> 1532118 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr'
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1000970441
   [junit4]   2> 1532119 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr]
   [junit4]   2> 1532120 WARN  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/lib
   [junit4]   2> 1532135 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 
600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,
   [junit4]   2> 1532160 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
   [junit4]   2> 1532167 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] o.a.s.l.LogWatcher 
SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1532167 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] o.a.s.l.LogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1532167 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 1532167 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1532168 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig-spellchecker.xml, transient=false, 
schema=schema-spellchecker.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=collection1, 
dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001,
 shard=shard1}
   [junit4]   2> 1532173 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1532454 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1532454 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr
   [junit4]   2> 1532454 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 1532454 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 1532507 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1532510 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1532533 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-spellchecker.xml
   [junit4]   2> 1532549 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=Solr SpellCheck Test
   [junit4]   2> 1532561 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1532561 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.s.IndexSchema query parser default operator is OR
   [junit4]   2> 1532597 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1532599 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1532599 INFO  (coreLoadExecutor-5881-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1532599 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory
   [junit4]   2> 1532599 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/]
   [junit4]   2> 1532600 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 1532600 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001
   [junit4]   2> 1532600 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index/
   [junit4]   2> 1532600 WARN  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1532601 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index
   [junit4]   2> 1532601 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=22, maxMergedSegmentMB=35.6865234375, 
floorSegmentMB=1.0439453125, forceMergeDeletesPctAllowed=13.127032215217136, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.18520952692273412
   [junit4]   2> 1532609 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c14ddf7),segFN=segments_1,generation=1}
   [junit4]   2> 1532609 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1532628 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 1532630 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1532630 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1532631 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1532631 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1532632 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    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-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/
   [junit4]   2> 1532633 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/suggest_fst,/admin/properties,/update/json,/admin/threads,/suggest_wfst,/suggest_tst,/update/csv,/sql,/admin/segments,/admin/system,/suggest,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
   [junit4]   2> 1532633 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1532634 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1532634 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1532635 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1532635 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c14ddf7),segFN=segments_1,generation=1}
   [junit4]   2> 1532635 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1532635 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@59e9fc09[collection1] main]
   [junit4]   2> 1532636 WARN  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
InMemoryStorage
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.s.s.Suggester init: 
{name=suggest,classname=org.apache.solr.spelling.suggest.Suggester,lookupImpl=org.apache.solr.spelling.suggest.jaspell.JaspellLookup,field=suggest,storeDir=suggest,buildOnCommit=true,threshold=0.0}
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.s.s.j.JaspellLookupFactory init: 
{name=suggest,classname=org.apache.solr.spelling.suggest.Suggester,lookupImpl=org.apache.solr.spelling.suggest.jaspell.JaspellLookup,field=suggest,storeDir=suggest,buildOnCommit=true,threshold=0.0}
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener 
for spellchecker: suggest
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent No queryConverter defined, using 
default converter
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.s.s.Suggester init: 
{name=suggest_tst,classname=org.apache.solr.spelling.suggest.Suggester,lookupImpl=org.apache.solr.spelling.suggest.tst.TSTLookup,field=suggest,storeDir=suggest_tst,buildOnCommit=true,threshold=0.0}
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener 
for spellchecker: suggest_tst
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent No queryConverter defined, using 
default converter
   [junit4]   2> 1532636 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.s.s.Suggester init: 
{name=suggest_fst,classname=org.apache.solr.spelling.suggest.Suggester,lookupImpl=org.apache.solr.spelling.suggest.fst.FSTLookup,field=suggest,storeDir=suggest_fst,buildOnCommit=true,weightBuckets=5,exactMatchFirst=true}
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener 
for spellchecker: suggest_fst
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent No queryConverter defined, using 
default converter
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.s.s.Suggester init: 
{name=suggest_wfst,classname=org.apache.solr.spelling.suggest.Suggester,lookupImpl=org.apache.solr.spelling.suggest.fst.WFSTLookupFactory,field=suggest,storeDir=suggest_wfst,buildOnCommit=true,exactMatchFirst=true}
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener 
for spellchecker: suggest_wfst
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent No queryConverter defined, using 
default converter
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1532637 INFO  (coreLoadExecutor-5881-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1532638 INFO  
(SUITE-SuggesterTSTTest-seed#[4B17D181DD650A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1532640 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testReload
   [junit4]   2> 1532641 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[1]} 0 0
   [junit4]   2> 1532642 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[2]} 0 0
   [junit4]   2> 1532642 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={}{add=[3]} 0 0
   [junit4]   2> 1532642 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1532651 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: suggest
   [junit4]   2> 1532651 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.s.s.Suggester reload()
   [junit4]   2> 1532651 ERROR 
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Exception in reloading spell check index for 
spellchecker: suggest
   [junit4]   2> java.io.FileNotFoundException: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/suggest/jaspell.dat
 (No such file or directory)
   [junit4]   2>        at java.io.FileInputStream.open0(Native Method)
   [junit4]   2>        at 
java.io.FileInputStream.open(FileInputStream.java:195)
   [junit4]   2>        at 
java.io.FileInputStream.<init>(FileInputStream.java:138)
   [junit4]   2>        at 
org.apache.solr.spelling.suggest.Suggester.reload(Suggester.java:182)
   [junit4]   2>        at 
org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener.newSearcher(SpellCheckComponent.java:818)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getSearcher$3(SolrCore.java:1789)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1532659 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c14ddf7),segFN=segments_1,generation=1}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/index
 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c14ddf7),segFN=segments_2,generation=2}
   [junit4]   2> 1532671 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: suggest_tst
   [junit4]   2> 1532671 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1532672 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.s.s.Suggester reload()
   [junit4]   2> 1532672 WARN  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING: Overlapping 
onDeckSearchers=2
   [junit4]   2> 1532673 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@69eeb6f2[collection1] main]
   [junit4]   2> 1532673 INFO  
(TEST-SuggesterTSTTest.testReload-seed#[4B17D181DD650A]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1532673 ERROR 
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Exception in reloading spell check index for 
spellchecker: suggest_tst
   [junit4]   2> java.io.FileNotFoundException: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/suggest_tst/tst.dat
 (No such file or directory)
   [junit4]   2>        at java.io.FileInputStream.open0(Native Method)
   [junit4]   2>        at 
java.io.FileInputStream.open(FileInputStream.java:195)
   [junit4]   2>        at 
java.io.FileInputStream.<init>(FileInputStream.java:138)
   [junit4]   2>        at 
org.apache.solr.spelling.suggest.Suggester.reload(Suggester.java:182)
   [junit4]   2>        at 
org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener.newSearcher(SpellCheckComponent.java:818)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getSearcher$3(SolrCore.java:1789)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1532674 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: suggest_fst
   [junit4]   2> 1532674 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.s.s.Suggester reload()
   [junit4]   2> 1532674 ERROR 
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Exception in reloading spell check index for 
spellchecker: suggest_fst
   [junit4]   2> java.io.FileNotFoundException: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.spelling.suggest.SuggesterTSTTest_4B17D181DD650A-001/init-core-data-001/suggest_fst/fst.bin
 (No such file or directory)
   [junit4]   2>        at java.io.FileInputStream.open0(Native Method)
   [junit4]   2>        at 
java.io.FileInputStream.open(FileInputStream.java:195)
   [junit4]   2>        at 
java.io.FileInputStream.<init>(FileInputStream.java:138)
   [junit4]   2>        at 
org.apache.solr.spelling.suggest.Suggester.reload(Suggester.java:182)
   [junit4]   2>        at 
org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener.newSearcher(SpellCheckComponent.java:818)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getSearcher$3(SolrCore.java:1789)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1532674 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: suggest_wfst
   [junit4]   2> 1532674 INFO  
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.s.s.Suggester reload()
   [junit4]   2> 1532674 ERROR 
(searcherExecutor-5882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Exception in reloading spell check index for 
spellchecker: suggest_wfst
   [juni

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

)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 2667802 INFO  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.CachingDirectoryFactory looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.schema.TestManagedSchemaAPI_4B17D181DD650A-001/tempDir-001/node2/./testschemaapi_shard1_replica1/data
 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.schema.TestManagedSchemaAPI_4B17D181DD650A-001/tempDir-001/node2/./testschemaapi_shard1_replica1/data;done=false>>]
   [junit4]   2> 2667806 INFO  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
   [junit4]   2> 2667806 INFO  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.schema.TestManagedSchemaAPI_4B17D181DD650A-001/tempDir-001/node2/./testschemaapi_shard1_replica1/data
   [junit4]   2> 2667806 INFO  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.CachingDirectoryFactory looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.schema.TestManagedSchemaAPI_4B17D181DD650A-001/tempDir-001/node2/./testschemaapi_shard1_replica1/data/index
 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.schema.TestManagedSchemaAPI_4B17D181DD650A-001/tempDir-001/node2/./testschemaapi_shard1_replica1/data/index;done=false>>]
   [junit4]   2> 2667806 INFO  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
   [junit4]   2> 2667806 INFO  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.schema.TestManagedSchemaAPI_4B17D181DD650A-001/tempDir-001/node2/./testschemaapi_shard1_replica1/data/index
   [junit4]   2> 2667806 WARN  (Thread-5572) [n:127.0.0.1:45694_solr 
c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica1] 
o.a.s.c.ZkController listener throws error
   [junit4]   2> org.apache.solr.common.SolrException: Unable to reload core 
[testschemaapi_shard1_replica1]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:945)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2488)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkController$4.run(ZkController.java:2425)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not 
find config name for collection:testschemaapi
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:772)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.reload(SolrCore.java:461)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:939)
   [junit4]   2>        ... 2 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not 
find config name for collection:testschemaapi
   [junit4]   2>        at 
org.apache.solr.rest.ManagedResourceStorage.newStorageIO(ManagedResourceStorage.java:101)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.initRestManager(SolrCore.java:2283)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:748)
   [junit4]   2>        ... 4 more
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): 
{_version_=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
id=PostingsFormat(name=MockRandom), 
myNewField1=PostingsFormat(name=MockRandom), myNewField=FSTOrd50}, 
docValues:{}, maxPointsInLeafNode=596, maxMBSortInHeap=6.154320425897943, 
sim=ClassicSimilarity, locale=sk, timezone=SystemV/EST5EDT
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=177640240,total=529530880
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestWordDelimiterFilterFactory, SimpleMLTQParserTest, 
TestTolerantUpdateProcessorRandomCloud, HdfsChaosMonkeyNothingIsSafeTest, 
TestCryptoKeys, SimplePostToolTest, SaslZkACLProviderTest, 
TestEmbeddedSolrServerConstructors, TestDFRSimilarityFactory, 
TestRandomCollapseQParserPlugin, TestInitQParser, HdfsDirectoryFactoryTest, 
FullHLLTest, TestChildDocTransformer, TestQuerySenderNoQuery, 
PKIAuthenticationIntegrationTest, CollectionsAPIDistributedZkTest, 
UpdateRequestProcessorFactoryTest, DocValuesMissingTest, SortByFunctionTest, 
TestCloudSchemaless, WrapperMergePolicyFactoryTest, TestUpdate, 
SmileWriterTest, TestTrie, TestFastLRUCache, HdfsDirectoryTest, 
WordBreakSolrSpellCheckerTest, TestConfigSetsAPI, TestCloudInspectUtil, 
AsyncMigrateRouteKeyTest, OverseerRolesTest, DocValuesTest, 
TestFileDictionaryLookup, TestSolrCLIRunExample, CSVRequestHandlerTest, 
SolrCmdDistributorTest, TestSolrCoreProperties, TestSimpleQParserPlugin, 
BlockCacheTest, TestTrackingShardHandlerFactory, MoreLikeThisHandlerTest, 
TestFieldTypeCollectionResource, StressHdfsTest, DirectSolrSpellCheckerTest, 
RecoveryAfterSoftCommitTest, HdfsNNFailoverTest, DistanceUnitsTest, RulesTest, 
TestDistributedStatsComponentCardinality, TestDynamicFieldResource, 
SolrIndexConfigTest, TestSolrConfigHandlerConcurrent, TestCodecSupport, 
BasicFunctionalityTest, TestSolrXml, TestHashPartitioner, TestRestoreCore, 
CustomCollectionTest, RestartWhileUpdatingTest, ConfigSetsAPITest, 
TestLFUCache, TestExclusionRuleCollectionAccess, TestInitParams, 
ChaosMonkeySafeLeaderTest, FileUtilsTest, FastVectorHighlighterTest, 
SpellCheckComponentTest, CoreMergeIndexesAdminHandlerTest, 
ChaosMonkeyNothingIsSafeTest, ShardRoutingCustomTest, ZkStateWriterTest, 
TestSolrFieldCacheMBean, TestDynamicLoading, TestBinaryResponseWriter, 
BigEndianAscendingWordSerializerTest, IndexBasedSpellCheckerTest, 
ConvertedLegacyTest, SparseHLLTest, TestTrieFacet, TimeZoneUtilsTest, 
ClusterStateUpdateTest, TestRawResponseWriter, TestCursorMarkWithoutUniqueKey, 
NumericFieldsTest, TestDistributedGrouping, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestSolrDeletionPolicy2, 
TestUseDocValuesAsStored2, TestBM25SimilarityFactory, 
LeaderInitiatedRecoveryOnShardRestartTest, MultiTermTest, SolrInfoMBeanTest, 
TermsComponentTest, SpatialFilterTest, DistribCursorPagingTest, 
HttpPartitionTest, SharedFSAutoReplicaFailoverUtilsTest, 
SimpleCollectionCreateDeleteTest, SolrCloudExampleTest, TestCloudDeleteByQuery, 
TestCloudPivotFacet, TestConfigSetsAPIExclusivity, TestMiniSolrCloudCluster, 
TestRequestForwarding, TestRequestStatusCollectionAPI, 
TestTolerantUpdateProcessorCloud, DirectoryFactoryTest, TestConfigSetImmutable, 
TestConfigSetProperties, TestInfoStreamLogging, TestNRTOpen, 
TestShardHandlerFactory, TestConfigReload, TestSolrConfigHandlerCloud, 
TestManagedSchema, TestManagedSchemaAPI]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestManagedSchemaAPI -Dtests.seed=4B17D181DD650A 
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sk 
-Dtests.timezone=SystemV/EST5EDT -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestManagedSchemaAPI (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: ObjectTracker found 2 
object(s) that were not released!!! [MockDirectoryWrapper, MockDirectoryWrapper]
   [junit4]    >        at __randomizedtesting.SeedInfo.seed([4B17D181DD650A]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:255)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [538/590 (3!)] on J1 in 13.87s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 174 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:529:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014:
 There were test failures: 590 suites (10 ignored), 2382 tests, 1 suite-level 
error, 2 errors, 85 ignored (70 assumptions) [seed: 4B17D181DD650A]

Total time: 87 minutes 30 seconds
Build step 'Invoke Ant' marked build as failure
Archiving 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