You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/04/22 02:11:38 UTC
[JENKINS] Lucene-Solr-Tests-master - Build # 1097 - Still Failing
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